builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1469045776.99 results: success (0) buildid: 20160720125722 builduid: 05f979a1e18f4f738dd1bb39e4d51b23 revision: c6e4b6a744697056dcebe1cf298ed3b7de85311c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:16.992576) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:16.992992) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:16.993277) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:17.007703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:17.008051) ========= 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=bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 13:16:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-07-20 13:16:17 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095913 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:17.117608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:17.117927) ========= 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=bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020273 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:17.166955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:17.167311) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c6e4b6a744697056dcebe1cf298ed3b7de85311c --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 c6e4b6a744697056dcebe1cf298ed3b7de85311c --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=bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 13:16:17,456 truncating revision to first 12 chars 2016-07-20 13:16:17,456 Setting DEBUG logging. 2016-07-20 13:16:17,456 attempt 1/10 2016-07-20 13:16:17,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c6e4b6a74469?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 13:16:17,807 unpacking tar archive at: fx-team-c6e4b6a74469/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667833 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:17.848575) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:17.848891) ========= script_repo_revision: c6e4b6a744697056dcebe1cf298ed3b7de85311c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:17.849282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:17.849651) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 13:16:17.860502) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-20 13:16:17.860871) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:16:18 INFO - MultiFileLogger online at 20160720 13:16:18 in /builds/slave/test 13:16:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:16:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:16:18 INFO - {'append_to_log': False, 13:16:18 INFO - 'base_work_dir': '/builds/slave/test', 13:16:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:16:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:16:18 INFO - 'branch': 'Fx-Team-Non-PGO', 13:16:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:16:18 INFO - 'config_files': ('talos/linux_config.py',), 13:16:18 INFO - 'default_actions': ('clobber', 13:16:18 INFO - 'read-buildbot-config', 13:16:18 INFO - 'download-and-extract', 13:16:18 INFO - 'populate-webroot', 13:16:18 INFO - 'create-virtualenv', 13:16:18 INFO - 'install', 13:16:18 INFO - 'run-tests'), 13:16:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:16:18 INFO - 'download_minidump_stackwalk': True, 13:16:18 INFO - 'download_symbols': 'ondemand', 13:16:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:16:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:16:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:16:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:16:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:16:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:16:18 INFO - 'installer_path': 'installer.exe', 13:16:18 INFO - 'log_level': 'info', 13:16:18 INFO - 'log_name': 'talos', 13:16:18 INFO - 'log_to_console': True, 13:16:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:16:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:16:18 INFO - 'opt_config_files': (), 13:16:18 INFO - 'pip_index': False, 13:16:18 INFO - 'sps_profile': False, 13:16:18 INFO - 'sps_profile_interval': 0, 13:16:18 INFO - 'suite': 'dromaeojs', 13:16:18 INFO - 'system_bits': '32', 13:16:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:16:18 INFO - 'title': 'talos-linux64-ix-055', 13:16:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:16:18 INFO - 'use_talos_json': True, 13:16:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:16:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:16:18 INFO - 'work_dir': 'build'} 13:16:18 INFO - [mozharness: 2016-07-20 20:16:18.241487Z] Running clobber step. 13:16:18 INFO - Running pre-action listener: _resource_record_pre_action 13:16:18 INFO - Running main action method: clobber 13:16:18 INFO - rmtree: /builds/slave/test/build 13:16:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:16:18 INFO - Running post-action listener: _resource_record_post_action 13:16:18 INFO - [mozharness: 2016-07-20 20:16:18.712340Z] Finished clobber step (success) 13:16:18 INFO - [mozharness: 2016-07-20 20:16:18.712441Z] Running read-buildbot-config step. 13:16:18 INFO - Running pre-action listener: _resource_record_pre_action 13:16:18 INFO - Running main action method: read_buildbot_config 13:16:18 INFO - Using buildbot properties: 13:16:18 INFO - { 13:16:18 INFO - "project": "", 13:16:18 INFO - "product": "firefox", 13:16:18 INFO - "script_repo_revision": "production", 13:16:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:16:18 INFO - "repository": "", 13:16:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:16:18 INFO - "buildid": "20160720125722", 13:16:18 INFO - "pgo_build": "False", 13:16:18 INFO - "basedir": "/builds/slave/test", 13:16:18 INFO - "buildnumber": 2005, 13:16:18 INFO - "slavename": "talos-linux64-ix-055", 13:16:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:16:18 INFO - "platform": "ubuntu64_hw", 13:16:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:16:18 INFO - "branch": "fx-team", 13:16:18 INFO - "repo_path": "integration/fx-team", 13:16:18 INFO - "revision": "c6e4b6a744697056dcebe1cf298ed3b7de85311c", 13:16:18 INFO - "stage_platform": "linux64", 13:16:18 INFO - "builduid": "05f979a1e18f4f738dd1bb39e4d51b23", 13:16:18 INFO - "slavebuilddir": "test" 13:16:18 INFO - } 13:16:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:16:18 INFO - Running post-action listener: _resource_record_post_action 13:16:18 INFO - [mozharness: 2016-07-20 20:16:18.714883Z] Finished read-buildbot-config step (success) 13:16:18 INFO - [mozharness: 2016-07-20 20:16:18.714973Z] Running download-and-extract step. 13:16:18 INFO - Running pre-action listener: _resource_record_pre_action 13:16:18 INFO - Running main action method: download_and_extract 13:16:18 INFO - mkdir: /builds/slave/test/build/tests 13:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:16:18 INFO - https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/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:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/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:16:19 INFO - Downloaded 1361 bytes. 13:16:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:19 INFO - Using the following test package requirements: 13:16:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:16:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:16:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:16:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:19 INFO - u'jsshell-linux-x86_64.zip'], 13:16:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:16:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:16:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:16:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:16:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:16:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:16:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:16:19 INFO - https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:16:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/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:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/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:16:20 INFO - Downloaded 22772441 bytes. 13:16:20 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:16:20 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:16:21 INFO - Return code: 0 13:16:21 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:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:16:21 INFO - https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:16:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/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:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/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:16:23 INFO - Downloaded 22772441 bytes. 13:16:23 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:16:23 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:16:24 INFO - Return code: 0 13:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:16:24 INFO - https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:16:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:16:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:16:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/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:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/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:16:27 INFO - Downloaded 14403317 bytes. 13:16:27 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:16:27 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:16:27 INFO - Return code: 0 13:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:16:27 INFO - https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:16:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/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:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqSRdIIASlSSjWA75J4zHw/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:16:28 INFO - Downloaded 57110163 bytes. 13:16:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:28 INFO - mkdir: /builds/slave/test/properties 13:16:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:16:28 INFO - Writing to file /builds/slave/test/properties/build_url 13:16:28 INFO - Contents: 13:16:28 INFO - build_url:https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:29 INFO - Running post-action listener: _resource_record_post_action 13:16:29 INFO - Running post-action listener: set_extra_try_arguments 13:16:29 INFO - [mozharness: 2016-07-20 20:16:29.712573Z] Finished download-and-extract step (success) 13:16:29 INFO - [mozharness: 2016-07-20 20:16:29.712807Z] Running populate-webroot step. 13:16:29 INFO - Running pre-action listener: _resource_record_pre_action 13:16:29 INFO - Running main action method: populate_webroot 13:16:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:16:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:16:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:16:29 INFO - '--tppagecycles', 13:16:29 INFO - '7'], 13:16:29 INFO - 'tests': ['tsvgm']}}, 13:16:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:16:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:16:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:16:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:16:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:16:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:16:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:29 INFO - 'talos_options': ['--disable-e10s'], 13:16:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:29 INFO - 'talos_options': ['--disable-e10s'], 13:16:29 INFO - 'tests': ['damp', 'tps']}, 13:16:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:29 INFO - 'tests': ['damp', 'tps']}, 13:16:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:16:29 INFO - 'tests': ['dromaeo_dom']}, 13:16:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:16:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:16:29 INFO - 'tests': ['basic_compositor_video']}, 13:16:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:16:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:16:29 INFO - 'tests': ['a11yr', 13:16:29 INFO - 'ts_paint', 13:16:29 INFO - 'tpaint', 13:16:29 INFO - 'sessionrestore', 13:16:29 INFO - 'sessionrestore_no_auto_restore', 13:16:29 INFO - 'tabpaint']}, 13:16:29 INFO - 'other-e10s': {'tests': ['a11yr', 13:16:29 INFO - 'ts_paint', 13:16:29 INFO - 'tpaint', 13:16:29 INFO - 'sessionrestore', 13:16:29 INFO - 'sessionrestore_no_auto_restore', 13:16:29 INFO - 'tabpaint']}, 13:16:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:16:29 INFO - 'ts_paint', 13:16:29 INFO - 'tpaint', 13:16:29 INFO - 'sessionrestore', 13:16:29 INFO - 'sessionrestore_no_auto_restore', 13:16:29 INFO - 'tabpaint']}, 13:16:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:16:29 INFO - 'ts_paint', 13:16:29 INFO - 'tpaint', 13:16:29 INFO - 'sessionrestore', 13:16:29 INFO - 'sessionrestore_no_auto_restore', 13:16:29 INFO - 'tabpaint']}, 13:16:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:16:29 INFO - 'tests': ['a11yr', 13:16:29 INFO - 'ts_paint', 13:16:29 INFO - 'tpaint', 13:16:29 INFO - 'sessionrestore', 13:16:29 INFO - 'sessionrestore_no_auto_restore', 13:16:29 INFO - 'tabpaint']}, 13:16:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:16:29 INFO - 'tests': ['a11yr', 13:16:29 INFO - 'ts_paint', 13:16:29 INFO - 'tpaint', 13:16:29 INFO - 'sessionrestore', 13:16:29 INFO - 'sessionrestore_no_auto_restore', 13:16:29 INFO - 'tabpaint']}, 13:16:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:16:29 INFO - 'tests': ['tsvgx', 13:16:29 INFO - 'tsvgr_opacity', 13:16:29 INFO - 'tart', 13:16:29 INFO - 'tscrollx', 13:16:29 INFO - 'cart']}, 13:16:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:16:29 INFO - 'tsvgr_opacity', 13:16:29 INFO - 'tart', 13:16:29 INFO - 'tscrollx', 13:16:29 INFO - 'cart']}, 13:16:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:29 INFO - 'talos_options': ['--disable-e10s'], 13:16:29 INFO - 'tests': ['tp5o']}, 13:16:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:29 INFO - 'tests': ['tp5o']}, 13:16:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:29 INFO - 'talos_options': ['--disable-e10s', 13:16:29 INFO - '--xperf_path', 13:16:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:29 INFO - 'tests': ['tp5n']}, 13:16:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:29 INFO - 'talos_options': ['--xperf_path', 13:16:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:29 INFO - 'tests': ['tp5n']}}, 13:16:29 INFO - 'talos.zip': {'path': '', 13:16:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:16:29 INFO - Running post-action listener: _resource_record_post_action 13:16:29 INFO - [mozharness: 2016-07-20 20:16:29.731511Z] Finished populate-webroot step (success) 13:16:29 INFO - [mozharness: 2016-07-20 20:16:29.731601Z] Running create-virtualenv step. 13:16:29 INFO - Running pre-action listener: _resource_record_pre_action 13:16:29 INFO - Running main action method: create_virtualenv 13:16:29 INFO - Creating virtualenv /builds/slave/test/build/venv 13:16:29 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:16:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:16:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:16:29 INFO - Using real prefix '/usr' 13:16:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:16:30 INFO - Installing distribute.............................................................................................................................................................................................done. 13:16:32 INFO - Installing pip.................done. 13:16:32 INFO - Return code: 0 13:16:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289e3b0>, '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 0x289f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289f740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', '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:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:16:32 INFO - Using env: {'DISPLAY': ':0', 13:16:32 INFO - 'HOME': '/home/cltbld', 13:16:32 INFO - 'LANG': 'en_US.UTF-8', 13:16:32 INFO - 'LANGUAGE': 'en_US:en', 13:16:32 INFO - 'LOGNAME': 'cltbld', 13:16:32 INFO - 'MAIL': '/var/mail/cltbld', 13:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:32 INFO - 'MOZ_NO_REMOTE': '1', 13:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:32 INFO - 'NO_EM_RESTART': '1', 13:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:32 INFO - 'PWD': '/builds/slave/test', 13:16:32 INFO - 'SHELL': '/bin/bash', 13:16:32 INFO - 'SHLVL': '1', 13:16:32 INFO - 'TERM': 'linux', 13:16:32 INFO - 'TMOUT': '86400', 13:16:32 INFO - 'USER': 'cltbld', 13:16:32 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', 13:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:32 INFO - '_': '/tools/buildbot/bin/python'} 13:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:32 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:16:32 INFO - Cleaning up... 13:16:32 INFO - Return code: 0 13:16:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289e3b0>, '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 0x289f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289f740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', '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:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:16:32 INFO - Using env: {'DISPLAY': ':0', 13:16:32 INFO - 'HOME': '/home/cltbld', 13:16:32 INFO - 'LANG': 'en_US.UTF-8', 13:16:32 INFO - 'LANGUAGE': 'en_US:en', 13:16:32 INFO - 'LOGNAME': 'cltbld', 13:16:32 INFO - 'MAIL': '/var/mail/cltbld', 13:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:32 INFO - 'MOZ_NO_REMOTE': '1', 13:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:32 INFO - 'NO_EM_RESTART': '1', 13:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:32 INFO - 'PWD': '/builds/slave/test', 13:16:32 INFO - 'SHELL': '/bin/bash', 13:16:32 INFO - 'SHLVL': '1', 13:16:32 INFO - 'TERM': 'linux', 13:16:32 INFO - 'TMOUT': '86400', 13:16:32 INFO - 'USER': 'cltbld', 13:16:32 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', 13:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:32 INFO - '_': '/tools/buildbot/bin/python'} 13:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:32 INFO - Downloading/unpacking psutil>=3.1.1 13:16:32 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:16:32 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:16:32 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:16:32 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:16:32 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:16:32 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:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:16:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:16:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:16:34 INFO - Installing collected packages: psutil 13:16:34 INFO - Running setup.py install for psutil 13:16:34 INFO - building 'psutil._psutil_linux' extension 13:16:34 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:16:34 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:16:34 INFO - building 'psutil._psutil_posix' extension 13:16:34 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:16:35 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:16:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:16:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:16:35 INFO - Successfully installed psutil 13:16:35 INFO - Cleaning up... 13:16:35 INFO - Return code: 0 13:16:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:16:35 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:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:35 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:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:35 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 0x25df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289e3b0>, '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 0x289f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289f740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', '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:16:35 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:16:35 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:16:35 INFO - Using env: {'DISPLAY': ':0', 13:16:35 INFO - 'HOME': '/home/cltbld', 13:16:35 INFO - 'LANG': 'en_US.UTF-8', 13:16:35 INFO - 'LANGUAGE': 'en_US:en', 13:16:35 INFO - 'LOGNAME': 'cltbld', 13:16:35 INFO - 'MAIL': '/var/mail/cltbld', 13:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:35 INFO - 'MOZ_NO_REMOTE': '1', 13:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:35 INFO - 'NO_EM_RESTART': '1', 13:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:35 INFO - 'PWD': '/builds/slave/test', 13:16:35 INFO - 'SHELL': '/bin/bash', 13:16:35 INFO - 'SHLVL': '1', 13:16:35 INFO - 'TERM': 'linux', 13:16:35 INFO - 'TMOUT': '86400', 13:16:35 INFO - 'USER': 'cltbld', 13:16:35 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', 13:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:35 INFO - '_': '/tools/buildbot/bin/python'} 13:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:16:40 INFO - Installing collected packages: mozsystemmonitor 13:16:40 INFO - Running setup.py install for mozsystemmonitor 13:16:40 INFO - Successfully installed mozsystemmonitor 13:16:40 INFO - Cleaning up... 13:16:40 INFO - Return code: 0 13:16:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:16:40 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:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:40 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:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:40 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 0x25df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289e3b0>, '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 0x289f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289f740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', '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:16:40 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:16:40 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:16:40 INFO - Using env: {'DISPLAY': ':0', 13:16:40 INFO - 'HOME': '/home/cltbld', 13:16:40 INFO - 'LANG': 'en_US.UTF-8', 13:16:40 INFO - 'LANGUAGE': 'en_US:en', 13:16:40 INFO - 'LOGNAME': 'cltbld', 13:16:40 INFO - 'MAIL': '/var/mail/cltbld', 13:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:40 INFO - 'MOZ_NO_REMOTE': '1', 13:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:40 INFO - 'NO_EM_RESTART': '1', 13:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:40 INFO - 'PWD': '/builds/slave/test', 13:16:40 INFO - 'SHELL': '/bin/bash', 13:16:40 INFO - 'SHLVL': '1', 13:16:40 INFO - 'TERM': 'linux', 13:16:40 INFO - 'TMOUT': '86400', 13:16:40 INFO - 'USER': 'cltbld', 13:16:40 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', 13:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:40 INFO - '_': '/tools/buildbot/bin/python'} 13:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:40 INFO - Downloading/unpacking jsonschema==2.5.1 13:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:16:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:43 INFO - Downloading functools32-3.2.3-2.tar.gz 13:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:16:43 INFO - warning: no files found matching '*.txt' 13:16:43 INFO - no previously-included directories found matching 'build' 13:16:43 INFO - no previously-included directories found matching 'dist' 13:16:43 INFO - no previously-included directories found matching '.git*' 13:16:43 INFO - Installing collected packages: jsonschema, functools32 13:16:43 INFO - Running setup.py install for functools32 13:16:43 INFO - warning: no files found matching '*.txt' 13:16:43 INFO - no previously-included directories found matching 'build' 13:16:43 INFO - no previously-included directories found matching 'dist' 13:16:43 INFO - no previously-included directories found matching '.git*' 13:16:43 INFO - Successfully installed jsonschema functools32 13:16:43 INFO - Cleaning up... 13:16:43 INFO - Return code: 0 13:16:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:16: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:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16: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:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:43 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 0x25df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289e3b0>, '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 0x289f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289f740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', '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:16:43 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:16:43 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:16:43 INFO - Using env: {'DISPLAY': ':0', 13:16:43 INFO - 'HOME': '/home/cltbld', 13:16:43 INFO - 'LANG': 'en_US.UTF-8', 13:16:43 INFO - 'LANGUAGE': 'en_US:en', 13:16:43 INFO - 'LOGNAME': 'cltbld', 13:16:43 INFO - 'MAIL': '/var/mail/cltbld', 13:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:43 INFO - 'MOZ_NO_REMOTE': '1', 13:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:43 INFO - 'NO_EM_RESTART': '1', 13:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:43 INFO - 'PWD': '/builds/slave/test', 13:16:43 INFO - 'SHELL': '/bin/bash', 13:16:43 INFO - 'SHLVL': '1', 13:16:43 INFO - 'TERM': 'linux', 13:16:43 INFO - 'TMOUT': '86400', 13:16:43 INFO - 'USER': 'cltbld', 13:16:43 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', 13:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:43 INFO - '_': '/tools/buildbot/bin/python'} 13:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:43 INFO - Downloading/unpacking blobuploader==1.2.4 13:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:57 INFO - Downloading blobuploader-1.2.4.tar.gz 13:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:16:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:16:57 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:16:57 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:16:57 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:16:57 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:16:57 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:16:57 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:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:16:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:16:57 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:16:57 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:16:57 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:16:57 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:16:57 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:16:57 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:16:57 INFO - Downloading docopt-0.6.1.tar.gz 13:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:16:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:16:57 INFO - Running setup.py install for blobuploader 13:16:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:16:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:16:58 INFO - Running setup.py install for requests 13:16:58 INFO - Running setup.py install for docopt 13:16:58 INFO - Successfully installed blobuploader requests docopt 13:16:58 INFO - Cleaning up... 13:16:58 INFO - Return code: 0 13:16:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:58 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 0x25df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289e3b0>, '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 0x289f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289f740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', '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:16:58 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:16:58 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:16:58 INFO - Using env: {'DISPLAY': ':0', 13:16:58 INFO - 'HOME': '/home/cltbld', 13:16:58 INFO - 'LANG': 'en_US.UTF-8', 13:16:58 INFO - 'LANGUAGE': 'en_US:en', 13:16:58 INFO - 'LOGNAME': 'cltbld', 13:16:58 INFO - 'MAIL': '/var/mail/cltbld', 13:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:58 INFO - 'MOZ_NO_REMOTE': '1', 13:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:58 INFO - 'NO_EM_RESTART': '1', 13:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:58 INFO - 'PWD': '/builds/slave/test', 13:16:58 INFO - 'SHELL': '/bin/bash', 13:16:58 INFO - 'SHLVL': '1', 13:16:58 INFO - 'TERM': 'linux', 13:16:58 INFO - 'TMOUT': '86400', 13:16:58 INFO - 'USER': 'cltbld', 13:16:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', 13:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:58 INFO - '_': '/tools/buildbot/bin/python'} 13:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:16:58 INFO - Running setup.py (path:/tmp/pip-CDsqEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:16:58 INFO - Running setup.py (path:/tmp/pip-pkaUKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:16:58 INFO - Running setup.py (path:/tmp/pip-WQScFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:16:58 INFO - Running setup.py (path:/tmp/pip-_yikVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:16:59 INFO - Running setup.py (path:/tmp/pip-ojgPlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:16:59 INFO - Running setup.py (path:/tmp/pip-Gubtyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:16:59 INFO - Running setup.py (path:/tmp/pip-XWO_zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:16:59 INFO - Running setup.py (path:/tmp/pip-ZnJBOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:16:59 INFO - Running setup.py (path:/tmp/pip-_rjwqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:16:59 INFO - Running setup.py (path:/tmp/pip-d5iiE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:16:59 INFO - Running setup.py (path:/tmp/pip-xDSc9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:16:59 INFO - Running setup.py (path:/tmp/pip-bm3W0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:16:59 INFO - Running setup.py (path:/tmp/pip-wjtKCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:16:59 INFO - Running setup.py (path:/tmp/pip-PR719B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:59 INFO - Running setup.py (path:/tmp/pip-JzVLAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:16:59 INFO - Running setup.py (path:/tmp/pip-jCgxw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:16:59 INFO - Running setup.py (path:/tmp/pip-HfzWD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:16:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:16:59 INFO - Running setup.py install for manifestparser 13:17:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:00 INFO - Running setup.py install for mozcrash 13:17:00 INFO - Running setup.py install for mozdebug 13:17:00 INFO - Running setup.py install for mozdevice 13:17:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:17:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:00 INFO - Running setup.py install for mozfile 13:17:00 INFO - Running setup.py install for mozhttpd 13:17:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:00 INFO - Running setup.py install for mozinfo 13:17:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:00 INFO - Running setup.py install for mozInstall 13:17:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:00 INFO - Running setup.py install for mozleak 13:17:00 INFO - Running setup.py install for mozlog 13:17:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:01 INFO - Running setup.py install for moznetwork 13:17:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:01 INFO - Running setup.py install for mozprocess 13:17:01 INFO - Running setup.py install for mozprofile 13:17:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:01 INFO - Running setup.py install for mozrunner 13:17:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:01 INFO - Running setup.py install for mozscreenshot 13:17:01 INFO - Running setup.py install for moztest 13:17:02 INFO - Running setup.py install for mozversion 13:17:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:02 INFO - Cleaning up... 13:17:02 INFO - Return code: 0 13:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17: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:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:02 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 0x25df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289e3b0>, '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 0x289f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289f740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', '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:17:02 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:17:02 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:17:02 INFO - Using env: {'DISPLAY': ':0', 13:17:02 INFO - 'HOME': '/home/cltbld', 13:17:02 INFO - 'LANG': 'en_US.UTF-8', 13:17:02 INFO - 'LANGUAGE': 'en_US:en', 13:17:02 INFO - 'LOGNAME': 'cltbld', 13:17:02 INFO - 'MAIL': '/var/mail/cltbld', 13:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:02 INFO - 'MOZ_NO_REMOTE': '1', 13:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:02 INFO - 'NO_EM_RESTART': '1', 13:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:02 INFO - 'PWD': '/builds/slave/test', 13:17:02 INFO - 'SHELL': '/bin/bash', 13:17:02 INFO - 'SHLVL': '1', 13:17:02 INFO - 'TERM': 'linux', 13:17:02 INFO - 'TMOUT': '86400', 13:17:02 INFO - 'USER': 'cltbld', 13:17:02 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', 13:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:02 INFO - '_': '/tools/buildbot/bin/python'} 13:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:02 INFO - Running setup.py (path:/tmp/pip-P8hfqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:02 INFO - Running setup.py (path:/tmp/pip-KaqnXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:02 INFO - Running setup.py (path:/tmp/pip-kcVmA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:02 INFO - Running setup.py (path:/tmp/pip-AV1Jw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:02 INFO - Running setup.py (path:/tmp/pip-uGYnsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:02 INFO - Running setup.py (path:/tmp/pip-BPYWYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:02 INFO - Running setup.py (path:/tmp/pip-2Wf4Aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:02 INFO - Running setup.py (path:/tmp/pip-4qsvLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:02 INFO - Running setup.py (path:/tmp/pip-9cchKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:03 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:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:03 INFO - Running setup.py (path:/tmp/pip-VR97Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:03 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:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:03 INFO - Running setup.py (path:/tmp/pip-NgNodH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:03 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:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:03 INFO - Running setup.py (path:/tmp/pip-krrZ5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:03 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:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:03 INFO - Running setup.py (path:/tmp/pip-fe1PV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:03 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:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:03 INFO - Running setup.py (path:/tmp/pip-WXX8Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:03 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:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:03 INFO - Running setup.py (path:/tmp/pip-kSOTJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:03 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:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:03 INFO - Running setup.py (path:/tmp/pip-8CvB_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:03 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:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:03 INFO - Running setup.py (path:/tmp/pip-BhWlDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:05 INFO - Downloading blessings-1.6.tar.gz 13:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:17:05 INFO - Installing collected packages: blessings 13:17:05 INFO - Running setup.py install for blessings 13:17:05 INFO - Successfully installed blessings 13:17:05 INFO - Cleaning up... 13:17:05 INFO - Return code: 0 13:17:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:17:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:06 INFO - Reading from file tmpfile_stdout 13:17:06 INFO - Current package versions: 13:17:06 INFO - argparse == 1.2.1 13:17:06 INFO - blessings == 1.6 13:17:06 INFO - blobuploader == 1.2.4 13:17:06 INFO - docopt == 0.6.1 13:17:06 INFO - functools32 == 3.2.3-2 13:17:06 INFO - jsonschema == 2.5.1 13:17:06 INFO - manifestparser == 1.1 13:17:06 INFO - mozInstall == 1.12 13:17:06 INFO - mozcrash == 0.17 13:17:06 INFO - mozdebug == 0.1 13:17:06 INFO - mozdevice == 0.48 13:17:06 INFO - mozfile == 1.2 13:17:06 INFO - mozhttpd == 0.7 13:17:06 INFO - mozinfo == 0.9 13:17:06 INFO - mozleak == 0.1 13:17:06 INFO - mozlog == 3.3 13:17:06 INFO - moznetwork == 0.27 13:17:06 INFO - mozprocess == 0.23 13:17:06 INFO - mozprofile == 0.28 13:17:06 INFO - mozrunner == 6.12 13:17:06 INFO - mozscreenshot == 0.1 13:17:06 INFO - mozsystemmonitor == 0.3 13:17:06 INFO - moztest == 0.7 13:17:06 INFO - mozversion == 1.4 13:17:06 INFO - psutil == 3.1.1 13:17:06 INFO - requests == 1.2.3 13:17:06 INFO - wsgiref == 0.1.2 13:17:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:06 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 0x25df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289e3b0>, '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 0x289f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289f740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', '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:17:06 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:17:06 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:17:06 INFO - Using env: {'DISPLAY': ':0', 13:17:06 INFO - 'HOME': '/home/cltbld', 13:17:06 INFO - 'LANG': 'en_US.UTF-8', 13:17:06 INFO - 'LANGUAGE': 'en_US:en', 13:17:06 INFO - 'LOGNAME': 'cltbld', 13:17:06 INFO - 'MAIL': '/var/mail/cltbld', 13:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:06 INFO - 'MOZ_NO_REMOTE': '1', 13:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:06 INFO - 'NO_EM_RESTART': '1', 13:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:06 INFO - 'PWD': '/builds/slave/test', 13:17:06 INFO - 'SHELL': '/bin/bash', 13:17:06 INFO - 'SHLVL': '1', 13:17:06 INFO - 'TERM': 'linux', 13:17:06 INFO - 'TMOUT': '86400', 13:17:06 INFO - 'USER': 'cltbld', 13:17:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', 13:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:06 INFO - '_': '/tools/buildbot/bin/python'} 13:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:06 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:17:06 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:17:06 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:17:06 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:17:06 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:17:06 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:17:06 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:17:06 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:17:06 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:17:06 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:17:06 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:17:06 INFO - Cleaning up... 13:17:06 INFO - Return code: 0 13:17:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:06 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 0x25df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289e3b0>, '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 0x289f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289f740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', '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:17:06 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:17:06 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:17:06 INFO - Using env: {'DISPLAY': ':0', 13:17:06 INFO - 'HOME': '/home/cltbld', 13:17:06 INFO - 'LANG': 'en_US.UTF-8', 13:17:06 INFO - 'LANGUAGE': 'en_US:en', 13:17:06 INFO - 'LOGNAME': 'cltbld', 13:17:06 INFO - 'MAIL': '/var/mail/cltbld', 13:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:06 INFO - 'MOZ_NO_REMOTE': '1', 13:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:06 INFO - 'NO_EM_RESTART': '1', 13:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:06 INFO - 'PWD': '/builds/slave/test', 13:17:06 INFO - 'SHELL': '/bin/bash', 13:17:06 INFO - 'SHLVL': '1', 13:17:06 INFO - 'TERM': 'linux', 13:17:06 INFO - 'TMOUT': '86400', 13:17:06 INFO - 'USER': 'cltbld', 13:17:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', 13:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:06 INFO - '_': '/tools/buildbot/bin/python'} 13:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:17:06 INFO - Cleaning up... 13:17:06 INFO - Return code: 0 13:17:06 INFO - Running post-action listener: _resource_record_post_action 13:17:06 INFO - Running post-action listener: _start_resource_monitoring 13:17:06 INFO - Starting resource monitoring. 13:17:06 INFO - [mozharness: 2016-07-20 20:17:06.576317Z] Finished create-virtualenv step (success) 13:17:06 INFO - [mozharness: 2016-07-20 20:17:06.576796Z] Running install step. 13:17:06 INFO - Running pre-action listener: _resource_record_pre_action 13:17:06 INFO - Running main action method: install 13:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:06 INFO - Reading from file tmpfile_stdout 13:17:06 INFO - Detecting whether we're running mozinstall >=1.0... 13:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:17:06 INFO - Reading from file tmpfile_stdout 13:17:06 INFO - Output received: 13:17:06 INFO - Usage: mozinstall [options] installer 13:17:06 INFO - Options: 13:17:06 INFO - -h, --help show this help message and exit 13:17:06 INFO - -d DEST, --destination=DEST 13:17:06 INFO - Directory to install application into. [default: 13:17:06 INFO - "/builds/slave/test"] 13:17:06 INFO - --app=APP Application being installed. [default: firefox] 13:17:06 INFO - mkdir: /builds/slave/test/build/application 13:17:06 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:17:06 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:17:23 INFO - Reading from file tmpfile_stdout 13:17:23 INFO - Output received: 13:17:23 INFO - /builds/slave/test/build/application/firefox/firefox 13:17:23 INFO - Running post-action listener: _resource_record_post_action 13:17:23 INFO - [mozharness: 2016-07-20 20:17:23.271075Z] Finished install step (success) 13:17:23 INFO - [mozharness: 2016-07-20 20:17:23.271412Z] Running run-tests step. 13:17:23 INFO - Running pre-action listener: _resource_record_pre_action 13:17:23 INFO - Running main action method: run_tests 13:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:17:23 INFO - Python 2.7.3 13:17:23 INFO - Return code: 0 13:17:23 INFO - grabbing minidump binary from tooltool 13:17:23 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:17:23 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 0x289e3b0>, '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 0x289f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:17:23 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:17:23 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:17:23 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:17:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:17:23 INFO - Return code: 0 13:17:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:17:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:17:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:17:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:17:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:17:23 INFO - Using env: {'DISPLAY': ':0', 13:17:23 INFO - 'HOME': '/home/cltbld', 13:17:23 INFO - 'LANG': 'en_US.UTF-8', 13:17:23 INFO - 'LANGUAGE': 'en_US:en', 13:17:23 INFO - 'LOGNAME': 'cltbld', 13:17:23 INFO - 'MAIL': '/var/mail/cltbld', 13:17:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:17:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:23 INFO - 'MOZ_NO_REMOTE': '1', 13:17:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:23 INFO - 'NO_EM_RESTART': '1', 13:17:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:23 INFO - 'PWD': '/builds/slave/test', 13:17:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:17:23 INFO - 'SHELL': '/bin/bash', 13:17:23 INFO - 'SHLVL': '1', 13:17:23 INFO - 'TERM': 'linux', 13:17:23 INFO - 'TMOUT': '86400', 13:17:23 INFO - 'USER': 'cltbld', 13:17:23 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280', 13:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:23 INFO - '_': '/tools/buildbot/bin/python'} 13:17:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:17:23 INFO - mozversion application_buildid: 20160720125722 13:17:23 INFO - mozversion application_changeset: c6e4b6a744697056dcebe1cf298ed3b7de85311c 13:17:23 INFO - mozversion application_display_name: Nightly 13:17:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:17:23 INFO - mozversion application_name: Firefox 13:17:23 INFO - mozversion application_remotingname: firefox 13:17:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:17:23 INFO - mozversion application_vendor: Mozilla 13:17:23 INFO - mozversion application_version: 50.0a1 13:17:23 INFO - mozversion platform_buildid: 20160720125722 13:17:23 INFO - mozversion platform_changeset: c6e4b6a744697056dcebe1cf298ed3b7de85311c 13:17:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:17:23 INFO - mozversion platform_version: 50.0a1 13:17:23 INFO - using testdate: 1469045843 13:17:23 INFO - actual date: 1469045843 13:17:23 INFO - starting webserver on 'localhost:50576' 13:17:23 INFO - SUITE-START | Running 2 tests 13:17:23 INFO - TEST-START | dromaeo_css 13:17:23 INFO - operating with platform_type : linux_ 13:17:23 INFO - Initialising browser for dromaeo_css test... 13:17:23 INFO - TEST-INFO | started process 30403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxemiiX/profile http://localhost:50576/getInfo.html) 13:17:27 INFO - PROCESS | 30403 | __metrics Screen width/height:1600/1200 13:17:27 INFO - PROCESS | 30403 | colorDepth:24 13:17:27 INFO - PROCESS | 30403 | Browser inner width/height: 1024/697 13:17:27 INFO - PROCESS | 30403 | __metrics 13:17:28 INFO - PROCESS | 30403 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:17:28 INFO - PROCESS | 30403 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:17:29 INFO - TEST-INFO | 30403: exit 0 13:17:29 INFO - Browser initialized. 13:17:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:17:29 INFO - TEST-INFO | started process 30481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxemiiX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:41 INFO - PROCESS | 30481 | RSS: Main: 158642176 13:17:41 INFO - PROCESS | 30481 | 13:18:33 INFO - PROCESS | 30481 | 1469045913159 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:20:45 INFO - PROCESS | 30481 | Cycle 1(1): loaded http://localhost:50576/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50576/tests/dromaeo/cssquery-ext.html) 13:20:46 INFO - PROCESS | 30481 | RSS: Main: 232140800 13:20:46 INFO - PROCESS | 30481 | 13:23:48 INFO - PROCESS | 30481 | Cycle 1(1): loaded http://localhost:50576/tests/dromaeo/cssquery-ext.html (next: http://localhost:50576/tests/dromaeo/cssquery-jquery.html) 13:23:49 INFO - PROCESS | 30481 | RSS: Main: 242618368 13:23:49 INFO - PROCESS | 30481 | 13:26:51 INFO - PROCESS | 30481 | Cycle 1(1): loaded http://localhost:50576/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50576/tests/dromaeo/cssquery-mootools.html) 13:26:52 INFO - PROCESS | 30481 | RSS: Main: 191430656 13:26:52 INFO - PROCESS | 30481 | 13:29:54 INFO - PROCESS | 30481 | Cycle 1(1): loaded http://localhost:50576/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50576/tests/dromaeo/cssquery-prototype.html) 13:29:54 INFO - PROCESS | 30481 | RSS: Main: 199688192 13:29:54 INFO - PROCESS | 30481 | 13:32:57 INFO - PROCESS | 30481 | Cycle 1(1): loaded http://localhost:50576/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50576/tests/dromaeo/cssquery-yui.html) 13:32:58 INFO - PROCESS | 30481 | RSS: Main: 190468096 13:32:58 INFO - PROCESS | 30481 | 13:36:01 INFO - PROCESS | 30481 | Cycle 1(1): loaded http://localhost:50576/tests/dromaeo/cssquery-yui.html (next: http://localhost:50576/tests/dromaeo/cssquery-dojo.html) 13:36:01 INFO - PROCESS | 30481 | RSS: Main: 284725248 13:36:01 INFO - PROCESS | 30481 | 13:36:01 INFO - PROCESS | 30481 | __start_tp_report 13:36:01 INFO - PROCESS | 30481 | _x_x_mozilla_page_load 13:36:01 INFO - PROCESS | 30481 | _x_x_mozilla_page_load_details 13:36:01 INFO - PROCESS | 30481 | |i|pagename|runs| 13:36:01 INFO - PROCESS | 30481 | |0;dojo.html;2581.909633162839;2605.3356394119496;2632.47350529894;2652.4827658606578;2655.2698008047782;4613.8615841524725;4712.528747125294;4784.162771514984;4805.1831188697915;4815.470298267192;4640.535946405358;4709.623230141589;4715.104130215265;4729.9054018919605;4737.360456338393;4310.331898555729;4340.804663790122;4362.105768317495;4365.716228445141;4422.535633758457;4364.301711726124;4428.512863585003;4460.041091165399;4507.977460112695;4542.500324964251;4484.641228701696;4493.438320209973;4500.639948804121;4522.751248681321;4544.8863778405475;4228.217779710763;4306.5262821089655;4334.046509767878;4405.361222622734;4417.403650507173;4228.577142285778;4233.068724880522;4274.978625106885;4276.994906197041;4441.467023957113;4647.140279048387;4657.091867085919;4673.065386922629;4693.55411235932;4707.317438971364;4889.29105279736;5007.924881126786;5018;5023.824166154167;5026.874328141826;5154.12379895415;5160.535551800319;5166.07010738067;5170.069387510247;5177.870553236162;4782.306565547976;4804.2073057945745;4816.470188279286;4818.397700287464;4824.807007719652;5087.364079490064;5164.870878227999;5216.295800066942;5242.239875218072;5272.156454967264;5020.673656212334;5073.518015788494;5091.058154241403;5092.770825312869;5093.9490605094215;5138;5138.306328645585;5141.665791723526;5164.251183578435;5189.247559103909;4880.853574392774;4894.388201474816;4897.657163998557;4954.256861470808;5052.646314758005;4928.7289199093675;4949.727764972961;4980.526849949249;4996.475370086161;4997.025580011863;4284.89287767802;4290.656747460196;4290.656747460196;4333.155034768253;4335.82656693735;3713.962860371416;3722.4602432647116;3727.496787933594;3754.4931434256027;3788.109794198361;4327.956720432819;4362.8036738346855;4365.890852728708;4377.387165796791;4423.402840616475;5083.440821509631;5111.156659151273;5116.590672746172;5117.078925793318;5161.974190129025;4282.871513854527;4357.586029327209;4358.934615980763;4360.629346505582;4406.33904914259;4549.431321084864;4550.408446901948;4590.97704511482;4591.770411479412;4633.4671512775785;4758.04839032188;4769.260764581495;4777;4786.6888652238185;4808.591269742111;5025.095482813129;5060.772265248146;5080.923786143137;5098.694078355162;5125.051865404912;4641.8143274270005;4774.546418090275;4833.10587541306;4833.806647734052;4891.33966914462;5064.290999260033;5075.796968121382;5076.593872490266;5081.11080560893;5127.743612819419;5150.072986862251;5156.7421628917655;5158.742062896765;5160.200168973815;5166.45752196029;4790.257510085942;4927.310176575354;4960.355153829979;4979.975100124621;5040.521150490697;4990.451050384528;5002.124628189979;5003.499650034967;5006.724630145377;5049.747512624427;4925.310456536016;4935.8025678972435;4936.234883593049;4941.160002799605;4992.975035124801;4699.953000469952;4875.878103047452;4940.135476291706;4944.258361245842;5000.949990500048;4863.3434486343895;4875.414950205998;4875.658703890694;4877.365942427462;4922.212446008622 13:36:01 INFO - PROCESS | 30481 | |1;ext.html;578.7193211292524;583.2417856786179;584.9824505264841;590.1973316289846;596.6300893446064;27727.16818495446;39158;40508.79745601268;40626.187476250496;44525.554744452624;40697;41225;41269;41286.38070428946;41299.38050929231;7822.84354312912;7982.560959147245;7988.480748751342;7992.160823113577;7998.36013118952;7862.292393684567;7940.2853743163105;7942.3646108311195;7944.324732397753;7946.6821327146845;7943.64253608589;8015.519068855858;8015.559144247064;8020.598970051474;8020.919790802076;7901;7946.920530794676;7958.243966823143;7958.403119765982;7960.681572737083;7802.492837965571;7871.685132594689;7871.724489642835;7877.133515313311;7879.054513458422;38133.427998580046;38539.42190867139;38573;38590;38599.8070009651;2824.053941929456;3081.784275100744;3717.7955212463303;3733.925321493582;3796.90507737306;27309.726902731116;29539.85230073836;29903.102906912827;29967.550486742715;30008.399832003455;3316.8839090631955;3341.465365541526;3421.640727723603;3435.6220815710253;3491.807950562718;275940;276320;277091;277359;277580.99999999796;29062.854685726437;56388.15417768737;56739.148912766344;56900.43099569034;56922.146167807514;31063.223419414695;32843.671563284064;33059.33881322408;33079.17302067467;33095.35951045383;13800.378982945791;13954.790678139836;13957.720845583031;13960.441582336593;13961.720765584632;11502.827457588142;11508.251963622337;11526.769464610661;11532.481038353295;11545.076393888468;7830.334421574116;7893.684252629945;7964.721234756872;8002;8050.557219352875;3142.135912624047;3142.4500712375243;3189.3940151371166;3207.6792320767736;3236.0777178504486;841.5329492131925;876.1939016105199;878.6485405837716;880.8546589812737;977.022977022977;27911.441771164464;28445.431091378472;28544;28941;29045.709542904722;969.3892847506027;974.288769198489;1011.6155860772859;1013.6452241715488;1105.7180418993105;14943.775843362359;15245.923770381078;15246.313915873812;15610.673092787014;15627.374905003673;467764.64470711077;480011;482515;755747;759516;51061;51567.7421612897;51609.483905160465;51659.741701292005;51707;1210.509743553862;1216.2512721249861;1230.5508489401484;1231.4396949388185;1239.2440611227144;27698.446031079668;28613.427731444837;29196.854015729787;29960.70039299579;30154;43092.78453607712;43435.13129737324;43583.12833743244;43745.34381984209;43849.78075109604;357674;359292.23892686155;359415;359698;359953;25628.487430251662;25811.225663230132;26209.73790262073;26256.455378523653;26314.605280921183;40538.79730601328;40910;41727;41801.95495112646;42138.57861421347;35475.645243548264;35654.643453565135;35940;36172.638273616925;37228.44157337588;35461;35820.462693060144;35898.8205058973;35921.46117808287;36104.63895361118;30085;34113.14717132092;35368.823155884056;35716.64283357133;35841.103972400895;29190.27024324409;31797.933134346193;32562.837185813918;32873.50689739608;32936.67063329336;24161.87919060464;24390;24771.256862293438;24852.875735621205;24868 13:36:01 INFO - PROCESS | 30481 | |2;jquery.html;360.38554264978217;360.9801460919649;367.44515781170435;375.3206695880458;385.8745907580037;16386.91806540967;17724.37964671237;17892;17974;18099.90950045251;16464.423745168922;17719.911400443012;17744;17776.46670599881;17887.373941912036;5061.772220250079;5310.20346947957;5315.415304316522;5335.599830012745;5340.519353258206;3838.3282925488065;3885.8834234972855;3971.98714327846;5232.92150617741;5302.973485132588;6205.03821907605;6207.968960155193;6213;6213.720382582795;6214.968925155368;5923.378045305246;6043.546733994968;6148.508119350441;6183.319834818167;6188.690565471731;5364.088105022156;5368.087425137736;5379.5427388671615;5387.057264978613;5388.973055134699;18711.906440467847;21445.463863403384;21495.892520537454;21660.89169554158;21702.782972170233;1907.5612609099846;1963.7054441833839;2007.2272175212502;2051.3743308290964;2543.796496280293;8623;13310.86689133106;13391.799123013163;13573.253471059088;13811.654708632364;1681.5207665815185;1726.8791184617082;1779.350537053979;1808.8191180881938;1836.5316844204776;69672.651636742;69730.95403569001;69995.30004699939;72121;74011;9432.434053956784;9550.140487356171;9597.376170548892;9722.805543889224;9843;13327.133736307109;13339.933300333436;13354.866451335361;13357.33213339329;13367.398467069006;7504.849903002018;7618.809529761689;7626.275503827128;7719.729809456642;7747.496412733154;7472.813179670552;7482;7486.775396738107;7658.923410765821;7664.271894170045;6057.394260573908;6128.17269668598;6213.813585592439;6230.221222347207;6295.181626388632;1715.5968347438343;1737.3137610643978;1756.1833747307564;1764.1179410294853;1792.3099606651533;402.9879103626896;408.04517429215775;408.88551205662463;851.8977722673319;886.5522910930068;10718.571257149782;10726.73183170427;10749.78500429987;11011.119110471143;11249.268797528135;396.1739772574215;406.47970597634486;409.47587088526734;410.06914304528556;411.66860677155177;4935.432425271068;5701.743421546041;5746.511546518593;5779.306483222041;5961.135635332853;142563;266308;446938;447071;452460;79957.60021199973;80423;81407;81831;83320.58339708384;421.3574299193754;434.58497135236405;435.16448419034896;435.22747123854776;436.11468718501493;9745.512724363613;9793;9808.852867206855;9844.950775246078;9917.553710083208;37292.81353593323;37653.435198471496;38273;38322.42516362201;38778.80610596929;51832;52239.47760522346;54706;55123.72438137783;57220;7424.591647459226;7461.850762984818;7481.326680598772;7588.8482230356185;7877.6455059523605;8807.603657835285;11212.887871121184;11368.829467557827;12442.937785311016;12834.037447191311;9736.513174341397;9769.658061967797;9827.85258221113;10246.077852993267;10319.845202322122;9438.622455101719;10124.645637402655;10204.081632653097;10204.336718113298;10217.693469195936;9497.192738617296;9762.853557196506;9841.803163936538;10184.643537476153;10203.846942295722;7603.695852165852;7743.688893551737;7759.262870027338;7811.609419528887;7999.84000320002;8845.867311990196;9968.950155249177;9990.300678952404;10052.195824333889;10269.845952310572 13:36:01 INFO - PROCESS | 30481 | |3;mootools.html;1273.0261350067194;1373.21726615829;1414.1444426122196;1504.4057597249086;1752.0276246683093;6944.444444444445;7624.237576242373;7847.725329613465;7875.645595948182;7884.132745398002;7648.694052237904;7807.5315481071175;7814.882776758353;8064.153263907278;8066.395020373466;2217.079911836586;2261.42333704905;2268.206127855254;2269.1604106480545;2269.466675331296;2128.755193152792;2184.530325979914;2188.0481990334174;2189.474526113729;2190.452386903274;2180.520285537187;2206.1947389202905;2213.8228941684706;2215.878126703031;2216.645336746121;2160.319499357697;2175.8803265820375;2182.2798476502717;2183.3340831046526;2183.4977955070262;2173.5109600339956;2180.8473406861526;2181.9781802181933;2183.1813070098715;2187.3547303545492;7956.204379562056;8056.677732890677;8058.838823223561;8069;8069.233422824822;4630.560096790799;4798.904021919542;4823.083614113307;4877.170880950247;4888.486708895551;2804.2708895687065;2944.2050646325374;2978.4489869374233;2989.5067313893182;3001.3096987692734;957.9616815327379;965.2663975378763;971.4754032822267;972.6790159247431;977.6871401151634;10765.084967777748;11043.282186657922;11052.778944421067;11069.335839849555;11074.667759967213;4286.421333120051;4313.202057619351;4359.04101097758;4401.911961760811;4432.667549933768;9587.233021358275;9615.375000624937;9616.807663846825;9620.518974051269;9624.51877406127;4820;4829.203181475087;4830.589399901048;4837.129316723023;4837.95162048382;3517.2262102337445;3618.8914332570066;4375.890602734893;4420.646348292129;4421.226285400042;3730.9626903730614;3791.374423220193;3796.7152463565344;3857.633524815138;3860.247251785931;1186.323795436593;1211.6425654431964;1217.9147459677738;1226.4910062324213;1235.2835355493792;596.174298596447;700.1283402164338;798.772349880293;833.2542374574722;839.6515446089804;5043.167877300278;5166.5866730661455;5247.239150323258;5270.8155214567305;5322.36131664195;427.85666801621807;432.0236266038775;442.12018084013226;443.55422800085705;592.2715060475639;3387.2378714788974;3453.5165076889257;3468.8959331220103;3542.5926018507685;3608.8736894208578;9765.707028789147;10065.496725163712;10159;10168.898311016796;10211.642592509226;9838.458884761407;9858.852117218104;9970.40177589347;9991.200703943667;10058.899411005796;7595.5822429766895;7599.050118735158;7634.770956871303;7638.541687498879;7648.42636802242;5228.3987341454695;5271.472852714698;5348.064088784525;5351.03681337363;5434.347878254634;9022.233110185707;9173.724788256362;9216;9257.953710231406;9301.302402319718;9307.255419566554;9345.48599827016;9388.95305523468;9389.24886009104;9405.24758019343;6971.47713921468;7042.119735033121;7046.2249152594195;7050.2597227292445;7050.929490705027;7527.585982770781;7573.810654733676;7617.42869284817;7627.54234745917;7636.198199189227;6851.725930962705;6864.176298844171;6918;6929.099217101744;6963.9651801740665;6813.4208592270215;6850.177978642595;6937.410320122644;6967.7212911482975;6978.79063628092;6196.349383314687;6282.591631543935;6283.5287353449585;6289.779857704958;6294.15028971083;4605.194091033989;4646.558576935186;4702.600278976325;4720.268358404453;4738.928916066193;4718.103560323528;4718.669693121586;4752.667313288037;4774.236122220428;4903.092927808367 13:36:01 INFO - PROCESS | 30481 | |4;prototype.html;296.93912747886685;301.0561888479616;307.1737027396305;309.05275331110147;309.28709325005866;4794.496577859322;4815.831445899395;4828.744526423129;4854.150523658354;4866.8053277868885;4517.209488339544;4636.907261854769;4656.580907718305;4758.785854636541;4819.0602832447685;3800.182960663457;3807.5811660717436;3825.8469661213658;3833.961660383395;3859.6333348331864;3808.2672384065186;3810.7043605174235;3810.866619668312;3833.118382771964;3848.7883166425836;3614.9096272593133;3627.419612861943;3786.602406747293;3792.924141517168;3793.0706976790725;3756.906077348061;3761.2101458693705;3796.886093417202;3801.258754542865;3809.7904615246152;3379.4761811919193;3388.508666243381;3389.711874490671;3391.3217356528794;3396.6603339666085;4466.397036400077;4739.312799644067;4740.597049250818;4766.666333356667;4775.737334446604;4237.4279472271155;4277.508086570022;4280.614744672963;4312.5903039211225;4322.935155972631;5039.571636410909;5047.823326183566;5049.267856160836;5057.671251368649;5070.847874563769;3620.275944811022;3623.873164439232;3626.1659818241687;3627.093226693327;3636.6363363663686;5158;5190.273361729361;5207;5245;5254.8686282842855;3667.7982710951155;3675.5221821163614;3686.612905644922;3697.3714468539874;3699.9445008324897;3755.6244375562774;3778.923006943008;3780.4896338994436;3781.9977705907954;3795.544534655859;4178.979105104516;4280.92976755811;4288.742675439421;4294.849680261176;4297.978510107492;4989.950100498949;5009.874753131201;5013.172826483589;5015.22264049073;5019.247112933089;1280.1678908709414;1293.9223646581236;1294.288141522159;1298.9935050324877;1301.6550614087275;817.5707753429497;837.5519097282925;853.5732133933034;882.2589025218847;898.6989358564823;4392.472903251566;4392.604665580113;4399.934000989988;4404.603585677304;4406.876246557107;5118.923216151761;5129.435762066169;5130.2048182531025;5142.460041695643;5145.691258524501;4228.498882896527;4354.455693038371;4399.934000989923;4414.933775993362;4419.64642828573;2702.7027027027407;2710.6069619905;2712.1321177223494;2713.158920734539;2713.5658294672758;4777.402824646919;4791.281307803857;4814.422269327703;4815.15734746425;4829.758512074382;5080.491950804964;5223.634345595772;5228.2941802856885;5236.947630523646;5266.3943646480375;4765.118453086259;4772.331873537708;4780.187368147493;4797.760111994457;4810.653017155202;5045.268436076822;5051.545360917535;5080.898382032265;5093.668911520739;5105.668131571436;4788.712677239377;4946.7138543979545;4961.925571116509;4967.975160124176;4981.651284410056;4765.428148622187;4778.805298675331;4792.640551958687;4801.50321832652;4809.903801923872;3654.597994220687;3689.5941446440333;3709.1283548365573;3709.888703338904;3714.517112775322;5002.399712034579;5188.896222075613;5192.610554208525;5194.402643696023;5276.865473923125;5002.499750025114;5064.645474816874;5083.856132370335;5131.820386286462;5150.948490515197;5079.187330027178;5134.686863035068;5140.537351638371;5140.56305214046;5140.742962851918;4870.514493079645;4970.229614409773;5019.598432125495;5052.873678158076;5059.418166910852;4790.377250957354;4859.271109333628;5039.874003149951;5054.721990290569;5067.822626208065;4939.827106051271;4940.11078005948;4949.950500495093;4952.727599982036;4969.801207951786 13:36:01 INFO - PROCESS | 30481 | |5;yui.html;622.6388694557154;641.5669423139382;643.9195100612424;670.7719375412362;719.2807192807193;13049.41277642506;14225.502107426242;14273.2863356832;14281.571552853406;14287.571372858818;13388.531401400953;13489.258090805002;13525.391357388917;13527.458901643948;13551.25468099254;620.7051650466016;625.9467945224661;770.6378002338892;778.4317448262772;789.9960500197491;793.7063286583972;795.8845967334732;796.6892911764387;796.77690246731;796.8167321516055;834.1366685480529;834.7328854766478;840.1220724343076;840.3403328387217;840.5461051032435;656.1175219329994;672.3310306245269;672.8553361027354;674.3762020131408;837.7444879311807;593.664579512574;612.3876123876124;615.1695211464532;616.4451993206151;616.9352218017088;13271.800922986164;13296.401661925236;13300;13313.933430332787;13320.733585328337;12035;12097;12380.876191238063;12650;12830.101892867502;11511.48198331077;11713.590024349192;11947.522099116024;12273.57042503517;12452.626421207378;4110.99589694229;4125.1131006833675;4194.832206711728;4318.632916202127;4325.610695037431;59672.403275967554;59727;59827.40172598305;59841.700791495765;59880;9983.700488985342;10216.642417515352;10339.741506462398;10379.481025948673;10686.51910664022;18581.721274180898;18713.345032923782;18717.532061698566;18729.250829966648;18738.531536711693;6352.301246862841;6801.523893327519;6962.373386395248;7113.0753002109395;7136.107986501687;3732.9813350933073;3886.6696330811633;3904.141088960424;3933.252681990413;3959.128991621896;2953.2173973896934;3057.2356910772305;3078.1381213259874;3082.2910730532103;3086.6913308668954;504.32420556454525;521.0698902459093;532.0449792622252;532.6324835863242;541.8564080518665;370.01022265439843;466.6360239013575;471.6627611257967;497.5124378109473;524.3157679228567;7395;7560;7594.126675432285;7713.421493387906;7998.12020677725;492.1977177201211;497.3310896843739;501.75664802570725;514.8584139361706;516.7080599461292;3391.184517984468;3537.4163263061823;3589.587197472324;3615.439606860941;3634.890953271406;56336.154957675666;68631.65684171548;91587.54206228926;93437;94623.52688236514;47311;50626.49373506218;76809.99999999888;76847.23152768401;82125.58937205275;68998;70180.92919314242;72991.63504182445;72998.27001730021;77112;6684.799456016327;6884.173899132136;6940.7917762467205;7054.153501579844;7096.822579435556;43394.349084764384;43660;44141.33787993118;45623.31565026593;46729.53270467252;60013.699931500065;62347.6882615584;62713.37286627258;63683.363166367744;66834.99747503888;8991.55042247898;9045.73856535866;9125.22435592982;9318.254539636677;9408.106229908148;10163.237757168094;10293;10299.330543514647;10607;11088.112950964065;9055.592498337459;9089.545522723969;9166.587503562223;9379.718608441757;9429.198518126037;9569.473678947725;9669.323147379617;9890.505474726378;9968.352057116264;10324.948375258076;9385.483798391155;9592.376495527767;9742.415455072718;9778.266630002636;9789.412635241908;7917.564533950688;8049.39629527776;8242.958785206036;8251.917480825115;8315.210055044761;8233.300169485661;8327.292180164512;8703.825923481621;8804;8945.23965462943 13:36:01 INFO - PROCESS | 30481 | __end_tp_report 13:36:01 INFO - PROCESS | 30481 | __start_cc_report 13:36:01 INFO - PROCESS | 30481 | _x_x_mozilla_cycle_collect,1136 13:36:01 INFO - PROCESS | 30481 | __end_cc_report 13:36:01 INFO - PROCESS | 30481 | __startTimestamp1469046961599__endTimestamp 13:36:01 INFO - PROCESS | 30481 | 13:36:01 INFO - PROCESS | 30481 | ------- Summary: start ------- 13:36:01 INFO - PROCESS | 30481 | Number of tests: 6 13:36:01 INFO - PROCESS | 30481 | 13:36:01 INFO - PROCESS | 30481 | [#0] dojo.html Cycles:165 Average:4698.66 Median:4818.40 stddev:500.41 (10.4%) stddev-sans-first:473.60 13:36:01 INFO - PROCESS | 30481 | Values: 2581.9 2605.3 2632.5 2652.5 2655.3 4613.9 4712.5 4784.2 4805.2 4815.5 4640.5 4709.6 4715.1 4729.9 4737.4 4310.3 4340.8 4362.1 4365.7 4422.5 4364.3 4428.5 4460.0 4508.0 4542.5 4484.6 4493.4 4500.6 4522.8 4544.9 4228.2 4306.5 4334.0 4405.4 4417.4 4228.6 4233.1 4275.0 4277.0 4441.5 4647.1 4657.1 4673.1 4693.6 4707.3 4889.3 5007.9 5018.0 5023.8 5026.9 5154.1 5160.5 5166.1 5170.1 5177.9 4782.3 4804.2 4816.5 4818.4 4824.8 5087.4 5164.9 5216.3 5242.2 5272.2 5020.7 5073.5 5091.1 5092.8 5093.9 5138.0 5138.3 5141.7 5164.3 5189.2 4880.9 4894.4 4897.7 4954.3 5052.6 4928.7 4949.7 4980.5 4996.5 4997.0 4284.9 4290.7 4290.7 4333.2 4335.8 3714.0 3722.5 3727.5 3754.5 3788.1 4328.0 4362.8 4365.9 4377.4 4423.4 5083.4 5111.2 5116.6 5117.1 5162.0 4282.9 4357.6 4358.9 4360.6 4406.3 4549.4 4550.4 4591.0 4591.8 4633.5 4758.0 4769.3 4777.0 4786.7 4808.6 5025.1 5060.8 5080.9 5098.7 5125.1 4641.8 4774.5 4833.1 4833.8 4891.3 5064.3 5075.8 5076.6 5081.1 5127.7 5150.1 5156.7 5158.7 5160.2 5166.5 4790.3 4927.3 4960.4 4980.0 5040.5 4990.5 5002.1 5003.5 5006.7 5049.7 4925.3 4935.8 4936.2 4941.2 4993.0 4700.0 4875.9 4940.1 4944.3 5000.9 4863.3 4875.4 4875.7 4877.4 4922.2 13:36:01 INFO - PROCESS | 30481 | 13:36:01 INFO - PROCESS | 30481 | [#1] ext.html Cycles:180 Average:53931.58 Median:197677.50 stddev:117149.46 (59.3%) stddev-sans-first:117409.61 13:36:01 INFO - PROCESS | 30481 | Values: 578.7 583.2 585.0 590.2 596.6 27727.2 39158.0 40508.8 40626.2 44525.6 40697.0 41225.0 41269.0 41286.4 41299.4 7822.8 7982.6 7988.5 7992.2 7998.4 7862.3 7940.3 7942.4 7944.3 7946.7 7943.6 8015.5 8015.6 8020.6 8020.9 7901.0 7946.9 7958.2 7958.4 7960.7 7802.5 7871.7 7871.7 7877.1 7879.1 38133.4 38539.4 38573.0 38590.0 38599.8 2824.1 3081.8 3717.8 3733.9 3796.9 27309.7 29539.9 29903.1 29967.6 30008.4 3316.9 3341.5 3421.6 3435.6 3491.8 275940.0 276320.0 277091.0 277359.0 277581.0 29062.9 56388.2 56739.1 56900.4 56922.1 31063.2 32843.7 33059.3 33079.2 33095.4 13800.4 13954.8 13957.7 13960.4 13961.7 11502.8 11508.3 11526.8 11532.5 11545.1 7830.3 7893.7 7964.7 8002.0 8050.6 3142.1 3142.5 3189.4 3207.7 3236.1 841.5 876.2 878.6 880.9 977.0 27911.4 28445.4 28544.0 28941.0 29045.7 969.4 974.3 1011.6 1013.6 1105.7 14943.8 15245.9 15246.3 15610.7 15627.4 467764.6 480011.0 482515.0 755747.0 759516.0 51061.0 51567.7 51609.5 51659.7 51707.0 1210.5 1216.3 1230.6 1231.4 1239.2 27698.4 28613.4 29196.9 29960.7 30154.0 43092.8 43435.1 43583.1 43745.3 43849.8 357674.0 359292.2 359415.0 359698.0 359953.0 25628.5 25811.2 26209.7 26256.5 26314.6 40538.8 40910.0 41727.0 41802.0 42138.6 35475.6 35654.6 35940.0 36172.6 37228.4 35461.0 35820.5 35898.8 35921.5 36104.6 30085.0 34113.1 35368.8 35716.6 35841.1 29190.3 31797.9 32562.8 32873.5 32936.7 24161.9 24390.0 24771.3 24852.9 24868.0 13:36:01 INFO - PROCESS | 30481 | 13:36:01 INFO - PROCESS | 30481 | [#2] jquery.html Cycles:180 Average:23235.36 Median:28446.89 stddev:62190.25 (218.6%) stddev-sans-first:62340.99 13:36:01 INFO - PROCESS | 30481 | Values: 360.4 361.0 367.4 375.3 385.9 16386.9 17724.4 17892.0 17974.0 18099.9 16464.4 17719.9 17744.0 17776.5 17887.4 5061.8 5310.2 5315.4 5335.6 5340.5 3838.3 3885.9 3972.0 5232.9 5303.0 6205.0 6208.0 6213.0 6213.7 6215.0 5923.4 6043.5 6148.5 6183.3 6188.7 5364.1 5368.1 5379.5 5387.1 5389.0 18711.9 21445.5 21495.9 21660.9 21702.8 1907.6 1963.7 2007.2 2051.4 2543.8 8623.0 13310.9 13391.8 13573.3 13811.7 1681.5 1726.9 1779.4 1808.8 1836.5 69672.7 69731.0 69995.3 72121.0 74011.0 9432.4 9550.1 9597.4 9722.8 9843.0 13327.1 13339.9 13354.9 13357.3 13367.4 7504.8 7618.8 7626.3 7719.7 7747.5 7472.8 7482.0 7486.8 7658.9 7664.3 6057.4 6128.2 6213.8 6230.2 6295.2 1715.6 1737.3 1756.2 1764.1 1792.3 403.0 408.0 408.9 851.9 886.6 10718.6 10726.7 10749.8 11011.1 11249.3 396.2 406.5 409.5 410.1 411.7 4935.4 5701.7 5746.5 5779.3 5961.1 142563.0 266308.0 446938.0 447071.0 452460.0 79957.6 80423.0 81407.0 81831.0 83320.6 421.4 434.6 435.2 435.2 436.1 9745.5 9793.0 9808.9 9845.0 9917.6 37292.8 37653.4 38273.0 38322.4 38778.8 51832.0 52239.5 54706.0 55123.7 57220.0 7424.6 7461.9 7481.3 7588.8 7877.6 8807.6 11212.9 11368.8 12442.9 12834.0 9736.5 9769.7 9827.9 10246.1 10319.8 9438.6 10124.6 10204.1 10204.3 10217.7 9497.2 9762.9 9841.8 10184.6 10203.8 7603.7 7743.7 7759.3 7811.6 7999.8 8845.9 9969.0 9990.3 10052.2 10269.8 13:36:01 INFO - PROCESS | 30481 | 13:36:01 INFO - PROCESS | 30481 | [#3] mootools.html Cycles:180 Average:5257.06 Median:4857.56 stddev:3007.52 (61.9%) stddev-sans-first:3001.05 13:36:01 INFO - PROCESS | 30481 | Values: 1273.0 1373.2 1414.1 1504.4 1752.0 6944.4 7624.2 7847.7 7875.6 7884.1 7648.7 7807.5 7814.9 8064.2 8066.4 2217.1 2261.4 2268.2 2269.2 2269.5 2128.8 2184.5 2188.0 2189.5 2190.5 2180.5 2206.2 2213.8 2215.9 2216.6 2160.3 2175.9 2182.3 2183.3 2183.5 2173.5 2180.8 2182.0 2183.2 2187.4 7956.2 8056.7 8058.8 8069.0 8069.2 4630.6 4798.9 4823.1 4877.2 4888.5 2804.3 2944.2 2978.4 2989.5 3001.3 958.0 965.3 971.5 972.7 977.7 10765.1 11043.3 11052.8 11069.3 11074.7 4286.4 4313.2 4359.0 4401.9 4432.7 9587.2 9615.4 9616.8 9620.5 9624.5 4820.0 4829.2 4830.6 4837.1 4838.0 3517.2 3618.9 4375.9 4420.6 4421.2 3731.0 3791.4 3796.7 3857.6 3860.2 1186.3 1211.6 1217.9 1226.5 1235.3 596.2 700.1 798.8 833.3 839.7 5043.2 5166.6 5247.2 5270.8 5322.4 427.9 432.0 442.1 443.6 592.3 3387.2 3453.5 3468.9 3542.6 3608.9 9765.7 10065.5 10159.0 10168.9 10211.6 9838.5 9858.9 9970.4 9991.2 10058.9 7595.6 7599.1 7634.8 7638.5 7648.4 5228.4 5271.5 5348.1 5351.0 5434.3 9022.2 9173.7 9216.0 9258.0 9301.3 9307.3 9345.5 9389.0 9389.2 9405.2 6971.5 7042.1 7046.2 7050.3 7050.9 7527.6 7573.8 7617.4 7627.5 7636.2 6851.7 6864.2 6918.0 6929.1 6964.0 6813.4 6850.2 6937.4 6967.7 6978.8 6196.3 6282.6 6283.5 6289.8 6294.2 4605.2 4646.6 4702.6 4720.3 4738.9 4718.1 4718.7 4752.7 4774.2 4903.1 13:36:01 INFO - PROCESS | 30481 | 13:36:01 INFO - PROCESS | 30481 | [#4] prototype.html Cycles:180 Average:4175.41 Median:4774.03 stddev:1198.24 (25.1%) stddev-sans-first:1165.70 13:36:01 INFO - PROCESS | 30481 | Values: 296.9 301.1 307.2 309.1 309.3 4794.5 4815.8 4828.7 4854.2 4866.8 4517.2 4636.9 4656.6 4758.8 4819.1 3800.2 3807.6 3825.8 3834.0 3859.6 3808.3 3810.7 3810.9 3833.1 3848.8 3614.9 3627.4 3786.6 3792.9 3793.1 3756.9 3761.2 3796.9 3801.3 3809.8 3379.5 3388.5 3389.7 3391.3 3396.7 4466.4 4739.3 4740.6 4766.7 4775.7 4237.4 4277.5 4280.6 4312.6 4322.9 5039.6 5047.8 5049.3 5057.7 5070.8 3620.3 3623.9 3626.2 3627.1 3636.6 5158.0 5190.3 5207.0 5245.0 5254.9 3667.8 3675.5 3686.6 3697.4 3699.9 3755.6 3778.9 3780.5 3782.0 3795.5 4179.0 4280.9 4288.7 4294.8 4298.0 4990.0 5009.9 5013.2 5015.2 5019.2 1280.2 1293.9 1294.3 1299.0 1301.7 817.6 837.6 853.6 882.3 898.7 4392.5 4392.6 4399.9 4404.6 4406.9 5118.9 5129.4 5130.2 5142.5 5145.7 4228.5 4354.5 4399.9 4414.9 4419.6 2702.7 2710.6 2712.1 2713.2 2713.6 4777.4 4791.3 4814.4 4815.2 4829.8 5080.5 5223.6 5228.3 5236.9 5266.4 4765.1 4772.3 4780.2 4797.8 4810.7 5045.3 5051.5 5080.9 5093.7 5105.7 4788.7 4946.7 4961.9 4968.0 4981.7 4765.4 4778.8 4792.6 4801.5 4809.9 3654.6 3689.6 3709.1 3709.9 3714.5 5002.4 5188.9 5192.6 5194.4 5276.9 5002.5 5064.6 5083.9 5131.8 5150.9 5079.2 5134.7 5140.5 5140.6 5140.7 4870.5 4970.2 5019.6 5052.9 5059.4 4790.4 4859.3 5039.9 5054.7 5067.8 4939.8 4940.1 4950.0 4952.7 4969.8 13:36:01 INFO - PROCESS | 30481 | 13:36:01 INFO - PROCESS | 30481 | [#5] yui.html Cycles:180 Average:16364.78 Median:613.78 stddev:22901.30 (3731.2%) stddev-sans-first:22935.04 13:36:01 INFO - PROCESS | 30481 | Values: 622.6 641.6 643.9 670.8 719.3 13049.4 14225.5 14273.3 14281.6 14287.6 13388.5 13489.3 13525.4 13527.5 13551.3 620.7 625.9 770.6 778.4 790.0 793.7 795.9 796.7 796.8 796.8 834.1 834.7 840.1 840.3 840.5 656.1 672.3 672.9 674.4 837.7 593.7 612.4 615.2 616.4 616.9 13271.8 13296.4 13300.0 13313.9 13320.7 12035.0 12097.0 12380.9 12650.0 12830.1 11511.5 11713.6 11947.5 12273.6 12452.6 4111.0 4125.1 4194.8 4318.6 4325.6 59672.4 59727.0 59827.4 59841.7 59880.0 9983.7 10216.6 10339.7 10379.5 10686.5 18581.7 18713.3 18717.5 18729.3 18738.5 6352.3 6801.5 6962.4 7113.1 7136.1 3733.0 3886.7 3904.1 3933.3 3959.1 2953.2 3057.2 3078.1 3082.3 3086.7 504.3 521.1 532.0 532.6 541.9 370.0 466.6 471.7 497.5 524.3 7395.0 7560.0 7594.1 7713.4 7998.1 492.2 497.3 501.8 514.9 516.7 3391.2 3537.4 3589.6 3615.4 3634.9 56336.2 68631.7 91587.5 93437.0 94623.5 47311.0 50626.5 76810.0 76847.2 82125.6 68998.0 70180.9 72991.6 72998.3 77112.0 6684.8 6884.2 6940.8 7054.2 7096.8 43394.3 43660.0 44141.3 45623.3 46729.5 60013.7 62347.7 62713.4 63683.4 66835.0 8991.6 9045.7 9125.2 9318.3 9408.1 10163.2 10293.0 10299.3 10607.0 11088.1 9055.6 9089.5 9166.6 9379.7 9429.2 9569.5 9669.3 9890.5 9968.4 10324.9 9385.5 9592.4 9742.4 9778.3 9789.4 7917.6 8049.4 8243.0 8251.9 8315.2 8233.3 8327.3 8703.8 8804.0 8945.2 13:36:01 INFO - PROCESS | 30481 | -------- Summary: end -------- 13:36:01 INFO - PROCESS | 30481 | 13:36:02 INFO - TEST-INFO | 30481: exit 0 13:36:02 INFO - TEST-OK | dromaeo_css | took 1118894ms 13:36:02 INFO - TEST-START | kraken 13:36:02 INFO - operating with platform_type : linux_ 13:36:02 INFO - Initialising browser for kraken test... 13:36:02 INFO - TEST-INFO | started process 30665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeVlp0o/profile http://localhost:50576/getInfo.html) 13:36:06 INFO - PROCESS | 30665 | __metrics Screen width/height:1600/1200 13:36:06 INFO - PROCESS | 30665 | colorDepth:24 13:36:06 INFO - PROCESS | 30665 | Browser inner width/height: 1024/697 13:36:06 INFO - PROCESS | 30665 | __metrics 13:36:07 INFO - PROCESS | 30665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:36:07 INFO - PROCESS | 30665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:36:08 INFO - TEST-INFO | 30665: exit 0 13:36:08 INFO - Browser initialized. 13:36:08 INFO - Running cycle 1/1 for kraken test... 13:36:08 INFO - TEST-INFO | started process 30745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeVlp0o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:20 INFO - PROCESS | 30745 | RSS: Main: 158613504 13:36:20 INFO - PROCESS | 30745 | 13:36:23 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50576/tests/kraken/driver.html?testName=audio-beat-detection) 13:36:24 INFO - PROCESS | 30745 | RSS: Main: 214798336 13:36:24 INFO - PROCESS | 30745 | 13:36:26 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50576/tests/kraken/driver.html?testName=audio-dft) 13:36:27 INFO - PROCESS | 30745 | RSS: Main: 192409600 13:36:27 INFO - PROCESS | 30745 | 13:36:30 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50576/tests/kraken/driver.html?testName=audio-fft) 13:36:31 INFO - PROCESS | 30745 | RSS: Main: 272859136 13:36:31 INFO - PROCESS | 30745 | 13:36:33 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50576/tests/kraken/driver.html?testName=audio-oscillator) 13:36:34 INFO - PROCESS | 30745 | RSS: Main: 182452224 13:36:34 INFO - PROCESS | 30745 | 13:36:36 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50576/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:36:36 INFO - PROCESS | 30745 | RSS: Main: 186200064 13:36:36 INFO - PROCESS | 30745 | 13:36:39 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50576/tests/kraken/driver.html?testName=imaging-darkroom) 13:36:40 INFO - PROCESS | 30745 | RSS: Main: 223006720 13:36:40 INFO - PROCESS | 30745 | 13:36:44 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50576/tests/kraken/driver.html?testName=imaging-desaturate) 13:36:44 INFO - PROCESS | 30745 | RSS: Main: 216846336 13:36:44 INFO - PROCESS | 30745 | 13:36:47 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50576/tests/kraken/driver.html?testName=json-parse-financial) 13:36:48 INFO - PROCESS | 30745 | RSS: Main: 219148288 13:36:48 INFO - PROCESS | 30745 | 13:36:49 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50576/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:36:50 INFO - PROCESS | 30745 | RSS: Main: 185217024 13:36:50 INFO - PROCESS | 30745 | 13:36:52 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50576/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:36:53 INFO - PROCESS | 30745 | RSS: Main: 190697472 13:36:53 INFO - PROCESS | 30745 | 13:36:55 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50576/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:36:55 INFO - PROCESS | 30745 | RSS: Main: 195100672 13:36:55 INFO - PROCESS | 30745 | 13:36:58 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:36:59 INFO - PROCESS | 30745 | RSS: Main: 190021632 13:36:59 INFO - PROCESS | 30745 | 13:37:02 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:37:02 INFO - PROCESS | 30745 | RSS: Main: 193175552 13:37:02 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:50576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50576/tests/kraken/driver.html?testName=ai-astar) 13:37:04 INFO - PROCESS | 30745 | RSS: Main: 244543488 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | __start_tp_report 13:37:04 INFO - PROCESS | 30745 | _x_x_mozilla_page_load 13:37:04 INFO - PROCESS | 30745 | _x_x_mozilla_page_load_details 13:37:04 INFO - PROCESS | 30745 | |i|pagename|runs| 13:37:04 INFO - PROCESS | 30745 | |0;ai-astar;105;117;114;116;115;114;113;115;114;114 13:37:04 INFO - PROCESS | 30745 | |1;audio-beat-detection;151;123;122;186;123;122;152;122;165;121 13:37:04 INFO - PROCESS | 30745 | |2;audio-dft;160;160;159;160;160;162;159;162;162;161 13:37:04 INFO - PROCESS | 30745 | |3;audio-fft;76;76;76;104;76;78;75;76;118;75 13:37:04 INFO - PROCESS | 30745 | |4;audio-oscillator;84;85;116;85;86;86;121;85;86;123 13:37:04 INFO - PROCESS | 30745 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;118;116 13:37:04 INFO - PROCESS | 30745 | |6;imaging-darkroom;146;146;147;146;147;146;147;148;147;147 13:37:04 INFO - PROCESS | 30745 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 13:37:04 INFO - PROCESS | 30745 | |8;json-parse-financial;64;64;63;62;63;62;64;72;63;63 13:37:04 INFO - PROCESS | 30745 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;69;65 13:37:04 INFO - PROCESS | 30745 | |10;stanford-crypto-aes;80;79;78;79;78;79;78;85;79;85 13:37:04 INFO - PROCESS | 30745 | |11;stanford-crypto-ccm;130;131;127;128;135;126;126;126;167;150 13:37:04 INFO - PROCESS | 30745 | |12;stanford-crypto-pbkdf2;169;165;164;170;163;174;164;162;163;164 13:37:04 INFO - PROCESS | 30745 | |13;stanford-crypto-sha256-iterative;67;71;67;66;67;71;65;66;65;66 13:37:04 INFO - PROCESS | 30745 | __end_tp_report 13:37:04 INFO - PROCESS | 30745 | __start_cc_report 13:37:04 INFO - PROCESS | 30745 | _x_x_mozilla_cycle_collect,1992 13:37:04 INFO - PROCESS | 30745 | __end_cc_report 13:37:04 INFO - PROCESS | 30745 | __startTimestamp1469047024655__endTimestamp 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | ------- Summary: start ------- 13:37:04 INFO - PROCESS | 30745 | Number of tests: 14 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:3.27 (2.9%) stddev-sans-first:1.22 13:37:04 INFO - PROCESS | 30745 | Values: 105.0 117.0 114.0 116.0 115.0 114.0 113.0 115.0 114.0 114.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:137.00 stddev:23.33 (17.0%) stddev-sans-first:24.32 13:37:04 INFO - PROCESS | 30745 | Values: 151.0 123.0 122.0 186.0 123.0 122.0 152.0 122.0 165.0 121.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.18 (0.7%) stddev-sans-first:1.24 13:37:04 INFO - PROCESS | 30745 | Values: 160.0 160.0 159.0 160.0 160.0 162.0 159.0 162.0 162.0 161.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.14 (19.9%) stddev-sans-first:15.85 13:37:04 INFO - PROCESS | 30745 | Values: 76.0 76.0 76.0 104.0 76.0 78.0 75.0 76.0 118.0 75.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:85.00 stddev:16.87 (19.8%) stddev-sans-first:17.35 13:37:04 INFO - PROCESS | 30745 | Values: 84.0 85.0 116.0 85.0 86.0 86.0 121.0 85.0 86.0 123.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:37:04 INFO - PROCESS | 30745 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 116.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 13:37:04 INFO - PROCESS | 30745 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 147.0 148.0 147.0 147.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 13:37:04 INFO - PROCESS | 30745 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:63.50 stddev:2.91 (4.6%) stddev-sans-first:3.08 13:37:04 INFO - PROCESS | 30745 | Values: 64.0 64.0 63.0 62.0 63.0 62.0 64.0 72.0 63.0 63.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 13:37:04 INFO - PROCESS | 30745 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 69.0 65.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:2.71 (3.4%) stddev-sans-first:2.87 13:37:04 INFO - PROCESS | 30745 | Values: 80.0 79.0 78.0 79.0 78.0 79.0 78.0 85.0 79.0 85.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:130.50 stddev:13.52 (10.4%) stddev-sans-first:14.23 13:37:04 INFO - PROCESS | 30745 | Values: 130.0 131.0 127.0 128.0 135.0 126.0 126.0 126.0 167.0 150.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:164.50 stddev:3.88 (2.4%) stddev-sans-first:3.94 13:37:04 INFO - PROCESS | 30745 | Values: 169.0 165.0 164.0 170.0 163.0 174.0 164.0 162.0 163.0 164.0 13:37:04 INFO - PROCESS | 30745 | 13:37:04 INFO - PROCESS | 30745 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.18 (3.3%) stddev-sans-first:2.32 13:37:04 INFO - PROCESS | 30745 | Values: 67.0 71.0 67.0 66.0 67.0 71.0 65.0 66.0 65.0 66.0 13:37:04 INFO - PROCESS | 30745 | -------- Summary: end -------- 13:37:04 INFO - PROCESS | 30745 | 13:37:05 INFO - TEST-INFO | 30745: exit 0 13:37:05 INFO - TEST-OK | kraken | took 63338ms 13:37:05 INFO - SUITE-END | took 1182s 13:37:05 INFO - Completed test suite (00:19:42) 13:37:05 INFO - javascript benchmark 13:37:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.909633162839, 2605.3356394119496, 2632.47350529894, 2652.4827658606578, 2655.2698008047782, 4613.8615841524725, 4712.528747125294, 4784.162771514984, 4805.1831188697915, 4815.470298267192, 4640.535946405358, 4709.623230141589, 4715.104130215265, 4729.9054018919605, 4737.360456338393, 4310.331898555729, 4340.804663790122, 4362.105768317495, 4365.716228445141, 4422.535633758457, 4364.301711726124, 4428.512863585003, 4460.041091165399, 4507.977460112695, 4542.500324964251, 4484.641228701696, 4493.438320209973, 4500.639948804121, 4522.751248681321, 4544.8863778405475, 4228.217779710763, 4306.5262821089655, 4334.046509767878, 4405.361222622734, 4417.403650507173, 4228.577142285778, 4233.068724880522, 4274.978625106885, 4276.994906197041, 4441.467023957113, 4647.140279048387, 4657.091867085919, 4673.065386922629, 4693.55411235932, 4707.317438971364, 4889.29105279736, 5007.924881126786, 5018.0, 5023.824166154167, 5026.874328141826, 5154.12379895415, 5160.535551800319, 5166.07010738067, 5170.069387510247, 5177.870553236162, 4782.306565547976, 4804.2073057945745, 4816.470188279286, 4818.397700287464, 4824.807007719652, 5087.364079490064, 5164.870878227999, 5216.295800066942, 5242.239875218072, 5272.156454967264, 5020.673656212334, 5073.518015788494, 5091.058154241403, 5092.770825312869, 5093.9490605094215, 5138.0, 5138.306328645585, 5141.665791723526, 5164.251183578435, 5189.247559103909, 4880.853574392774, 4894.388201474816, 4897.657163998557, 4954.256861470808, 5052.646314758005, 4928.7289199093675, 4949.727764972961, 4980.526849949249, 4996.475370086161, 4997.025580011863, 4284.89287767802, 4290.656747460196, 4290.656747460196, 4333.155034768253, 4335.82656693735, 3713.962860371416, 3722.4602432647116, 3727.496787933594, 3754.4931434256027, 3788.109794198361, 4327.956720432819, 4362.8036738346855, 4365.890852728708, 4377.387165796791, 4423.402840616475, 5083.440821509631, 5111.156659151273, 5116.590672746172, 5117.078925793318, 5161.974190129025, 4282.871513854527, 4357.586029327209, 4358.934615980763, 4360.629346505582, 4406.33904914259, 4549.431321084864, 4550.408446901948, 4590.97704511482, 4591.770411479412, 4633.4671512775785, 4758.04839032188, 4769.260764581495, 4777.0, 4786.6888652238185, 4808.591269742111, 5025.095482813129, 5060.772265248146, 5080.923786143137, 5098.694078355162, 5125.051865404912, 4641.8143274270005, 4774.546418090275, 4833.10587541306, 4833.806647734052, 4891.33966914462, 5064.290999260033, 5075.796968121382, 5076.593872490266, 5081.11080560893, 5127.743612819419, 5150.072986862251, 5156.7421628917655, 5158.742062896765, 5160.200168973815, 5166.45752196029, 4790.257510085942, 4927.310176575354, 4960.355153829979, 4979.975100124621, 5040.521150490697, 4990.451050384528, 5002.124628189979, 5003.499650034967, 5006.724630145377, 5049.747512624427, 4925.310456536016, 4935.8025678972435, 4936.234883593049, 4941.160002799605, 4992.975035124801, 4699.953000469952, 4875.878103047452, 4940.135476291706, 4944.258361245842, 5000.949990500048, 4863.3434486343895, 4875.414950205998, 4875.658703890694, 4877.365942427462, 4922.212446008622], "value": 4666.053554384107, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7193211292524, 583.2417856786179, 584.9824505264841, 590.1973316289846, 596.6300893446064, 27727.16818495446, 39158.0, 40508.79745601268, 40626.187476250496, 44525.554744452624, 40697.0, 41225.0, 41269.0, 41286.38070428946, 41299.38050929231, 7822.84354312912, 7982.560959147245, 7988.480748751342, 7992.160823113577, 7998.36013118952, 7862.292393684567, 7940.2853743163105, 7942.3646108311195, 7944.324732397753, 7946.6821327146845, 7943.64253608589, 8015.519068855858, 8015.559144247064, 8020.598970051474, 8020.919790802076, 7901.0, 7946.920530794676, 7958.243966823143, 7958.403119765982, 7960.681572737083, 7802.492837965571, 7871.685132594689, 7871.724489642835, 7877.133515313311, 7879.054513458422, 38133.427998580046, 38539.42190867139, 38573.0, 38590.0, 38599.8070009651, 2824.053941929456, 3081.784275100744, 3717.7955212463303, 3733.925321493582, 3796.90507737306, 27309.726902731116, 29539.85230073836, 29903.102906912827, 29967.550486742715, 30008.399832003455, 3316.8839090631955, 3341.465365541526, 3421.640727723603, 3435.6220815710253, 3491.807950562718, 275940.0, 276320.0, 277091.0, 277359.0, 277580.99999999796, 29062.854685726437, 56388.15417768737, 56739.148912766344, 56900.43099569034, 56922.146167807514, 31063.223419414695, 32843.671563284064, 33059.33881322408, 33079.17302067467, 33095.35951045383, 13800.378982945791, 13954.790678139836, 13957.720845583031, 13960.441582336593, 13961.720765584632, 11502.827457588142, 11508.251963622337, 11526.769464610661, 11532.481038353295, 11545.076393888468, 7830.334421574116, 7893.684252629945, 7964.721234756872, 8002.0, 8050.557219352875, 3142.135912624047, 3142.4500712375243, 3189.3940151371166, 3207.6792320767736, 3236.0777178504486, 841.5329492131925, 876.1939016105199, 878.6485405837716, 880.8546589812737, 977.022977022977, 27911.441771164464, 28445.431091378472, 28544.0, 28941.0, 29045.709542904722, 969.3892847506027, 974.288769198489, 1011.6155860772859, 1013.6452241715488, 1105.7180418993105, 14943.775843362359, 15245.923770381078, 15246.313915873812, 15610.673092787014, 15627.374905003673, 467764.64470711077, 480011.0, 482515.0, 755747.0, 759516.0, 51061.0, 51567.7421612897, 51609.483905160465, 51659.741701292005, 51707.0, 1210.509743553862, 1216.2512721249861, 1230.5508489401484, 1231.4396949388185, 1239.2440611227144, 27698.446031079668, 28613.427731444837, 29196.854015729787, 29960.70039299579, 30154.0, 43092.78453607712, 43435.13129737324, 43583.12833743244, 43745.34381984209, 43849.78075109604, 357674.0, 359292.23892686155, 359415.0, 359698.0, 359953.0, 25628.487430251662, 25811.225663230132, 26209.73790262073, 26256.455378523653, 26314.605280921183, 40538.79730601328, 40910.0, 41727.0, 41801.95495112646, 42138.57861421347, 35475.645243548264, 35654.643453565135, 35940.0, 36172.638273616925, 37228.44157337588, 35461.0, 35820.462693060144, 35898.8205058973, 35921.46117808287, 36104.63895361118, 30085.0, 34113.14717132092, 35368.823155884056, 35716.64283357133, 35841.103972400895, 29190.27024324409, 31797.933134346193, 32562.837185813918, 32873.50689739608, 32936.67063329336, 24161.87919060464, 24390.0, 24771.256862293438, 24852.875735621205, 24868.0], "value": 16964.55176628948, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.38554264978217, 360.9801460919649, 367.44515781170435, 375.3206695880458, 385.8745907580037, 16386.91806540967, 17724.37964671237, 17892.0, 17974.0, 18099.90950045251, 16464.423745168922, 17719.911400443012, 17744.0, 17776.46670599881, 17887.373941912036, 5061.772220250079, 5310.20346947957, 5315.415304316522, 5335.599830012745, 5340.519353258206, 3838.3282925488065, 3885.8834234972855, 3971.98714327846, 5232.92150617741, 5302.973485132588, 6205.03821907605, 6207.968960155193, 6213.0, 6213.720382582795, 6214.968925155368, 5923.378045305246, 6043.546733994968, 6148.508119350441, 6183.319834818167, 6188.690565471731, 5364.088105022156, 5368.087425137736, 5379.5427388671615, 5387.057264978613, 5388.973055134699, 18711.906440467847, 21445.463863403384, 21495.892520537454, 21660.89169554158, 21702.782972170233, 1907.5612609099846, 1963.7054441833839, 2007.2272175212502, 2051.3743308290964, 2543.796496280293, 8623.0, 13310.86689133106, 13391.799123013163, 13573.253471059088, 13811.654708632364, 1681.5207665815185, 1726.8791184617082, 1779.350537053979, 1808.8191180881938, 1836.5316844204776, 69672.651636742, 69730.95403569001, 69995.30004699939, 72121.0, 74011.0, 9432.434053956784, 9550.140487356171, 9597.376170548892, 9722.805543889224, 9843.0, 13327.133736307109, 13339.933300333436, 13354.866451335361, 13357.33213339329, 13367.398467069006, 7504.849903002018, 7618.809529761689, 7626.275503827128, 7719.729809456642, 7747.496412733154, 7472.813179670552, 7482.0, 7486.775396738107, 7658.923410765821, 7664.271894170045, 6057.394260573908, 6128.17269668598, 6213.813585592439, 6230.221222347207, 6295.181626388632, 1715.5968347438343, 1737.3137610643978, 1756.1833747307564, 1764.1179410294853, 1792.3099606651533, 402.9879103626896, 408.04517429215775, 408.88551205662463, 851.8977722673319, 886.5522910930068, 10718.571257149782, 10726.73183170427, 10749.78500429987, 11011.119110471143, 11249.268797528135, 396.1739772574215, 406.47970597634486, 409.47587088526734, 410.06914304528556, 411.66860677155177, 4935.432425271068, 5701.743421546041, 5746.511546518593, 5779.306483222041, 5961.135635332853, 142563.0, 266308.0, 446938.0, 447071.0, 452460.0, 79957.60021199973, 80423.0, 81407.0, 81831.0, 83320.58339708384, 421.3574299193754, 434.58497135236405, 435.16448419034896, 435.22747123854776, 436.11468718501493, 9745.512724363613, 9793.0, 9808.852867206855, 9844.950775246078, 9917.553710083208, 37292.81353593323, 37653.435198471496, 38273.0, 38322.42516362201, 38778.80610596929, 51832.0, 52239.47760522346, 54706.0, 55123.72438137783, 57220.0, 7424.591647459226, 7461.850762984818, 7481.326680598772, 7588.8482230356185, 7877.6455059523605, 8807.603657835285, 11212.887871121184, 11368.829467557827, 12442.937785311016, 12834.037447191311, 9736.513174341397, 9769.658061967797, 9827.85258221113, 10246.077852993267, 10319.845202322122, 9438.622455101719, 10124.645637402655, 10204.081632653097, 10204.336718113298, 10217.693469195936, 9497.192738617296, 9762.853557196506, 9841.803163936538, 10184.643537476153, 10203.846942295722, 7603.695852165852, 7743.688893551737, 7759.262870027338, 7811.609419528887, 7999.84000320002, 8845.867311990196, 9968.950155249177, 9990.300678952404, 10052.195824333889, 10269.845952310572], "value": 7677.281403165208, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.0261350067194, 1373.21726615829, 1414.1444426122196, 1504.4057597249086, 1752.0276246683093, 6944.444444444445, 7624.237576242373, 7847.725329613465, 7875.645595948182, 7884.132745398002, 7648.694052237904, 7807.5315481071175, 7814.882776758353, 8064.153263907278, 8066.395020373466, 2217.079911836586, 2261.42333704905, 2268.206127855254, 2269.1604106480545, 2269.466675331296, 2128.755193152792, 2184.530325979914, 2188.0481990334174, 2189.474526113729, 2190.452386903274, 2180.520285537187, 2206.1947389202905, 2213.8228941684706, 2215.878126703031, 2216.645336746121, 2160.319499357697, 2175.8803265820375, 2182.2798476502717, 2183.3340831046526, 2183.4977955070262, 2173.5109600339956, 2180.8473406861526, 2181.9781802181933, 2183.1813070098715, 2187.3547303545492, 7956.204379562056, 8056.677732890677, 8058.838823223561, 8069.0, 8069.233422824822, 4630.560096790799, 4798.904021919542, 4823.083614113307, 4877.170880950247, 4888.486708895551, 2804.2708895687065, 2944.2050646325374, 2978.4489869374233, 2989.5067313893182, 3001.3096987692734, 957.9616815327379, 965.2663975378763, 971.4754032822267, 972.6790159247431, 977.6871401151634, 10765.084967777748, 11043.282186657922, 11052.778944421067, 11069.335839849555, 11074.667759967213, 4286.421333120051, 4313.202057619351, 4359.04101097758, 4401.911961760811, 4432.667549933768, 9587.233021358275, 9615.375000624937, 9616.807663846825, 9620.518974051269, 9624.51877406127, 4820.0, 4829.203181475087, 4830.589399901048, 4837.129316723023, 4837.95162048382, 3517.2262102337445, 3618.8914332570066, 4375.890602734893, 4420.646348292129, 4421.226285400042, 3730.9626903730614, 3791.374423220193, 3796.7152463565344, 3857.633524815138, 3860.247251785931, 1186.323795436593, 1211.6425654431964, 1217.9147459677738, 1226.4910062324213, 1235.2835355493792, 596.174298596447, 700.1283402164338, 798.772349880293, 833.2542374574722, 839.6515446089804, 5043.167877300278, 5166.5866730661455, 5247.239150323258, 5270.8155214567305, 5322.36131664195, 427.85666801621807, 432.0236266038775, 442.12018084013226, 443.55422800085705, 592.2715060475639, 3387.2378714788974, 3453.5165076889257, 3468.8959331220103, 3542.5926018507685, 3608.8736894208578, 9765.707028789147, 10065.496725163712, 10159.0, 10168.898311016796, 10211.642592509226, 9838.458884761407, 9858.852117218104, 9970.40177589347, 9991.200703943667, 10058.899411005796, 7595.5822429766895, 7599.050118735158, 7634.770956871303, 7638.541687498879, 7648.42636802242, 5228.3987341454695, 5271.472852714698, 5348.064088784525, 5351.03681337363, 5434.347878254634, 9022.233110185707, 9173.724788256362, 9216.0, 9257.953710231406, 9301.302402319718, 9307.255419566554, 9345.48599827016, 9388.95305523468, 9389.24886009104, 9405.24758019343, 6971.47713921468, 7042.119735033121, 7046.2249152594195, 7050.2597227292445, 7050.929490705027, 7527.585982770781, 7573.810654733676, 7617.42869284817, 7627.54234745917, 7636.198199189227, 6851.725930962705, 6864.176298844171, 6918.0, 6929.099217101744, 6963.9651801740665, 6813.4208592270215, 6850.177978642595, 6937.410320122644, 6967.7212911482975, 6978.79063628092, 6196.349383314687, 6282.591631543935, 6283.5287353449585, 6289.779857704958, 6294.15028971083, 4605.194091033989, 4646.558576935186, 4702.600278976325, 4720.268358404453, 4738.928916066193, 4718.103560323528, 4718.669693121586, 4752.667313288037, 4774.236122220428, 4903.092927808367], "value": 4144.023868488021, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.93912747886685, 301.0561888479616, 307.1737027396305, 309.05275331110147, 309.28709325005866, 4794.496577859322, 4815.831445899395, 4828.744526423129, 4854.150523658354, 4866.8053277868885, 4517.209488339544, 4636.907261854769, 4656.580907718305, 4758.785854636541, 4819.0602832447685, 3800.182960663457, 3807.5811660717436, 3825.8469661213658, 3833.961660383395, 3859.6333348331864, 3808.2672384065186, 3810.7043605174235, 3810.866619668312, 3833.118382771964, 3848.7883166425836, 3614.9096272593133, 3627.419612861943, 3786.602406747293, 3792.924141517168, 3793.0706976790725, 3756.906077348061, 3761.2101458693705, 3796.886093417202, 3801.258754542865, 3809.7904615246152, 3379.4761811919193, 3388.508666243381, 3389.711874490671, 3391.3217356528794, 3396.6603339666085, 4466.397036400077, 4739.312799644067, 4740.597049250818, 4766.666333356667, 4775.737334446604, 4237.4279472271155, 4277.508086570022, 4280.614744672963, 4312.5903039211225, 4322.935155972631, 5039.571636410909, 5047.823326183566, 5049.267856160836, 5057.671251368649, 5070.847874563769, 3620.275944811022, 3623.873164439232, 3626.1659818241687, 3627.093226693327, 3636.6363363663686, 5158.0, 5190.273361729361, 5207.0, 5245.0, 5254.8686282842855, 3667.7982710951155, 3675.5221821163614, 3686.612905644922, 3697.3714468539874, 3699.9445008324897, 3755.6244375562774, 3778.923006943008, 3780.4896338994436, 3781.9977705907954, 3795.544534655859, 4178.979105104516, 4280.92976755811, 4288.742675439421, 4294.849680261176, 4297.978510107492, 4989.950100498949, 5009.874753131201, 5013.172826483589, 5015.22264049073, 5019.247112933089, 1280.1678908709414, 1293.9223646581236, 1294.288141522159, 1298.9935050324877, 1301.6550614087275, 817.5707753429497, 837.5519097282925, 853.5732133933034, 882.2589025218847, 898.6989358564823, 4392.472903251566, 4392.604665580113, 4399.934000989988, 4404.603585677304, 4406.876246557107, 5118.923216151761, 5129.435762066169, 5130.2048182531025, 5142.460041695643, 5145.691258524501, 4228.498882896527, 4354.455693038371, 4399.934000989923, 4414.933775993362, 4419.64642828573, 2702.7027027027407, 2710.6069619905, 2712.1321177223494, 2713.158920734539, 2713.5658294672758, 4777.402824646919, 4791.281307803857, 4814.422269327703, 4815.15734746425, 4829.758512074382, 5080.491950804964, 5223.634345595772, 5228.2941802856885, 5236.947630523646, 5266.3943646480375, 4765.118453086259, 4772.331873537708, 4780.187368147493, 4797.760111994457, 4810.653017155202, 5045.268436076822, 5051.545360917535, 5080.898382032265, 5093.668911520739, 5105.668131571436, 4788.712677239377, 4946.7138543979545, 4961.925571116509, 4967.975160124176, 4981.651284410056, 4765.428148622187, 4778.805298675331, 4792.640551958687, 4801.50321832652, 4809.903801923872, 3654.597994220687, 3689.5941446440333, 3709.1283548365573, 3709.888703338904, 3714.517112775322, 5002.399712034579, 5188.896222075613, 5192.610554208525, 5194.402643696023, 5276.865473923125, 5002.499750025114, 5064.645474816874, 5083.856132370335, 5131.820386286462, 5150.948490515197, 5079.187330027178, 5134.686863035068, 5140.537351638371, 5140.56305214046, 5140.742962851918, 4870.514493079645, 4970.229614409773, 5019.598432125495, 5052.873678158076, 5059.418166910852, 4790.377250957354, 4859.271109333628, 5039.874003149951, 5054.721990290569, 5067.822626208065, 4939.827106051271, 4940.11078005948, 4949.950500495093, 4952.727599982036, 4969.801207951786], "value": 3796.200810866757, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.6388694557154, 641.5669423139382, 643.9195100612424, 670.7719375412362, 719.2807192807193, 13049.41277642506, 14225.502107426242, 14273.2863356832, 14281.571552853406, 14287.571372858818, 13388.531401400953, 13489.258090805002, 13525.391357388917, 13527.458901643948, 13551.25468099254, 620.7051650466016, 625.9467945224661, 770.6378002338892, 778.4317448262772, 789.9960500197491, 793.7063286583972, 795.8845967334732, 796.6892911764387, 796.77690246731, 796.8167321516055, 834.1366685480529, 834.7328854766478, 840.1220724343076, 840.3403328387217, 840.5461051032435, 656.1175219329994, 672.3310306245269, 672.8553361027354, 674.3762020131408, 837.7444879311807, 593.664579512574, 612.3876123876124, 615.1695211464532, 616.4451993206151, 616.9352218017088, 13271.800922986164, 13296.401661925236, 13300.0, 13313.933430332787, 13320.733585328337, 12035.0, 12097.0, 12380.876191238063, 12650.0, 12830.101892867502, 11511.48198331077, 11713.590024349192, 11947.522099116024, 12273.57042503517, 12452.626421207378, 4110.99589694229, 4125.1131006833675, 4194.832206711728, 4318.632916202127, 4325.610695037431, 59672.403275967554, 59727.0, 59827.40172598305, 59841.700791495765, 59880.0, 9983.700488985342, 10216.642417515352, 10339.741506462398, 10379.481025948673, 10686.51910664022, 18581.721274180898, 18713.345032923782, 18717.532061698566, 18729.250829966648, 18738.531536711693, 6352.301246862841, 6801.523893327519, 6962.373386395248, 7113.0753002109395, 7136.107986501687, 3732.9813350933073, 3886.6696330811633, 3904.141088960424, 3933.252681990413, 3959.128991621896, 2953.2173973896934, 3057.2356910772305, 3078.1381213259874, 3082.2910730532103, 3086.6913308668954, 504.32420556454525, 521.0698902459093, 532.0449792622252, 532.6324835863242, 541.8564080518665, 370.01022265439843, 466.6360239013575, 471.6627611257967, 497.5124378109473, 524.3157679228567, 7395.0, 7560.0, 7594.126675432285, 7713.421493387906, 7998.12020677725, 492.1977177201211, 497.3310896843739, 501.75664802570725, 514.8584139361706, 516.7080599461292, 3391.184517984468, 3537.4163263061823, 3589.587197472324, 3615.439606860941, 3634.890953271406, 56336.154957675666, 68631.65684171548, 91587.54206228926, 93437.0, 94623.52688236514, 47311.0, 50626.49373506218, 76809.99999999888, 76847.23152768401, 82125.58937205275, 68998.0, 70180.92919314242, 72991.63504182445, 72998.27001730021, 77112.0, 6684.799456016327, 6884.173899132136, 6940.7917762467205, 7054.153501579844, 7096.822579435556, 43394.349084764384, 43660.0, 44141.33787993118, 45623.31565026593, 46729.53270467252, 60013.699931500065, 62347.6882615584, 62713.37286627258, 63683.363166367744, 66834.99747503888, 8991.55042247898, 9045.73856535866, 9125.22435592982, 9318.254539636677, 9408.106229908148, 10163.237757168094, 10293.0, 10299.330543514647, 10607.0, 11088.112950964065, 9055.592498337459, 9089.545522723969, 9166.587503562223, 9379.718608441757, 9429.198518126037, 9569.473678947725, 9669.323147379617, 9890.505474726378, 9968.352057116264, 10324.948375258076, 9385.483798391155, 9592.376495527767, 9742.415455072718, 9778.266630002636, 9789.412635241908, 7917.564533950688, 8049.39629527776, 8242.958785206036, 8251.917480825115, 8315.210055044761, 8233.300169485661, 8327.292180164512, 8703.825923481621, 8804.0, 8945.23965462943], "value": 6186.794763534791, "unit": "score"}], "name": "dromaeo_css", "value": 6242.098923587417, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 114.0, 116.0, 115.0, 114.0, 113.0, 115.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 122.0, 186.0, 123.0, 122.0, 152.0, 122.0, 165.0, 121.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 160.0, 160.0, 162.0, 159.0, 162.0, 162.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 104.0, 76.0, 78.0, 75.0, 76.0, 118.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 116.0, 85.0, 86.0, 86.0, 121.0, 85.0, 86.0, 123.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 62.0, 63.0, 62.0, 64.0, 72.0, 63.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 69.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 79.0, 78.0, 79.0, 78.0, 85.0, 79.0, 85.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 127.0, 128.0, 135.0, 126.0, 126.0, 126.0, 167.0, 150.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 164.0, 170.0, 163.0, 174.0, 164.0, 162.0, 163.0, 164.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 67.0, 66.0, 67.0, 71.0, 65.0, 66.0, 65.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1527.3999999999999, "alertThreshold": 2.0}]} 13:37:05 INFO - Return code: 0 13:37:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:37:05 INFO - # TBPL SUCCESS # 13:37:05 INFO - Running post-action listener: _resource_record_post_action 13:37:05 INFO - [mozharness: 2016-07-20 20:37:05.943954Z] Finished run-tests step (success) 13:37:05 INFO - Running post-run listener: _resource_record_post_run 13:37:06 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284839936; Read time: 16; Write time: 144636 13:37:06 INFO - TinderboxPrint: CPU usage
12.9% 13:37:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:37:06 INFO - TinderboxPrint: I/O write bytes / time
284,839,936 / 144,636 13:37:06 INFO - TinderboxPrint: CPU idle
8,331.0 (87.0%) 13:37:06 INFO - TinderboxPrint: CPU user
1,198.0 (12.5%) 13:37:06 INFO - TinderboxPrint: Swap in / out
0 / 0 13:37:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1114112; Read time: 0; Write time: 196 13:37:06 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 283160576; Read time: 0; Write time: 144440 13:37:06 INFO - Running post-run listener: _upload_blobber_files 13:37:06 INFO - Blob upload gear active. 13:37:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:37:06 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:37:06 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:37:06 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:37:07 INFO - (blobuploader) - INFO - Open directory for files ... 13:37:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:37:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:37:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:08 INFO - (blobuploader) - INFO - Done attempting. 13:37:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:37:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:37:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:08 INFO - (blobuploader) - INFO - Done attempting. 13:37:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:37:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:23 INFO - (blobuploader) - INFO - Done attempting. 13:37:23 INFO - (blobuploader) - INFO - Iteration through files over. 13:37:23 INFO - Return code: 0 13:37:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:37:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:37:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/591c650690a58ec2203ca0ffa2c46bfc7c0260ce8f3c9f23cee7a691e1c2ea478ab07f7b7ef26492986da1027bda229fef846971d2abbd6855debb8e4609f00a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf5f3a5392d1c72e5ad37fc148853d0bfb2e71533815c2017838160b1ce6ae3c6d973627623afbe675e45ed68e1240cf9ebfbd50123670b862603c177e7fba1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3e5014c1e278d7e2d00d8b4a0bf9c03fef26d996de72d74ddbdf64006c9c0f397f3c87bf2a134987e975708d5434e45836ca2391362b604fc25ecc5d78e21c5"} 13:37:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:37:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:37:23 INFO - Contents: 13:37:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/591c650690a58ec2203ca0ffa2c46bfc7c0260ce8f3c9f23cee7a691e1c2ea478ab07f7b7ef26492986da1027bda229fef846971d2abbd6855debb8e4609f00a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf5f3a5392d1c72e5ad37fc148853d0bfb2e71533815c2017838160b1ce6ae3c6d973627623afbe675e45ed68e1240cf9ebfbd50123670b862603c177e7fba1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3e5014c1e278d7e2d00d8b4a0bf9c03fef26d996de72d74ddbdf64006c9c0f397f3c87bf2a134987e975708d5434e45836ca2391362b604fc25ecc5d78e21c5"} 13:37:23 INFO - Running post-run listener: copy_logs_to_upload_dir 13:37:23 INFO - Copying logs to upload dir... 13:37:23 INFO - mkdir: /builds/slave/test/build/upload/logs 13:37:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.228525 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-20 13:37:23.106186) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 13:37:23.109620) ========= 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=bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/591c650690a58ec2203ca0ffa2c46bfc7c0260ce8f3c9f23cee7a691e1c2ea478ab07f7b7ef26492986da1027bda229fef846971d2abbd6855debb8e4609f00a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf5f3a5392d1c72e5ad37fc148853d0bfb2e71533815c2017838160b1ce6ae3c6d973627623afbe675e45ed68e1240cf9ebfbd50123670b862603c177e7fba1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3e5014c1e278d7e2d00d8b4a0bf9c03fef26d996de72d74ddbdf64006c9c0f397f3c87bf2a134987e975708d5434e45836ca2391362b604fc25ecc5d78e21c5"} build_url:https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/EqSRdIIASlSSjWA75J4zHw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/591c650690a58ec2203ca0ffa2c46bfc7c0260ce8f3c9f23cee7a691e1c2ea478ab07f7b7ef26492986da1027bda229fef846971d2abbd6855debb8e4609f00a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf5f3a5392d1c72e5ad37fc148853d0bfb2e71533815c2017838160b1ce6ae3c6d973627623afbe675e45ed68e1240cf9ebfbd50123670b862603c177e7fba1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3e5014c1e278d7e2d00d8b4a0bf9c03fef26d996de72d74ddbdf64006c9c0f397f3c87bf2a134987e975708d5434e45836ca2391362b604fc25ecc5d78e21c5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 13:37:23.138041) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:37:23.138798) ========= 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=bb9b54edd4a927dc735d112f000001d9-1469045776.124809-243667280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:37:23.222790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 13:37:23.223537) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 13:37:23.224135) ========= ========= Total master_lag: 0.17 =========