builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1472353911.08 results: success (0) buildid: 20160827173002 builduid: 6448e1cec2744660b1232cac8a4cf518 revision: b02228e2a9eb38fa2a1a947f7943def10c5310be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.077922) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.078347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.078640) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.178119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.178405) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-27 20:11:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.0M=0s 2016-08-27 20:11:51 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109119 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.306990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.307281) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020691 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.356931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.357309) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b02228e2a9eb38fa2a1a947f7943def10c5310be --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b02228e2a9eb38fa2a1a947f7943def10c5310be --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-27 20:11:51,953 truncating revision to first 12 chars 2016-08-27 20:11:51,953 Setting DEBUG logging. 2016-08-27 20:11:51,953 attempt 1/10 2016-08-27 20:11:51,953 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b02228e2a9eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 20:11:52,247 unpacking tar archive at: fx-team-b02228e2a9eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.981425) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.981727) ========= script_repo_revision: b02228e2a9eb38fa2a1a947f7943def10c5310be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.982149) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.982433) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 20:11:51.998265) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-27 20:11:51.998553) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:11:52 INFO - MultiFileLogger online at 20160827 20:11:52 in /builds/slave/test 20:11:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:11:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:11:52 INFO - {'append_to_log': False, 20:11:52 INFO - 'base_work_dir': '/builds/slave/test', 20:11:52 INFO - 'blob_upload_branch': 'Fx-Team', 20:11:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:11:52 INFO - 'branch': 'Fx-Team', 20:11:52 INFO - 'buildbot_json_path': 'buildprops.json', 20:11:52 INFO - 'config_files': ('talos/linux_config.py',), 20:11:52 INFO - 'default_actions': ('clobber', 20:11:52 INFO - 'read-buildbot-config', 20:11:52 INFO - 'download-and-extract', 20:11:52 INFO - 'populate-webroot', 20:11:52 INFO - 'create-virtualenv', 20:11:52 INFO - 'install', 20:11:52 INFO - 'run-tests'), 20:11:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:11:52 INFO - 'download_minidump_stackwalk': True, 20:11:52 INFO - 'download_symbols': 'ondemand', 20:11:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:11:52 INFO - 'tooltool.py': '/tools/tooltool.py', 20:11:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:11:52 INFO - '/tools/misc-python/virtualenv.py')}, 20:11:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:11:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:11:52 INFO - 'installer_path': 'installer.exe', 20:11:52 INFO - 'log_level': 'info', 20:11:52 INFO - 'log_name': 'talos', 20:11:52 INFO - 'log_to_console': True, 20:11:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:11:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:11:52 INFO - 'opt_config_files': (), 20:11:52 INFO - 'pip_index': False, 20:11:52 INFO - 'sps_profile': False, 20:11:52 INFO - 'sps_profile_interval': 0, 20:11:52 INFO - 'suite': 'dromaeojs', 20:11:52 INFO - 'system_bits': '32', 20:11:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:11:52 INFO - 'title': 'talos-linux64-ix-010', 20:11:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:11:52 INFO - 'use_talos_json': True, 20:11:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:11:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:11:52 INFO - 'work_dir': 'build'} 20:11:52 INFO - [mozharness: 2016-08-28 03:11:52.689594Z] Running clobber step. 20:11:52 INFO - Running pre-action listener: _resource_record_pre_action 20:11:52 INFO - Running main action method: clobber 20:11:52 INFO - rmtree: /builds/slave/test/build 20:11:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:11:53 INFO - Running post-action listener: _resource_record_post_action 20:11:53 INFO - [mozharness: 2016-08-28 03:11:53.672028Z] Finished clobber step (success) 20:11:53 INFO - [mozharness: 2016-08-28 03:11:53.672128Z] Running read-buildbot-config step. 20:11:53 INFO - Running pre-action listener: _resource_record_pre_action 20:11:53 INFO - Running main action method: read_buildbot_config 20:11:53 INFO - Using buildbot properties: 20:11:53 INFO - { 20:11:53 INFO - "project": "", 20:11:53 INFO - "product": "firefox", 20:11:53 INFO - "script_repo_revision": "production", 20:11:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:11:53 INFO - "repository": "", 20:11:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:11:53 INFO - "buildid": "20160827173002", 20:11:53 INFO - "pgo_build": "True", 20:11:53 INFO - "basedir": "/builds/slave/test", 20:11:53 INFO - "buildnumber": 1015, 20:11:53 INFO - "slavename": "talos-linux64-ix-010", 20:11:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:11:53 INFO - "platform": "ubuntu64_hw", 20:11:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:11:53 INFO - "branch": "fx-team", 20:11:53 INFO - "repo_path": "integration/fx-team", 20:11:53 INFO - "revision": "b02228e2a9eb38fa2a1a947f7943def10c5310be", 20:11:53 INFO - "stage_platform": "linux64-pgo", 20:11:53 INFO - "builduid": "6448e1cec2744660b1232cac8a4cf518", 20:11:53 INFO - "slavebuilddir": "test" 20:11:53 INFO - } 20:11:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:11:53 INFO - Running post-action listener: _resource_record_post_action 20:11:53 INFO - [mozharness: 2016-08-28 03:11:53.674577Z] Finished read-buildbot-config step (success) 20:11:53 INFO - [mozharness: 2016-08-28 03:11:53.674667Z] Running download-and-extract step. 20:11:53 INFO - Running pre-action listener: _resource_record_pre_action 20:11:53 INFO - Running main action method: download_and_extract 20:11:53 INFO - mkdir: /builds/slave/test/build/tests 20:11:53 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')]} 20:11:53 INFO - trying https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:11:53 INFO - Downloading https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/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 20:11:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/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 20:11:54 INFO - Downloaded 1361 bytes. 20:11:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:11:54 INFO - Using the following test package requirements: 20:11:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:11:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:11:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:11:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:54 INFO - u'jsshell-linux-x86_64.zip'], 20:11:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:11:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:11:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:11:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:11:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:11:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:11:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:54 INFO - trying https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:11:54 INFO - Downloading https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/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 20:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/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 20:11:55 INFO - Downloaded 21876528 bytes. 20:11:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:11:59 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 20:11: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')]} 20:11:59 INFO - trying https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:11:59 INFO - Downloading https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/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 20:11:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/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 20:12:00 INFO - Downloaded 21876528 bytes. 20:12:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:12: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')]} 20:12:04 INFO - trying https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:12:04 INFO - Downloading https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/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 20:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/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 20:12:05 INFO - Downloaded 14413998 bytes. 20:12:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 20:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:05 INFO - trying https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:12:05 INFO - Downloading https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/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 20:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/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 20:12:07 INFO - Downloaded 59731680 bytes. 20:12:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:12:07 INFO - mkdir: /builds/slave/test/properties 20:12:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:12:07 INFO - Writing to file /builds/slave/test/properties/build_url 20:12:07 INFO - Contents: 20:12:07 INFO - build_url:https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:12:08 INFO - Running post-action listener: _resource_record_post_action 20:12:08 INFO - Running post-action listener: set_extra_try_arguments 20:12:08 INFO - [mozharness: 2016-08-28 03:12:08.090947Z] Finished download-and-extract step (success) 20:12:08 INFO - [mozharness: 2016-08-28 03:12:08.091175Z] Running populate-webroot step. 20:12:08 INFO - Running pre-action listener: _resource_record_pre_action 20:12:08 INFO - Running main action method: populate_webroot 20:12:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:12:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:12:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:12:08 INFO - '--tppagecycles', 20:12:08 INFO - '7'], 20:12:08 INFO - 'tests': ['tsvgm']}}, 20:12:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:12:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:12:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:12:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:12:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:12:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:12:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:08 INFO - 'talos_options': ['--disable-e10s'], 20:12:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:12:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:12:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:08 INFO - 'talos_options': ['--disable-e10s'], 20:12:08 INFO - 'tests': ['damp', 'tps']}, 20:12:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:08 INFO - 'tests': ['damp', 'tps']}, 20:12:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:12:08 INFO - 'tests': ['dromaeo_dom']}, 20:12:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:12:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:12:08 INFO - 'tests': ['basic_compositor_video']}, 20:12:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:12:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:12:08 INFO - 'tests': ['a11yr', 20:12:08 INFO - 'ts_paint', 20:12:08 INFO - 'tpaint', 20:12:08 INFO - 'sessionrestore', 20:12:08 INFO - 'sessionrestore_no_auto_restore', 20:12:08 INFO - 'tabpaint']}, 20:12:08 INFO - 'other-e10s': {'tests': ['a11yr', 20:12:08 INFO - 'ts_paint', 20:12:08 INFO - 'tpaint', 20:12:08 INFO - 'sessionrestore', 20:12:08 INFO - 'sessionrestore_no_auto_restore', 20:12:08 INFO - 'tabpaint']}, 20:12:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:12:08 INFO - 'ts_paint', 20:12:08 INFO - 'tpaint', 20:12:08 INFO - 'sessionrestore', 20:12:08 INFO - 'sessionrestore_no_auto_restore', 20:12:08 INFO - 'tabpaint']}, 20:12:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:12:08 INFO - 'ts_paint', 20:12:08 INFO - 'tpaint', 20:12:08 INFO - 'sessionrestore', 20:12:08 INFO - 'sessionrestore_no_auto_restore', 20:12:08 INFO - 'tabpaint']}, 20:12:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:12:08 INFO - 'tests': ['a11yr', 20:12:08 INFO - 'ts_paint', 20:12:08 INFO - 'tpaint', 20:12:08 INFO - 'sessionrestore', 20:12:08 INFO - 'sessionrestore_no_auto_restore', 20:12:08 INFO - 'tabpaint']}, 20:12:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:12:08 INFO - 'tests': ['a11yr', 20:12:08 INFO - 'ts_paint', 20:12:08 INFO - 'tpaint', 20:12:08 INFO - 'sessionrestore', 20:12:08 INFO - 'sessionrestore_no_auto_restore', 20:12:08 INFO - 'tabpaint']}, 20:12:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:12:08 INFO - 'tests': ['tsvgx', 20:12:08 INFO - 'tsvgr_opacity', 20:12:08 INFO - 'tart', 20:12:08 INFO - 'tscrollx', 20:12:08 INFO - 'cart']}, 20:12:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:12:08 INFO - 'tsvgr_opacity', 20:12:08 INFO - 'tart', 20:12:08 INFO - 'tscrollx', 20:12:08 INFO - 'cart']}, 20:12:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:08 INFO - 'talos_options': ['--disable-e10s'], 20:12:08 INFO - 'tests': ['tp5o']}, 20:12:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:08 INFO - 'tests': ['tp5o']}, 20:12:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:08 INFO - 'talos_options': ['--disable-e10s', 20:12:08 INFO - '--xperf_path', 20:12:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:12:08 INFO - 'tests': ['tp5n']}, 20:12:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:08 INFO - 'talos_options': ['--xperf_path', 20:12:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:12:08 INFO - 'tests': ['tp5n']}}, 20:12:08 INFO - 'talos.zip': {'path': '', 20:12:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:12:08 INFO - Running post-action listener: _resource_record_post_action 20:12:08 INFO - [mozharness: 2016-08-28 03:12:08.106632Z] Finished populate-webroot step (success) 20:12:08 INFO - [mozharness: 2016-08-28 03:12:08.106722Z] Running create-virtualenv step. 20:12:08 INFO - Running pre-action listener: _resource_record_pre_action 20:12:08 INFO - Running main action method: create_virtualenv 20:12:08 INFO - Creating virtualenv /builds/slave/test/build/venv 20:12:08 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 20:12:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:12:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:12:08 INFO - Using real prefix '/usr' 20:12:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:12:08 INFO - Installing distribute.............................................................................................................................................................................................done. 20:12:10 INFO - Installing pip.................done. 20:12:10 INFO - Return code: 0 20:12:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:10 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 0x7f6cb1867f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2286370>, '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 0x22898f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', '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 20:12:10 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 20:12:10 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 20:12:10 INFO - Using env: {'DISPLAY': ':0', 20:12:10 INFO - 'HOME': '/home/cltbld', 20:12:10 INFO - 'LANG': 'en_US.UTF-8', 20:12:10 INFO - 'LANGUAGE': 'en_US:en', 20:12:10 INFO - 'LOGNAME': 'cltbld', 20:12:10 INFO - 'MAIL': '/var/mail/cltbld', 20:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:10 INFO - 'MOZ_NO_REMOTE': '1', 20:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:10 INFO - 'NO_EM_RESTART': '1', 20:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:10 INFO - 'PWD': '/builds/slave/test', 20:12:10 INFO - 'SHELL': '/bin/bash', 20:12:10 INFO - 'SHLVL': '1', 20:12:10 INFO - 'TERM': 'linux', 20:12:10 INFO - 'TMOUT': '86400', 20:12:10 INFO - 'USER': 'cltbld', 20:12:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', 20:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:10 INFO - '_': '/tools/buildbot/bin/python'} 20:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:10 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 20:12:10 INFO - Cleaning up... 20:12:10 INFO - Return code: 0 20:12:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:10 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 0x7f6cb1867f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2286370>, '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 0x22898f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', '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 20:12:10 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 20:12:10 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 20:12:10 INFO - Using env: {'DISPLAY': ':0', 20:12:10 INFO - 'HOME': '/home/cltbld', 20:12:10 INFO - 'LANG': 'en_US.UTF-8', 20:12:10 INFO - 'LANGUAGE': 'en_US:en', 20:12:10 INFO - 'LOGNAME': 'cltbld', 20:12:10 INFO - 'MAIL': '/var/mail/cltbld', 20:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:10 INFO - 'MOZ_NO_REMOTE': '1', 20:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:10 INFO - 'NO_EM_RESTART': '1', 20:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:10 INFO - 'PWD': '/builds/slave/test', 20:12:10 INFO - 'SHELL': '/bin/bash', 20:12:10 INFO - 'SHLVL': '1', 20:12:10 INFO - 'TERM': 'linux', 20:12:10 INFO - 'TMOUT': '86400', 20:12:10 INFO - 'USER': 'cltbld', 20:12:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', 20:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:10 INFO - '_': '/tools/buildbot/bin/python'} 20:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:11 INFO - Downloading/unpacking psutil>=3.1.1 20:12:11 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 20:12:11 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 20:12:11 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 20:12:11 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 20:12:11 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 20:12:11 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 20:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:12:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:12:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:12:13 INFO - Installing collected packages: psutil 20:12:13 INFO - Running setup.py install for psutil 20:12:13 INFO - building 'psutil._psutil_linux' extension 20:12:13 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 20:12:13 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 20:12:13 INFO - building 'psutil._psutil_posix' extension 20:12:13 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 20:12:13 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 20:12:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:12:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:12:13 INFO - Successfully installed psutil 20:12:13 INFO - Cleaning up... 20:12:13 INFO - Return code: 0 20:12:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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')]} 20:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cb1867f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2286370>, '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 0x22898f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', '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 20:12: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:12: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 mozsystemmonitor==0.3 20:12:13 INFO - Using env: {'DISPLAY': ':0', 20:12:13 INFO - 'HOME': '/home/cltbld', 20:12:13 INFO - 'LANG': 'en_US.UTF-8', 20:12:13 INFO - 'LANGUAGE': 'en_US:en', 20:12:13 INFO - 'LOGNAME': 'cltbld', 20:12:13 INFO - 'MAIL': '/var/mail/cltbld', 20:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:13 INFO - 'MOZ_NO_REMOTE': '1', 20:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:13 INFO - 'NO_EM_RESTART': '1', 20:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:13 INFO - 'PWD': '/builds/slave/test', 20:12:13 INFO - 'SHELL': '/bin/bash', 20:12:13 INFO - 'SHLVL': '1', 20:12:13 INFO - 'TERM': 'linux', 20:12:13 INFO - 'TMOUT': '86400', 20:12:13 INFO - 'USER': 'cltbld', 20:12:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', 20:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:13 INFO - '_': '/tools/buildbot/bin/python'} 20:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:12:15 INFO - Installing collected packages: mozsystemmonitor 20:12:15 INFO - Running setup.py install for mozsystemmonitor 20:12:15 INFO - Successfully installed mozsystemmonitor 20:12:15 INFO - Cleaning up... 20:12:15 INFO - Return code: 0 20:12:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:15 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 0x7f6cb1867f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2286370>, '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 0x22898f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', '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 20:12:15 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 20:12:15 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 20:12:15 INFO - Using env: {'DISPLAY': ':0', 20:12:15 INFO - 'HOME': '/home/cltbld', 20:12:15 INFO - 'LANG': 'en_US.UTF-8', 20:12:15 INFO - 'LANGUAGE': 'en_US:en', 20:12:15 INFO - 'LOGNAME': 'cltbld', 20:12:15 INFO - 'MAIL': '/var/mail/cltbld', 20:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:15 INFO - 'MOZ_NO_REMOTE': '1', 20:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:15 INFO - 'NO_EM_RESTART': '1', 20:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:15 INFO - 'PWD': '/builds/slave/test', 20:12:15 INFO - 'SHELL': '/bin/bash', 20:12:15 INFO - 'SHLVL': '1', 20:12:15 INFO - 'TERM': 'linux', 20:12:15 INFO - 'TMOUT': '86400', 20:12:15 INFO - 'USER': 'cltbld', 20:12:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', 20:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:15 INFO - '_': '/tools/buildbot/bin/python'} 20:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:16 INFO - Downloading/unpacking jsonschema==2.5.1 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:12:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:18 INFO - Downloading functools32-3.2.3-2.tar.gz 20:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:12:18 INFO - warning: no files found matching '*.txt' 20:12:18 INFO - no previously-included directories found matching 'build' 20:12:18 INFO - no previously-included directories found matching 'dist' 20:12:18 INFO - no previously-included directories found matching '.git*' 20:12:18 INFO - Installing collected packages: jsonschema, functools32 20:12:18 INFO - Running setup.py install for functools32 20:12:18 INFO - warning: no files found matching '*.txt' 20:12:18 INFO - no previously-included directories found matching 'build' 20:12:18 INFO - no previously-included directories found matching 'dist' 20:12:18 INFO - no previously-included directories found matching '.git*' 20:12:18 INFO - Successfully installed jsonschema functools32 20:12:18 INFO - Cleaning up... 20:12:18 INFO - Return code: 0 20:12:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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')]} 20:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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', '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 0x7f6cb1867f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2286370>, '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 0x22898f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', '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 20:12: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:12: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 functools32==3.2.3-2 20:12:18 INFO - Using env: {'DISPLAY': ':0', 20:12:18 INFO - 'HOME': '/home/cltbld', 20:12:18 INFO - 'LANG': 'en_US.UTF-8', 20:12:18 INFO - 'LANGUAGE': 'en_US:en', 20:12:18 INFO - 'LOGNAME': 'cltbld', 20:12:18 INFO - 'MAIL': '/var/mail/cltbld', 20:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:18 INFO - 'MOZ_NO_REMOTE': '1', 20:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:18 INFO - 'NO_EM_RESTART': '1', 20:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:18 INFO - 'PWD': '/builds/slave/test', 20:12:18 INFO - 'SHELL': '/bin/bash', 20:12:18 INFO - 'SHLVL': '1', 20:12:18 INFO - 'TERM': 'linux', 20:12:18 INFO - 'TMOUT': '86400', 20:12:18 INFO - 'USER': 'cltbld', 20:12:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', 20:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:18 INFO - '_': '/tools/buildbot/bin/python'} 20:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:12:18 INFO - Cleaning up... 20:12:18 INFO - Return code: 0 20:12:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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')]} 20:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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', '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 0x7f6cb1867f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2286370>, '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 0x22898f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', '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 20:12: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:12: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 blobuploader==1.2.4 20:12:18 INFO - Using env: {'DISPLAY': ':0', 20:12:18 INFO - 'HOME': '/home/cltbld', 20:12:18 INFO - 'LANG': 'en_US.UTF-8', 20:12:18 INFO - 'LANGUAGE': 'en_US:en', 20:12:18 INFO - 'LOGNAME': 'cltbld', 20:12:18 INFO - 'MAIL': '/var/mail/cltbld', 20:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:18 INFO - 'MOZ_NO_REMOTE': '1', 20:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:18 INFO - 'NO_EM_RESTART': '1', 20:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:18 INFO - 'PWD': '/builds/slave/test', 20:12:18 INFO - 'SHELL': '/bin/bash', 20:12:18 INFO - 'SHLVL': '1', 20:12:18 INFO - 'TERM': 'linux', 20:12:18 INFO - 'TMOUT': '86400', 20:12:18 INFO - 'USER': 'cltbld', 20:12:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', 20:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:18 INFO - '_': '/tools/buildbot/bin/python'} 20:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:18 INFO - Downloading/unpacking blobuploader==1.2.4 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:20 INFO - Downloading blobuploader-1.2.4.tar.gz 20:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:12:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:12:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:21 INFO - Downloading docopt-0.6.1.tar.gz 20:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:12:21 INFO - Installing collected packages: blobuploader, requests, docopt 20:12:21 INFO - Running setup.py install for blobuploader 20:12:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:12:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:12:21 INFO - Running setup.py install for requests 20:12:22 INFO - Running setup.py install for docopt 20:12:22 INFO - Successfully installed blobuploader requests docopt 20:12:22 INFO - Cleaning up... 20:12:22 INFO - Return code: 0 20:12:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:22 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 0x7f6cb1867f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2286370>, '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 0x22898f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', '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 20:12:22 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 20:12:22 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 20:12:22 INFO - Using env: {'DISPLAY': ':0', 20:12:22 INFO - 'HOME': '/home/cltbld', 20:12:22 INFO - 'LANG': 'en_US.UTF-8', 20:12:22 INFO - 'LANGUAGE': 'en_US:en', 20:12:22 INFO - 'LOGNAME': 'cltbld', 20:12:22 INFO - 'MAIL': '/var/mail/cltbld', 20:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:22 INFO - 'MOZ_NO_REMOTE': '1', 20:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:22 INFO - 'NO_EM_RESTART': '1', 20:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:22 INFO - 'PWD': '/builds/slave/test', 20:12:22 INFO - 'SHELL': '/bin/bash', 20:12:22 INFO - 'SHLVL': '1', 20:12:22 INFO - 'TERM': 'linux', 20:12:22 INFO - 'TMOUT': '86400', 20:12:22 INFO - 'USER': 'cltbld', 20:12:22 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', 20:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:22 INFO - '_': '/tools/buildbot/bin/python'} 20:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:12:22 INFO - Running setup.py (path:/tmp/pip-6pRd3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:12:22 INFO - Running setup.py (path:/tmp/pip-mRF6Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:12:22 INFO - Running setup.py (path:/tmp/pip-l5Gs7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:12:22 INFO - Running setup.py (path:/tmp/pip-UPqL9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:12:22 INFO - Running setup.py (path:/tmp/pip-m7TJNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:12:22 INFO - Running setup.py (path:/tmp/pip-k4VdW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:12:22 INFO - Running setup.py (path:/tmp/pip-h534Ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:12:22 INFO - Running setup.py (path:/tmp/pip-77Xpn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:12:23 INFO - Running setup.py (path:/tmp/pip-BCNYUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:12:23 INFO - Running setup.py (path:/tmp/pip-S5aJzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:12:23 INFO - Running setup.py (path:/tmp/pip-ZiVqOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:12:23 INFO - Running setup.py (path:/tmp/pip-ZX8Kko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:12:23 INFO - Running setup.py (path:/tmp/pip-X3Om9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:12:23 INFO - Running setup.py (path:/tmp/pip-jeAJph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:23 INFO - Running setup.py (path:/tmp/pip-o4pLFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:12:23 INFO - Running setup.py (path:/tmp/pip-VbTRHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:12:23 INFO - Running setup.py (path:/tmp/pip-2T1mHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:12:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:12:23 INFO - Running setup.py install for manifestparser 20:12:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:12:23 INFO - Running setup.py install for mozcrash 20:12:23 INFO - Running setup.py install for mozdebug 20:12:23 INFO - Running setup.py install for mozdevice 20:12:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Running setup.py install for mozfile 20:12:24 INFO - Running setup.py install for mozhttpd 20:12:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Running setup.py install for mozinfo 20:12:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Running setup.py install for mozInstall 20:12:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Running setup.py install for mozleak 20:12:24 INFO - Running setup.py install for mozlog 20:12:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Running setup.py install for moznetwork 20:12:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Running setup.py install for mozprocess 20:12:24 INFO - Running setup.py install for mozprofile 20:12:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Running setup.py install for mozrunner 20:12:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:12:25 INFO - Running setup.py install for mozscreenshot 20:12:25 INFO - Running setup.py install for moztest 20:12:25 INFO - Running setup.py install for mozversion 20:12:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:12:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:12:25 INFO - Cleaning up... 20:12:25 INFO - Return code: 0 20:12:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:25 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 0x7f6cb1867f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2286370>, '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 0x22898f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', '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 20:12:25 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 20:12:25 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 20:12:25 INFO - Using env: {'DISPLAY': ':0', 20:12:25 INFO - 'HOME': '/home/cltbld', 20:12:25 INFO - 'LANG': 'en_US.UTF-8', 20:12:25 INFO - 'LANGUAGE': 'en_US:en', 20:12:25 INFO - 'LOGNAME': 'cltbld', 20:12:25 INFO - 'MAIL': '/var/mail/cltbld', 20:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:25 INFO - 'MOZ_NO_REMOTE': '1', 20:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:25 INFO - 'NO_EM_RESTART': '1', 20:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:25 INFO - 'PWD': '/builds/slave/test', 20:12:25 INFO - 'SHELL': '/bin/bash', 20:12:25 INFO - 'SHLVL': '1', 20:12:25 INFO - 'TERM': 'linux', 20:12:25 INFO - 'TMOUT': '86400', 20:12:25 INFO - 'USER': 'cltbld', 20:12:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', 20:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:25 INFO - '_': '/tools/buildbot/bin/python'} 20:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:12:25 INFO - Running setup.py (path:/tmp/pip-WYugxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:12:25 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)) 20:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:12:25 INFO - Running setup.py (path:/tmp/pip-0HxEia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:12:25 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)) 20:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:12:25 INFO - Running setup.py (path:/tmp/pip-mheStr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:12:25 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)) 20:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:12:25 INFO - Running setup.py (path:/tmp/pip-JZC021-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:12:25 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)) 20:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:12:25 INFO - Running setup.py (path:/tmp/pip-VVc79b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:12:26 INFO - Running setup.py (path:/tmp/pip-DsUSUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:12:26 INFO - Running setup.py (path:/tmp/pip-Xke3Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:12:26 INFO - Running setup.py (path:/tmp/pip-S20jpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:12:26 INFO - Running setup.py (path:/tmp/pip-P2pbJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:12:26 INFO - Running setup.py (path:/tmp/pip-E3lu9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:12:26 INFO - Running setup.py (path:/tmp/pip-43QyQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:12:26 INFO - Running setup.py (path:/tmp/pip-BazkFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:12:26 INFO - Running setup.py (path:/tmp/pip-_WeC3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:12:26 INFO - Running setup.py (path:/tmp/pip-8S2Oia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:26 INFO - Running setup.py (path:/tmp/pip-bcw5hX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:12:26 INFO - Running setup.py (path:/tmp/pip-sVZoiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:12:26 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)) 20:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:12:26 INFO - Running setup.py (path:/tmp/pip-yr9c5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:12:26 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)) 20:12:26 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)) 20:12:26 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)) 20:12:26 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)) 20:12:26 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)) 20:12:26 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)) 20:12:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:28 INFO - Downloading blessings-1.6.tar.gz 20:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:12:28 INFO - Installing collected packages: blessings 20:12:28 INFO - Running setup.py install for blessings 20:12:28 INFO - Successfully installed blessings 20:12:28 INFO - Cleaning up... 20:12:29 INFO - Return code: 0 20:12:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:12:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:12:29 INFO - Reading from file tmpfile_stdout 20:12:29 INFO - Current package versions: 20:12:29 INFO - argparse == 1.2.1 20:12:29 INFO - blessings == 1.6 20:12:29 INFO - blobuploader == 1.2.4 20:12:29 INFO - docopt == 0.6.1 20:12:29 INFO - functools32 == 3.2.3-2 20:12:29 INFO - jsonschema == 2.5.1 20:12:29 INFO - manifestparser == 1.1 20:12:29 INFO - mozInstall == 1.12 20:12:29 INFO - mozcrash == 0.17 20:12:29 INFO - mozdebug == 0.1 20:12:29 INFO - mozdevice == 0.48 20:12:29 INFO - mozfile == 1.2 20:12:29 INFO - mozhttpd == 0.7 20:12:29 INFO - mozinfo == 0.9 20:12:29 INFO - mozleak == 0.1 20:12:29 INFO - mozlog == 3.3 20:12:29 INFO - moznetwork == 0.27 20:12:29 INFO - mozprocess == 0.23 20:12:29 INFO - mozprofile == 0.28 20:12:29 INFO - mozrunner == 6.12 20:12:29 INFO - mozscreenshot == 0.1 20:12:29 INFO - mozsystemmonitor == 0.3 20:12:29 INFO - moztest == 0.7 20:12:29 INFO - mozversion == 1.4 20:12:29 INFO - psutil == 3.1.1 20:12:29 INFO - requests == 1.2.3 20:12:29 INFO - wsgiref == 0.1.2 20:12:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:29 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')]} 20:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:29 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')]} 20:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:29 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 0x7f6cb1867f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2286370>, '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 0x22898f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', '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 20:12:29 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 20:12:29 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 20:12:29 INFO - Using env: {'DISPLAY': ':0', 20:12:29 INFO - 'HOME': '/home/cltbld', 20:12:29 INFO - 'LANG': 'en_US.UTF-8', 20:12:29 INFO - 'LANGUAGE': 'en_US:en', 20:12:29 INFO - 'LOGNAME': 'cltbld', 20:12:29 INFO - 'MAIL': '/var/mail/cltbld', 20:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:29 INFO - 'MOZ_NO_REMOTE': '1', 20:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:29 INFO - 'NO_EM_RESTART': '1', 20:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:29 INFO - 'PWD': '/builds/slave/test', 20:12:29 INFO - 'SHELL': '/bin/bash', 20:12:29 INFO - 'SHLVL': '1', 20:12:29 INFO - 'TERM': 'linux', 20:12:29 INFO - 'TMOUT': '86400', 20:12:29 INFO - 'USER': 'cltbld', 20:12:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', 20:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:29 INFO - '_': '/tools/buildbot/bin/python'} 20:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 INFO - Cleaning up... 20:12:29 INFO - Return code: 0 20:12:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:12:29 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')]} 20:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:29 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')]} 20:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:29 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 0x7f6cb1867f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2286370>, '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 0x22898f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', '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 20:12:29 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 20:12:29 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 20:12:29 INFO - Using env: {'DISPLAY': ':0', 20:12:29 INFO - 'HOME': '/home/cltbld', 20:12:29 INFO - 'LANG': 'en_US.UTF-8', 20:12:29 INFO - 'LANGUAGE': 'en_US:en', 20:12:29 INFO - 'LOGNAME': 'cltbld', 20:12:29 INFO - 'MAIL': '/var/mail/cltbld', 20:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:29 INFO - 'MOZ_NO_REMOTE': '1', 20:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:29 INFO - 'NO_EM_RESTART': '1', 20:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:29 INFO - 'PWD': '/builds/slave/test', 20:12:29 INFO - 'SHELL': '/bin/bash', 20:12:29 INFO - 'SHLVL': '1', 20:12:29 INFO - 'TERM': 'linux', 20:12:29 INFO - 'TMOUT': '86400', 20:12:29 INFO - 'USER': 'cltbld', 20:12:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', 20:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:29 INFO - '_': '/tools/buildbot/bin/python'} 20:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:12:29 INFO - Cleaning up... 20:12:29 INFO - Return code: 0 20:12:29 INFO - Running post-action listener: _resource_record_post_action 20:12:29 INFO - Running post-action listener: _start_resource_monitoring 20:12:29 INFO - Starting resource monitoring. 20:12:29 INFO - [mozharness: 2016-08-28 03:12:29.731892Z] Finished create-virtualenv step (success) 20:12:29 INFO - [mozharness: 2016-08-28 03:12:29.732395Z] Running install step. 20:12:29 INFO - Running pre-action listener: _resource_record_pre_action 20:12:29 INFO - Running main action method: install 20:12:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:12:29 INFO - Reading from file tmpfile_stdout 20:12:29 INFO - Detecting whether we're running mozinstall >=1.0... 20:12:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:12:30 INFO - Reading from file tmpfile_stdout 20:12:30 INFO - Output received: 20:12:30 INFO - Usage: mozinstall [options] installer 20:12:30 INFO - Options: 20:12:30 INFO - -h, --help show this help message and exit 20:12:30 INFO - -d DEST, --destination=DEST 20:12:30 INFO - Directory to install application into. [default: 20:12:30 INFO - "/builds/slave/test"] 20:12:30 INFO - --app=APP Application being installed. [default: firefox] 20:12:30 INFO - mkdir: /builds/slave/test/build/application 20:12:30 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'] 20:12:30 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 20:12:47 INFO - Reading from file tmpfile_stdout 20:12:47 INFO - Output received: 20:12:47 INFO - /builds/slave/test/build/application/firefox/firefox 20:12:47 INFO - Running post-action listener: _resource_record_post_action 20:12:47 INFO - [mozharness: 2016-08-28 03:12:47.047100Z] Finished install step (success) 20:12:47 INFO - [mozharness: 2016-08-28 03:12:47.047378Z] Running run-tests step. 20:12:47 INFO - Running pre-action listener: _resource_record_pre_action 20:12:47 INFO - Running main action method: run_tests 20:12:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:12:47 INFO - Python 2.7.3 20:12:47 INFO - Return code: 0 20:12:47 INFO - grabbing minidump binary from tooltool 20:12:47 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')]} 20:12:47 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 0x2286370>, '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 0x22898f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:12:47 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 20:12:47 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 20:12:47 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 20:12:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:12:47 INFO - Return code: 0 20:12:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:12:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:12:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:12:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:12:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:12:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:12:47 INFO - Using env: {'DISPLAY': ':0', 20:12:47 INFO - 'HOME': '/home/cltbld', 20:12:47 INFO - 'LANG': 'en_US.UTF-8', 20:12:47 INFO - 'LANGUAGE': 'en_US:en', 20:12:47 INFO - 'LOGNAME': 'cltbld', 20:12:47 INFO - 'MAIL': '/var/mail/cltbld', 20:12:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:12:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:47 INFO - 'MOZ_NO_REMOTE': '1', 20:12:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:47 INFO - 'NO_EM_RESTART': '1', 20:12:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:47 INFO - 'PWD': '/builds/slave/test', 20:12:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:12:47 INFO - 'SHELL': '/bin/bash', 20:12:47 INFO - 'SHLVL': '1', 20:12:47 INFO - 'TERM': 'linux', 20:12:47 INFO - 'TMOUT': '86400', 20:12:47 INFO - 'USER': 'cltbld', 20:12:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675', 20:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:47 INFO - '_': '/tools/buildbot/bin/python'} 20:12:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:12:47 INFO - mozversion application_buildid: 20160827173002 20:12:47 INFO - mozversion application_changeset: b02228e2a9eb38fa2a1a947f7943def10c5310be 20:12:47 INFO - mozversion application_display_name: Nightly 20:12:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:12:47 INFO - mozversion application_name: Firefox 20:12:47 INFO - mozversion application_remotingname: firefox 20:12:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:12:47 INFO - mozversion application_vendor: Mozilla 20:12:47 INFO - mozversion application_version: 51.0a1 20:12:47 INFO - mozversion platform_buildid: 20160827173002 20:12:47 INFO - mozversion platform_changeset: b02228e2a9eb38fa2a1a947f7943def10c5310be 20:12:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:12:47 INFO - mozversion platform_version: 51.0a1 20:12:47 INFO - using testdate: 1472353967 20:12:47 INFO - actual date: 1472353967 20:12:47 INFO - starting webserver on 'localhost:37839' 20:12:47 INFO - SUITE-START | Running 2 tests 20:12:47 INFO - TEST-START | dromaeo_css 20:12:47 INFO - operating with platform_type : linux_ 20:12:47 INFO - Initialising browser for dromaeo_css test... 20:12:47 INFO - TEST-INFO | started process 7570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4PXeiO/profile http://localhost:37839/getInfo.html) 20:12:51 INFO - PROCESS | 7570 | __metrics Screen width/height:1600/1200 20:12:51 INFO - PROCESS | 7570 | colorDepth:24 20:12:51 INFO - PROCESS | 7570 | Browser inner width/height: 1024/697 20:12:51 INFO - PROCESS | 7570 | __metrics 20:12:52 INFO - PROCESS | 7570 | 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" 20:12:52 INFO - PROCESS | 7570 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:12:53 INFO - PROCESS | 7570 | console.error: PushService: 20:12:53 INFO - PROCESS | 7570 | stateChangeProcessEnqueue: Error transitioning state 20:12:53 INFO - PROCESS | 7570 | UnknownError 20:12:53 INFO - TEST-INFO | 7570: exit 0 20:12:53 INFO - Browser initialized. 20:12:53 INFO - Running cycle 1/1 for dromaeo_css test... 20:12:53 INFO - TEST-INFO | started process 7653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4PXeiO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:13:05 INFO - PROCESS | 7653 | RSS: Main: 183939072 20:13:05 INFO - PROCESS | 7653 | 20:13:57 INFO - PROCESS | 7653 | 1472354037432 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] 20:16:06 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:37839/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37839/tests/dromaeo/cssquery-ext.html) 20:16:08 INFO - PROCESS | 7653 | RSS: Main: 329973760 20:16:08 INFO - PROCESS | 7653 | 20:19:10 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:37839/tests/dromaeo/cssquery-ext.html (next: http://localhost:37839/tests/dromaeo/cssquery-jquery.html) 20:19:11 INFO - PROCESS | 7653 | RSS: Main: 274554880 20:19:11 INFO - PROCESS | 7653 | 20:22:13 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:37839/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37839/tests/dromaeo/cssquery-mootools.html) 20:22:14 INFO - PROCESS | 7653 | RSS: Main: 213114880 20:22:14 INFO - PROCESS | 7653 | 20:25:16 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:37839/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37839/tests/dromaeo/cssquery-prototype.html) 20:25:16 INFO - PROCESS | 7653 | RSS: Main: 213004288 20:25:16 INFO - PROCESS | 7653 | 20:28:19 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:37839/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37839/tests/dromaeo/cssquery-yui.html) 20:28:20 INFO - PROCESS | 7653 | RSS: Main: 215089152 20:28:20 INFO - PROCESS | 7653 | 20:31:23 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:37839/tests/dromaeo/cssquery-yui.html (next: http://localhost:37839/tests/dromaeo/cssquery-dojo.html) 20:31:23 INFO - PROCESS | 7653 | RSS: Main: 304533504 20:31:23 INFO - PROCESS | 7653 | 20:31:23 INFO - PROCESS | 7653 | __start_tp_report 20:31:23 INFO - PROCESS | 7653 | _x_x_mozilla_page_load 20:31:23 INFO - PROCESS | 7653 | _x_x_mozilla_page_load_details 20:31:23 INFO - PROCESS | 7653 | |i|pagename|runs| 20:31:23 INFO - PROCESS | 7653 | |0;dojo.html;3045.710657487538;3054.602901622789;3080.5379193121043;3097.426976009437;3124.7031532004453;5252.842414727555;5289;5356.517913387795;5387.838364849056;5418.8916221675545;5275.525202731754;5377.919331210025;5402.756875940582;5420.295361602996;5498.340199176095;4817.566419022287;4850.611951043908;4897.436794768594;4953.157963146274;4962.900741985158;4925.975370123162;4926.531979461945;4995.35060442142;5001.024800163969;5004.874878128039;4911.16510193268;4917.286993385975;4961.603071754251;4976.253561965716;4998.125328067592;4810.7113573185725;4829.082474329866;4859.0767754126955;4889.119958407486;4892.53520915516;4767.547083027107;4768.928466072977;4769.35613692154;4789.2816077588295;4822.855314340575;5345.091334473149;5349.438308977579;5352.277442545245;5379.569634429236;5396.541293990015;5600.859978500529;5635;5711.143328500717;5722.227499287626;5733.283339582552;5735.426457354273;5762.538996880239;5779.8555036124435;5783.9710801446145;5796.50729687977;5365.275687782138;5371.086915224421;5373.167159090347;5374.220737993008;5376.623636345457;5722.942770572241;5860.882782344414;5929.792457263975;5935.109733540004;6027.126066720301;5674.460926212003;5685;5687.175359572839;5687.544996400278;5688.516476099578;5766.625169363978;5769.048107062372;5770.10563362671;5776.711164441761;5777.6822274775295;5581.358143813432;5613.943860561342;5632.718364081779;5685.545156387479;5764.74058667361;5695.145728140812;5704.828855134353;5709.143628455682;5757.136429535603;5765.827025189167;4388.780560971939;4431.423914891044;4435.223835828717;4436.866893993185;4482.618977386894;3890.902727431837;3891.552471465761;3927.8232479538487;3948.6446219840354;3959.6832253419657;5448.128299472145;5451.37309209446;5452.509274165344;5469.835904922858;5516.91724624131;5770.365259821417;5784.739686714108;5787.479126878601;5788.27646544182;5791.0734282514595;5348.572114230852;5381.892362152735;5438.157085651651;5447.291852059207;5456.672599644034;5024.472430394829;5053.1157047516535;5057.039162559102;5065.594752419797;5070.923936140961;5914.792982245687;5951.880962380815;5957.434043765836;5966.254218222723;5968.283805943228;5537.916931246115;5790.305163380422;5797.797077102281;5799.884002320015;5800.970995144998;5803.535717142534;5858.882822343615;5874.118882167709;5906.852328691817;5967.492763115184;5613.045782216951;5614.69119198448;5616.971915140398;5617.943820561905;5618.831435056954;5617.606767526234;5691.174779656843;5712.600117991867;5713.742881570256;5719.370869204467;5518.80684176068;5523.392426833126;5558.91661625084;5568.220449137043;5605.915911261252;5546.611737178358;5595.888082238251;5597.908407860428;5607.943920560905;5643.32280126371;5588.105903055654;5601.24383208278;5601.663900166003;5602.243697101002;5604;5490.313710786152;5549.639273447213;5605.887882242414;5611.38274789781;5618.325800903917;5496.258005169251;5533.6403133796175;5534.031544479781;5536.114221724505;5582.246396736388 20:31:23 INFO - PROCESS | 7653 | |1;ext.html;573.1517354315613;619.08066521216;630.5334052800926;638.7700427845974;658.8682263547291;31669.841650791743;41876.55604771383;42977.35533966993;43060;43147.784261078654;44673.329900051445;44705.329420058726;44946.325805112865;44957.32564011542;45152.774236128855;8198.38512111591;8984.236339911098;9127.224185944202;9131.634734610641;10791;10838.837417438745;10963.122950163968;10964.451777411137;10967.50646220922;10971.23201375904;11029.393383363911;11081.889181108207;11082;11085.83371249428;11086.279391839505;10914.563417463292;10954.452277386099;10967.122630189566;10967.50646220914;10977.83533247002;10851.782964340748;10874.293170943864;10881.401522916236;10930.617428390047;10943.671689849318;41989.16021679549;42334;42381;42390.78804605988;42404.57595424037;3415.077928959192;3537.2394935088823;3621.953596218155;3715.386961151407;3729.1609387887506;31458.37083258322;31481.842590787128;31769.364612707846;31939.840300798347;32787.18032049218;4302.096559722462;4344.239758042361;4402.217102073665;4445.51099379068;4492.034212644297;260726;260905;261531;261867.69066154739;263479;56277;56531.15203271954;56648.43351566514;56701.716491417275;56744;35954.64045359513;37404;37449.25101497955;59148.40851591515;59270;17506.299748009937;17955.192016359295;17962.55093622644;17967.460976170736;17969.640607187783;12207.572734954412;13092.869071309355;13303.866961330456;13474.93262533681;13754.243516606683;16027;18575.349862754738;18664.813351866578;18695.813041869405;18697.699529108108;5961;7148.39238664709;7286.744963926237;7328.3404493595835;7399.741009064657;969.7963427680126;1015.3958394755109;1032.4734385463469;1115.3252282369212;1117.7205698575356;31591.36817263642;32294.515582266285;32450.513242301386;32486.132875656138;32899;1065.3448129400517;1075;1087.5801342013956;1110.7389763405592;1142.6000899685043;16371.590710232102;16676.83323166777;17220.397286094925;17322.48032559025;17692.203850826743;583090;588295;588815;589796;589969;51040.489595104315;57955;58478.70760646169;60647.393526065054;63398.68300658467;1312.5078095714107;1334.3461703765279;1351.4391527516168;1367.0840536840342;1370.3696299702249;29647;31385.529217061307;31554.842225788725;31630.36739265248;32185.517217242228;48382.5161748378;49114.75442622764;49164.75417622889;49170;49225;549258;563687;565943;831480;833725;42283.7885810569;43158.38940937658;43296.56703432925;43435.56564434442;43975.78012110047;47774.52225477701;47892.521074788805;48000.27999580079;48202.75898620485;49027;40346;40744.592554075265;40907;41377.1724565501;42715.78642106769;40123;40967.1806563873;41595;41976.58023419727;42266.57733422749;39484.802575986934;40843;41866.58133418627;42032.36951445792;42080;34118.65881341254;36566.63433365632;37052;37344.6265537352;37658.43512347372;27725.44549108966;27794.583081253393;28170.577441338806;28240.15279541535;28272.43455130927 20:31:23 INFO - PROCESS | 7653 | |2;jquery.html;364.3041790180755;374.3916136278547;383.59339100553404;389.3575600259571;399.0522509041028;15186.924065379671;17200.827991720078;18772.624547509058;19356.612867742635;19547.804521954775;19649.705254421195;20094.799052009475;20097.799022009774;20285.188592456285;20290.49273768153;5229.581633469314;5498.890022199554;5559.277293951801;5740.712964351766;5752.568557358194;5604.8038318658855;5668.57485688573;5686.886262274752;5698.572607054467;5712.571557133211;5589.217509548666;5678.318601767794;5680.914786278188;5683.374828768832;5866.88266234675;5828.009238429456;5868.823935281948;5869.266341707286;5869.383714709958;5869.647821130725;5539.750711218005;5678.886422271531;5691.146328050784;5700.515456186229;5715.914261286084;13835.584932452042;13931.373088211054;13998.440062397493;21389.5722085559;23639.763602363928;2224.0325458425473;2283.2807665585287;2427.7814996650386;2565.9230223093336;2636.077372919482;9778.217742580577;10070.295079344449;10671.519781609846;12341.444634991447;14738.115713057143;1781.32309722306;1823.9908800456046;1867.7198420236937;1868.6356160548698;1917.8945158016304;77238.22761772366;80724;83746.59223679091;84141.57929210376;87850;10671;11002.524432002736;11006.174536909764;11221.55113795439;11571.594994175164;15547.144907030222;15557.988730732466;15561.922190389201;15567.29947152381;15572.454964076203;7756.612169391507;7791.376689864797;8072.112067672551;8084.83830323402;8127.75616731499;7393.408527317909;7417.888731669029;7437.070366204224;7594.468387212842;7646.273604007611;4777.808887644455;4795.808167673254;4822.758862056883;4834.806607735652;4954.133026720309;1967.8228959393723;2029.7259869917668;2037.518582785982;2065.617860695746;2087.676410156428;745.7874505765939;785.5679376343103;831.8544254755394;973.6738192705382;1037;18353.265869365343;19251.22995080181;19625.901870490557;19750.40748777539;19901.800981989996;972.5380444288907;1014.2849291249652;1031.0926384781494;1050.7740835720356;1056.4717641179411;10368.377897326185;10855.837162442569;10958;10970.286931349438;10970.396628185366;459548;474417;510082;515463;534053;56854.715726421106;87305.56347218351;91191;91950.54024729834;96703.51648241714;1018.8369860822232;1027;1030.4950574218578;1057.513543769859;1073.270176280137;16716.58208544796;17194.828051719323;17682.204300806236;17879.19543620514;18059.729104063186;31508;40882;43380.34929475997;44627.77686111549;48035.5196448045;55750.44249557615;57826.4217357821;58185.709071454374;59725.70137149286;60207;8186.672533098609;8511.276541493795;8515.233628973423;8840.602172902363;8909;9147.313951453534;9229.769255768391;9435.150836424755;9534.761630959281;10026.348287361297;8555.914440855511;8845.51349675774;8976.147266009719;9054.349990045737;9107.134822191882;8167.673293068211;8378.24595786382;8396.328293736364;8555;9004.414713043894;8991.91008089937;9127.406718563272;9431.104045115702;9437.480938548171;9531.332806703742;12500;12706.428210730355;12880.003599442101;12885.48458061667;12959.157654752411;12206.206596571194;12263.141580089308;12273.140880138304;12391.318477483825;12497.750044999231 20:31:23 INFO - PROCESS | 7653 | |3;mootools.html;1466.5453709350102;1506.1640789361902;1625.1549194418903;1782.6702060118887;1801.297493977349;8650.783730406734;9302.953485232581;9305.860412093816;9316.627334906596;9320.86018709719;7924.286814186722;8682.175193356637;8966.237869781076;9006.774830629238;9009.864852027209;2389.104085967762;2403.663487111806;2406.1217655555683;2407.0973384980634;2421.2736179146273;2394.449276666368;2434.5374378868046;2437.1348171399163;2441.523902838947;2447.657327974085;2427.963580546293;2447.155731272717;2468.9135880244194;2506.0602274147195;2506.4611108611643;2391.617341225413;2412.1436889904007;2419.2863105383954;2420.745821688724;2431.3192306154306;2381.988090059556;2385.272491889973;2391.5097405031925;2397.2808157552663;2398.65219543167;9053.456792592466;9147.725568232963;9162.221211197057;9279.118483744101;9279.164875161201;5296.364436267672;5372.7045012524295;5373.516383525502;5401.3248343957;5444.891102177934;3268.7711860169798;3368.898933032013;3417.9487307690406;3421.5038819371302;3514.595821480537;1073.9677809665723;1087.6736978906297;1115.6151127860956;1127.9453710780447;1130.7116685245292;12633.305168215744;12645.557405490763;12761.489540418372;12773.552925647651;12775.29735864527;4548.31775233711;4618;4779.665423420327;4805.495422980606;4848.612111031109;10611.522481488351;10618.09746171584;10656;10737.677869663923;10739;5430.294061771944;5434;5437.755301011464;5441.238226648273;5445.264889239981;4261.190373829025;4402.449693788277;4409.228385032607;4875.68308059975;4986.80052797884;4078.632923036941;4168.354454796209;4197.349410841324;4198.328267477189;4219.346001369792;1347.5687779910531;1362.9182249065088;1372.1561239837429;1372.7185926884965;1378.3590630356932;810.6109067647562;895.4895709445684;909.5997760985146;925.4863550729275;972.2270794718216;5818.6217895836635;5998.130271110665;6055.061465472859;6073.058675905242;6250.499960003189;890.3189060368823;897.3135551303258;903.1781079217881;941.5998200764648;975.8877729061248;3846.9807650961566;4217.873463796091;4231.513375961742;4241.893952651209;4359.1717573661535;11036.448177591088;11215.43922803873;11318.717032074099;11330.490127944262;11331.32012079278;11118.388488633203;11294.774104517863;11302.208845380745;11312.377819220023;11323;8289.129641387688;8392.832143357098;8468.872966905501;8504.44721093127;8528.317734581218;5936;5955.880882382241;5956.910646340395;5957.225560677084;6142.416470435302;10046.748831279276;10243.23175761806;10311.948440257751;10386.272960892666;10448.843267350843;10673.092787112872;10705.357678539312;10730.624428144978;10812.297200681931;10831.620893269013;7208.96395518019;7643.312101910855;7862.056553213651;8099.595020248846;8232;8473.95763021181;8646.610902509528;8647.654093836176;8648.04871464151;8649.870251946351;7581.355584775356;7727.574983375968;7776.494527855672;7910.920890791019;7936.56348900816;7644.312011918954;7736.651850666846;7744.612769361622;7750.806229844299;7790.493617914817;7136.393406560501;7239.8914016290855;7244.855102897807;7285.927140728525;7293.781186564412;4936.679115857458;5041.747912604282;5059.367579052619;5112.3865136183895;5140.228965655182;5051.217061355495;5091.414487334004;5109.616778741535;5198.272241886063;5203.531682148625 20:31:23 INFO - PROCESS | 7653 | |4;prototype.html;310.42726170215946;315.56136969612237;317.8887389413705;318.66699299232283;320.6953394275439;5310.867228319294;5329.227262047001;5336.626436149471;5352.2239275305055;5358.955003774266;5266.894662106755;5268.8155914542995;5299.894002119955;5326.227696983945;5338.91991620125;4157.605027522381;4174.8121334539865;4178.247915375231;4198.97900510497;4211.094614657848;3899.161680238748;4098.323776576861;4131.876043718693;4138.586141385867;4150.937735933963;4039.676825853939;4051.5745846686114;4068;4078.449409329732;4098.159877225162;3779.7354185207046;3910.8463003414063;4080.5511393746665;4090.1185454690876;4108.3221268490815;3186.776925615208;3425.845836937344;3437.7765445246228;3525.876594319212;3550.5384300041087;5184.585233181337;5192.480751924815;5198.844034678966;5222.947770522284;5227.398849132361;4607;4629;4640.67515273931;4649.558291962258;4656.767161641905;5184.222366644995;5229.927864787747;5408.242846001563;5424.349078110613;5502.752376143043;3868.6905047596124;3872.186840763443;3886.6502014818802;3887.4168874668744;3912.080661044652;5510.504054635062;5634.450526105313;5796.913046304308;5809.941900580982;5819.7672093116225;3896.2791883501077;3905.4727611772614;3916.138449541096;3917.2948869203815;3937.350337194388;3998.3207053037795;4002.3596224603925;4006.45912801768;4016.779077150785;4019.954811748966;4458.458678553258;4631.305304204329;4633.142868569258;4633.864703147683;4635.976820115878;5519.227308176858;5525.281713377235;5540.861478463071;5562.276904002454;5598.916016259759;1361.251311778518;1378.910370825893;1382.10853999172;1382.9446822127204;1386.4800699737598;839.3746658739278;885.6368888755708;894.3739382432324;901.1529162587148;907.419251678926;4683.882902927386;4690.889099905056;4703.3885594872445;4747.359106520645;4762.904741905142;4927;5006.924896126561;5062.443131255559;5063.468335824686;5083.542481176712;4702.753770250886;4706.552877476634;4718.386609740712;4781.35043410023;4964.833264182914;2941.838198899081;2984.925376865596;2992.356643321696;2996.730294273526;2998.2804127009795;5840.2991641003355;5868.207791948118;5873.442023007808;5904.232449781501;5916.7337469813965;5596.272484576979;5761.711914404263;5799.6230245034785;5810.273715785527;5833.7083145842535;5829.125631155361;5843.035899076604;5850.151727999416;5861.70691465425;5869.354371019184;5420.376656684532;5690.857728556819;5694.490959895548;5721.628094173865;5725.883452726845;5639;5640.85897852557;5649.491545760901;5668.412844403573;5671.858203544944;5564.777408903598;5725.398833122629;5869.589128761117;5888.411158884249;5891.558133139946;3970.7419017763755;3981.900452488595;4000.3799411091327;4022.597740225954;4030.6573941215324;5803.332616749128;5820.650760954356;5825.650460972186;5834.38738932406;5839.656878917788;5309.814156504503;5590.329160500603;5606.495415412633;5610.7755689773585;5684.175794509855;5557.5831812613405;5571.498565129158;5577.044166591713;5577.163425486209;5600.187972744011;5265.473452654704;5546.861328466821;5557.388687244481;5569.498745112959;5585.497305242548;5612.298462692163;5623.662580245198;5623.746931388016;5636.126400407943;5638.379778224474;5456.781728730965;5493.368262649847;5494.478024587658;5500.367457742411;5507.284053073075 20:31:23 INFO - PROCESS | 7653 | |5;yui.html;798.1300382582983;798.4769975665937;824.1305422778966;828.9005319361676;834.3992325525624;15392.846071539281;16185.19074046299;16444.753328700062;16532.66934661306;16606;15616.687666246668;15626.921865390657;15640.217989100556;15653;15715.057096574184;805.9032916050068;819.0212695828487;823.2261674026425;823.9423240373146;824.6041899888057;658.4830907737403;674.039493721445;676.9424598909098;680.5134328954796;818.6725309876037;839.3620848155385;864.7621903976394;866.4844417571567;873.7990262239689;875.4440930009458;854.0733304364771;859.3597769661611;860.1570460948275;861.1044513705739;864.0107077396347;510.1276816643544;628.5097623853402;628.779927025542;629.9149614801989;630.1115427247605;11760.58837940668;12276.386180691019;14284.500042498566;14801.777973330409;14966.551003469913;14582.70834583313;15313.923430382889;15338.539843804592;15572.532824015298;15622.9218853905;11853.822192667118;11869.347185904771;12012.939935300268;12274.38628068593;12440.253584784941;3849.191669749356;3894.844206231747;3923.588023257574;3984.900377490557;4090.141070375225;84783;84892.15107848904;86198.5690071552;87367;88437.55781221052;11853.644390668294;11898.702532436759;11953.282803031845;12105.697357565956;12147.635570932885;22943.770562294165;22947;22978.310650680505;22988.310350689506;22992.88503557505;8392.83214335722;8803.955980220186;8810.823783524294;8835.116488351114;8842.911570884338;4663.533646635309;4777.140114779373;4872.975635121802;4880.072786170616;5002.424721157041;3651.707863370924;3731;3752.587215406303;3772.6227377262603;3774.584795672474;601.711178634258;613.1722175063628;617.5337620096798;624.5128799536369;633.5280216238839;716.502031088399;727.9672414741349;763.9541627502257;771.7646117934084;785.3481610263468;8739.423904338903;9120.498372589438;10217.436568607114;10313;10551.84172237417;642.2966851297915;694.3369082526175;704.3027402871121;724.1057294241607;783.749200255924;4645.094206629675;4740.866186835368;4745.786439610226;4761.071591039783;4787.664863459594;111711.88288117177;125533.23400298005;129364;132130;132369.67630323765;108110;109023.45488272667;109944.4502777497;111586.44206778915;116537;91964.99999999866;93432.13135737248;94220;94548;94587.52706236424;8643.56782160902;9134.22359099484;9166.645942652562;9188.862167067366;9357.906420935704;53665.46334536605;57331;57333;58576.4142358571;58855.411445886704;75728.24271757212;76075.61962190154;76248.51887589617;77439.2256077432;78840;13765;13988.720225595634;14015.50945716895;14026.08830426019;14351;15179.620509487351;15260.160691162093;15756.842431575997;16172.838271617133;16428.67142657164;13699.589012329647;13968.02223844321;15596.68806623884;15610;15722.685546289238;14332.928335358256;14488.637784055483;14700.852991469948;15138.848611514184;15300.464483743015;11643.243189192675;12118.212316199419;12157.270563766202;12585.685357866127;12655.746885062063;10940.781184376427;10981.61564345244;11499;11923.701907452383;11940.820887686865;10630.415327157081;10861.67414977552;11120.666380008613;11292.491837867152;12922.418491167731 20:31:23 INFO - PROCESS | 7653 | __end_tp_report 20:31:23 INFO - PROCESS | 7653 | __start_cc_report 20:31:23 INFO - PROCESS | 7653 | _x_x_mozilla_cycle_collect,1280 20:31:23 INFO - PROCESS | 7653 | __end_cc_report 20:31:23 INFO - PROCESS | 7653 | __startTimestamp1472355083376__endTimestamp 20:31:23 INFO - PROCESS | 7653 | 20:31:23 INFO - PROCESS | 7653 | ------- Summary: start ------- 20:31:23 INFO - PROCESS | 7653 | Number of tests: 6 20:31:23 INFO - PROCESS | 7653 | 20:31:23 INFO - PROCESS | 7653 | [#0] dojo.html Cycles:165 Average:5334.22 Median:5537.92 stddev:599.62 (10.8%) stddev-sans-first:573.95 20:31:23 INFO - PROCESS | 7653 | Values: 3045.7 3054.6 3080.5 3097.4 3124.7 5252.8 5289.0 5356.5 5387.8 5418.9 5275.5 5377.9 5402.8 5420.3 5498.3 4817.6 4850.6 4897.4 4953.2 4962.9 4926.0 4926.5 4995.4 5001.0 5004.9 4911.2 4917.3 4961.6 4976.3 4998.1 4810.7 4829.1 4859.1 4889.1 4892.5 4767.5 4768.9 4769.4 4789.3 4822.9 5345.1 5349.4 5352.3 5379.6 5396.5 5600.9 5635.0 5711.1 5722.2 5733.3 5735.4 5762.5 5779.9 5784.0 5796.5 5365.3 5371.1 5373.2 5374.2 5376.6 5722.9 5860.9 5929.8 5935.1 6027.1 5674.5 5685.0 5687.2 5687.5 5688.5 5766.6 5769.0 5770.1 5776.7 5777.7 5581.4 5613.9 5632.7 5685.5 5764.7 5695.1 5704.8 5709.1 5757.1 5765.8 4388.8 4431.4 4435.2 4436.9 4482.6 3890.9 3891.6 3927.8 3948.6 3959.7 5448.1 5451.4 5452.5 5469.8 5516.9 5770.4 5784.7 5787.5 5788.3 5791.1 5348.6 5381.9 5438.2 5447.3 5456.7 5024.5 5053.1 5057.0 5065.6 5070.9 5914.8 5951.9 5957.4 5966.3 5968.3 5537.9 5790.3 5797.8 5799.9 5801.0 5803.5 5858.9 5874.1 5906.9 5967.5 5613.0 5614.7 5617.0 5617.9 5618.8 5617.6 5691.2 5712.6 5713.7 5719.4 5518.8 5523.4 5558.9 5568.2 5605.9 5546.6 5595.9 5597.9 5607.9 5643.3 5588.1 5601.2 5601.7 5602.2 5604.0 5490.3 5549.6 5605.9 5611.4 5618.3 5496.3 5533.6 5534.0 5536.1 5582.2 20:31:23 INFO - PROCESS | 7653 | 20:31:23 INFO - PROCESS | 7653 | [#1] ext.html Cycles:180 Average:65829.10 Median:37374.31 stddev:145357.52 (388.9%) stddev-sans-first:145682.71 20:31:23 INFO - PROCESS | 7653 | Values: 573.2 619.1 630.5 638.8 658.9 31669.8 41876.6 42977.4 43060.0 43147.8 44673.3 44705.3 44946.3 44957.3 45152.8 8198.4 8984.2 9127.2 9131.6 10791.0 10838.8 10963.1 10964.5 10967.5 10971.2 11029.4 11081.9 11082.0 11085.8 11086.3 10914.6 10954.5 10967.1 10967.5 10977.8 10851.8 10874.3 10881.4 10930.6 10943.7 41989.2 42334.0 42381.0 42390.8 42404.6 3415.1 3537.2 3622.0 3715.4 3729.2 31458.4 31481.8 31769.4 31939.8 32787.2 4302.1 4344.2 4402.2 4445.5 4492.0 260726.0 260905.0 261531.0 261867.7 263479.0 56277.0 56531.2 56648.4 56701.7 56744.0 35954.6 37404.0 37449.3 59148.4 59270.0 17506.3 17955.2 17962.6 17967.5 17969.6 12207.6 13092.9 13303.9 13474.9 13754.2 16027.0 18575.3 18664.8 18695.8 18697.7 5961.0 7148.4 7286.7 7328.3 7399.7 969.8 1015.4 1032.5 1115.3 1117.7 31591.4 32294.5 32450.5 32486.1 32899.0 1065.3 1075.0 1087.6 1110.7 1142.6 16371.6 16676.8 17220.4 17322.5 17692.2 583090.0 588295.0 588815.0 589796.0 589969.0 51040.5 57955.0 58478.7 60647.4 63398.7 1312.5 1334.3 1351.4 1367.1 1370.4 29647.0 31385.5 31554.8 31630.4 32185.5 48382.5 49114.8 49164.8 49170.0 49225.0 549258.0 563687.0 565943.0 831480.0 833725.0 42283.8 43158.4 43296.6 43435.6 43975.8 47774.5 47892.5 48000.3 48202.8 49027.0 40346.0 40744.6 40907.0 41377.2 42715.8 40123.0 40967.2 41595.0 41976.6 42266.6 39484.8 40843.0 41866.6 42032.4 42080.0 34118.7 36566.6 37052.0 37344.6 37658.4 27725.4 27794.6 28170.6 28240.2 28272.4 20:31:23 INFO - PROCESS | 7653 | 20:31:23 INFO - PROCESS | 7653 | [#2] jquery.html Cycles:180 Average:28775.24 Median:239597.40 stddev:82299.66 (34.3%) stddev-sans-first:82502.88 20:31:23 INFO - PROCESS | 7653 | Values: 364.3 374.4 383.6 389.4 399.1 15186.9 17200.8 18772.6 19356.6 19547.8 19649.7 20094.8 20097.8 20285.2 20290.5 5229.6 5498.9 5559.3 5740.7 5752.6 5604.8 5668.6 5686.9 5698.6 5712.6 5589.2 5678.3 5680.9 5683.4 5866.9 5828.0 5868.8 5869.3 5869.4 5869.6 5539.8 5678.9 5691.1 5700.5 5715.9 13835.6 13931.4 13998.4 21389.6 23639.8 2224.0 2283.3 2427.8 2565.9 2636.1 9778.2 10070.3 10671.5 12341.4 14738.1 1781.3 1824.0 1867.7 1868.6 1917.9 77238.2 80724.0 83746.6 84141.6 87850.0 10671.0 11002.5 11006.2 11221.6 11571.6 15547.1 15558.0 15561.9 15567.3 15572.5 7756.6 7791.4 8072.1 8084.8 8127.8 7393.4 7417.9 7437.1 7594.5 7646.3 4777.8 4795.8 4822.8 4834.8 4954.1 1967.8 2029.7 2037.5 2065.6 2087.7 745.8 785.6 831.9 973.7 1037.0 18353.3 19251.2 19625.9 19750.4 19901.8 972.5 1014.3 1031.1 1050.8 1056.5 10368.4 10855.8 10958.0 10970.3 10970.4 459548.0 474417.0 510082.0 515463.0 534053.0 56854.7 87305.6 91191.0 91950.5 96703.5 1018.8 1027.0 1030.5 1057.5 1073.3 16716.6 17194.8 17682.2 17879.2 18059.7 31508.0 40882.0 43380.3 44627.8 48035.5 55750.4 57826.4 58185.7 59725.7 60207.0 8186.7 8511.3 8515.2 8840.6 8909.0 9147.3 9229.8 9435.2 9534.8 10026.3 8555.9 8845.5 8976.1 9054.3 9107.1 8167.7 8378.2 8396.3 8555.0 9004.4 8991.9 9127.4 9431.1 9437.5 9531.3 12500.0 12706.4 12880.0 12885.5 12959.2 12206.2 12263.1 12273.1 12391.3 12497.8 20:31:23 INFO - PROCESS | 7653 | 20:31:23 INFO - PROCESS | 7653 | [#3] mootools.html Cycles:180 Average:5938.46 Median:4792.58 stddev:3403.74 (71.0%) stddev-sans-first:3396.69 20:31:23 INFO - PROCESS | 7653 | Values: 1466.5 1506.2 1625.2 1782.7 1801.3 8650.8 9303.0 9305.9 9316.6 9320.9 7924.3 8682.2 8966.2 9006.8 9009.9 2389.1 2403.7 2406.1 2407.1 2421.3 2394.4 2434.5 2437.1 2441.5 2447.7 2428.0 2447.2 2468.9 2506.1 2506.5 2391.6 2412.1 2419.3 2420.7 2431.3 2382.0 2385.3 2391.5 2397.3 2398.7 9053.5 9147.7 9162.2 9279.1 9279.2 5296.4 5372.7 5373.5 5401.3 5444.9 3268.8 3368.9 3417.9 3421.5 3514.6 1074.0 1087.7 1115.6 1127.9 1130.7 12633.3 12645.6 12761.5 12773.6 12775.3 4548.3 4618.0 4779.7 4805.5 4848.6 10611.5 10618.1 10656.0 10737.7 10739.0 5430.3 5434.0 5437.8 5441.2 5445.3 4261.2 4402.4 4409.2 4875.7 4986.8 4078.6 4168.4 4197.3 4198.3 4219.3 1347.6 1362.9 1372.2 1372.7 1378.4 810.6 895.5 909.6 925.5 972.2 5818.6 5998.1 6055.1 6073.1 6250.5 890.3 897.3 903.2 941.6 975.9 3847.0 4217.9 4231.5 4241.9 4359.2 11036.4 11215.4 11318.7 11330.5 11331.3 11118.4 11294.8 11302.2 11312.4 11323.0 8289.1 8392.8 8468.9 8504.4 8528.3 5936.0 5955.9 5956.9 5957.2 6142.4 10046.7 10243.2 10311.9 10386.3 10448.8 10673.1 10705.4 10730.6 10812.3 10831.6 7209.0 7643.3 7862.1 8099.6 8232.0 8474.0 8646.6 8647.7 8648.0 8649.9 7581.4 7727.6 7776.5 7910.9 7936.6 7644.3 7736.7 7744.6 7750.8 7790.5 7136.4 7239.9 7244.9 7285.9 7293.8 4936.7 5041.7 5059.4 5112.4 5140.2 5051.2 5091.4 5109.6 5198.3 5203.5 20:31:23 INFO - PROCESS | 7653 | 20:31:23 INFO - PROCESS | 7653 | [#4] prototype.html Cycles:180 Average:4597.46 Median:5228.66 stddev:1378.38 (26.4%) stddev-sans-first:1344.16 20:31:23 INFO - PROCESS | 7653 | Values: 310.4 315.6 317.9 318.7 320.7 5310.9 5329.2 5336.6 5352.2 5359.0 5266.9 5268.8 5299.9 5326.2 5338.9 4157.6 4174.8 4178.2 4199.0 4211.1 3899.2 4098.3 4131.9 4138.6 4150.9 4039.7 4051.6 4068.0 4078.4 4098.2 3779.7 3910.8 4080.6 4090.1 4108.3 3186.8 3425.8 3437.8 3525.9 3550.5 5184.6 5192.5 5198.8 5222.9 5227.4 4607.0 4629.0 4640.7 4649.6 4656.8 5184.2 5229.9 5408.2 5424.3 5502.8 3868.7 3872.2 3886.7 3887.4 3912.1 5510.5 5634.5 5796.9 5809.9 5819.8 3896.3 3905.5 3916.1 3917.3 3937.4 3998.3 4002.4 4006.5 4016.8 4020.0 4458.5 4631.3 4633.1 4633.9 4636.0 5519.2 5525.3 5540.9 5562.3 5598.9 1361.3 1378.9 1382.1 1382.9 1386.5 839.4 885.6 894.4 901.2 907.4 4683.9 4690.9 4703.4 4747.4 4762.9 4927.0 5006.9 5062.4 5063.5 5083.5 4702.8 4706.6 4718.4 4781.4 4964.8 2941.8 2984.9 2992.4 2996.7 2998.3 5840.3 5868.2 5873.4 5904.2 5916.7 5596.3 5761.7 5799.6 5810.3 5833.7 5829.1 5843.0 5850.2 5861.7 5869.4 5420.4 5690.9 5694.5 5721.6 5725.9 5639.0 5640.9 5649.5 5668.4 5671.9 5564.8 5725.4 5869.6 5888.4 5891.6 3970.7 3981.9 4000.4 4022.6 4030.7 5803.3 5820.7 5825.7 5834.4 5839.7 5309.8 5590.3 5606.5 5610.8 5684.2 5557.6 5571.5 5577.0 5577.2 5600.2 5265.5 5546.9 5557.4 5569.5 5585.5 5612.3 5623.7 5623.7 5636.1 5638.4 5456.8 5493.4 5494.5 5500.4 5507.3 20:31:23 INFO - PROCESS | 7653 | 20:31:23 INFO - PROCESS | 7653 | [#5] yui.html Cycles:180 Average:22372.03 Median:3954.24 stddev:33056.15 (836.0%) stddev-sans-first:33109.19 20:31:23 INFO - PROCESS | 7653 | Values: 798.1 798.5 824.1 828.9 834.4 15392.8 16185.2 16444.8 16532.7 16606.0 15616.7 15626.9 15640.2 15653.0 15715.1 805.9 819.0 823.2 823.9 824.6 658.5 674.0 676.9 680.5 818.7 839.4 864.8 866.5 873.8 875.4 854.1 859.4 860.2 861.1 864.0 510.1 628.5 628.8 629.9 630.1 11760.6 12276.4 14284.5 14801.8 14966.6 14582.7 15313.9 15338.5 15572.5 15622.9 11853.8 11869.3 12012.9 12274.4 12440.3 3849.2 3894.8 3923.6 3984.9 4090.1 84783.0 84892.2 86198.6 87367.0 88437.6 11853.6 11898.7 11953.3 12105.7 12147.6 22943.8 22947.0 22978.3 22988.3 22992.9 8392.8 8804.0 8810.8 8835.1 8842.9 4663.5 4777.1 4873.0 4880.1 5002.4 3651.7 3731.0 3752.6 3772.6 3774.6 601.7 613.2 617.5 624.5 633.5 716.5 728.0 764.0 771.8 785.3 8739.4 9120.5 10217.4 10313.0 10551.8 642.3 694.3 704.3 724.1 783.7 4645.1 4740.9 4745.8 4761.1 4787.7 111711.9 125533.2 129364.0 132130.0 132369.7 108110.0 109023.5 109944.5 111586.4 116537.0 91965.0 93432.1 94220.0 94548.0 94587.5 8643.6 9134.2 9166.6 9188.9 9357.9 53665.5 57331.0 57333.0 58576.4 58855.4 75728.2 76075.6 76248.5 77439.2 78840.0 13765.0 13988.7 14015.5 14026.1 14351.0 15179.6 15260.2 15756.8 16172.8 16428.7 13699.6 13968.0 15596.7 15610.0 15722.7 14332.9 14488.6 14700.9 15138.8 15300.5 11643.2 12118.2 12157.3 12585.7 12655.7 10940.8 10981.6 11499.0 11923.7 11940.8 10630.4 10861.7 11120.7 11292.5 12922.4 20:31:23 INFO - PROCESS | 7653 | -------- Summary: end -------- 20:31:23 INFO - PROCESS | 7653 | 20:31:24 INFO - TEST-INFO | 7653: exit 0 20:31:24 INFO - TEST-OK | dromaeo_css | took 1117050ms 20:31:24 INFO - TEST-START | kraken 20:31:24 INFO - operating with platform_type : linux_ 20:31:24 INFO - Initialising browser for kraken test... 20:31:24 INFO - TEST-INFO | started process 7963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMQW5z_/profile http://localhost:37839/getInfo.html) 20:31:28 INFO - PROCESS | 7963 | __metrics Screen width/height:1600/1200 20:31:28 INFO - PROCESS | 7963 | colorDepth:24 20:31:28 INFO - PROCESS | 7963 | Browser inner width/height: 1024/697 20:31:28 INFO - PROCESS | 7963 | __metrics 20:31:29 INFO - PROCESS | 7963 | 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" 20:31:29 INFO - PROCESS | 7963 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:31:30 INFO - PROCESS | 7963 | console.error: PushService: 20:31:30 INFO - PROCESS | 7963 | stateChangeProcessEnqueue: Error transitioning state 20:31:30 INFO - PROCESS | 7963 | UnknownError 20:31:30 INFO - TEST-INFO | 7963: exit 0 20:31:30 INFO - Browser initialized. 20:31:30 INFO - Running cycle 1/1 for kraken test... 20:31:30 INFO - TEST-INFO | started process 8042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMQW5z_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:31:42 INFO - PROCESS | 8042 | RSS: Main: 180502528 20:31:42 INFO - PROCESS | 8042 | 20:31:45 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37839/tests/kraken/driver.html?testName=audio-beat-detection) 20:31:46 INFO - PROCESS | 8042 | RSS: Main: 237613056 20:31:46 INFO - PROCESS | 8042 | 20:31:48 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37839/tests/kraken/driver.html?testName=audio-dft) 20:31:49 INFO - PROCESS | 8042 | RSS: Main: 224792576 20:31:49 INFO - PROCESS | 8042 | 20:31:52 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37839/tests/kraken/driver.html?testName=audio-fft) 20:31:53 INFO - PROCESS | 8042 | RSS: Main: 298958848 20:31:53 INFO - PROCESS | 8042 | 20:31:55 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37839/tests/kraken/driver.html?testName=audio-oscillator) 20:31:55 INFO - PROCESS | 8042 | RSS: Main: 211091456 20:31:55 INFO - PROCESS | 8042 | 20:31:57 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37839/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:31:58 INFO - PROCESS | 8042 | RSS: Main: 213569536 20:31:58 INFO - PROCESS | 8042 | 20:32:01 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37839/tests/kraken/driver.html?testName=imaging-darkroom) 20:32:02 INFO - PROCESS | 8042 | RSS: Main: 252534784 20:32:02 INFO - PROCESS | 8042 | 20:32:05 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37839/tests/kraken/driver.html?testName=imaging-desaturate) 20:32:06 INFO - PROCESS | 8042 | RSS: Main: 251600896 20:32:06 INFO - PROCESS | 8042 | 20:32:08 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37839/tests/kraken/driver.html?testName=json-parse-financial) 20:32:09 INFO - PROCESS | 8042 | RSS: Main: 251289600 20:32:09 INFO - PROCESS | 8042 | 20:32:10 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37839/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:32:11 INFO - PROCESS | 8042 | RSS: Main: 213606400 20:32:11 INFO - PROCESS | 8042 | 20:32:13 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37839/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:32:13 INFO - PROCESS | 8042 | RSS: Main: 221433856 20:32:13 INFO - PROCESS | 8042 | 20:32:15 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37839/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:32:16 INFO - PROCESS | 8042 | RSS: Main: 221855744 20:32:16 INFO - PROCESS | 8042 | 20:32:19 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:32:19 INFO - PROCESS | 8042 | RSS: Main: 223154176 20:32:19 INFO - PROCESS | 8042 | 20:32:22 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:32:23 INFO - PROCESS | 8042 | RSS: Main: 220971008 20:32:23 INFO - PROCESS | 8042 | 20:32:24 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:37839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37839/tests/kraken/driver.html?testName=ai-astar) 20:32:25 INFO - PROCESS | 8042 | RSS: Main: 272371712 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | __start_tp_report 20:32:25 INFO - PROCESS | 8042 | _x_x_mozilla_page_load 20:32:25 INFO - PROCESS | 8042 | _x_x_mozilla_page_load_details 20:32:25 INFO - PROCESS | 8042 | |i|pagename|runs| 20:32:25 INFO - PROCESS | 8042 | |0;ai-astar;112;113;127;111;113;114;111;111;111;111 20:32:25 INFO - PROCESS | 8042 | |1;audio-beat-detection;148;120;148;173;122;148;150;127;183;123 20:32:25 INFO - PROCESS | 8042 | |2;audio-dft;162;162;161;163;161;161;161;162;161;161 20:32:25 INFO - PROCESS | 8042 | |3;audio-fft;75;75;76;174;76;75;74;74;167;77 20:32:25 INFO - PROCESS | 8042 | |4;audio-oscillator;82;83;146;83;83;84;141;82;82;146 20:32:25 INFO - PROCESS | 8042 | |5;imaging-gaussian-blur;116;117;117;117;117;116;118;117;117;116 20:32:25 INFO - PROCESS | 8042 | |6;imaging-darkroom;148;145;146;146;146;146;146;146;146;145 20:32:25 INFO - PROCESS | 8042 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;95;95 20:32:25 INFO - PROCESS | 8042 | |8;json-parse-financial;52;52;54;52;53;54;53;52;52;51 20:32:25 INFO - PROCESS | 8042 | |9;json-stringify-tinderbox;62;62;62;62;62;62;61;62;62;62 20:32:25 INFO - PROCESS | 8042 | |10;stanford-crypto-aes;78;80;79;79;82;83;79;78;79;78 20:32:25 INFO - PROCESS | 8042 | |11;stanford-crypto-ccm;130;124;125;125;134;131;129;129;165;135 20:32:25 INFO - PROCESS | 8042 | |12;stanford-crypto-pbkdf2;163;161;160;163;160;162;160;162;160;165 20:32:25 INFO - PROCESS | 8042 | |13;stanford-crypto-sha256-iterative;68;73;65;65;65;64;63;67;64;63 20:32:25 INFO - PROCESS | 8042 | __end_tp_report 20:32:25 INFO - PROCESS | 8042 | __start_cc_report 20:32:25 INFO - PROCESS | 8042 | _x_x_mozilla_cycle_collect,1740 20:32:25 INFO - PROCESS | 8042 | __end_cc_report 20:32:25 INFO - PROCESS | 8042 | __startTimestamp1472355145155__endTimestamp 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | ------- Summary: start ------- 20:32:25 INFO - PROCESS | 8042 | Number of tests: 14 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#0] ai-astar Cycles:10 Average:113.40 Median:112.50 stddev:4.90 (4.4%) stddev-sans-first:5.17 20:32:25 INFO - PROCESS | 8042 | Values: 112.0 113.0 127.0 111.0 113.0 114.0 111.0 111.0 111.0 111.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:148.00 stddev:21.69 (14.7%) stddev-sans-first:22.97 20:32:25 INFO - PROCESS | 8042 | Values: 148.0 120.0 148.0 173.0 122.0 148.0 150.0 127.0 183.0 123.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 20:32:25 INFO - PROCESS | 8042 | Values: 162.0 162.0 161.0 163.0 161.0 161.0 161.0 162.0 161.0 161.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.00 stddev:40.21 (53.6%) stddev-sans-first:42.03 20:32:25 INFO - PROCESS | 8042 | Values: 75.0 75.0 76.0 174.0 76.0 75.0 74.0 74.0 167.0 77.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:82.50 stddev:29.80 (36.1%) stddev-sans-first:30.79 20:32:25 INFO - PROCESS | 8042 | Values: 82.0 83.0 146.0 83.0 83.0 84.0 141.0 82.0 82.0 146.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 20:32:25 INFO - PROCESS | 8042 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 116.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.44 20:32:25 INFO - PROCESS | 8042 | Values: 148.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:32:25 INFO - PROCESS | 8042 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:0.97 (1.9%) stddev-sans-first:1.01 20:32:25 INFO - PROCESS | 8042 | Values: 52.0 52.0 54.0 52.0 53.0 54.0 53.0 52.0 52.0 51.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 20:32:25 INFO - PROCESS | 8042 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:1.72 (2.2%) stddev-sans-first:1.73 20:32:25 INFO - PROCESS | 8042 | Values: 78.0 80.0 79.0 79.0 82.0 83.0 79.0 78.0 79.0 78.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:130.50 stddev:11.94 (9.1%) stddev-sans-first:12.62 20:32:25 INFO - PROCESS | 8042 | Values: 130.0 124.0 125.0 125.0 134.0 131.0 129.0 129.0 165.0 135.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.00 stddev:1.71 (1.1%) stddev-sans-first:1.74 20:32:25 INFO - PROCESS | 8042 | Values: 163.0 161.0 160.0 163.0 160.0 162.0 160.0 162.0 160.0 165.0 20:32:25 INFO - PROCESS | 8042 | 20:32:25 INFO - PROCESS | 8042 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.00 stddev:3.02 (4.6%) stddev-sans-first:3.09 20:32:25 INFO - PROCESS | 8042 | Values: 68.0 73.0 65.0 65.0 65.0 64.0 63.0 67.0 64.0 63.0 20:32:25 INFO - PROCESS | 8042 | -------- Summary: end -------- 20:32:25 INFO - PROCESS | 8042 | 20:32:26 INFO - TEST-INFO | 8042: exit 0 20:32:26 INFO - TEST-OK | kraken | took 62003ms 20:32:26 INFO - SUITE-END | took 1179s 20:32:26 INFO - Completed test suite (00:19:39) 20:32:26 INFO - javascript benchmark 20:32:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.710657487538, 3054.602901622789, 3080.5379193121043, 3097.426976009437, 3124.7031532004453, 5252.842414727555, 5289.0, 5356.517913387795, 5387.838364849056, 5418.8916221675545, 5275.525202731754, 5377.919331210025, 5402.756875940582, 5420.295361602996, 5498.340199176095, 4817.566419022287, 4850.611951043908, 4897.436794768594, 4953.157963146274, 4962.900741985158, 4925.975370123162, 4926.531979461945, 4995.35060442142, 5001.024800163969, 5004.874878128039, 4911.16510193268, 4917.286993385975, 4961.603071754251, 4976.253561965716, 4998.125328067592, 4810.7113573185725, 4829.082474329866, 4859.0767754126955, 4889.119958407486, 4892.53520915516, 4767.547083027107, 4768.928466072977, 4769.35613692154, 4789.2816077588295, 4822.855314340575, 5345.091334473149, 5349.438308977579, 5352.277442545245, 5379.569634429236, 5396.541293990015, 5600.859978500529, 5635.0, 5711.143328500717, 5722.227499287626, 5733.283339582552, 5735.426457354273, 5762.538996880239, 5779.8555036124435, 5783.9710801446145, 5796.50729687977, 5365.275687782138, 5371.086915224421, 5373.167159090347, 5374.220737993008, 5376.623636345457, 5722.942770572241, 5860.882782344414, 5929.792457263975, 5935.109733540004, 6027.126066720301, 5674.460926212003, 5685.0, 5687.175359572839, 5687.544996400278, 5688.516476099578, 5766.625169363978, 5769.048107062372, 5770.10563362671, 5776.711164441761, 5777.6822274775295, 5581.358143813432, 5613.943860561342, 5632.718364081779, 5685.545156387479, 5764.74058667361, 5695.145728140812, 5704.828855134353, 5709.143628455682, 5757.136429535603, 5765.827025189167, 4388.780560971939, 4431.423914891044, 4435.223835828717, 4436.866893993185, 4482.618977386894, 3890.902727431837, 3891.552471465761, 3927.8232479538487, 3948.6446219840354, 3959.6832253419657, 5448.128299472145, 5451.37309209446, 5452.509274165344, 5469.835904922858, 5516.91724624131, 5770.365259821417, 5784.739686714108, 5787.479126878601, 5788.27646544182, 5791.0734282514595, 5348.572114230852, 5381.892362152735, 5438.157085651651, 5447.291852059207, 5456.672599644034, 5024.472430394829, 5053.1157047516535, 5057.039162559102, 5065.594752419797, 5070.923936140961, 5914.792982245687, 5951.880962380815, 5957.434043765836, 5966.254218222723, 5968.283805943228, 5537.916931246115, 5790.305163380422, 5797.797077102281, 5799.884002320015, 5800.970995144998, 5803.535717142534, 5858.882822343615, 5874.118882167709, 5906.852328691817, 5967.492763115184, 5613.045782216951, 5614.69119198448, 5616.971915140398, 5617.943820561905, 5618.831435056954, 5617.606767526234, 5691.174779656843, 5712.600117991867, 5713.742881570256, 5719.370869204467, 5518.80684176068, 5523.392426833126, 5558.91661625084, 5568.220449137043, 5605.915911261252, 5546.611737178358, 5595.888082238251, 5597.908407860428, 5607.943920560905, 5643.32280126371, 5588.105903055654, 5601.24383208278, 5601.663900166003, 5602.243697101002, 5604.0, 5490.313710786152, 5549.639273447213, 5605.887882242414, 5611.38274789781, 5618.325800903917, 5496.258005169251, 5533.6403133796175, 5534.031544479781, 5536.114221724505, 5582.246396736388], "value": 5293.715313611022, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.1517354315613, 619.08066521216, 630.5334052800926, 638.7700427845974, 658.8682263547291, 31669.841650791743, 41876.55604771383, 42977.35533966993, 43060.0, 43147.784261078654, 44673.329900051445, 44705.329420058726, 44946.325805112865, 44957.32564011542, 45152.774236128855, 8198.38512111591, 8984.236339911098, 9127.224185944202, 9131.634734610641, 10791.0, 10838.837417438745, 10963.122950163968, 10964.451777411137, 10967.50646220922, 10971.23201375904, 11029.393383363911, 11081.889181108207, 11082.0, 11085.83371249428, 11086.279391839505, 10914.563417463292, 10954.452277386099, 10967.122630189566, 10967.50646220914, 10977.83533247002, 10851.782964340748, 10874.293170943864, 10881.401522916236, 10930.617428390047, 10943.671689849318, 41989.16021679549, 42334.0, 42381.0, 42390.78804605988, 42404.57595424037, 3415.077928959192, 3537.2394935088823, 3621.953596218155, 3715.386961151407, 3729.1609387887506, 31458.37083258322, 31481.842590787128, 31769.364612707846, 31939.840300798347, 32787.18032049218, 4302.096559722462, 4344.239758042361, 4402.217102073665, 4445.51099379068, 4492.034212644297, 260726.0, 260905.0, 261531.0, 261867.69066154739, 263479.0, 56277.0, 56531.15203271954, 56648.43351566514, 56701.716491417275, 56744.0, 35954.64045359513, 37404.0, 37449.25101497955, 59148.40851591515, 59270.0, 17506.299748009937, 17955.192016359295, 17962.55093622644, 17967.460976170736, 17969.640607187783, 12207.572734954412, 13092.869071309355, 13303.866961330456, 13474.93262533681, 13754.243516606683, 16027.0, 18575.349862754738, 18664.813351866578, 18695.813041869405, 18697.699529108108, 5961.0, 7148.39238664709, 7286.744963926237, 7328.3404493595835, 7399.741009064657, 969.7963427680126, 1015.3958394755109, 1032.4734385463469, 1115.3252282369212, 1117.7205698575356, 31591.36817263642, 32294.515582266285, 32450.513242301386, 32486.132875656138, 32899.0, 1065.3448129400517, 1075.0, 1087.5801342013956, 1110.7389763405592, 1142.6000899685043, 16371.590710232102, 16676.83323166777, 17220.397286094925, 17322.48032559025, 17692.203850826743, 583090.0, 588295.0, 588815.0, 589796.0, 589969.0, 51040.489595104315, 57955.0, 58478.70760646169, 60647.393526065054, 63398.68300658467, 1312.5078095714107, 1334.3461703765279, 1351.4391527516168, 1367.0840536840342, 1370.3696299702249, 29647.0, 31385.529217061307, 31554.842225788725, 31630.36739265248, 32185.517217242228, 48382.5161748378, 49114.75442622764, 49164.75417622889, 49170.0, 49225.0, 549258.0, 563687.0, 565943.0, 831480.0, 833725.0, 42283.7885810569, 43158.38940937658, 43296.56703432925, 43435.56564434442, 43975.78012110047, 47774.52225477701, 47892.521074788805, 48000.27999580079, 48202.75898620485, 49027.0, 40346.0, 40744.592554075265, 40907.0, 41377.1724565501, 42715.78642106769, 40123.0, 40967.1806563873, 41595.0, 41976.58023419727, 42266.57733422749, 39484.802575986934, 40843.0, 41866.58133418627, 42032.36951445792, 42080.0, 34118.65881341254, 36566.63433365632, 37052.0, 37344.6265537352, 37658.43512347372, 27725.44549108966, 27794.583081253393, 28170.577441338806, 28240.15279541535, 28272.43455130927], "value": 20835.33622819687, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.3041790180755, 374.3916136278547, 383.59339100553404, 389.3575600259571, 399.0522509041028, 15186.924065379671, 17200.827991720078, 18772.624547509058, 19356.612867742635, 19547.804521954775, 19649.705254421195, 20094.799052009475, 20097.799022009774, 20285.188592456285, 20290.49273768153, 5229.581633469314, 5498.890022199554, 5559.277293951801, 5740.712964351766, 5752.568557358194, 5604.8038318658855, 5668.57485688573, 5686.886262274752, 5698.572607054467, 5712.571557133211, 5589.217509548666, 5678.318601767794, 5680.914786278188, 5683.374828768832, 5866.88266234675, 5828.009238429456, 5868.823935281948, 5869.266341707286, 5869.383714709958, 5869.647821130725, 5539.750711218005, 5678.886422271531, 5691.146328050784, 5700.515456186229, 5715.914261286084, 13835.584932452042, 13931.373088211054, 13998.440062397493, 21389.5722085559, 23639.763602363928, 2224.0325458425473, 2283.2807665585287, 2427.7814996650386, 2565.9230223093336, 2636.077372919482, 9778.217742580577, 10070.295079344449, 10671.519781609846, 12341.444634991447, 14738.115713057143, 1781.32309722306, 1823.9908800456046, 1867.7198420236937, 1868.6356160548698, 1917.8945158016304, 77238.22761772366, 80724.0, 83746.59223679091, 84141.57929210376, 87850.0, 10671.0, 11002.524432002736, 11006.174536909764, 11221.55113795439, 11571.594994175164, 15547.144907030222, 15557.988730732466, 15561.922190389201, 15567.29947152381, 15572.454964076203, 7756.612169391507, 7791.376689864797, 8072.112067672551, 8084.83830323402, 8127.75616731499, 7393.408527317909, 7417.888731669029, 7437.070366204224, 7594.468387212842, 7646.273604007611, 4777.808887644455, 4795.808167673254, 4822.758862056883, 4834.806607735652, 4954.133026720309, 1967.8228959393723, 2029.7259869917668, 2037.518582785982, 2065.617860695746, 2087.676410156428, 745.7874505765939, 785.5679376343103, 831.8544254755394, 973.6738192705382, 1037.0, 18353.265869365343, 19251.22995080181, 19625.901870490557, 19750.40748777539, 19901.800981989996, 972.5380444288907, 1014.2849291249652, 1031.0926384781494, 1050.7740835720356, 1056.4717641179411, 10368.377897326185, 10855.837162442569, 10958.0, 10970.286931349438, 10970.396628185366, 459548.0, 474417.0, 510082.0, 515463.0, 534053.0, 56854.715726421106, 87305.56347218351, 91191.0, 91950.54024729834, 96703.51648241714, 1018.8369860822232, 1027.0, 1030.4950574218578, 1057.513543769859, 1073.270176280137, 16716.58208544796, 17194.828051719323, 17682.204300806236, 17879.19543620514, 18059.729104063186, 31508.0, 40882.0, 43380.34929475997, 44627.77686111549, 48035.5196448045, 55750.44249557615, 57826.4217357821, 58185.709071454374, 59725.70137149286, 60207.0, 8186.672533098609, 8511.276541493795, 8515.233628973423, 8840.602172902363, 8909.0, 9147.313951453534, 9229.769255768391, 9435.150836424755, 9534.761630959281, 10026.348287361297, 8555.914440855511, 8845.51349675774, 8976.147266009719, 9054.349990045737, 9107.134822191882, 8167.673293068211, 8378.24595786382, 8396.328293736364, 8555.0, 9004.414713043894, 8991.91008089937, 9127.406718563272, 9431.104045115702, 9437.480938548171, 9531.332806703742, 12500.0, 12706.428210730355, 12880.003599442101, 12885.48458061667, 12959.157654752411, 12206.206596571194, 12263.141580089308, 12273.140880138304, 12391.318477483825, 12497.750044999231], "value": 8970.241929310072, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.5453709350102, 1506.1640789361902, 1625.1549194418903, 1782.6702060118887, 1801.297493977349, 8650.783730406734, 9302.953485232581, 9305.860412093816, 9316.627334906596, 9320.86018709719, 7924.286814186722, 8682.175193356637, 8966.237869781076, 9006.774830629238, 9009.864852027209, 2389.104085967762, 2403.663487111806, 2406.1217655555683, 2407.0973384980634, 2421.2736179146273, 2394.449276666368, 2434.5374378868046, 2437.1348171399163, 2441.523902838947, 2447.657327974085, 2427.963580546293, 2447.155731272717, 2468.9135880244194, 2506.0602274147195, 2506.4611108611643, 2391.617341225413, 2412.1436889904007, 2419.2863105383954, 2420.745821688724, 2431.3192306154306, 2381.988090059556, 2385.272491889973, 2391.5097405031925, 2397.2808157552663, 2398.65219543167, 9053.456792592466, 9147.725568232963, 9162.221211197057, 9279.118483744101, 9279.164875161201, 5296.364436267672, 5372.7045012524295, 5373.516383525502, 5401.3248343957, 5444.891102177934, 3268.7711860169798, 3368.898933032013, 3417.9487307690406, 3421.5038819371302, 3514.595821480537, 1073.9677809665723, 1087.6736978906297, 1115.6151127860956, 1127.9453710780447, 1130.7116685245292, 12633.305168215744, 12645.557405490763, 12761.489540418372, 12773.552925647651, 12775.29735864527, 4548.31775233711, 4618.0, 4779.665423420327, 4805.495422980606, 4848.612111031109, 10611.522481488351, 10618.09746171584, 10656.0, 10737.677869663923, 10739.0, 5430.294061771944, 5434.0, 5437.755301011464, 5441.238226648273, 5445.264889239981, 4261.190373829025, 4402.449693788277, 4409.228385032607, 4875.68308059975, 4986.80052797884, 4078.632923036941, 4168.354454796209, 4197.349410841324, 4198.328267477189, 4219.346001369792, 1347.5687779910531, 1362.9182249065088, 1372.1561239837429, 1372.7185926884965, 1378.3590630356932, 810.6109067647562, 895.4895709445684, 909.5997760985146, 925.4863550729275, 972.2270794718216, 5818.6217895836635, 5998.130271110665, 6055.061465472859, 6073.058675905242, 6250.499960003189, 890.3189060368823, 897.3135551303258, 903.1781079217881, 941.5998200764648, 975.8877729061248, 3846.9807650961566, 4217.873463796091, 4231.513375961742, 4241.893952651209, 4359.1717573661535, 11036.448177591088, 11215.43922803873, 11318.717032074099, 11330.490127944262, 11331.32012079278, 11118.388488633203, 11294.774104517863, 11302.208845380745, 11312.377819220023, 11323.0, 8289.129641387688, 8392.832143357098, 8468.872966905501, 8504.44721093127, 8528.317734581218, 5936.0, 5955.880882382241, 5956.910646340395, 5957.225560677084, 6142.416470435302, 10046.748831279276, 10243.23175761806, 10311.948440257751, 10386.272960892666, 10448.843267350843, 10673.092787112872, 10705.357678539312, 10730.624428144978, 10812.297200681931, 10831.620893269013, 7208.96395518019, 7643.312101910855, 7862.056553213651, 8099.595020248846, 8232.0, 8473.95763021181, 8646.610902509528, 8647.654093836176, 8648.04871464151, 8649.870251946351, 7581.355584775356, 7727.574983375968, 7776.494527855672, 7910.920890791019, 7936.56348900816, 7644.312011918954, 7736.651850666846, 7744.612769361622, 7750.806229844299, 7790.493617914817, 7136.393406560501, 7239.8914016290855, 7244.855102897807, 7285.927140728525, 7293.781186564412, 4936.679115857458, 5041.747912604282, 5059.367579052619, 5112.3865136183895, 5140.228965655182, 5051.217061355495, 5091.414487334004, 5109.616778741535, 5198.272241886063, 5203.531682148625], "value": 4738.295853425397, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.42726170215946, 315.56136969612237, 317.8887389413705, 318.66699299232283, 320.6953394275439, 5310.867228319294, 5329.227262047001, 5336.626436149471, 5352.2239275305055, 5358.955003774266, 5266.894662106755, 5268.8155914542995, 5299.894002119955, 5326.227696983945, 5338.91991620125, 4157.605027522381, 4174.8121334539865, 4178.247915375231, 4198.97900510497, 4211.094614657848, 3899.161680238748, 4098.323776576861, 4131.876043718693, 4138.586141385867, 4150.937735933963, 4039.676825853939, 4051.5745846686114, 4068.0, 4078.449409329732, 4098.159877225162, 3779.7354185207046, 3910.8463003414063, 4080.5511393746665, 4090.1185454690876, 4108.3221268490815, 3186.776925615208, 3425.845836937344, 3437.7765445246228, 3525.876594319212, 3550.5384300041087, 5184.585233181337, 5192.480751924815, 5198.844034678966, 5222.947770522284, 5227.398849132361, 4607.0, 4629.0, 4640.67515273931, 4649.558291962258, 4656.767161641905, 5184.222366644995, 5229.927864787747, 5408.242846001563, 5424.349078110613, 5502.752376143043, 3868.6905047596124, 3872.186840763443, 3886.6502014818802, 3887.4168874668744, 3912.080661044652, 5510.504054635062, 5634.450526105313, 5796.913046304308, 5809.941900580982, 5819.7672093116225, 3896.2791883501077, 3905.4727611772614, 3916.138449541096, 3917.2948869203815, 3937.350337194388, 3998.3207053037795, 4002.3596224603925, 4006.45912801768, 4016.779077150785, 4019.954811748966, 4458.458678553258, 4631.305304204329, 4633.142868569258, 4633.864703147683, 4635.976820115878, 5519.227308176858, 5525.281713377235, 5540.861478463071, 5562.276904002454, 5598.916016259759, 1361.251311778518, 1378.910370825893, 1382.10853999172, 1382.9446822127204, 1386.4800699737598, 839.3746658739278, 885.6368888755708, 894.3739382432324, 901.1529162587148, 907.419251678926, 4683.882902927386, 4690.889099905056, 4703.3885594872445, 4747.359106520645, 4762.904741905142, 4927.0, 5006.924896126561, 5062.443131255559, 5063.468335824686, 5083.542481176712, 4702.753770250886, 4706.552877476634, 4718.386609740712, 4781.35043410023, 4964.833264182914, 2941.838198899081, 2984.925376865596, 2992.356643321696, 2996.730294273526, 2998.2804127009795, 5840.2991641003355, 5868.207791948118, 5873.442023007808, 5904.232449781501, 5916.7337469813965, 5596.272484576979, 5761.711914404263, 5799.6230245034785, 5810.273715785527, 5833.7083145842535, 5829.125631155361, 5843.035899076604, 5850.151727999416, 5861.70691465425, 5869.354371019184, 5420.376656684532, 5690.857728556819, 5694.490959895548, 5721.628094173865, 5725.883452726845, 5639.0, 5640.85897852557, 5649.491545760901, 5668.412844403573, 5671.858203544944, 5564.777408903598, 5725.398833122629, 5869.589128761117, 5888.411158884249, 5891.558133139946, 3970.7419017763755, 3981.900452488595, 4000.3799411091327, 4022.597740225954, 4030.6573941215324, 5803.332616749128, 5820.650760954356, 5825.650460972186, 5834.38738932406, 5839.656878917788, 5309.814156504503, 5590.329160500603, 5606.495415412633, 5610.7755689773585, 5684.175794509855, 5557.5831812613405, 5571.498565129158, 5577.044166591713, 5577.163425486209, 5600.187972744011, 5265.473452654704, 5546.861328466821, 5557.388687244481, 5569.498745112959, 5585.497305242548, 5612.298462692163, 5623.662580245198, 5623.746931388016, 5636.126400407943, 5638.379778224474, 5456.781728730965, 5493.368262649847, 5494.478024587658, 5500.367457742411, 5507.284053073075], "value": 4152.883557470232, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.1300382582983, 798.4769975665937, 824.1305422778966, 828.9005319361676, 834.3992325525624, 15392.846071539281, 16185.19074046299, 16444.753328700062, 16532.66934661306, 16606.0, 15616.687666246668, 15626.921865390657, 15640.217989100556, 15653.0, 15715.057096574184, 805.9032916050068, 819.0212695828487, 823.2261674026425, 823.9423240373146, 824.6041899888057, 658.4830907737403, 674.039493721445, 676.9424598909098, 680.5134328954796, 818.6725309876037, 839.3620848155385, 864.7621903976394, 866.4844417571567, 873.7990262239689, 875.4440930009458, 854.0733304364771, 859.3597769661611, 860.1570460948275, 861.1044513705739, 864.0107077396347, 510.1276816643544, 628.5097623853402, 628.779927025542, 629.9149614801989, 630.1115427247605, 11760.58837940668, 12276.386180691019, 14284.500042498566, 14801.777973330409, 14966.551003469913, 14582.70834583313, 15313.923430382889, 15338.539843804592, 15572.532824015298, 15622.9218853905, 11853.822192667118, 11869.347185904771, 12012.939935300268, 12274.38628068593, 12440.253584784941, 3849.191669749356, 3894.844206231747, 3923.588023257574, 3984.900377490557, 4090.141070375225, 84783.0, 84892.15107848904, 86198.5690071552, 87367.0, 88437.55781221052, 11853.644390668294, 11898.702532436759, 11953.282803031845, 12105.697357565956, 12147.635570932885, 22943.770562294165, 22947.0, 22978.310650680505, 22988.310350689506, 22992.88503557505, 8392.83214335722, 8803.955980220186, 8810.823783524294, 8835.116488351114, 8842.911570884338, 4663.533646635309, 4777.140114779373, 4872.975635121802, 4880.072786170616, 5002.424721157041, 3651.707863370924, 3731.0, 3752.587215406303, 3772.6227377262603, 3774.584795672474, 601.711178634258, 613.1722175063628, 617.5337620096798, 624.5128799536369, 633.5280216238839, 716.502031088399, 727.9672414741349, 763.9541627502257, 771.7646117934084, 785.3481610263468, 8739.423904338903, 9120.498372589438, 10217.436568607114, 10313.0, 10551.84172237417, 642.2966851297915, 694.3369082526175, 704.3027402871121, 724.1057294241607, 783.749200255924, 4645.094206629675, 4740.866186835368, 4745.786439610226, 4761.071591039783, 4787.664863459594, 111711.88288117177, 125533.23400298005, 129364.0, 132130.0, 132369.67630323765, 108110.0, 109023.45488272667, 109944.4502777497, 111586.44206778915, 116537.0, 91964.99999999866, 93432.13135737248, 94220.0, 94548.0, 94587.52706236424, 8643.56782160902, 9134.22359099484, 9166.645942652562, 9188.862167067366, 9357.906420935704, 53665.46334536605, 57331.0, 57333.0, 58576.4142358571, 58855.411445886704, 75728.24271757212, 76075.61962190154, 76248.51887589617, 77439.2256077432, 78840.0, 13765.0, 13988.720225595634, 14015.50945716895, 14026.08830426019, 14351.0, 15179.620509487351, 15260.160691162093, 15756.842431575997, 16172.838271617133, 16428.67142657164, 13699.589012329647, 13968.02223844321, 15596.68806623884, 15610.0, 15722.685546289238, 14332.928335358256, 14488.637784055483, 14700.852991469948, 15138.848611514184, 15300.464483743015, 11643.243189192675, 12118.212316199419, 12157.270563766202, 12585.685357866127, 12655.746885062063, 10940.781184376427, 10981.61564345244, 11499.0, 11923.701907452383, 11940.820887686865, 10630.415327157081, 10861.67414977552, 11120.666380008613, 11292.491837867152, 12922.418491167731], "value": 7793.345074381291, "unit": "score"}], "name": "dromaeo_css", "value": 7303.2795221023325, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 127.0, 111.0, 113.0, 114.0, 111.0, 111.0, 111.0, 111.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 148.0, 173.0, 122.0, 148.0, 150.0, 127.0, 183.0, 123.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 174.0, 76.0, 75.0, 74.0, 74.0, 167.0, 77.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 146.0, 83.0, 83.0, 84.0, 141.0, 82.0, 82.0, 146.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 52.0, 53.0, 54.0, 53.0, 52.0, 52.0, 51.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 79.0, 82.0, 83.0, 79.0, 78.0, 79.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 124.0, 125.0, 125.0, 134.0, 131.0, 129.0, 129.0, 165.0, 135.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 163.0, 160.0, 162.0, 160.0, 162.0, 160.0, 165.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 65.0, 65.0, 65.0, 64.0, 63.0, 67.0, 64.0, 63.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1526.1, "alertThreshold": 2.0}]} 20:32:26 INFO - Return code: 0 20:32:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:32:26 INFO - # TBPL SUCCESS # 20:32:26 INFO - Running post-action listener: _resource_record_post_action 20:32:26 INFO - [mozharness: 2016-08-28 03:32:26.940097Z] Finished run-tests step (success) 20:32:26 INFO - Running post-run listener: _resource_record_post_run 20:32:27 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 423776256; Read time: 20; Write time: 353572 20:32:27 INFO - TinderboxPrint: CPU usage
13.1% 20:32:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 20:32:27 INFO - TinderboxPrint: I/O write bytes / time
423,776,256 / 353,572 20:32:27 INFO - TinderboxPrint: CPU idle
8,302.0 (86.9%) 20:32:27 INFO - TinderboxPrint: CPU user
1,197.6 (12.5%) 20:32:27 INFO - TinderboxPrint: Swap in / out
0 / 0 20:32:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 134488064; Read time: 0; Write time: 124848 20:32:27 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288673792; Read time: 0; Write time: 228724 20:32:27 INFO - Running post-run listener: _upload_blobber_files 20:32:27 INFO - Blob upload gear active. 20:32:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:32:27 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 20:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:32:27 INFO - Traceback (most recent call last): 20:32:27 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 20:32:27 INFO - main() 20:32:27 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 20:32:27 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 20:32:27 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 20:32:27 INFO - return set(response.json().get('whitelist', [])) 20:32:27 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 20:32:27 INFO - return json.loads(self.text or self.content, **kwargs) 20:32:27 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 20:32:27 INFO - return _default_decoder.decode(s) 20:32:27 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 20:32:27 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 20:32:27 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 20:32:27 INFO - raise ValueError("No JSON object could be decoded") 20:32:27 INFO - ValueError: No JSON object could be decoded 20:32:27 ERROR - Return code: 1 20:32:27 INFO - Setting buildbot property blobber_files to {} 20:32:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:32:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:32:27 INFO - Contents: 20:32:27 INFO - blobber_files:{} 20:32:27 INFO - Running post-run listener: copy_logs_to_upload_dir 20:32:27 INFO - Copying logs to upload dir... 20:32:27 INFO - mkdir: /builds/slave/test/build/upload/logs 20:32:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.470541 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-27 20:32:27.485183) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 20:32:27.488395) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/IKGJ4DsCSFCZqBr_qWeKmg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 20:32:27.540339) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 20:32:27.540871) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1472342724.705407-2006654675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 20:32:27.591748) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 20:32:27.592214) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 20:32:27.592518) ========= ========= Total master_lag: 0.17 =========