builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1469218120.79 results: success (0) buildid: 20160722083025 builduid: 90f9e25df22548d1a017b0ededf34064 revision: ff29f08b72c466b65dea5efa6f82f99add8f17ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:40.792742) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:40.793290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:40.793612) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:40.808497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:40.808861) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 13:08:40-- 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% 46.3M=0s 2016-07-22 13:08:40 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:40.938633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:40.939413) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015047 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:40.990303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 13:08:40.990735) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff29f08b72c466b65dea5efa6f82f99add8f17ef --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 ff29f08b72c466b65dea5efa6f82f99add8f17ef --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=5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 13:08:41,003 truncating revision to first 12 chars 2016-07-22 13:08:41,003 Setting DEBUG logging. 2016-07-22 13:08:41,003 attempt 1/10 2016-07-22 13:08:41,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff29f08b72c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 13:08:41,766 unpacking tar archive at: fx-team-ff29f08b72c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.140438 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 13:08:42.145522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:42.145883) ========= script_repo_revision: ff29f08b72c466b65dea5efa6f82f99add8f17ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:42.146337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:42.146635) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 13:08:42.156226) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-22 13:08:42.156597) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:08:42 INFO - MultiFileLogger online at 20160722 13:08:42 in /builds/slave/test 13:08:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:08:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:08:42 INFO - {'append_to_log': False, 13:08:42 INFO - 'base_work_dir': '/builds/slave/test', 13:08:42 INFO - 'blob_upload_branch': 'Fx-Team', 13:08:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:08:42 INFO - 'branch': 'Fx-Team', 13:08:42 INFO - 'buildbot_json_path': 'buildprops.json', 13:08:42 INFO - 'config_files': ('talos/linux_config.py',), 13:08:42 INFO - 'default_actions': ('clobber', 13:08:42 INFO - 'read-buildbot-config', 13:08:42 INFO - 'download-and-extract', 13:08:42 INFO - 'populate-webroot', 13:08:42 INFO - 'create-virtualenv', 13:08:42 INFO - 'install', 13:08:42 INFO - 'run-tests'), 13:08:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:08:42 INFO - 'download_minidump_stackwalk': True, 13:08:42 INFO - 'download_symbols': 'ondemand', 13:08:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:08:42 INFO - 'tooltool.py': '/tools/tooltool.py', 13:08:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:08:42 INFO - '/tools/misc-python/virtualenv.py')}, 13:08:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:08:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:08:42 INFO - 'installer_path': 'installer.exe', 13:08:42 INFO - 'log_level': 'info', 13:08:42 INFO - 'log_name': 'talos', 13:08:42 INFO - 'log_to_console': True, 13:08:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:08:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:08:42 INFO - 'opt_config_files': (), 13:08:42 INFO - 'pip_index': False, 13:08:42 INFO - 'sps_profile': False, 13:08:42 INFO - 'sps_profile_interval': 0, 13:08:42 INFO - 'suite': 'dromaeojs-e10s', 13:08:42 INFO - 'system_bits': '32', 13:08:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:08:42 INFO - 'title': 'talos-linux64-ix-011', 13:08:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:08:42 INFO - 'use_talos_json': True, 13:08:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:08:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:08:42 INFO - 'work_dir': 'build'} 13:08:42 INFO - [mozharness: 2016-07-22 20:08:42.257843Z] Running clobber step. 13:08:42 INFO - Running pre-action listener: _resource_record_pre_action 13:08:42 INFO - Running main action method: clobber 13:08:42 INFO - rmtree: /builds/slave/test/build 13:08:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:08:42 INFO - Running post-action listener: _resource_record_post_action 13:08:42 INFO - [mozharness: 2016-07-22 20:08:42.716652Z] Finished clobber step (success) 13:08:42 INFO - [mozharness: 2016-07-22 20:08:42.716754Z] Running read-buildbot-config step. 13:08:42 INFO - Running pre-action listener: _resource_record_pre_action 13:08:42 INFO - Running main action method: read_buildbot_config 13:08:42 INFO - Using buildbot properties: 13:08:42 INFO - { 13:08:42 INFO - "project": "", 13:08:42 INFO - "product": "firefox", 13:08:42 INFO - "script_repo_revision": "production", 13:08:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:08:42 INFO - "repository": "", 13:08:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 13:08:42 INFO - "buildid": "20160722083025", 13:08:42 INFO - "pgo_build": "True", 13:08:42 INFO - "basedir": "/builds/slave/test", 13:08:42 INFO - "buildnumber": 636, 13:08:42 INFO - "slavename": "talos-linux64-ix-011", 13:08:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:08:42 INFO - "platform": "ubuntu64_hw", 13:08:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:08:42 INFO - "branch": "fx-team", 13:08:42 INFO - "repo_path": "integration/fx-team", 13:08:42 INFO - "revision": "ff29f08b72c466b65dea5efa6f82f99add8f17ef", 13:08:42 INFO - "stage_platform": "linux64-pgo", 13:08:42 INFO - "builduid": "90f9e25df22548d1a017b0ededf34064", 13:08:42 INFO - "slavebuilddir": "test" 13:08:42 INFO - } 13:08:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:08:42 INFO - Running post-action listener: _resource_record_post_action 13:08:42 INFO - [mozharness: 2016-07-22 20:08:42.719439Z] Finished read-buildbot-config step (success) 13:08:42 INFO - [mozharness: 2016-07-22 20:08:42.719529Z] Running download-and-extract step. 13:08:42 INFO - Running pre-action listener: _resource_record_pre_action 13:08:42 INFO - Running main action method: download_and_extract 13:08:42 INFO - mkdir: /builds/slave/test/build/tests 13:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:42 INFO - https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:08:43 INFO - Downloaded 1361 bytes. 13:08:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:43 INFO - Using the following test package requirements: 13:08:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:08:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:08:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:08:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:43 INFO - u'jsshell-linux-x86_64.zip'], 13:08:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:08:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:08:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:08:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:08:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:08:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:08:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:43 INFO - https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:08:44 INFO - Downloaded 24308968 bytes. 13:08:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:08:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:08:45 INFO - Return code: 0 13:08:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:45 INFO - https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:08:46 INFO - Downloaded 24308968 bytes. 13:08:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:08:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:08:48 INFO - Return code: 0 13:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:48 INFO - https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:08:49 INFO - Downloaded 14403289 bytes. 13:08:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:08:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:08:50 INFO - Return code: 0 13:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:50 INFO - https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:08:51 INFO - Downloaded 60849208 bytes. 13:08:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:51 INFO - mkdir: /builds/slave/test/properties 13:08:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:08:51 INFO - Writing to file /builds/slave/test/properties/build_url 13:08:51 INFO - Contents: 13:08:51 INFO - build_url:https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:52 INFO - Running post-action listener: _resource_record_post_action 13:08:52 INFO - Running post-action listener: set_extra_try_arguments 13:08:52 INFO - [mozharness: 2016-07-22 20:08:52.258942Z] Finished download-and-extract step (success) 13:08:52 INFO - [mozharness: 2016-07-22 20:08:52.259177Z] Running populate-webroot step. 13:08:52 INFO - Running pre-action listener: _resource_record_pre_action 13:08:52 INFO - Running main action method: populate_webroot 13:08:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:08:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:08:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:08:52 INFO - '--tppagecycles', 13:08:52 INFO - '7'], 13:08:52 INFO - 'tests': ['tsvgm']}}, 13:08:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:08:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:08:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:08:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:08:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:08:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:08:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:52 INFO - 'talos_options': ['--disable-e10s'], 13:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:52 INFO - 'talos_options': ['--disable-e10s'], 13:08:52 INFO - 'tests': ['damp', 'tps']}, 13:08:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:52 INFO - 'tests': ['damp', 'tps']}, 13:08:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:08:52 INFO - 'tests': ['dromaeo_dom']}, 13:08:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:08:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:08:52 INFO - 'tests': ['basic_compositor_video']}, 13:08:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:08:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:08:52 INFO - 'tests': ['a11yr', 13:08:52 INFO - 'ts_paint', 13:08:52 INFO - 'tpaint', 13:08:52 INFO - 'sessionrestore', 13:08:52 INFO - 'sessionrestore_no_auto_restore', 13:08:52 INFO - 'tabpaint']}, 13:08:52 INFO - 'other-e10s': {'tests': ['a11yr', 13:08:52 INFO - 'ts_paint', 13:08:52 INFO - 'tpaint', 13:08:52 INFO - 'sessionrestore', 13:08:52 INFO - 'sessionrestore_no_auto_restore', 13:08:52 INFO - 'tabpaint']}, 13:08:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:08:52 INFO - 'ts_paint', 13:08:52 INFO - 'tpaint', 13:08:52 INFO - 'sessionrestore', 13:08:52 INFO - 'sessionrestore_no_auto_restore', 13:08:52 INFO - 'tabpaint']}, 13:08:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:08:52 INFO - 'ts_paint', 13:08:52 INFO - 'tpaint', 13:08:52 INFO - 'sessionrestore', 13:08:52 INFO - 'sessionrestore_no_auto_restore', 13:08:52 INFO - 'tabpaint']}, 13:08:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:08:52 INFO - 'tests': ['a11yr', 13:08:52 INFO - 'ts_paint', 13:08:52 INFO - 'tpaint', 13:08:52 INFO - 'sessionrestore', 13:08:52 INFO - 'sessionrestore_no_auto_restore', 13:08:52 INFO - 'tabpaint']}, 13:08:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:08:52 INFO - 'tests': ['a11yr', 13:08:52 INFO - 'ts_paint', 13:08:52 INFO - 'tpaint', 13:08:52 INFO - 'sessionrestore', 13:08:52 INFO - 'sessionrestore_no_auto_restore', 13:08:52 INFO - 'tabpaint']}, 13:08:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:08:52 INFO - 'tests': ['tsvgx', 13:08:52 INFO - 'tsvgr_opacity', 13:08:52 INFO - 'tart', 13:08:52 INFO - 'tscrollx', 13:08:52 INFO - 'cart']}, 13:08:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:08:52 INFO - 'tsvgr_opacity', 13:08:52 INFO - 'tart', 13:08:52 INFO - 'tscrollx', 13:08:52 INFO - 'cart']}, 13:08:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:52 INFO - 'talos_options': ['--disable-e10s'], 13:08:52 INFO - 'tests': ['tp5o']}, 13:08:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:52 INFO - 'tests': ['tp5o']}, 13:08:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:52 INFO - 'talos_options': ['--disable-e10s', 13:08:52 INFO - '--xperf_path', 13:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:52 INFO - 'tests': ['tp5n']}, 13:08:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:52 INFO - 'talos_options': ['--xperf_path', 13:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:52 INFO - 'tests': ['tp5n']}}, 13:08:52 INFO - 'talos.zip': {'path': '', 13:08:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:08:52 INFO - Running post-action listener: _resource_record_post_action 13:08:52 INFO - [mozharness: 2016-07-22 20:08:52.281401Z] Finished populate-webroot step (success) 13:08:52 INFO - [mozharness: 2016-07-22 20:08:52.281491Z] Running create-virtualenv step. 13:08:52 INFO - Running pre-action listener: _resource_record_pre_action 13:08:52 INFO - Running main action method: create_virtualenv 13:08:52 INFO - Creating virtualenv /builds/slave/test/build/venv 13:08:52 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 13:08:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:08:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:08:52 INFO - Using real prefix '/usr' 13:08:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:08:52 INFO - Installing distribute.............................................................................................................................................................................................done. 13:08:54 INFO - Installing pip.................done. 13:08:54 INFO - Return code: 0 13:08:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:54 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 0xb8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a3b0>, '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 0xe4b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', '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 13:08:54 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 13:08:54 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 13:08:54 INFO - Using env: {'DISPLAY': ':0', 13:08:54 INFO - 'HOME': '/home/cltbld', 13:08:54 INFO - 'LANG': 'en_US.UTF-8', 13:08:54 INFO - 'LANGUAGE': 'en_US:en', 13:08:54 INFO - 'LOGNAME': 'cltbld', 13:08:54 INFO - 'MAIL': '/var/mail/cltbld', 13:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:54 INFO - 'MOZ_NO_REMOTE': '1', 13:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:54 INFO - 'NO_EM_RESTART': '1', 13:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:54 INFO - 'PWD': '/builds/slave/test', 13:08:54 INFO - 'SHELL': '/bin/bash', 13:08:54 INFO - 'SHLVL': '1', 13:08:54 INFO - 'TERM': 'linux', 13:08:54 INFO - 'TMOUT': '86400', 13:08:54 INFO - 'USER': 'cltbld', 13:08:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', 13:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:54 INFO - '_': '/tools/buildbot/bin/python'} 13:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:55 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 13:08:55 INFO - Cleaning up... 13:08:55 INFO - Return code: 0 13:08:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a3b0>, '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 0xe4b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', '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 13:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:08:55 INFO - Using env: {'DISPLAY': ':0', 13:08:55 INFO - 'HOME': '/home/cltbld', 13:08:55 INFO - 'LANG': 'en_US.UTF-8', 13:08:55 INFO - 'LANGUAGE': 'en_US:en', 13:08:55 INFO - 'LOGNAME': 'cltbld', 13:08:55 INFO - 'MAIL': '/var/mail/cltbld', 13:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:55 INFO - 'MOZ_NO_REMOTE': '1', 13:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:55 INFO - 'NO_EM_RESTART': '1', 13:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:55 INFO - 'PWD': '/builds/slave/test', 13:08:55 INFO - 'SHELL': '/bin/bash', 13:08:55 INFO - 'SHLVL': '1', 13:08:55 INFO - 'TERM': 'linux', 13:08:55 INFO - 'TMOUT': '86400', 13:08:55 INFO - 'USER': 'cltbld', 13:08:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', 13:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:55 INFO - '_': '/tools/buildbot/bin/python'} 13:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:55 INFO - Downloading/unpacking psutil>=3.1.1 13:08:55 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 13:08:55 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 13:08:55 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 13:08:55 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 13:08:55 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 13:08:55 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 13:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:58 INFO - Installing collected packages: psutil 13:08:58 INFO - Running setup.py install for psutil 13:08:58 INFO - building 'psutil._psutil_linux' extension 13:08:58 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 13:08:58 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 13:08:58 INFO - building 'psutil._psutil_posix' extension 13:08:58 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 13:08:58 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 13:08:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:00 INFO - Successfully installed psutil 13:09:00 INFO - Cleaning up... 13:09:00 INFO - Return code: 0 13:09:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:00 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 0xb8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a3b0>, '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 0xe4b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', '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 13:09:00 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 13:09:00 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 13:09:00 INFO - Using env: {'DISPLAY': ':0', 13:09:00 INFO - 'HOME': '/home/cltbld', 13:09:00 INFO - 'LANG': 'en_US.UTF-8', 13:09:00 INFO - 'LANGUAGE': 'en_US:en', 13:09:00 INFO - 'LOGNAME': 'cltbld', 13:09:00 INFO - 'MAIL': '/var/mail/cltbld', 13:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:00 INFO - 'MOZ_NO_REMOTE': '1', 13:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:00 INFO - 'NO_EM_RESTART': '1', 13:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:00 INFO - 'PWD': '/builds/slave/test', 13:09:00 INFO - 'SHELL': '/bin/bash', 13:09:00 INFO - 'SHLVL': '1', 13:09:00 INFO - 'TERM': 'linux', 13:09:00 INFO - 'TMOUT': '86400', 13:09:00 INFO - 'USER': 'cltbld', 13:09:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', 13:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:00 INFO - '_': '/tools/buildbot/bin/python'} 13:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:09:02 INFO - Installing collected packages: mozsystemmonitor 13:09:02 INFO - Running setup.py install for mozsystemmonitor 13:09:02 INFO - Successfully installed mozsystemmonitor 13:09:02 INFO - Cleaning up... 13:09:02 INFO - Return code: 0 13:09:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:02 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 0xb8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a3b0>, '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 0xe4b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', '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 13:09:02 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 13:09:02 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 13:09:02 INFO - Using env: {'DISPLAY': ':0', 13:09:02 INFO - 'HOME': '/home/cltbld', 13:09:02 INFO - 'LANG': 'en_US.UTF-8', 13:09:02 INFO - 'LANGUAGE': 'en_US:en', 13:09:02 INFO - 'LOGNAME': 'cltbld', 13:09:02 INFO - 'MAIL': '/var/mail/cltbld', 13:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:02 INFO - 'MOZ_NO_REMOTE': '1', 13:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:02 INFO - 'NO_EM_RESTART': '1', 13:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:02 INFO - 'PWD': '/builds/slave/test', 13:09:02 INFO - 'SHELL': '/bin/bash', 13:09:02 INFO - 'SHLVL': '1', 13:09:02 INFO - 'TERM': 'linux', 13:09:02 INFO - 'TMOUT': '86400', 13:09:02 INFO - 'USER': 'cltbld', 13:09:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', 13:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:02 INFO - '_': '/tools/buildbot/bin/python'} 13:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:02 INFO - Downloading/unpacking jsonschema==2.5.1 13:09:02 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 13:09:02 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 13:09:02 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 13:09:02 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 13:09:02 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 13:09:02 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 13:09:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:09:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:09:04 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 13:09:04 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 13:09:04 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 13:09:04 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 13:09:04 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 13:09:04 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 13:09:04 INFO - Downloading functools32-3.2.3-2.tar.gz 13:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:09:04 INFO - warning: no files found matching '*.txt' 13:09:04 INFO - no previously-included directories found matching 'build' 13:09:04 INFO - no previously-included directories found matching 'dist' 13:09:04 INFO - no previously-included directories found matching '.git*' 13:09:04 INFO - Installing collected packages: jsonschema, functools32 13:09:04 INFO - Running setup.py install for functools32 13:09:04 INFO - warning: no files found matching '*.txt' 13:09:04 INFO - no previously-included directories found matching 'build' 13:09:04 INFO - no previously-included directories found matching 'dist' 13:09:04 INFO - no previously-included directories found matching '.git*' 13:09:05 INFO - Successfully installed jsonschema functools32 13:09:05 INFO - Cleaning up... 13:09:05 INFO - Return code: 0 13:09:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:05 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 0xb8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a3b0>, '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 0xe4b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', '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 13:09:05 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 13:09:05 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 13:09:05 INFO - Using env: {'DISPLAY': ':0', 13:09:05 INFO - 'HOME': '/home/cltbld', 13:09:05 INFO - 'LANG': 'en_US.UTF-8', 13:09:05 INFO - 'LANGUAGE': 'en_US:en', 13:09:05 INFO - 'LOGNAME': 'cltbld', 13:09:05 INFO - 'MAIL': '/var/mail/cltbld', 13:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:05 INFO - 'MOZ_NO_REMOTE': '1', 13:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:05 INFO - 'NO_EM_RESTART': '1', 13:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:05 INFO - 'PWD': '/builds/slave/test', 13:09:05 INFO - 'SHELL': '/bin/bash', 13:09:05 INFO - 'SHLVL': '1', 13:09:05 INFO - 'TERM': 'linux', 13:09:05 INFO - 'TMOUT': '86400', 13:09:05 INFO - 'USER': 'cltbld', 13:09:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', 13:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:05 INFO - '_': '/tools/buildbot/bin/python'} 13:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:05 INFO - Downloading/unpacking blobuploader==1.2.4 13:09:05 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 13:09:05 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 13:09:05 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 13:09:05 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 13:09:05 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 13:09:05 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 13:09:07 INFO - Downloading blobuploader-1.2.4.tar.gz 13:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:09:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:09:07 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 13:09:07 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 13:09:07 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 13:09:07 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 13:09:07 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 13:09:07 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 13:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:09:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:09:07 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 13:09:07 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 13:09:07 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 13:09:07 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 13:09:07 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 13:09:07 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 13:09:07 INFO - Downloading docopt-0.6.1.tar.gz 13:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:09:07 INFO - Installing collected packages: blobuploader, requests, docopt 13:09:07 INFO - Running setup.py install for blobuploader 13:09:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:09:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:09:08 INFO - Running setup.py install for requests 13:09:08 INFO - Running setup.py install for docopt 13:09:08 INFO - Successfully installed blobuploader requests docopt 13:09:08 INFO - Cleaning up... 13:09:08 INFO - Return code: 0 13:09:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:08 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 0xb8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a3b0>, '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 0xe4b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', '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 13:09:08 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 13:09:08 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 13:09:08 INFO - Using env: {'DISPLAY': ':0', 13:09:08 INFO - 'HOME': '/home/cltbld', 13:09:08 INFO - 'LANG': 'en_US.UTF-8', 13:09:08 INFO - 'LANGUAGE': 'en_US:en', 13:09:08 INFO - 'LOGNAME': 'cltbld', 13:09:08 INFO - 'MAIL': '/var/mail/cltbld', 13:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:08 INFO - 'MOZ_NO_REMOTE': '1', 13:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:08 INFO - 'NO_EM_RESTART': '1', 13:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:08 INFO - 'PWD': '/builds/slave/test', 13:09:08 INFO - 'SHELL': '/bin/bash', 13:09:08 INFO - 'SHLVL': '1', 13:09:08 INFO - 'TERM': 'linux', 13:09:08 INFO - 'TMOUT': '86400', 13:09:08 INFO - 'USER': 'cltbld', 13:09:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', 13:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:08 INFO - '_': '/tools/buildbot/bin/python'} 13:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:08 INFO - Running setup.py (path:/tmp/pip-wjT5Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:08 INFO - Running setup.py (path:/tmp/pip-__WUnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:08 INFO - Running setup.py (path:/tmp/pip-8Puwut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:09 INFO - Running setup.py (path:/tmp/pip-2Eajqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:09 INFO - Running setup.py (path:/tmp/pip-LloO7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:09 INFO - Running setup.py (path:/tmp/pip-_GwoZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:09 INFO - Running setup.py (path:/tmp/pip-3f7tlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:09 INFO - Running setup.py (path:/tmp/pip-YXK2Tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:09 INFO - Running setup.py (path:/tmp/pip-rc0qFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:09 INFO - Running setup.py (path:/tmp/pip-cDNWrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:09 INFO - Running setup.py (path:/tmp/pip-SxACYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:09 INFO - Running setup.py (path:/tmp/pip-3yBZ55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:09 INFO - Running setup.py (path:/tmp/pip-9JvbXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:09 INFO - Running setup.py (path:/tmp/pip-ud28mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:09 INFO - Running setup.py (path:/tmp/pip-bOl4wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:09 INFO - Running setup.py (path:/tmp/pip-vgESZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:09 INFO - Running setup.py (path:/tmp/pip-t6TlOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:09:10 INFO - Running setup.py install for manifestparser 13:09:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:09:10 INFO - Running setup.py install for mozcrash 13:09:10 INFO - Running setup.py install for mozdebug 13:09:10 INFO - Running setup.py install for mozdevice 13:09:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:09:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:09:10 INFO - Running setup.py install for mozfile 13:09:10 INFO - Running setup.py install for mozhttpd 13:09:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:09:10 INFO - Running setup.py install for mozinfo 13:09:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:09:10 INFO - Running setup.py install for mozInstall 13:09:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:09:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:09:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:09:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:09:10 INFO - Running setup.py install for mozleak 13:09:10 INFO - Running setup.py install for mozlog 13:09:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:09:11 INFO - Running setup.py install for moznetwork 13:09:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:09:11 INFO - Running setup.py install for mozprocess 13:09:11 INFO - Running setup.py install for mozprofile 13:09:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:09:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:09:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:09:11 INFO - Running setup.py install for mozrunner 13:09:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:09:11 INFO - Running setup.py install for mozscreenshot 13:09:11 INFO - Running setup.py install for moztest 13:09:11 INFO - Running setup.py install for mozversion 13:09:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:09:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:09:11 INFO - Cleaning up... 13:09:11 INFO - Return code: 0 13:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:11 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 0xb8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a3b0>, '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 0xe4b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', '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 13:09:11 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 13:09:11 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 13:09:11 INFO - Using env: {'DISPLAY': ':0', 13:09:11 INFO - 'HOME': '/home/cltbld', 13:09:11 INFO - 'LANG': 'en_US.UTF-8', 13:09:11 INFO - 'LANGUAGE': 'en_US:en', 13:09:11 INFO - 'LOGNAME': 'cltbld', 13:09:11 INFO - 'MAIL': '/var/mail/cltbld', 13:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:11 INFO - 'MOZ_NO_REMOTE': '1', 13:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:11 INFO - 'NO_EM_RESTART': '1', 13:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:11 INFO - 'PWD': '/builds/slave/test', 13:09:11 INFO - 'SHELL': '/bin/bash', 13:09:11 INFO - 'SHLVL': '1', 13:09:11 INFO - 'TERM': 'linux', 13:09:11 INFO - 'TMOUT': '86400', 13:09:11 INFO - 'USER': 'cltbld', 13:09:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', 13:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:11 INFO - '_': '/tools/buildbot/bin/python'} 13:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:12 INFO - Running setup.py (path:/tmp/pip-CAdx0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:12 INFO - Running setup.py (path:/tmp/pip-icMzt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:12 INFO - Running setup.py (path:/tmp/pip-DjAVPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:12 INFO - Running setup.py (path:/tmp/pip-RygKQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:12 INFO - Running setup.py (path:/tmp/pip-LwEWzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:12 INFO - Running setup.py (path:/tmp/pip-bB3ipx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:12 INFO - Running setup.py (path:/tmp/pip-DrdSgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:12 INFO - Running setup.py (path:/tmp/pip-J8TdyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:12 INFO - Running setup.py (path:/tmp/pip-pC1mg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:12 INFO - Running setup.py (path:/tmp/pip-wY6wEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:12 INFO - Running setup.py (path:/tmp/pip-JhiO3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:12 INFO - Running setup.py (path:/tmp/pip-fTI188-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:12 INFO - Running setup.py (path:/tmp/pip-V2feCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:12 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)) 13:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:12 INFO - Running setup.py (path:/tmp/pip-nTaNtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:13 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)) 13:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:13 INFO - Running setup.py (path:/tmp/pip-c1Ef_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:13 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)) 13:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:13 INFO - Running setup.py (path:/tmp/pip-qPtFB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:13 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)) 13:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:13 INFO - Running setup.py (path:/tmp/pip-tbRI1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:13 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)) 13:09:13 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)) 13:09:13 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)) 13:09:13 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)) 13:09:13 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)) 13:09:13 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)) 13:09:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09:15 INFO - Downloading blessings-1.6.tar.gz 13:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:09:15 INFO - Installing collected packages: blessings 13:09:15 INFO - Running setup.py install for blessings 13:09:15 INFO - Successfully installed blessings 13:09:15 INFO - Cleaning up... 13:09:15 INFO - Return code: 0 13:09:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:15 INFO - Reading from file tmpfile_stdout 13:09:15 INFO - Current package versions: 13:09:15 INFO - argparse == 1.2.1 13:09:15 INFO - blessings == 1.6 13:09:15 INFO - blobuploader == 1.2.4 13:09:15 INFO - docopt == 0.6.1 13:09:15 INFO - functools32 == 3.2.3-2 13:09:15 INFO - jsonschema == 2.5.1 13:09:15 INFO - manifestparser == 1.1 13:09:15 INFO - mozInstall == 1.12 13:09:15 INFO - mozcrash == 0.17 13:09:15 INFO - mozdebug == 0.1 13:09:15 INFO - mozdevice == 0.48 13:09:15 INFO - mozfile == 1.2 13:09:15 INFO - mozhttpd == 0.7 13:09:15 INFO - mozinfo == 0.9 13:09:15 INFO - mozleak == 0.1 13:09:15 INFO - mozlog == 3.3 13:09:15 INFO - moznetwork == 0.27 13:09:15 INFO - mozprocess == 0.23 13:09:15 INFO - mozprofile == 0.28 13:09:15 INFO - mozrunner == 6.12 13:09:15 INFO - mozscreenshot == 0.1 13:09:15 INFO - mozsystemmonitor == 0.3 13:09:15 INFO - moztest == 0.7 13:09:15 INFO - mozversion == 1.4 13:09:15 INFO - psutil == 3.1.1 13:09:15 INFO - requests == 1.2.3 13:09:15 INFO - wsgiref == 0.1.2 13:09:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:15 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 0xb8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a3b0>, '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 0xe4b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', '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 13:09:15 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 13:09:15 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 13:09:15 INFO - Using env: {'DISPLAY': ':0', 13:09:15 INFO - 'HOME': '/home/cltbld', 13:09:15 INFO - 'LANG': 'en_US.UTF-8', 13:09:15 INFO - 'LANGUAGE': 'en_US:en', 13:09:15 INFO - 'LOGNAME': 'cltbld', 13:09:15 INFO - 'MAIL': '/var/mail/cltbld', 13:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:15 INFO - 'MOZ_NO_REMOTE': '1', 13:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:15 INFO - 'NO_EM_RESTART': '1', 13:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:15 INFO - 'PWD': '/builds/slave/test', 13:09:15 INFO - 'SHELL': '/bin/bash', 13:09:15 INFO - 'SHLVL': '1', 13:09:15 INFO - 'TERM': 'linux', 13:09:15 INFO - 'TMOUT': '86400', 13:09:15 INFO - 'USER': 'cltbld', 13:09:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', 13:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:15 INFO - '_': '/tools/buildbot/bin/python'} 13:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:15 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)) 13:09:15 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)) 13:09:15 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)) 13:09:15 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)) 13:09:15 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)) 13:09:15 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)) 13:09:15 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)) 13:09:15 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)) 13:09:15 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)) 13:09:15 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)) 13:09:15 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)) 13:09:15 INFO - Cleaning up... 13:09:15 INFO - Return code: 0 13:09:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a3b0>, '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 0xe4b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b740>, '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': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', '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 13:09: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'] in /builds/slave/test/build 13:09: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 13:09:15 INFO - Using env: {'DISPLAY': ':0', 13:09:15 INFO - 'HOME': '/home/cltbld', 13:09:15 INFO - 'LANG': 'en_US.UTF-8', 13:09:15 INFO - 'LANGUAGE': 'en_US:en', 13:09:15 INFO - 'LOGNAME': 'cltbld', 13:09:15 INFO - 'MAIL': '/var/mail/cltbld', 13:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:15 INFO - 'MOZ_NO_REMOTE': '1', 13:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:15 INFO - 'NO_EM_RESTART': '1', 13:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:15 INFO - 'PWD': '/builds/slave/test', 13:09:15 INFO - 'SHELL': '/bin/bash', 13:09:15 INFO - 'SHLVL': '1', 13:09:15 INFO - 'TERM': 'linux', 13:09:15 INFO - 'TMOUT': '86400', 13:09:15 INFO - 'USER': 'cltbld', 13:09:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', 13:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:15 INFO - '_': '/tools/buildbot/bin/python'} 13:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:09:16 INFO - Cleaning up... 13:09:16 INFO - Return code: 0 13:09:16 INFO - Running post-action listener: _resource_record_post_action 13:09:16 INFO - Running post-action listener: _start_resource_monitoring 13:09:16 INFO - Starting resource monitoring. 13:09:16 INFO - [mozharness: 2016-07-22 20:09:16.110249Z] Finished create-virtualenv step (success) 13:09:16 INFO - [mozharness: 2016-07-22 20:09:16.110692Z] Running install step. 13:09:16 INFO - Running pre-action listener: _resource_record_pre_action 13:09:16 INFO - Running main action method: install 13:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:16 INFO - Reading from file tmpfile_stdout 13:09:16 INFO - Detecting whether we're running mozinstall >=1.0... 13:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:09:16 INFO - Reading from file tmpfile_stdout 13:09:16 INFO - Output received: 13:09:16 INFO - Usage: mozinstall [options] installer 13:09:16 INFO - Options: 13:09:16 INFO - -h, --help show this help message and exit 13:09:16 INFO - -d DEST, --destination=DEST 13:09:16 INFO - Directory to install application into. [default: 13:09:16 INFO - "/builds/slave/test"] 13:09:16 INFO - --app=APP Application being installed. [default: firefox] 13:09:16 INFO - mkdir: /builds/slave/test/build/application 13:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:09:33 INFO - Reading from file tmpfile_stdout 13:09:33 INFO - Output received: 13:09:33 INFO - /builds/slave/test/build/application/firefox/firefox 13:09:33 INFO - Running post-action listener: _resource_record_post_action 13:09:33 INFO - [mozharness: 2016-07-22 20:09:33.625109Z] Finished install step (success) 13:09:33 INFO - [mozharness: 2016-07-22 20:09:33.625418Z] Running run-tests step. 13:09:33 INFO - Running pre-action listener: _resource_record_pre_action 13:09:33 INFO - Running main action method: run_tests 13:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:09:33 INFO - Python 2.7.3 13:09:33 INFO - Return code: 0 13:09:33 INFO - grabbing minidump binary from tooltool 13:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:33 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 0xe4a3b0>, '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 0xe4b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:09:33 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 13:09:33 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 13:09:33 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 13:09:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:09:33 INFO - Return code: 0 13:09:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:09:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:09:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:09:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:09:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:09:33 INFO - Using env: {'DISPLAY': ':0', 13:09:33 INFO - 'HOME': '/home/cltbld', 13:09:33 INFO - 'LANG': 'en_US.UTF-8', 13:09:33 INFO - 'LANGUAGE': 'en_US:en', 13:09:33 INFO - 'LOGNAME': 'cltbld', 13:09:33 INFO - 'MAIL': '/var/mail/cltbld', 13:09:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:09:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:33 INFO - 'MOZ_NO_REMOTE': '1', 13:09:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:33 INFO - 'NO_EM_RESTART': '1', 13:09:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:33 INFO - 'PWD': '/builds/slave/test', 13:09:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:09:33 INFO - 'SHELL': '/bin/bash', 13:09:33 INFO - 'SHLVL': '1', 13:09:33 INFO - 'TERM': 'linux', 13:09:33 INFO - 'TMOUT': '86400', 13:09:33 INFO - 'USER': 'cltbld', 13:09:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292', 13:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:33 INFO - '_': '/tools/buildbot/bin/python'} 13:09:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:09:33 INFO - mozversion application_buildid: 20160722083025 13:09:33 INFO - mozversion application_changeset: ff29f08b72c466b65dea5efa6f82f99add8f17ef 13:09:33 INFO - mozversion application_display_name: Nightly 13:09:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:09:33 INFO - mozversion application_name: Firefox 13:09:33 INFO - mozversion application_remotingname: firefox 13:09:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:09:33 INFO - mozversion application_vendor: Mozilla 13:09:33 INFO - mozversion application_version: 50.0a1 13:09:33 INFO - mozversion platform_buildid: 20160722083025 13:09:33 INFO - mozversion platform_changeset: ff29f08b72c466b65dea5efa6f82f99add8f17ef 13:09:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:09:33 INFO - mozversion platform_version: 50.0a1 13:09:33 INFO - using testdate: 1469218173 13:09:33 INFO - actual date: 1469218173 13:09:33 INFO - starting webserver on 'localhost:39786' 13:09:33 INFO - SUITE-START | Running 2 tests 13:09:33 INFO - TEST-START | dromaeo_css 13:09:33 INFO - operating with platform_type : linux_ 13:09:33 INFO - Initialising browser for dromaeo_css test... 13:09:33 INFO - TEST-INFO | started process 7361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDRgekY/profile http://localhost:39786/getInfo.html) 13:09:37 INFO - PROCESS | 7361 | JavaScript error: , line 0: uncaught exception: undefined 13:09:39 INFO - PROCESS | 7361 | __metrics Screen width/height:1600/1200 13:09:39 INFO - PROCESS | 7361 | colorDepth:24 13:09:39 INFO - PROCESS | 7361 | Browser inner width/height: 1024/697 13:09:39 INFO - PROCESS | 7361 | __metrics 13:09:39 ERROR - PROCESS | 7361 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:09:40 INFO - TEST-INFO | 7361: exit 0 13:09:40 INFO - Browser initialized. 13:09:40 INFO - Running cycle 1/1 for dromaeo_css test... 13:09:40 INFO - TEST-INFO | started process 7484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDRgekY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:52 INFO - PROCESS | 7484 | RSS: Main: 167628800 13:09:52 INFO - PROCESS | 7484 | 13:10:42 INFO - PROCESS | 7484 | 1469218242045 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] 13:12:50 INFO - PROCESS | 7484 | Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39786/tests/dromaeo/cssquery-ext.html) 13:12:51 INFO - PROCESS | 7484 | RSS: Main: 172539904 13:12:51 INFO - PROCESS | 7484 | 13:15:53 INFO - PROCESS | 7484 | Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-ext.html (next: http://localhost:39786/tests/dromaeo/cssquery-jquery.html) 13:15:53 INFO - PROCESS | 7484 | RSS: Main: 169394176 13:15:53 INFO - PROCESS | 7484 | 13:18:55 INFO - PROCESS | 7484 | Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39786/tests/dromaeo/cssquery-mootools.html) 13:18:56 INFO - PROCESS | 7484 | RSS: Main: 173002752 13:18:56 INFO - PROCESS | 7484 | 13:21:58 INFO - PROCESS | 7484 | Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39786/tests/dromaeo/cssquery-prototype.html) 13:21:58 INFO - PROCESS | 7484 | RSS: Main: 168374272 13:21:58 INFO - PROCESS | 7484 | 13:25:01 INFO - PROCESS | 7484 | Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39786/tests/dromaeo/cssquery-yui.html) 13:25:01 INFO - PROCESS | 7484 | RSS: Main: 170098688 13:25:01 INFO - PROCESS | 7484 | 13:28:04 INFO - PROCESS | 7484 | Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-yui.html (next: http://localhost:39786/tests/dromaeo/cssquery-dojo.html) 13:28:04 INFO - PROCESS | 7484 | RSS: Main: 172978176 13:28:04 INFO - PROCESS | 7484 | 13:28:04 INFO - PROCESS | 7484 | __start_tp_report 13:28:04 INFO - PROCESS | 7484 | _x_x_mozilla_page_load 13:28:04 INFO - PROCESS | 7484 | _x_x_mozilla_page_load_details 13:28:04 INFO - PROCESS | 7484 | |i|pagename|runs| 13:28:04 INFO - PROCESS | 7484 | |0;dojo.html;3045.4974929136692;3081.429935461939;3104.2860142167315;3105.875764969401;3110.5489703992935;5395.298611180546;5404.594655400841;5416.214648875911;5481.945180548193;5550.056490396632;5362.4637536246355;5367.275417818593;5403.648762830413;5434.755436005379;5469.507744303012;4876.341693871335;4905.484924082955;5010.849674509771;5060.165072762989;5089.847304580869;4890.633202509826;5096.108181068316;5111.207762796754;5128.9230661540105;5133.614978876581;4865.0756356292195;4882.707037577739;4888.437829649601;4943.802247910097;4974.552290293873;4956.653034287601;4957.859692270762;4960.975195124001;4970;5017.397912250553;4914.7788349524;4926.0394223126505;4937.481564435754;4939.975300123477;4998.525140111684;5289.761960711778;5332.626716129873;5381.327334083239;5439.401665816757;5477.315335583052;5809.3609702932645;5824.446677565625;5830.941690583082;5843.415658434165;5860.677662728548;5839.883202335929;5858.794942177046;5864.384239654817;5866.911996320058;5875.471207591338;5327.547158491533;5341.198820177005;5347.51872331492;5475.917861232085;5476.397596264408;5872.911906321408;5900.1739756434135;5902.704864756745;5911.408859114054;5959.404059594006;5688.573356998241;5689.6586204827845;5689.943100569024;5692.117721753135;5713.914291285634;5611.8597035073635;5774.509166720792;5790.42095790426;5792.044312688359;5810.070388737781;5677.432256774289;5770.509506691894;5810.970945145332;5886.94113058864;5913.645181289136;5864.237649105674;5881.235439392937;5897.292324921037;5904.468597826216;5904.734286957011;4346.587074227943;4480.260756975063;4488.753118578445;4489.461264648263;4536.024754677695;3943.2902077626304;3947.2500224957166;3951.9802400988387;3972.741771784825;4025.677945764332;5619.719014049281;5621.100623900156;5647.887042259132;5659.8019069333195;5687.260656114679;5907.645541267538;5912.526997840162;5919.437653423004;5929.407059294036;5932.79235226765;5542.445755424425;5564.554835613141;5628.437156284339;5630.746616402272;5655.349634791969;5078.187490001582;5096.796128154832;5099.847004589868;5116.692998420107;5139.100657384943;6073.0283154695035;6094.8171554853425;6102.267727872595;6102.298235702862;6114.052321890114;5732.254806875079;5787.884242315046;5791.623544469596;5793.015187418065;5822.621529600562;5905.970470147622;5942.316633587193;5993.580449368676;5997.4002599741425;6030.6080104793045;5666.263385759825;5704.885902281848;5708.029634961983;5709.7145142741865;5711.543076553782;5695.487406133468;5743.942560574341;5788.855278618068;5792.623479473821;5796.884062318814;5627.071533196977;5640.492355687844;5642.802501912413;5660.688662123623;5683.005474041944;5600.551955843442;5633.549316054788;5643.576731745054;5648.604597678287;5664.0371136906;5499.780008799603;5563.7774489019985;5590.496855283044;5642.60501764889;5667.036603777286;5701.590154522047;5717.885642287048;5741.655500669973;5766.769329226784;5787.305523337226;5604.159376093618;5616.1014237721765;5622.32532096151;5652.7738890443925;5658.462446067617 13:28:04 INFO - PROCESS | 7484 | |1;ext.html;558.5258037946613;590.2798585725415;597.1967703438874;604.8004158627654;614.8647297594528;35553;36427;42882.57117428825;43800.56199438005;43902.34146487805;46265.30602040972;46657.7667111664;46668.53331466684;46740.29889551651;46809.531904680945;8948.32887533436;9131.406458580172;9136.177744003038;9141.314401419886;9142.13149750776;8996.68511602094;9085.54572271387;9086.182243598076;9086.591103400362;9093.909060909373;9088.681896133636;9144.908550914506;9148.817023659523;9155.67955121571;9163.35856490046;9040.909590904073;9053;9115.999999999967;9118.088191180828;9122.817543649124;8955.41789783662;9024.954875225581;9033.593488292976;9056.728298151065;9071.954640226822;44282.33576496355;44400.77799610981;44543;44670.10659786819;44693.77653111746;3694.8706795262037;3740.345439548068;3912.941305880414;3938.645521903014;4309.332053531676;33850.661493385;34096.659033409844;34533.30933381318;35495.82252088749;35709.64290357089;4456.977715111436;4513.340289163783;4607.470140933769;4690.296455531663;4695.530446955311;375179;375485;376485.99999999726;376889;377334;56670.71664641733;57102;57241.14138287929;57409.71295143497;57545.13682294769;60757.69621151866;60999;61043.69478152581;61346.693266534276;61400.38599614036;15983.280752366172;16300.836991629933;16405.097719625534;16622.584435389213;16891.91554042222;12922.612321630366;12948.935255323851;12974.740505190031;12986.220826750425;12987.610371688676;19594.118264678124;19807.60384792325;19808;19854.40436786899;19921.60156796856;7196.208417074117;7300.671469783872;7418.258174182539;7601.277878601524;7617.619119044026;1024.2522958240527;1129.5989923577176;1137.4710759496709;1151.3725019864194;1154.7170943118822;33399.66600334014;33565.16087097793;33581.32837343239;33979.830100849336;33999;1139.4416735799398;1140.1790710688292;1205.2045649871043;1212.6180253220207;1241.9813702794465;17436.825631743774;17495.82504174942;17540.561485962953;17607.911960440117;17762.5559361017;553206;556906;558957;560130;560285;60480;60719.392806072254;60959;61106.38893611007;61377;1351.6823546466574;1376.2224343246235;1378.5657517881834;1385.189664046544;1396.7066915947562;31370.843145784125;33054;33123;33290.334193316485;33707.325853483286;50901.49098509116;51132;51403.22895156501;51426;51492;408667;408819;409546;410345;412439;27477.45045099127;27911.581326279716;27971.580426293214;28043.57934631023;28063.298417538907;49309.2603610939;49773;49818.501814981384;50327.49672503228;50591.241131382325;40542;41896.58103419049;42256.36615450832;42493.150136997705;43256.78371608122;41621;41693;41715.37426938538;42757.35863962105;42866.78566607147;41421.1715765689;42188.78905605452;42598.57401425946;43174.568254318314;44541;32318.35363292768;36897.81551092335;37045;38623.42064868973;38734.418983714706;28371.432571348043;28621.713782861905;28670.713292866803;28884.27789305284;28913.56629650599 13:28:04 INFO - PROCESS | 7484 | |2;jquery.html;375.32066958804546;383.66046049246415;385.3891581842779;398.76472881000205;400.3054700095334;18717.4384768457;19552.608947821034;20795.376138715827;20933;21162.89418552907;10683.30558513696;11179.32924024557;11264.43677816108;11277.266977646468;15564.37742490299;5198.324217851674;5398.325209348832;5398.460153984609;5399.649022813524;5419.105847535152;3923.8038098095126;5250;5642.74607642655;5807.448292412214;5850.210221620069;5876.70616469177;5880;5889.057750759879;5901.734421951022;5902.2622172228475;6319.336469670688;6455.8063258101865;6537.607743535379;6547;6592.30780768022;4876;5104.540591346797;5771.567132465082;5779.075347944308;5779.739911703983;12882;13106.148100373444;13109.737805243842;13195.934020329933;20993.160273589037;2179.1936983316273;2296.954060918789;2548.2227920484247;2671.7461841125064;2717.904873329424;10011.249156313306;10247.38515689061;12220.450079746433;13816.93091534536;13819.792703109462;1876.193236908129;1885.6700077486523;1956.2664000999625;1965.7149713291492;1973.190991693399;80823.5958820208;82459.5877020617;82532.58733706352;83189;84946.57526712389;10301.9484902575;10392.116670083127;10522;10546.894531054591;10583.624128863199;14285.857141428452;14381.424743010371;14442.927785361006;14468.493602723855;14490;8063.959680201561;8131.512109273463;8317.8336433271;8444.57777111142;8485.151484851589;8167.346612271004;8181.877271840927;8259.876101858477;8275.420720549504;8385.413021088465;4404.603585677304;4464.732116073046;4524.434445694288;4553.225951588238;4555.111753208159;1576.747720364759;1677.4232221711552;1690.5435532406182;1854.6476169527746;1884.604233111062;968.5980318168022;972.9854052189223;989.0258095775655;1000.9949950250348;1067.204932325407;19428.708569371473;19651;20184.69722954157;20191;20453.38639840807;984.17329443268;991.3209451525584;1025.5333823110466;1043.3791893823163;1050.3855244681795;10592.258541901992;10763.461826908624;11108.389038602954;11189.776204476027;11647.301161930141;521286;522113;525632;530708;556410;93960.53019734858;96418;96903;99271.50364248133;100360;990.3067852503276;1031.2781053262745;1047.041956609709;1048.7227414330218;1065.7335666083634;10289.868114507548;11107.611233606785;17805.643887122445;17900.28398864031;18823.152958116643;41806.79096604497;42310.7884460588;42372.57627423686;42714.78642606767;42770.5722942779;57213;57897;59144.40855591561;61439;62121.37878621156;11091.38997355121;12178.878211218129;12328.19866708661;12595.685107872376;12825.102242842911;13238.602841914759;13703.657408564466;13777.311134443038;13891.791623125864;14076.507322243673;12180.878191217975;12198.207116537396;12229.449674764479;12601.87398126007;12665;12158.270503769802;12209.69475763113;12352.135350525377;12696.365181740692;12709.618711438672;11932.164748467523;12243.142979991315;12331.198472099284;12343.13598048128;12599.622011339674;11602.245854019462;12106.878931210575;12188.329641869783;12473.563425280072;12609.68475788076;11238.66284011481;11675.776136852131;12261.69345766363;12288.692782680504;12332.753344932871 13:28:04 INFO - PROCESS | 7484 | |3;mootools.html;1477.7192333456646;1497.1241823533232;1601.2714215032154;1807.918643661035;1825.6348730253953;7962.920370796291;8787.297016238701;8894.644214231439;9417.623295068197;9424.151826335628;8956.686515971942;9267.212286955617;9349.626014959393;9354.81290374192;9374.71875843724;2366.2191476812695;2396.065534441569;2396.2451827674313;2408.8675122868235;2410.3733029412306;2343.1915988983774;2357.9882100589557;2418.89114989825;2419.11702228687;2426.4055306449945;2386.59427897257;2390;2390.784829365357;2392.342105920868;2407.109369533275;2303.4817166137655;2314.7222333320024;2327.697399338084;2333.2533589251448;2361.303415492434;2330.9650355244685;2352.6235802271553;2355.74086850448;2360.5278944211054;2369.1707902234252;9273;9305;9315.347925645208;9380;9397.577109030042;5444;5546.889062218733;5562;5565.415631358689;5579.944200557983;3533.8233088345737;3599.1541987632886;3683.189698266377;3716.9814150929074;3745.8501659933568;1213.4175595714019;1222.6943264183953;1269.0545543570006;1276.2661469654893;1292.5282271970664;12910.096293259381;12927.806082908764;12929.48282068716;12953.676158096028;13036.934815325958;4413.58070983256;4684.250519916797;4784.138855006132;4825.1555977703765;4828.155072862305;10270.589176432859;10271.94864025675;10303;10310.381377117397;10387.94806025965;5257.737113144328;5270.1040823060175;5275.551578115903;5280.973595132;5291.973540132275;4408.096340250241;4829.782659780319;4965.90068198634;5095.541401273903;5117.232415137759;3855.7493762905883;3894.1043559981363;3978.224246271949;4033.9193216135513;4098.774567398762;1195.2051885496048;1206.7284860906225;1211.588060059584;1216.1243904388825;1237.888590026902;924.8520236762085;981.5239608789731;999.3104757717152;1021.9693409197736;1025.8102251083574;5975.342712301644;6056.697165141725;6090.086487026982;6092.51259899207;6266.310705822356;463.65457733988393;465.6461089571882;471.44134200971956;472.6856640334208;476.53299766229287;4078.1435898461064;4199.202151591188;4228.78856057202;4267.786610669454;4326.870193894189;11371.545138194546;11754.29474231549;11767.999720023894;11781.234219775688;11791.11566632506;11559.075273978062;11603.245789023855;11643.941780291045;11660.30038197711;11711.238769479956;8634.352423568258;8646.135386461303;8718.215360617574;8746.737597871946;8751.168638979287;5988;5999.610025348338;6081.300650425258;6135.969320153371;6203.286622038523;10482;10592.152627789605;10627.256092073481;10686.358818470917;10809.35143891369;10727.839082413926;10774.946125269324;10786.191035672513;10843.512041957973;10960.451977401257;6749.662516874038;7504.8499030018;7712.344450721752;7743.612819359122;7825.1783562725095;9093.909060909305;9095.49974751395;9123.954380228057;9166;9187.908120918706;7637.083549973817;7690;7862.2923936845955;7915;8240.629171687408;7702.499337543042;7864.72473463426;7902.367810575255;7930.444868859125;7938.722144724907;7515.6242187891485;7592.8861067085145;7606.163322034461;7615.847683046419;7633;5215.348081489814;5331.200319952039;5346.198070289488;5491.450854914477;5583.832485025456;5299.602529810202;5360.946390536044;5380.085385484399;5412.404635490014;5527.143292789463 13:28:04 INFO - PROCESS | 7484 | |4;prototype.html;307.403636944328;316.2836176061221;322.2652352635989;324.3626274370861;326.764828946582;5486.862828429281;5504.559635229182;5662.263905692259;5697.743601537935;5704.315482142144;5557.499825015748;5581.358143813462;5594.888102237953;5594.944050559503;5595.18869763884;4372.081862808806;4378.102488989765;4384.605385515303;4392.9560704393025;4393.582609652078;4120.546739858613;4315.51114865371;4345.261305578059;4396.076823866976;4399.2301347264265;4277.272863613193;4280.357946308048;4287.935680964788;4293.914121717564;4309.956900431002;4300.333448315516;4300.741955482681;4318.654507639381;4362.062156636307;4378.474583050054;3706;3734.981325093357;3818.16000479894;3818.1790914953417;3825.8660946866726;5452.591055670801;5456.563474921997;5466.781328746845;5478.288247317563;5532.197831314477;4964.205727083649;4978.950210497885;4978.975105124451;4986.00279944009;4990.201567749179;5783.913241301384;5824.796132135355;5893;5953.791617293417;5964.642121472682;4144.922320196741;4160.9375859362135;4164.250434921712;4169.291220492523;4172.374143878412;6123.142760013601;6134.846628834315;6172.290186628506;6173.536984726208;6173.753049878;4101.200265948171;4184.660908509248;4216.852410165629;4267.530571637118;4274.551172126944;4259.531451540328;4268.125034368009;4282.8715138545895;4296.9257685578605;4319.179355922364;4915.115279249698;4918.926216106761;4926.359573255526;4931.161702510582;4948;5829.708514574254;5897.823065307962;5911.261092363455;5944.346121926671;5968.671723055187;1457.9198144101963;1458.2781523146111;1458.846821083792;1461.8976671633097;1463.3780643226587;891.9732408027769;917.2432742987062;926.4070994563485;944.9527523623929;945.7966537194536;5039.949600504021;5111.284420181178;5128.743562821844;5132.743362831843;5182.611304152204;5436.809711660152;5446.91829622556;5450.283160804334;5484;5493.2696200696655;5104.642675012714;5118.488151184852;5175.835437026639;5365.919511207335;5780.84383123377;3223.580934478503;3228.8869889553753;3230.53157292196;3254.7558933080113;3264.298175892147;6054.485368743618;6260.530460215502;6306.49548036156;6309.905351419732;6325.620462772248;6197.721102550396;6223.222097237845;6240.4071613196675;6250.781222657276;6285.245770507477;6226.221722284715;6324;6345.206849143857;6358;6365.586236894587;5870.970645146747;6048.183495228088;6077.574569780073;6086.3000754913755;6100.938990610037;6034.9094763577705;6041.305249896318;6044.667543285162;6075.969620152047;6078.300995385587;5991.460768530853;6272.717727702173;6300.881063873412;6307.400796924285;6327.841803954938;4053.189362127527;4173.457450531411;4203.432536607519;4208.81060352291;4212.220739163142;6166.290876549254;6168.444839964424;6170.228721409824;6195.752169913153;6207.379262073757;5707.486326230659;5817.534597232296;5926.318473375444;5978.880422391615;5999.680070384508;5859.589828711949;5860.765569377178;5870.236869206976;5881.941180588139;5888.558358123072;5861.413858614104;5869.180554028265;5871.295444546511;5880.558958078247;5912.556558258062;5695.515881150149;5944.405559444021;5976.701164941823;6004.819855404345;6009.399060094131;5846.824595262149;5870.911936320873;5881.441263080001;5894.233749612523;5942.168096466585 13:28:04 INFO - PROCESS | 7484 | |5;yui.html;720.9603471809048;743.3718507860859;748.9662965166567;759.1876691939625;846.5440237668231;16199.514014579567;16952.321907123733;17022.914885425587;17066.402675906345;17107.144642767875;15541.456049038286;15592.142432166227;15685.058896466191;15697.136657483863;15724.29240684169;665.3712241931377;788.4953629677011;804.9315808156299;821.2854816309818;822.3380178955967;821.2731732416825;830.730012745857;832.2135581875131;836.9414141010132;838.7986883148031;876.4215617692324;876.9824603507926;877.8727084572733;879.8724184993204;880.9383343165981;878.14819624964;879.5690111845214;879.5734068976541;879.9516026618534;881.6781874615783;636.7389370358177;639.5970538560723;641.0704478506185;641.0960545630638;642.7332656947361;15691.921540392224;15699.293531791096;15742.055476671436;15812.288447019911;15842.207889605474;15615.297311621005;15738.134402607966;15986.280617372246;16042;16077.598060048475;12195.085368597302;12463.813042804366;12819.551315703906;12864.742705145938;13172.538961136313;3995.440638310639;4001.3197756381196;4016.9397459038137;4026.2148880968225;4117.279476091672;74374.62812685902;78649.60675196587;78715.21284787194;78974.60512697457;80048.59975700143;12004.819927700917;12086.818697719542;12093.395330233454;12128.75742485163;12241.510339586495;23578.528429431317;23714.407139821644;23856.64215036776;23868.40328991789;23918.162864299666;8903.73288801337;8971.461712297152;9098.181163695299;9111.726648200565;9161.587728552231;4806.7836947337455;4837.129316722953;4931.520543836835;4948.4309304429735;5026.145555255615;3594.964050359463;3683.7053035757076;3690.132818787583;3703.4259689748133;3713.0717320669833;606.8361542383532;620.8199622109538;622.2905887288495;642.5887432043403;644.7259914536397;602.2742595172806;674.8144260328351;718.8598223346502;746.2500187311717;753.9246075392526;10037.69886903394;10138.847917281246;10203.38779673222;10258.28192026566;10560.419176945341;720.6144712578745;727.8107692000118;734.4124700239894;742.5284944060561;750.53466850553;4767.70054969724;4922.704637721677;4953.6840528326675;5019.974900125549;5075.137226671474;98770.50614747024;103488.48255758673;107770;116141;117029.41485292518;99191.50404247933;99465;99536.50231748795;99713.50143249237;99766;83865;85034.57482712547;87297;89249.55375223212;92339;10277.17782577407;10719.249652524248;10958.12335013213;11067.114630829354;11075.556977721124;43496.782516087216;48339.75830120827;52291.47708522866;52427.47572524226;53691;70821;77828.61085694762;79229;79519.60240198762;82170.58914705388;13303.46786128544;13449.327533623475;13626.182429054288;13716.931415343259;13915.095518791246;14922.25388730581;15344.693106138038;15423.228838558252;15548.766768498255;15722.76415853786;14043.719125617636;14241.430342786172;14279.266992337805;14321.427142914583;15004;13702.65743356424;14228.644283892985;14365.425382984564;14723.558293251219;15056.397744090114;14194.290285485891;14564.927175364055;14756.852431475549;15294.694106117593;15336.846631533988;11498.712532186762;11645.763124066303;12049.939750301543;12199;12251.142420030512;10871.67384978452;11636.709082273012;12098.697532561757;12324.383780811102;12580.182288151242 13:28:04 INFO - PROCESS | 7484 | __end_tp_report 13:28:04 INFO - PROCESS | 7484 | __start_cc_report 13:28:04 INFO - PROCESS | 7484 | _x_x_mozilla_cycle_collect,371 13:28:04 INFO - PROCESS | 7484 | __end_cc_report 13:28:04 INFO - PROCESS | 7484 | __startTimestamp1469219284953__endTimestamp 13:28:04 INFO - PROCESS | 7484 | 13:28:04 INFO - PROCESS | 7484 | ------- Summary: start ------- 13:28:04 INFO - PROCESS | 7484 | Number of tests: 6 13:28:04 INFO - PROCESS | 7484 | 13:28:04 INFO - PROCESS | 7484 | [#0] dojo.html Cycles:165 Average:5413.92 Median:5642.61 stddev:616.94 (10.9%) stddev-sans-first:590.19 13:28:04 INFO - PROCESS | 7484 | Values: 3045.5 3081.4 3104.3 3105.9 3110.5 5395.3 5404.6 5416.2 5481.9 5550.1 5362.5 5367.3 5403.6 5434.8 5469.5 4876.3 4905.5 5010.8 5060.2 5089.8 4890.6 5096.1 5111.2 5128.9 5133.6 4865.1 4882.7 4888.4 4943.8 4974.6 4956.7 4957.9 4961.0 4970.0 5017.4 4914.8 4926.0 4937.5 4940.0 4998.5 5289.8 5332.6 5381.3 5439.4 5477.3 5809.4 5824.4 5830.9 5843.4 5860.7 5839.9 5858.8 5864.4 5866.9 5875.5 5327.5 5341.2 5347.5 5475.9 5476.4 5872.9 5900.2 5902.7 5911.4 5959.4 5688.6 5689.7 5689.9 5692.1 5713.9 5611.9 5774.5 5790.4 5792.0 5810.1 5677.4 5770.5 5811.0 5886.9 5913.6 5864.2 5881.2 5897.3 5904.5 5904.7 4346.6 4480.3 4488.8 4489.5 4536.0 3943.3 3947.3 3952.0 3972.7 4025.7 5619.7 5621.1 5647.9 5659.8 5687.3 5907.6 5912.5 5919.4 5929.4 5932.8 5542.4 5564.6 5628.4 5630.7 5655.3 5078.2 5096.8 5099.8 5116.7 5139.1 6073.0 6094.8 6102.3 6102.3 6114.1 5732.3 5787.9 5791.6 5793.0 5822.6 5906.0 5942.3 5993.6 5997.4 6030.6 5666.3 5704.9 5708.0 5709.7 5711.5 5695.5 5743.9 5788.9 5792.6 5796.9 5627.1 5640.5 5642.8 5660.7 5683.0 5600.6 5633.5 5643.6 5648.6 5664.0 5499.8 5563.8 5590.5 5642.6 5667.0 5701.6 5717.9 5741.7 5766.8 5787.3 5604.2 5616.1 5622.3 5652.8 5658.5 13:28:04 INFO - PROCESS | 7484 | 13:28:04 INFO - PROCESS | 7484 | [#1] ext.html Cycles:180 Average:61398.39 Median:42677.97 stddev:120550.88 (282.5%) stddev-sans-first:120802.51 13:28:04 INFO - PROCESS | 7484 | Values: 558.5 590.3 597.2 604.8 614.9 35553.0 36427.0 42882.6 43800.6 43902.3 46265.3 46657.8 46668.5 46740.3 46809.5 8948.3 9131.4 9136.2 9141.3 9142.1 8996.7 9085.5 9086.2 9086.6 9093.9 9088.7 9144.9 9148.8 9155.7 9163.4 9040.9 9053.0 9116.0 9118.1 9122.8 8955.4 9025.0 9033.6 9056.7 9072.0 44282.3 44400.8 44543.0 44670.1 44693.8 3694.9 3740.3 3912.9 3938.6 4309.3 33850.7 34096.7 34533.3 35495.8 35709.6 4457.0 4513.3 4607.5 4690.3 4695.5 375179.0 375485.0 376486.0 376889.0 377334.0 56670.7 57102.0 57241.1 57409.7 57545.1 60757.7 60999.0 61043.7 61346.7 61400.4 15983.3 16300.8 16405.1 16622.6 16891.9 12922.6 12948.9 12974.7 12986.2 12987.6 19594.1 19807.6 19808.0 19854.4 19921.6 7196.2 7300.7 7418.3 7601.3 7617.6 1024.3 1129.6 1137.5 1151.4 1154.7 33399.7 33565.2 33581.3 33979.8 33999.0 1139.4 1140.2 1205.2 1212.6 1242.0 17436.8 17495.8 17540.6 17607.9 17762.6 553206.0 556906.0 558957.0 560130.0 560285.0 60480.0 60719.4 60959.0 61106.4 61377.0 1351.7 1376.2 1378.6 1385.2 1396.7 31370.8 33054.0 33123.0 33290.3 33707.3 50901.5 51132.0 51403.2 51426.0 51492.0 408667.0 408819.0 409546.0 410345.0 412439.0 27477.5 27911.6 27971.6 28043.6 28063.3 49309.3 49773.0 49818.5 50327.5 50591.2 40542.0 41896.6 42256.4 42493.2 43256.8 41621.0 41693.0 41715.4 42757.4 42866.8 41421.2 42188.8 42598.6 43174.6 44541.0 32318.4 36897.8 37045.0 38623.4 38734.4 28371.4 28621.7 28670.7 28884.3 28913.6 13:28:04 INFO - PROCESS | 7484 | 13:28:04 INFO - PROCESS | 7484 | [#2] jquery.html Cycles:180 Average:30269.53 Median:10808.36 stddev:87568.41 (810.2%) stddev-sans-first:87785.30 13:28:04 INFO - PROCESS | 7484 | Values: 375.3 383.7 385.4 398.8 400.3 18717.4 19552.6 20795.4 20933.0 21162.9 10683.3 11179.3 11264.4 11277.3 15564.4 5198.3 5398.3 5398.5 5399.6 5419.1 3923.8 5250.0 5642.7 5807.4 5850.2 5876.7 5880.0 5889.1 5901.7 5902.3 6319.3 6455.8 6537.6 6547.0 6592.3 4876.0 5104.5 5771.6 5779.1 5779.7 12882.0 13106.1 13109.7 13195.9 20993.2 2179.2 2297.0 2548.2 2671.7 2717.9 10011.2 10247.4 12220.5 13816.9 13819.8 1876.2 1885.7 1956.3 1965.7 1973.2 80823.6 82459.6 82532.6 83189.0 84946.6 10301.9 10392.1 10522.0 10546.9 10583.6 14285.9 14381.4 14442.9 14468.5 14490.0 8064.0 8131.5 8317.8 8444.6 8485.2 8167.3 8181.9 8259.9 8275.4 8385.4 4404.6 4464.7 4524.4 4553.2 4555.1 1576.7 1677.4 1690.5 1854.6 1884.6 968.6 973.0 989.0 1001.0 1067.2 19428.7 19651.0 20184.7 20191.0 20453.4 984.2 991.3 1025.5 1043.4 1050.4 10592.3 10763.5 11108.4 11189.8 11647.3 521286.0 522113.0 525632.0 530708.0 556410.0 93960.5 96418.0 96903.0 99271.5 100360.0 990.3 1031.3 1047.0 1048.7 1065.7 10289.9 11107.6 17805.6 17900.3 18823.2 41806.8 42310.8 42372.6 42714.8 42770.6 57213.0 57897.0 59144.4 61439.0 62121.4 11091.4 12178.9 12328.2 12595.7 12825.1 13238.6 13703.7 13777.3 13891.8 14076.5 12180.9 12198.2 12229.4 12601.9 12665.0 12158.3 12209.7 12352.1 12696.4 12709.6 11932.2 12243.1 12331.2 12343.1 12599.6 11602.2 12106.9 12188.3 12473.6 12609.7 11238.7 11675.8 12261.7 12288.7 12332.8 13:28:04 INFO - PROCESS | 7484 | 13:28:04 INFO - PROCESS | 7484 | [#3] mootools.html Cycles:180 Average:6024.01 Median:2574.95 stddev:3500.36 (135.9%) stddev-sans-first:3493.51 13:28:04 INFO - PROCESS | 7484 | Values: 1477.7 1497.1 1601.3 1807.9 1825.6 7962.9 8787.3 8894.6 9417.6 9424.2 8956.7 9267.2 9349.6 9354.8 9374.7 2366.2 2396.1 2396.2 2408.9 2410.4 2343.2 2358.0 2418.9 2419.1 2426.4 2386.6 2390.0 2390.8 2392.3 2407.1 2303.5 2314.7 2327.7 2333.3 2361.3 2331.0 2352.6 2355.7 2360.5 2369.2 9273.0 9305.0 9315.3 9380.0 9397.6 5444.0 5546.9 5562.0 5565.4 5579.9 3533.8 3599.2 3683.2 3717.0 3745.9 1213.4 1222.7 1269.1 1276.3 1292.5 12910.1 12927.8 12929.5 12953.7 13036.9 4413.6 4684.3 4784.1 4825.2 4828.2 10270.6 10271.9 10303.0 10310.4 10387.9 5257.7 5270.1 5275.6 5281.0 5292.0 4408.1 4829.8 4965.9 5095.5 5117.2 3855.7 3894.1 3978.2 4033.9 4098.8 1195.2 1206.7 1211.6 1216.1 1237.9 924.9 981.5 999.3 1022.0 1025.8 5975.3 6056.7 6090.1 6092.5 6266.3 463.7 465.6 471.4 472.7 476.5 4078.1 4199.2 4228.8 4267.8 4326.9 11371.5 11754.3 11768.0 11781.2 11791.1 11559.1 11603.2 11643.9 11660.3 11711.2 8634.4 8646.1 8718.2 8746.7 8751.2 5988.0 5999.6 6081.3 6136.0 6203.3 10482.0 10592.2 10627.3 10686.4 10809.4 10727.8 10774.9 10786.2 10843.5 10960.5 6749.7 7504.8 7712.3 7743.6 7825.2 9093.9 9095.5 9124.0 9166.0 9187.9 7637.1 7690.0 7862.3 7915.0 8240.6 7702.5 7864.7 7902.4 7930.4 7938.7 7515.6 7592.9 7606.2 7615.8 7633.0 5215.3 5331.2 5346.2 5491.5 5583.8 5299.6 5360.9 5380.1 5412.4 5527.1 13:28:04 INFO - PROCESS | 7484 | 13:28:04 INFO - PROCESS | 7484 | [#4] prototype.html Cycles:180 Average:4918.72 Median:5544.85 stddev:1476.47 (26.6%) stddev-sans-first:1439.47 13:28:04 INFO - PROCESS | 7484 | Values: 307.4 316.3 322.3 324.4 326.8 5486.9 5504.6 5662.3 5697.7 5704.3 5557.5 5581.4 5594.9 5594.9 5595.2 4372.1 4378.1 4384.6 4393.0 4393.6 4120.5 4315.5 4345.3 4396.1 4399.2 4277.3 4280.4 4287.9 4293.9 4310.0 4300.3 4300.7 4318.7 4362.1 4378.5 3706.0 3735.0 3818.2 3818.2 3825.9 5452.6 5456.6 5466.8 5478.3 5532.2 4964.2 4979.0 4979.0 4986.0 4990.2 5783.9 5824.8 5893.0 5953.8 5964.6 4144.9 4160.9 4164.3 4169.3 4172.4 6123.1 6134.8 6172.3 6173.5 6173.8 4101.2 4184.7 4216.9 4267.5 4274.6 4259.5 4268.1 4282.9 4296.9 4319.2 4915.1 4918.9 4926.4 4931.2 4948.0 5829.7 5897.8 5911.3 5944.3 5968.7 1457.9 1458.3 1458.8 1461.9 1463.4 892.0 917.2 926.4 945.0 945.8 5039.9 5111.3 5128.7 5132.7 5182.6 5436.8 5446.9 5450.3 5484.0 5493.3 5104.6 5118.5 5175.8 5365.9 5780.8 3223.6 3228.9 3230.5 3254.8 3264.3 6054.5 6260.5 6306.5 6309.9 6325.6 6197.7 6223.2 6240.4 6250.8 6285.2 6226.2 6324.0 6345.2 6358.0 6365.6 5871.0 6048.2 6077.6 6086.3 6100.9 6034.9 6041.3 6044.7 6076.0 6078.3 5991.5 6272.7 6300.9 6307.4 6327.8 4053.2 4173.5 4203.4 4208.8 4212.2 6166.3 6168.4 6170.2 6195.8 6207.4 5707.5 5817.5 5926.3 5978.9 5999.7 5859.6 5860.8 5870.2 5881.9 5888.6 5861.4 5869.2 5871.3 5880.6 5912.6 5695.5 5944.4 5976.7 6004.8 6009.4 5846.8 5870.9 5881.4 5894.2 5942.2 13:28:04 INFO - PROCESS | 7484 | 13:28:04 INFO - PROCESS | 7484 | [#5] yui.html Cycles:180 Average:21265.99 Median:4009.13 stddev:29664.72 (739.9%) stddev-sans-first:29707.83 13:28:04 INFO - PROCESS | 7484 | Values: 721.0 743.4 749.0 759.2 846.5 16199.5 16952.3 17022.9 17066.4 17107.1 15541.5 15592.1 15685.1 15697.1 15724.3 665.4 788.5 804.9 821.3 822.3 821.3 830.7 832.2 836.9 838.8 876.4 877.0 877.9 879.9 880.9 878.1 879.6 879.6 880.0 881.7 636.7 639.6 641.1 641.1 642.7 15691.9 15699.3 15742.1 15812.3 15842.2 15615.3 15738.1 15986.3 16042.0 16077.6 12195.1 12463.8 12819.6 12864.7 13172.5 3995.4 4001.3 4016.9 4026.2 4117.3 74374.6 78649.6 78715.2 78974.6 80048.6 12004.8 12086.8 12093.4 12128.8 12241.5 23578.5 23714.4 23856.6 23868.4 23918.2 8903.7 8971.5 9098.2 9111.7 9161.6 4806.8 4837.1 4931.5 4948.4 5026.1 3595.0 3683.7 3690.1 3703.4 3713.1 606.8 620.8 622.3 642.6 644.7 602.3 674.8 718.9 746.3 753.9 10037.7 10138.8 10203.4 10258.3 10560.4 720.6 727.8 734.4 742.5 750.5 4767.7 4922.7 4953.7 5020.0 5075.1 98770.5 103488.5 107770.0 116141.0 117029.4 99191.5 99465.0 99536.5 99713.5 99766.0 83865.0 85034.6 87297.0 89249.6 92339.0 10277.2 10719.2 10958.1 11067.1 11075.6 43496.8 48339.8 52291.5 52427.5 53691.0 70821.0 77828.6 79229.0 79519.6 82170.6 13303.5 13449.3 13626.2 13716.9 13915.1 14922.3 15344.7 15423.2 15548.8 15722.8 14043.7 14241.4 14279.3 14321.4 15004.0 13702.7 14228.6 14365.4 14723.6 15056.4 14194.3 14564.9 14756.9 15294.7 15336.8 11498.7 11645.8 12049.9 12199.0 12251.1 10871.7 11636.7 12098.7 12324.4 12580.2 13:28:04 INFO - PROCESS | 7484 | -------- Summary: end -------- 13:28:04 INFO - PROCESS | 7484 | 13:28:05 INFO - TEST-INFO | 7484: exit 0 13:28:05 INFO - TEST-OK | dromaeo_css | took 1111806ms 13:28:05 INFO - TEST-START | kraken 13:28:05 INFO - operating with platform_type : linux_ 13:28:05 INFO - Initialising browser for kraken test... 13:28:05 INFO - TEST-INFO | started process 7731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQjBvH5/profile http://localhost:39786/getInfo.html) 13:28:09 INFO - PROCESS | 7731 | JavaScript error: , line 0: uncaught exception: undefined 13:28:10 INFO - PROCESS | 7731 | __metrics Screen width/height:1600/1200 13:28:10 INFO - PROCESS | 7731 | colorDepth:24 13:28:10 INFO - PROCESS | 7731 | Browser inner width/height: 1024/697 13:28:10 INFO - PROCESS | 7731 | __metrics 13:28:11 ERROR - PROCESS | 7731 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:28:11 INFO - TEST-INFO | 7731: exit 0 13:28:11 INFO - Browser initialized. 13:28:11 INFO - Running cycle 1/1 for kraken test... 13:28:11 INFO - TEST-INFO | started process 7854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQjBvH5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:23 INFO - PROCESS | 7854 | RSS: Main: 168103936 13:28:23 INFO - PROCESS | 7854 | 13:28:26 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39786/tests/kraken/driver.html?testName=audio-beat-detection) 13:28:27 INFO - PROCESS | 7854 | RSS: Main: 173199360 13:28:27 INFO - PROCESS | 7854 | 13:28:29 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39786/tests/kraken/driver.html?testName=audio-dft) 13:28:30 INFO - PROCESS | 7854 | RSS: Main: 171565056 13:28:30 INFO - PROCESS | 7854 | 13:28:33 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39786/tests/kraken/driver.html?testName=audio-fft) 13:28:33 INFO - PROCESS | 7854 | RSS: Main: 168099840 13:28:33 INFO - PROCESS | 7854 | 13:28:35 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39786/tests/kraken/driver.html?testName=audio-oscillator) 13:28:36 INFO - PROCESS | 7854 | RSS: Main: 169418752 13:28:36 INFO - PROCESS | 7854 | 13:28:38 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:28:39 INFO - PROCESS | 7854 | RSS: Main: 169897984 13:28:39 INFO - PROCESS | 7854 | 13:28:42 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39786/tests/kraken/driver.html?testName=imaging-darkroom) 13:28:43 INFO - PROCESS | 7854 | RSS: Main: 169369600 13:28:43 INFO - PROCESS | 7854 | 13:28:46 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39786/tests/kraken/driver.html?testName=imaging-desaturate) 13:28:47 INFO - PROCESS | 7854 | RSS: Main: 170299392 13:28:47 INFO - PROCESS | 7854 | 13:28:49 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39786/tests/kraken/driver.html?testName=json-parse-financial) 13:28:50 INFO - PROCESS | 7854 | RSS: Main: 170426368 13:28:50 INFO - PROCESS | 7854 | 13:28:52 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:28:52 INFO - PROCESS | 7854 | RSS: Main: 169730048 13:28:52 INFO - PROCESS | 7854 | 13:28:54 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:28:55 INFO - PROCESS | 7854 | RSS: Main: 170360832 13:28:55 INFO - PROCESS | 7854 | 13:28:57 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:28:57 INFO - PROCESS | 7854 | RSS: Main: 170774528 13:28:57 INFO - PROCESS | 7854 | 13:29:00 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:29:01 INFO - PROCESS | 7854 | RSS: Main: 170975232 13:29:01 INFO - PROCESS | 7854 | 13:29:03 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:29:04 INFO - PROCESS | 7854 | RSS: Main: 171069440 13:29:04 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39786/tests/kraken/driver.html?testName=ai-astar) 13:29:06 INFO - PROCESS | 7854 | RSS: Main: 171708416 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | __start_tp_report 13:29:06 INFO - PROCESS | 7854 | _x_x_mozilla_page_load 13:29:06 INFO - PROCESS | 7854 | _x_x_mozilla_page_load_details 13:29:06 INFO - PROCESS | 7854 | |i|pagename|runs| 13:29:06 INFO - PROCESS | 7854 | |0;ai-astar;102;111;107;112;112;113;115;112;110;112 13:29:06 INFO - PROCESS | 7854 | |1;audio-beat-detection;153;123;143;176;124;147;146;127;174;117 13:29:06 INFO - PROCESS | 7854 | |2;audio-dft;162;162;161;162;171;164;169;167;161;161 13:29:06 INFO - PROCESS | 7854 | |3;audio-fft;75;75;75;162;75;76;75;75;158;75 13:29:06 INFO - PROCESS | 7854 | |4;audio-oscillator;87;83;155;84;84;83;146;84;83;144 13:29:06 INFO - PROCESS | 7854 | |5;imaging-gaussian-blur;117;118;117;118;117;118;117;118;118;117 13:29:06 INFO - PROCESS | 7854 | |6;imaging-darkroom;148;148;147;148;148;147;147;146;150;147 13:29:06 INFO - PROCESS | 7854 | |7;imaging-desaturate;96;96;96;95;95;96;96;96;96;96 13:29:06 INFO - PROCESS | 7854 | |8;json-parse-financial;54;57;56;54;54;58;55;56;54;57 13:29:06 INFO - PROCESS | 7854 | |9;json-stringify-tinderbox;59;62;60;62;62;61;62;61;61;61 13:29:06 INFO - PROCESS | 7854 | |10;stanford-crypto-aes;77;77;77;77;80;77;77;77;86;78 13:29:06 INFO - PROCESS | 7854 | |11;stanford-crypto-ccm;137;131;139;139;122;120;124;120;166;135 13:29:06 INFO - PROCESS | 7854 | |12;stanford-crypto-pbkdf2;157;161;155;155;164;159;160;159;156;159 13:29:06 INFO - PROCESS | 7854 | |13;stanford-crypto-sha256-iterative;64;63;66;64;63;66;62;64;63;62 13:29:06 INFO - PROCESS | 7854 | __end_tp_report 13:29:06 INFO - PROCESS | 7854 | __start_cc_report 13:29:06 INFO - PROCESS | 7854 | _x_x_mozilla_cycle_collect,913 13:29:06 INFO - PROCESS | 7854 | __end_cc_report 13:29:06 INFO - PROCESS | 7854 | __startTimestamp1469219346485__endTimestamp 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | ------- Summary: start ------- 13:29:06 INFO - PROCESS | 7854 | Number of tests: 14 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.66 (3.3%) stddev-sans-first:2.19 13:29:06 INFO - PROCESS | 7854 | Values: 102.0 111.0 107.0 112.0 112.0 113.0 115.0 112.0 110.0 112.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:146.50 stddev:20.73 (14.2%) stddev-sans-first:21.67 13:29:06 INFO - PROCESS | 7854 | Values: 153.0 123.0 143.0 176.0 124.0 147.0 146.0 127.0 174.0 117.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:3.68 (2.3%) stddev-sans-first:3.83 13:29:06 INFO - PROCESS | 7854 | Values: 162.0 162.0 161.0 162.0 171.0 164.0 169.0 167.0 161.0 161.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#3] audio-fft Cycles:10 Average:92.10 Median:75.00 stddev:35.80 (47.7%) stddev-sans-first:37.43 13:29:06 INFO - PROCESS | 7854 | Values: 75.0 75.0 75.0 162.0 75.0 76.0 75.0 75.0 158.0 75.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:83.50 stddev:31.22 (37.4%) stddev-sans-first:32.55 13:29:06 INFO - PROCESS | 7854 | Values: 87.0 83.0 155.0 84.0 84.0 83.0 146.0 84.0 83.0 144.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:29:06 INFO - PROCESS | 7854 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 117.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 13:29:06 INFO - PROCESS | 7854 | Values: 148.0 148.0 147.0 148.0 148.0 147.0 147.0 146.0 150.0 147.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:29:06 INFO - PROCESS | 7854 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.51 (2.7%) stddev-sans-first:1.50 13:29:06 INFO - PROCESS | 7854 | Values: 54.0 57.0 56.0 54.0 54.0 58.0 55.0 56.0 54.0 57.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.50 stddev:0.99 (1.6%) stddev-sans-first:0.71 13:29:06 INFO - PROCESS | 7854 | Values: 59.0 62.0 60.0 62.0 62.0 61.0 62.0 61.0 61.0 61.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:77.00 stddev:2.87 (3.7%) stddev-sans-first:3.00 13:29:06 INFO - PROCESS | 7854 | Values: 77.0 77.0 77.0 77.0 80.0 77.0 77.0 77.0 86.0 78.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:136.00 stddev:13.84 (10.2%) stddev-sans-first:14.62 13:29:06 INFO - PROCESS | 7854 | Values: 137.0 131.0 139.0 139.0 122.0 120.0 124.0 120.0 166.0 135.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:159.00 stddev:2.84 (1.8%) stddev-sans-first:2.96 13:29:06 INFO - PROCESS | 7854 | Values: 157.0 161.0 155.0 155.0 164.0 159.0 160.0 159.0 156.0 159.0 13:29:06 INFO - PROCESS | 7854 | 13:29:06 INFO - PROCESS | 7854 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.42 (2.2%) stddev-sans-first:1.50 13:29:06 INFO - PROCESS | 7854 | Values: 64.0 63.0 66.0 64.0 63.0 66.0 62.0 64.0 63.0 62.0 13:29:06 INFO - PROCESS | 7854 | -------- Summary: end -------- 13:29:06 INFO - PROCESS | 7854 | 13:29:07 INFO - TEST-INFO | 7854: exit 0 13:29:07 INFO - TEST-OK | kraken | took 61771ms 13:29:07 INFO - SUITE-END | took 1173s 13:29:07 INFO - Completed test suite (00:19:33) 13:29:07 INFO - javascript benchmark 13:29:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7440.691505274644, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.4974929136692, 3081.429935461939, 3104.2860142167315, 3105.875764969401, 3110.5489703992935, 5395.298611180546, 5404.594655400841, 5416.214648875911, 5481.945180548193, 5550.056490396632, 5362.4637536246355, 5367.275417818593, 5403.648762830413, 5434.755436005379, 5469.507744303012, 4876.341693871335, 4905.484924082955, 5010.849674509771, 5060.165072762989, 5089.847304580869, 4890.633202509826, 5096.108181068316, 5111.207762796754, 5128.9230661540105, 5133.614978876581, 4865.0756356292195, 4882.707037577739, 4888.437829649601, 4943.802247910097, 4974.552290293873, 4956.653034287601, 4957.859692270762, 4960.975195124001, 4970.0, 5017.397912250553, 4914.7788349524, 4926.0394223126505, 4937.481564435754, 4939.975300123477, 4998.525140111684, 5289.761960711778, 5332.626716129873, 5381.327334083239, 5439.401665816757, 5477.315335583052, 5809.3609702932645, 5824.446677565625, 5830.941690583082, 5843.415658434165, 5860.677662728548, 5839.883202335929, 5858.794942177046, 5864.384239654817, 5866.911996320058, 5875.471207591338, 5327.547158491533, 5341.198820177005, 5347.51872331492, 5475.917861232085, 5476.397596264408, 5872.911906321408, 5900.1739756434135, 5902.704864756745, 5911.408859114054, 5959.404059594006, 5688.573356998241, 5689.6586204827845, 5689.943100569024, 5692.117721753135, 5713.914291285634, 5611.8597035073635, 5774.509166720792, 5790.42095790426, 5792.044312688359, 5810.070388737781, 5677.432256774289, 5770.509506691894, 5810.970945145332, 5886.94113058864, 5913.645181289136, 5864.237649105674, 5881.235439392937, 5897.292324921037, 5904.468597826216, 5904.734286957011, 4346.587074227943, 4480.260756975063, 4488.753118578445, 4489.461264648263, 4536.024754677695, 3943.2902077626304, 3947.2500224957166, 3951.9802400988387, 3972.741771784825, 4025.677945764332, 5619.719014049281, 5621.100623900156, 5647.887042259132, 5659.8019069333195, 5687.260656114679, 5907.645541267538, 5912.526997840162, 5919.437653423004, 5929.407059294036, 5932.79235226765, 5542.445755424425, 5564.554835613141, 5628.437156284339, 5630.746616402272, 5655.349634791969, 5078.187490001582, 5096.796128154832, 5099.847004589868, 5116.692998420107, 5139.100657384943, 6073.0283154695035, 6094.8171554853425, 6102.267727872595, 6102.298235702862, 6114.052321890114, 5732.254806875079, 5787.884242315046, 5791.623544469596, 5793.015187418065, 5822.621529600562, 5905.970470147622, 5942.316633587193, 5993.580449368676, 5997.4002599741425, 6030.6080104793045, 5666.263385759825, 5704.885902281848, 5708.029634961983, 5709.7145142741865, 5711.543076553782, 5695.487406133468, 5743.942560574341, 5788.855278618068, 5792.623479473821, 5796.884062318814, 5627.071533196977, 5640.492355687844, 5642.802501912413, 5660.688662123623, 5683.005474041944, 5600.551955843442, 5633.549316054788, 5643.576731745054, 5648.604597678287, 5664.0371136906, 5499.780008799603, 5563.7774489019985, 5590.496855283044, 5642.60501764889, 5667.036603777286, 5701.590154522047, 5717.885642287048, 5741.655500669973, 5766.769329226784, 5787.305523337226, 5604.159376093618, 5616.1014237721765, 5622.32532096151, 5652.7738890443925, 5658.462446067617], "value": 5371.490553536378, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5258037946613, 590.2798585725415, 597.1967703438874, 604.8004158627654, 614.8647297594528, 35553.0, 36427.0, 42882.57117428825, 43800.56199438005, 43902.34146487805, 46265.30602040972, 46657.7667111664, 46668.53331466684, 46740.29889551651, 46809.531904680945, 8948.32887533436, 9131.406458580172, 9136.177744003038, 9141.314401419886, 9142.13149750776, 8996.68511602094, 9085.54572271387, 9086.182243598076, 9086.591103400362, 9093.909060909373, 9088.681896133636, 9144.908550914506, 9148.817023659523, 9155.67955121571, 9163.35856490046, 9040.909590904073, 9053.0, 9115.999999999967, 9118.088191180828, 9122.817543649124, 8955.41789783662, 9024.954875225581, 9033.593488292976, 9056.728298151065, 9071.954640226822, 44282.33576496355, 44400.77799610981, 44543.0, 44670.10659786819, 44693.77653111746, 3694.8706795262037, 3740.345439548068, 3912.941305880414, 3938.645521903014, 4309.332053531676, 33850.661493385, 34096.659033409844, 34533.30933381318, 35495.82252088749, 35709.64290357089, 4456.977715111436, 4513.340289163783, 4607.470140933769, 4690.296455531663, 4695.530446955311, 375179.0, 375485.0, 376485.99999999726, 376889.0, 377334.0, 56670.71664641733, 57102.0, 57241.14138287929, 57409.71295143497, 57545.13682294769, 60757.69621151866, 60999.0, 61043.69478152581, 61346.693266534276, 61400.38599614036, 15983.280752366172, 16300.836991629933, 16405.097719625534, 16622.584435389213, 16891.91554042222, 12922.612321630366, 12948.935255323851, 12974.740505190031, 12986.220826750425, 12987.610371688676, 19594.118264678124, 19807.60384792325, 19808.0, 19854.40436786899, 19921.60156796856, 7196.208417074117, 7300.671469783872, 7418.258174182539, 7601.277878601524, 7617.619119044026, 1024.2522958240527, 1129.5989923577176, 1137.4710759496709, 1151.3725019864194, 1154.7170943118822, 33399.66600334014, 33565.16087097793, 33581.32837343239, 33979.830100849336, 33999.0, 1139.4416735799398, 1140.1790710688292, 1205.2045649871043, 1212.6180253220207, 1241.9813702794465, 17436.825631743774, 17495.82504174942, 17540.561485962953, 17607.911960440117, 17762.5559361017, 553206.0, 556906.0, 558957.0, 560130.0, 560285.0, 60480.0, 60719.392806072254, 60959.0, 61106.38893611007, 61377.0, 1351.6823546466574, 1376.2224343246235, 1378.5657517881834, 1385.189664046544, 1396.7066915947562, 31370.843145784125, 33054.0, 33123.0, 33290.334193316485, 33707.325853483286, 50901.49098509116, 51132.0, 51403.22895156501, 51426.0, 51492.0, 408667.0, 408819.0, 409546.0, 410345.0, 412439.0, 27477.45045099127, 27911.581326279716, 27971.580426293214, 28043.57934631023, 28063.298417538907, 49309.2603610939, 49773.0, 49818.501814981384, 50327.49672503228, 50591.241131382325, 40542.0, 41896.58103419049, 42256.36615450832, 42493.150136997705, 43256.78371608122, 41621.0, 41693.0, 41715.37426938538, 42757.35863962105, 42866.78566607147, 41421.1715765689, 42188.78905605452, 42598.57401425946, 43174.568254318314, 44541.0, 32318.35363292768, 36897.81551092335, 37045.0, 38623.42064868973, 38734.418983714706, 28371.432571348043, 28621.713782861905, 28670.713292866803, 28884.27789305284, 28913.56629650599], "value": 20675.28258977015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.32066958804546, 383.66046049246415, 385.3891581842779, 398.76472881000205, 400.3054700095334, 18717.4384768457, 19552.608947821034, 20795.376138715827, 20933.0, 21162.89418552907, 10683.30558513696, 11179.32924024557, 11264.43677816108, 11277.266977646468, 15564.37742490299, 5198.324217851674, 5398.325209348832, 5398.460153984609, 5399.649022813524, 5419.105847535152, 3923.8038098095126, 5250.0, 5642.74607642655, 5807.448292412214, 5850.210221620069, 5876.70616469177, 5880.0, 5889.057750759879, 5901.734421951022, 5902.2622172228475, 6319.336469670688, 6455.8063258101865, 6537.607743535379, 6547.0, 6592.30780768022, 4876.0, 5104.540591346797, 5771.567132465082, 5779.075347944308, 5779.739911703983, 12882.0, 13106.148100373444, 13109.737805243842, 13195.934020329933, 20993.160273589037, 2179.1936983316273, 2296.954060918789, 2548.2227920484247, 2671.7461841125064, 2717.904873329424, 10011.249156313306, 10247.38515689061, 12220.450079746433, 13816.93091534536, 13819.792703109462, 1876.193236908129, 1885.6700077486523, 1956.2664000999625, 1965.7149713291492, 1973.190991693399, 80823.5958820208, 82459.5877020617, 82532.58733706352, 83189.0, 84946.57526712389, 10301.9484902575, 10392.116670083127, 10522.0, 10546.894531054591, 10583.624128863199, 14285.857141428452, 14381.424743010371, 14442.927785361006, 14468.493602723855, 14490.0, 8063.959680201561, 8131.512109273463, 8317.8336433271, 8444.57777111142, 8485.151484851589, 8167.346612271004, 8181.877271840927, 8259.876101858477, 8275.420720549504, 8385.413021088465, 4404.603585677304, 4464.732116073046, 4524.434445694288, 4553.225951588238, 4555.111753208159, 1576.747720364759, 1677.4232221711552, 1690.5435532406182, 1854.6476169527746, 1884.604233111062, 968.5980318168022, 972.9854052189223, 989.0258095775655, 1000.9949950250348, 1067.204932325407, 19428.708569371473, 19651.0, 20184.69722954157, 20191.0, 20453.38639840807, 984.17329443268, 991.3209451525584, 1025.5333823110466, 1043.3791893823163, 1050.3855244681795, 10592.258541901992, 10763.461826908624, 11108.389038602954, 11189.776204476027, 11647.301161930141, 521286.0, 522113.0, 525632.0, 530708.0, 556410.0, 93960.53019734858, 96418.0, 96903.0, 99271.50364248133, 100360.0, 990.3067852503276, 1031.2781053262745, 1047.041956609709, 1048.7227414330218, 1065.7335666083634, 10289.868114507548, 11107.611233606785, 17805.643887122445, 17900.28398864031, 18823.152958116643, 41806.79096604497, 42310.7884460588, 42372.57627423686, 42714.78642606767, 42770.5722942779, 57213.0, 57897.0, 59144.40855591561, 61439.0, 62121.37878621156, 11091.38997355121, 12178.878211218129, 12328.19866708661, 12595.685107872376, 12825.102242842911, 13238.602841914759, 13703.657408564466, 13777.311134443038, 13891.791623125864, 14076.507322243673, 12180.878191217975, 12198.207116537396, 12229.449674764479, 12601.87398126007, 12665.0, 12158.270503769802, 12209.69475763113, 12352.135350525377, 12696.365181740692, 12709.618711438672, 11932.164748467523, 12243.142979991315, 12331.198472099284, 12343.13598048128, 12599.622011339674, 11602.245854019462, 12106.878931210575, 12188.329641869783, 12473.563425280072, 12609.68475788076, 11238.66284011481, 11675.776136852131, 12261.69345766363, 12288.692782680504, 12332.753344932871], "value": 9280.22027991301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.7192333456646, 1497.1241823533232, 1601.2714215032154, 1807.918643661035, 1825.6348730253953, 7962.920370796291, 8787.297016238701, 8894.644214231439, 9417.623295068197, 9424.151826335628, 8956.686515971942, 9267.212286955617, 9349.626014959393, 9354.81290374192, 9374.71875843724, 2366.2191476812695, 2396.065534441569, 2396.2451827674313, 2408.8675122868235, 2410.3733029412306, 2343.1915988983774, 2357.9882100589557, 2418.89114989825, 2419.11702228687, 2426.4055306449945, 2386.59427897257, 2390.0, 2390.784829365357, 2392.342105920868, 2407.109369533275, 2303.4817166137655, 2314.7222333320024, 2327.697399338084, 2333.2533589251448, 2361.303415492434, 2330.9650355244685, 2352.6235802271553, 2355.74086850448, 2360.5278944211054, 2369.1707902234252, 9273.0, 9305.0, 9315.347925645208, 9380.0, 9397.577109030042, 5444.0, 5546.889062218733, 5562.0, 5565.415631358689, 5579.944200557983, 3533.8233088345737, 3599.1541987632886, 3683.189698266377, 3716.9814150929074, 3745.8501659933568, 1213.4175595714019, 1222.6943264183953, 1269.0545543570006, 1276.2661469654893, 1292.5282271970664, 12910.096293259381, 12927.806082908764, 12929.48282068716, 12953.676158096028, 13036.934815325958, 4413.58070983256, 4684.250519916797, 4784.138855006132, 4825.1555977703765, 4828.155072862305, 10270.589176432859, 10271.94864025675, 10303.0, 10310.381377117397, 10387.94806025965, 5257.737113144328, 5270.1040823060175, 5275.551578115903, 5280.973595132, 5291.973540132275, 4408.096340250241, 4829.782659780319, 4965.90068198634, 5095.541401273903, 5117.232415137759, 3855.7493762905883, 3894.1043559981363, 3978.224246271949, 4033.9193216135513, 4098.774567398762, 1195.2051885496048, 1206.7284860906225, 1211.588060059584, 1216.1243904388825, 1237.888590026902, 924.8520236762085, 981.5239608789731, 999.3104757717152, 1021.9693409197736, 1025.8102251083574, 5975.342712301644, 6056.697165141725, 6090.086487026982, 6092.51259899207, 6266.310705822356, 463.65457733988393, 465.6461089571882, 471.44134200971956, 472.6856640334208, 476.53299766229287, 4078.1435898461064, 4199.202151591188, 4228.78856057202, 4267.786610669454, 4326.870193894189, 11371.545138194546, 11754.29474231549, 11767.999720023894, 11781.234219775688, 11791.11566632506, 11559.075273978062, 11603.245789023855, 11643.941780291045, 11660.30038197711, 11711.238769479956, 8634.352423568258, 8646.135386461303, 8718.215360617574, 8746.737597871946, 8751.168638979287, 5988.0, 5999.610025348338, 6081.300650425258, 6135.969320153371, 6203.286622038523, 10482.0, 10592.152627789605, 10627.256092073481, 10686.358818470917, 10809.35143891369, 10727.839082413926, 10774.946125269324, 10786.191035672513, 10843.512041957973, 10960.451977401257, 6749.662516874038, 7504.8499030018, 7712.344450721752, 7743.612819359122, 7825.1783562725095, 9093.909060909305, 9095.49974751395, 9123.954380228057, 9166.0, 9187.908120918706, 7637.083549973817, 7690.0, 7862.2923936845955, 7915.0, 8240.629171687408, 7702.499337543042, 7864.72473463426, 7902.367810575255, 7930.444868859125, 7938.722144724907, 7515.6242187891485, 7592.8861067085145, 7606.163322034461, 7615.847683046419, 7633.0, 5215.348081489814, 5331.200319952039, 5346.198070289488, 5491.450854914477, 5583.832485025456, 5299.602529810202, 5360.946390536044, 5380.085385484399, 5412.404635490014, 5527.143292789463], "value": 4715.0146323403, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.403636944328, 316.2836176061221, 322.2652352635989, 324.3626274370861, 326.764828946582, 5486.862828429281, 5504.559635229182, 5662.263905692259, 5697.743601537935, 5704.315482142144, 5557.499825015748, 5581.358143813462, 5594.888102237953, 5594.944050559503, 5595.18869763884, 4372.081862808806, 4378.102488989765, 4384.605385515303, 4392.9560704393025, 4393.582609652078, 4120.546739858613, 4315.51114865371, 4345.261305578059, 4396.076823866976, 4399.2301347264265, 4277.272863613193, 4280.357946308048, 4287.935680964788, 4293.914121717564, 4309.956900431002, 4300.333448315516, 4300.741955482681, 4318.654507639381, 4362.062156636307, 4378.474583050054, 3706.0, 3734.981325093357, 3818.16000479894, 3818.1790914953417, 3825.8660946866726, 5452.591055670801, 5456.563474921997, 5466.781328746845, 5478.288247317563, 5532.197831314477, 4964.205727083649, 4978.950210497885, 4978.975105124451, 4986.00279944009, 4990.201567749179, 5783.913241301384, 5824.796132135355, 5893.0, 5953.791617293417, 5964.642121472682, 4144.922320196741, 4160.9375859362135, 4164.250434921712, 4169.291220492523, 4172.374143878412, 6123.142760013601, 6134.846628834315, 6172.290186628506, 6173.536984726208, 6173.753049878, 4101.200265948171, 4184.660908509248, 4216.852410165629, 4267.530571637118, 4274.551172126944, 4259.531451540328, 4268.125034368009, 4282.8715138545895, 4296.9257685578605, 4319.179355922364, 4915.115279249698, 4918.926216106761, 4926.359573255526, 4931.161702510582, 4948.0, 5829.708514574254, 5897.823065307962, 5911.261092363455, 5944.346121926671, 5968.671723055187, 1457.9198144101963, 1458.2781523146111, 1458.846821083792, 1461.8976671633097, 1463.3780643226587, 891.9732408027769, 917.2432742987062, 926.4070994563485, 944.9527523623929, 945.7966537194536, 5039.949600504021, 5111.284420181178, 5128.743562821844, 5132.743362831843, 5182.611304152204, 5436.809711660152, 5446.91829622556, 5450.283160804334, 5484.0, 5493.2696200696655, 5104.642675012714, 5118.488151184852, 5175.835437026639, 5365.919511207335, 5780.84383123377, 3223.580934478503, 3228.8869889553753, 3230.53157292196, 3254.7558933080113, 3264.298175892147, 6054.485368743618, 6260.530460215502, 6306.49548036156, 6309.905351419732, 6325.620462772248, 6197.721102550396, 6223.222097237845, 6240.4071613196675, 6250.781222657276, 6285.245770507477, 6226.221722284715, 6324.0, 6345.206849143857, 6358.0, 6365.586236894587, 5870.970645146747, 6048.183495228088, 6077.574569780073, 6086.3000754913755, 6100.938990610037, 6034.9094763577705, 6041.305249896318, 6044.667543285162, 6075.969620152047, 6078.300995385587, 5991.460768530853, 6272.717727702173, 6300.881063873412, 6307.400796924285, 6327.841803954938, 4053.189362127527, 4173.457450531411, 4203.432536607519, 4208.81060352291, 4212.220739163142, 6166.290876549254, 6168.444839964424, 6170.228721409824, 6195.752169913153, 6207.379262073757, 5707.486326230659, 5817.534597232296, 5926.318473375444, 5978.880422391615, 5999.680070384508, 5859.589828711949, 5860.765569377178, 5870.236869206976, 5881.941180588139, 5888.558358123072, 5861.413858614104, 5869.180554028265, 5871.295444546511, 5880.558958078247, 5912.556558258062, 5695.515881150149, 5944.405559444021, 5976.701164941823, 6004.819855404345, 6009.399060094131, 5846.824595262149, 5870.911936320873, 5881.441263080001, 5894.233749612523, 5942.168096466585], "value": 4434.047435102211, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.9603471809048, 743.3718507860859, 748.9662965166567, 759.1876691939625, 846.5440237668231, 16199.514014579567, 16952.321907123733, 17022.914885425587, 17066.402675906345, 17107.144642767875, 15541.456049038286, 15592.142432166227, 15685.058896466191, 15697.136657483863, 15724.29240684169, 665.3712241931377, 788.4953629677011, 804.9315808156299, 821.2854816309818, 822.3380178955967, 821.2731732416825, 830.730012745857, 832.2135581875131, 836.9414141010132, 838.7986883148031, 876.4215617692324, 876.9824603507926, 877.8727084572733, 879.8724184993204, 880.9383343165981, 878.14819624964, 879.5690111845214, 879.5734068976541, 879.9516026618534, 881.6781874615783, 636.7389370358177, 639.5970538560723, 641.0704478506185, 641.0960545630638, 642.7332656947361, 15691.921540392224, 15699.293531791096, 15742.055476671436, 15812.288447019911, 15842.207889605474, 15615.297311621005, 15738.134402607966, 15986.280617372246, 16042.0, 16077.598060048475, 12195.085368597302, 12463.813042804366, 12819.551315703906, 12864.742705145938, 13172.538961136313, 3995.440638310639, 4001.3197756381196, 4016.9397459038137, 4026.2148880968225, 4117.279476091672, 74374.62812685902, 78649.60675196587, 78715.21284787194, 78974.60512697457, 80048.59975700143, 12004.819927700917, 12086.818697719542, 12093.395330233454, 12128.75742485163, 12241.510339586495, 23578.528429431317, 23714.407139821644, 23856.64215036776, 23868.40328991789, 23918.162864299666, 8903.73288801337, 8971.461712297152, 9098.181163695299, 9111.726648200565, 9161.587728552231, 4806.7836947337455, 4837.129316722953, 4931.520543836835, 4948.4309304429735, 5026.145555255615, 3594.964050359463, 3683.7053035757076, 3690.132818787583, 3703.4259689748133, 3713.0717320669833, 606.8361542383532, 620.8199622109538, 622.2905887288495, 642.5887432043403, 644.7259914536397, 602.2742595172806, 674.8144260328351, 718.8598223346502, 746.2500187311717, 753.9246075392526, 10037.69886903394, 10138.847917281246, 10203.38779673222, 10258.28192026566, 10560.419176945341, 720.6144712578745, 727.8107692000118, 734.4124700239894, 742.5284944060561, 750.53466850553, 4767.70054969724, 4922.704637721677, 4953.6840528326675, 5019.974900125549, 5075.137226671474, 98770.50614747024, 103488.48255758673, 107770.0, 116141.0, 117029.41485292518, 99191.50404247933, 99465.0, 99536.50231748795, 99713.50143249237, 99766.0, 83865.0, 85034.57482712547, 87297.0, 89249.55375223212, 92339.0, 10277.17782577407, 10719.249652524248, 10958.12335013213, 11067.114630829354, 11075.556977721124, 43496.782516087216, 48339.75830120827, 52291.47708522866, 52427.47572524226, 53691.0, 70821.0, 77828.61085694762, 79229.0, 79519.60240198762, 82170.58914705388, 13303.46786128544, 13449.327533623475, 13626.182429054288, 13716.931415343259, 13915.095518791246, 14922.25388730581, 15344.693106138038, 15423.228838558252, 15548.766768498255, 15722.76415853786, 14043.719125617636, 14241.430342786172, 14279.266992337805, 14321.427142914583, 15004.0, 13702.65743356424, 14228.644283892985, 14365.425382984564, 14723.558293251219, 15056.397744090114, 14194.290285485891, 14564.927175364055, 14756.852431475549, 15294.694106117593, 15336.846631533988, 11498.712532186762, 11645.763124066303, 12049.939750301543, 12199.0, 12251.142420030512, 10871.67384978452, 11636.709082273012, 12098.697532561757, 12324.383780811102, 12580.182288151242], "value": 7874.957452935839, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 107.0, 112.0, 112.0, 113.0, 115.0, 112.0, 110.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 143.0, 176.0, 124.0, 147.0, 146.0, 127.0, 174.0, 117.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 171.0, 164.0, 169.0, 167.0, 161.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 162.0, 75.0, 76.0, 75.0, 75.0, 158.0, 75.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 155.0, 84.0, 84.0, 83.0, 146.0, 84.0, 83.0, 144.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 146.0, 150.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 56.0, 54.0, 54.0, 58.0, 55.0, 56.0, 54.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 60.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 77.0, 80.0, 77.0, 77.0, 77.0, 86.0, 78.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 139.0, 139.0, 122.0, 120.0, 124.0, 120.0, 166.0, 135.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 155.0, 155.0, 164.0, 159.0, 160.0, 159.0, 156.0, 159.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 64.0, 63.0, 66.0, 62.0, 64.0, 63.0, 62.0], "value": 63.7, "unit": "score"}]}]} 13:29:07 INFO - Return code: 0 13:29:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:29:07 ERROR - # TBPL SUCCESS # 13:29:07 INFO - Running post-action listener: _resource_record_post_action 13:29:07 INFO - [mozharness: 2016-07-22 20:29:07.798926Z] Finished run-tests step (success) 13:29:07 INFO - Running post-run listener: _resource_record_post_run 13:29:07 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 385024; Write bytes: 306597888; Read time: 228; Write time: 390528 13:29:07 INFO - TinderboxPrint: CPU usage
13.3% 13:29:07 INFO - TinderboxPrint: I/O read bytes / time
385,024 / 228 13:29:07 INFO - TinderboxPrint: I/O write bytes / time
306,597,888 / 390,528 13:29:07 INFO - TinderboxPrint: CPU idle
8,233.7 (86.6%) 13:29:07 INFO - TinderboxPrint: CPU user
1,212.2 (12.8%) 13:29:07 INFO - TinderboxPrint: Swap in / out
0 / 0 13:29:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 14082048; Read time: 0; Write time: 5148 13:29:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 380928; Write bytes: 292515840; Read time: 216; Write time: 385380 13:29:08 INFO - Running post-run listener: _upload_blobber_files 13:29:08 INFO - Blob upload gear active. 13:29:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:08 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 13:29:08 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'] 13:29:08 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 13:29:08 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:29:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:09 INFO - (blobuploader) - INFO - Done attempting. 13:29:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:29:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:29:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:10 INFO - (blobuploader) - INFO - Done attempting. 13:29:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:29:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:29:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:25 INFO - (blobuploader) - INFO - Done attempting. 13:29:25 INFO - (blobuploader) - INFO - Iteration through files over. 13:29:25 INFO - Return code: 0 13:29:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:29:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:29:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/079bac51a9de9b2d2d116daa952aa6fcce1719faaf6d5f0eefe513753192054d2fed0f98626ae5362c390e28e7c011255b4aca487f9f95dd78bb2ad1e0d66d91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b2e24a4c1b63ad3c3e73f8402a317985a75e4e0162f22885e9378226fadfc272fb7e0203f0a960568f57a376d9a5a9b49739faf6d1bf967370ed70d30d2ea87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4f5a3a6b6c17e383ea63314832f2aa74a159bc6e4ee61ea134724bd64b8c7fe464d8350cd053262a69fdade8ade0c6dbebd42dd288a71bd020a5ebbaa7cd8dd"} 13:29:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:29:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:29:25 INFO - Contents: 13:29:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/079bac51a9de9b2d2d116daa952aa6fcce1719faaf6d5f0eefe513753192054d2fed0f98626ae5362c390e28e7c011255b4aca487f9f95dd78bb2ad1e0d66d91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b2e24a4c1b63ad3c3e73f8402a317985a75e4e0162f22885e9378226fadfc272fb7e0203f0a960568f57a376d9a5a9b49739faf6d1bf967370ed70d30d2ea87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4f5a3a6b6c17e383ea63314832f2aa74a159bc6e4ee61ea134724bd64b8c7fe464d8350cd053262a69fdade8ade0c6dbebd42dd288a71bd020a5ebbaa7cd8dd"} 13:29:25 INFO - Running post-run listener: copy_logs_to_upload_dir 13:29:25 INFO - Copying logs to upload dir... 13:29:25 INFO - mkdir: /builds/slave/test/build/upload/logs 13:29:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.954868 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-22 13:29:25.128208) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 13:29:25.131493) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/079bac51a9de9b2d2d116daa952aa6fcce1719faaf6d5f0eefe513753192054d2fed0f98626ae5362c390e28e7c011255b4aca487f9f95dd78bb2ad1e0d66d91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b2e24a4c1b63ad3c3e73f8402a317985a75e4e0162f22885e9378226fadfc272fb7e0203f0a960568f57a376d9a5a9b49739faf6d1bf967370ed70d30d2ea87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4f5a3a6b6c17e383ea63314832f2aa74a159bc6e4ee61ea134724bd64b8c7fe464d8350cd053262a69fdade8ade0c6dbebd42dd288a71bd020a5ebbaa7cd8dd"} build_url:https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/079bac51a9de9b2d2d116daa952aa6fcce1719faaf6d5f0eefe513753192054d2fed0f98626ae5362c390e28e7c011255b4aca487f9f95dd78bb2ad1e0d66d91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b2e24a4c1b63ad3c3e73f8402a317985a75e4e0162f22885e9378226fadfc272fb7e0203f0a960568f57a376d9a5a9b49739faf6d1bf967370ed70d30d2ea87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4f5a3a6b6c17e383ea63314832f2aa74a159bc6e4ee61ea134724bd64b8c7fe464d8350cd053262a69fdade8ade0c6dbebd42dd288a71bd020a5ebbaa7cd8dd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 13:29:25.157452) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:29:25.157876) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469218119.994414-550943292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:29:25.241456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 13:29:25.242005) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 13:29:25.242537) ========= ========= Total master_lag: 0.18 =========