builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1472180127.34 results: success (0) buildid: 20160825183618 builduid: 7136e384ba3c4c1887914d4665ad9e3c revision: ec1ebef4eb865b13b4320e87bab27786e1d424a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:27.343209) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:27.343661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:27.343943) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:27.358565) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:27.358849) ========= 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=745a4373a2a16df560f216e000000264-1472180126.900867-1842961609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 19:55:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-08-25 19:55:27 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:27.519943) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:27.520281) ========= 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=745a4373a2a16df560f216e000000264-1472180126.900867-1842961609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020696 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:27.570032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:27.570416) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ec1ebef4eb865b13b4320e87bab27786e1d424a5 --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 ec1ebef4eb865b13b4320e87bab27786e1d424a5 --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=745a4373a2a16df560f216e000000264-1472180126.900867-1842961609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 19:55:27,960 truncating revision to first 12 chars 2016-08-25 19:55:27,960 Setting DEBUG logging. 2016-08-25 19:55:27,960 attempt 1/10 2016-08-25 19:55:27,960 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ec1ebef4eb86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 19:55:28,247 unpacking tar archive at: fx-team-ec1ebef4eb86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577631 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:28.161761) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:28.162096) ========= script_repo_revision: ec1ebef4eb865b13b4320e87bab27786e1d424a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:28.162494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:28.162759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 19:55:28.173271) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-25 19:55:28.173586) ========= /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=745a4373a2a16df560f216e000000264-1472180126.900867-1842961609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:55:28 INFO - MultiFileLogger online at 20160825 19:55:28 in /builds/slave/test 19:55:28 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 19:55:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:55:28 INFO - {'append_to_log': False, 19:55:28 INFO - 'base_work_dir': '/builds/slave/test', 19:55:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:55:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:55:28 INFO - 'branch': 'Fx-Team-Non-PGO', 19:55:28 INFO - 'buildbot_json_path': 'buildprops.json', 19:55:28 INFO - 'config_files': ('talos/linux_config.py',), 19:55:28 INFO - 'default_actions': ('clobber', 19:55:28 INFO - 'read-buildbot-config', 19:55:28 INFO - 'download-and-extract', 19:55:28 INFO - 'populate-webroot', 19:55:28 INFO - 'create-virtualenv', 19:55:28 INFO - 'install', 19:55:28 INFO - 'run-tests'), 19:55:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:55:28 INFO - 'download_minidump_stackwalk': True, 19:55:28 INFO - 'download_symbols': 'ondemand', 19:55:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:55:28 INFO - 'tooltool.py': '/tools/tooltool.py', 19:55:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:55:28 INFO - '/tools/misc-python/virtualenv.py')}, 19:55:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:55:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:55:28 INFO - 'installer_path': 'installer.exe', 19:55:28 INFO - 'log_level': 'info', 19:55:28 INFO - 'log_name': 'talos', 19:55:28 INFO - 'log_to_console': True, 19:55:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:55:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:55:28 INFO - 'opt_config_files': (), 19:55:28 INFO - 'pip_index': False, 19:55:28 INFO - 'sps_profile': False, 19:55:28 INFO - 'sps_profile_interval': 0, 19:55:28 INFO - 'suite': 'dromaeojs', 19:55:28 INFO - 'system_bits': '32', 19:55:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:55:28 INFO - 'title': 'talos-linux64-ix-032', 19:55:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:55:28 INFO - 'use_talos_json': True, 19:55:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:55:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:55:28 INFO - 'work_dir': 'build'} 19:55:28 INFO - [mozharness: 2016-08-26 02:55:28.660118Z] Running clobber step. 19:55:28 INFO - Running pre-action listener: _resource_record_pre_action 19:55:28 INFO - Running main action method: clobber 19:55:28 INFO - rmtree: /builds/slave/test/build 19:55:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:55:29 INFO - Running post-action listener: _resource_record_post_action 19:55:29 INFO - [mozharness: 2016-08-26 02:55:29.683249Z] Finished clobber step (success) 19:55:29 INFO - [mozharness: 2016-08-26 02:55:29.683350Z] Running read-buildbot-config step. 19:55:29 INFO - Running pre-action listener: _resource_record_pre_action 19:55:29 INFO - Running main action method: read_buildbot_config 19:55:29 INFO - Using buildbot properties: 19:55:29 INFO - { 19:55:29 INFO - "project": "", 19:55:29 INFO - "product": "firefox", 19:55:29 INFO - "script_repo_revision": "production", 19:55:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:55:29 INFO - "repository": "", 19:55:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:55:29 INFO - "buildid": "20160825183618", 19:55:29 INFO - "pgo_build": "False", 19:55:29 INFO - "basedir": "/builds/slave/test", 19:55:29 INFO - "buildnumber": 2122, 19:55:29 INFO - "slavename": "talos-linux64-ix-032", 19:55:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:55:29 INFO - "platform": "ubuntu64_hw", 19:55:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:55:29 INFO - "branch": "fx-team", 19:55:29 INFO - "repo_path": "integration/fx-team", 19:55:29 INFO - "revision": "ec1ebef4eb865b13b4320e87bab27786e1d424a5", 19:55:29 INFO - "stage_platform": "linux64", 19:55:29 INFO - "builduid": "7136e384ba3c4c1887914d4665ad9e3c", 19:55:29 INFO - "slavebuilddir": "test" 19:55:29 INFO - } 19:55:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:55:29 INFO - Running post-action listener: _resource_record_post_action 19:55:29 INFO - [mozharness: 2016-08-26 02:55:29.685765Z] Finished read-buildbot-config step (success) 19:55:29 INFO - [mozharness: 2016-08-26 02:55:29.685854Z] Running download-and-extract step. 19:55:29 INFO - Running pre-action listener: _resource_record_pre_action 19:55:29 INFO - Running main action method: download_and_extract 19:55:29 INFO - mkdir: /builds/slave/test/build/tests 19:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:29 INFO - trying https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:55:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:55:30 INFO - Downloaded 1361 bytes. 19:55:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:55:30 INFO - Using the following test package requirements: 19:55:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:55:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:55:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:55:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'jsshell-linux-x86_64.zip'], 19:55:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:55:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:55:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:55:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:55:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:55:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:55:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:30 INFO - trying https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:55:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:55:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:55:31 INFO - Downloaded 20300824 bytes. 19:55:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 19:55:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:35 INFO - trying https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:55:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:55:36 INFO - Downloaded 20300824 bytes. 19:55:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 19:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:40 INFO - trying https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:55:41 INFO - Downloaded 14413981 bytes. 19:55:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 19:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:41 INFO - trying https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:55:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:55:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:55:43 INFO - Downloaded 55898746 bytes. 19:55:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:55:43 INFO - mkdir: /builds/slave/test/properties 19:55:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:55:43 INFO - Writing to file /builds/slave/test/properties/build_url 19:55:43 INFO - Contents: 19:55:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:55:43 INFO - Running post-action listener: _resource_record_post_action 19:55:43 INFO - Running post-action listener: set_extra_try_arguments 19:55:43 INFO - [mozharness: 2016-08-26 02:55:43.794018Z] Finished download-and-extract step (success) 19:55:43 INFO - [mozharness: 2016-08-26 02:55:43.794242Z] Running populate-webroot step. 19:55:43 INFO - Running pre-action listener: _resource_record_pre_action 19:55:43 INFO - Running main action method: populate_webroot 19:55:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:55:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:55:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:55:43 INFO - '--tppagecycles', 19:55:43 INFO - '7'], 19:55:43 INFO - 'tests': ['tsvgm']}}, 19:55:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:55:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:55:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:55:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:55:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:55:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:55:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:43 INFO - 'talos_options': ['--disable-e10s'], 19:55:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:43 INFO - 'talos_options': ['--disable-e10s'], 19:55:43 INFO - 'tests': ['damp', 'tps']}, 19:55:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:43 INFO - 'tests': ['damp', 'tps']}, 19:55:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:55:43 INFO - 'tests': ['dromaeo_dom']}, 19:55:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:55:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:55:43 INFO - 'tests': ['basic_compositor_video']}, 19:55:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:55:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:55:43 INFO - 'tests': ['a11yr', 19:55:43 INFO - 'ts_paint', 19:55:43 INFO - 'tpaint', 19:55:43 INFO - 'sessionrestore', 19:55:43 INFO - 'sessionrestore_no_auto_restore', 19:55:43 INFO - 'tabpaint']}, 19:55:43 INFO - 'other-e10s': {'tests': ['a11yr', 19:55:43 INFO - 'ts_paint', 19:55:43 INFO - 'tpaint', 19:55:43 INFO - 'sessionrestore', 19:55:43 INFO - 'sessionrestore_no_auto_restore', 19:55:43 INFO - 'tabpaint']}, 19:55:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:55:43 INFO - 'ts_paint', 19:55:43 INFO - 'tpaint', 19:55:43 INFO - 'sessionrestore', 19:55:43 INFO - 'sessionrestore_no_auto_restore', 19:55:43 INFO - 'tabpaint']}, 19:55:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:55:43 INFO - 'ts_paint', 19:55:43 INFO - 'tpaint', 19:55:43 INFO - 'sessionrestore', 19:55:43 INFO - 'sessionrestore_no_auto_restore', 19:55:43 INFO - 'tabpaint']}, 19:55:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:55:43 INFO - 'tests': ['a11yr', 19:55:43 INFO - 'ts_paint', 19:55:43 INFO - 'tpaint', 19:55:43 INFO - 'sessionrestore', 19:55:43 INFO - 'sessionrestore_no_auto_restore', 19:55:43 INFO - 'tabpaint']}, 19:55:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:55:43 INFO - 'tests': ['a11yr', 19:55:43 INFO - 'ts_paint', 19:55:43 INFO - 'tpaint', 19:55:43 INFO - 'sessionrestore', 19:55:43 INFO - 'sessionrestore_no_auto_restore', 19:55:43 INFO - 'tabpaint']}, 19:55:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:55:43 INFO - 'tests': ['tsvgx', 19:55:43 INFO - 'tsvgr_opacity', 19:55:43 INFO - 'tart', 19:55:43 INFO - 'tscrollx', 19:55:43 INFO - 'cart']}, 19:55:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:55:43 INFO - 'tsvgr_opacity', 19:55:43 INFO - 'tart', 19:55:43 INFO - 'tscrollx', 19:55:43 INFO - 'cart']}, 19:55:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:43 INFO - 'talos_options': ['--disable-e10s'], 19:55:43 INFO - 'tests': ['tp5o']}, 19:55:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:43 INFO - 'tests': ['tp5o']}, 19:55:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:43 INFO - 'talos_options': ['--disable-e10s', 19:55:43 INFO - '--xperf_path', 19:55:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:43 INFO - 'tests': ['tp5n']}, 19:55:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:43 INFO - 'talos_options': ['--xperf_path', 19:55:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:43 INFO - 'tests': ['tp5n']}}, 19:55:43 INFO - 'talos.zip': {'path': '', 19:55:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:55:43 INFO - Running post-action listener: _resource_record_post_action 19:55:43 INFO - [mozharness: 2016-08-26 02:55:43.811933Z] Finished populate-webroot step (success) 19:55:43 INFO - [mozharness: 2016-08-26 02:55:43.812021Z] Running create-virtualenv step. 19:55:43 INFO - Running pre-action listener: _resource_record_pre_action 19:55:43 INFO - Running main action method: create_virtualenv 19:55:43 INFO - Creating virtualenv /builds/slave/test/build/venv 19:55:43 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 19:55:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:55:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:55:43 INFO - Using real prefix '/usr' 19:55:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:55:44 INFO - Installing distribute.............................................................................................................................................................................................done. 19:55:46 INFO - Installing pip.................done. 19:55:46 INFO - Return code: 0 19:55:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:46 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 0x7f004cf7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d20>, '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 0x1063c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', '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 19:55:46 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 19:55:46 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 19:55:46 INFO - Using env: {'DISPLAY': ':0', 19:55:46 INFO - 'HOME': '/home/cltbld', 19:55:46 INFO - 'LANG': 'en_US.UTF-8', 19:55:46 INFO - 'LANGUAGE': 'en_US:en', 19:55:46 INFO - 'LOGNAME': 'cltbld', 19:55:46 INFO - 'MAIL': '/var/mail/cltbld', 19:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:46 INFO - 'MOZ_NO_REMOTE': '1', 19:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:46 INFO - 'NO_EM_RESTART': '1', 19:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:46 INFO - 'PWD': '/builds/slave/test', 19:55:46 INFO - 'SHELL': '/bin/bash', 19:55:46 INFO - 'SHLVL': '1', 19:55:46 INFO - 'TERM': 'linux', 19:55:46 INFO - 'TMOUT': '86400', 19:55:46 INFO - 'USER': 'cltbld', 19:55:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', 19:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:46 INFO - '_': '/tools/buildbot/bin/python'} 19:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:46 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 19:55:46 INFO - Cleaning up... 19:55:46 INFO - Return code: 0 19:55:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:46 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 0x7f004cf7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d20>, '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 0x1063c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', '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 19:55:46 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 19:55:46 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 19:55:46 INFO - Using env: {'DISPLAY': ':0', 19:55:46 INFO - 'HOME': '/home/cltbld', 19:55:46 INFO - 'LANG': 'en_US.UTF-8', 19:55:46 INFO - 'LANGUAGE': 'en_US:en', 19:55:46 INFO - 'LOGNAME': 'cltbld', 19:55:46 INFO - 'MAIL': '/var/mail/cltbld', 19:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:46 INFO - 'MOZ_NO_REMOTE': '1', 19:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:46 INFO - 'NO_EM_RESTART': '1', 19:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:46 INFO - 'PWD': '/builds/slave/test', 19:55:46 INFO - 'SHELL': '/bin/bash', 19:55:46 INFO - 'SHLVL': '1', 19:55:46 INFO - 'TERM': 'linux', 19:55:46 INFO - 'TMOUT': '86400', 19:55:46 INFO - 'USER': 'cltbld', 19:55:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', 19:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:46 INFO - '_': '/tools/buildbot/bin/python'} 19:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:46 INFO - Downloading/unpacking psutil>=3.1.1 19:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:55:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:48 INFO - Installing collected packages: psutil 19:55:48 INFO - Running setup.py install for psutil 19:55:48 INFO - building 'psutil._psutil_linux' extension 19:55:48 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 19:55:49 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 19:55:49 INFO - building 'psutil._psutil_posix' extension 19:55:49 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 19:55:49 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 19:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:49 INFO - Successfully installed psutil 19:55:49 INFO - Cleaning up... 19:55:49 INFO - Return code: 0 19:55:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:49 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 0x7f004cf7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d20>, '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 0x1063c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', '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 19:55:49 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 19:55:49 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 19:55:49 INFO - Using env: {'DISPLAY': ':0', 19:55:49 INFO - 'HOME': '/home/cltbld', 19:55:49 INFO - 'LANG': 'en_US.UTF-8', 19:55:49 INFO - 'LANGUAGE': 'en_US:en', 19:55:49 INFO - 'LOGNAME': 'cltbld', 19:55:49 INFO - 'MAIL': '/var/mail/cltbld', 19:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:49 INFO - 'MOZ_NO_REMOTE': '1', 19:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:49 INFO - 'NO_EM_RESTART': '1', 19:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:49 INFO - 'PWD': '/builds/slave/test', 19:55:49 INFO - 'SHELL': '/bin/bash', 19:55:49 INFO - 'SHLVL': '1', 19:55:49 INFO - 'TERM': 'linux', 19:55:49 INFO - 'TMOUT': '86400', 19:55:49 INFO - 'USER': 'cltbld', 19:55:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', 19:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:49 INFO - '_': '/tools/buildbot/bin/python'} 19:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:55:49 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 19:55:49 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 19:55:49 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 19:55:49 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 19:55:49 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 19:55:49 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 19:55:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:55:51 INFO - Installing collected packages: mozsystemmonitor 19:55:51 INFO - Running setup.py install for mozsystemmonitor 19:55:51 INFO - Successfully installed mozsystemmonitor 19:55:51 INFO - Cleaning up... 19:55:51 INFO - Return code: 0 19:55:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:51 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 0x7f004cf7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d20>, '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 0x1063c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', '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 19:55:51 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 19:55:51 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 19:55:51 INFO - Using env: {'DISPLAY': ':0', 19:55:51 INFO - 'HOME': '/home/cltbld', 19:55:51 INFO - 'LANG': 'en_US.UTF-8', 19:55:51 INFO - 'LANGUAGE': 'en_US:en', 19:55:51 INFO - 'LOGNAME': 'cltbld', 19:55:51 INFO - 'MAIL': '/var/mail/cltbld', 19:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:51 INFO - 'MOZ_NO_REMOTE': '1', 19:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:51 INFO - 'NO_EM_RESTART': '1', 19:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:51 INFO - 'PWD': '/builds/slave/test', 19:55:51 INFO - 'SHELL': '/bin/bash', 19:55:51 INFO - 'SHLVL': '1', 19:55:51 INFO - 'TERM': 'linux', 19:55:51 INFO - 'TMOUT': '86400', 19:55:51 INFO - 'USER': 'cltbld', 19:55:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', 19:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:51 INFO - '_': '/tools/buildbot/bin/python'} 19:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:51 INFO - Downloading/unpacking jsonschema==2.5.1 19:55:51 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 19:55:51 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 19:55:51 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 19:55:51 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 19:55:51 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 19:55:51 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 19:55:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:55:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:55:53 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 19:55:53 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 19:55:53 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 19:55:53 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 19:55:53 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 19:55:53 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 19:55:53 INFO - Downloading functools32-3.2.3-2.tar.gz 19:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:55:54 INFO - warning: no files found matching '*.txt' 19:55:54 INFO - no previously-included directories found matching 'build' 19:55:54 INFO - no previously-included directories found matching 'dist' 19:55:54 INFO - no previously-included directories found matching '.git*' 19:55:54 INFO - Installing collected packages: jsonschema, functools32 19:55:54 INFO - Running setup.py install for functools32 19:55:54 INFO - warning: no files found matching '*.txt' 19:55:54 INFO - no previously-included directories found matching 'build' 19:55:54 INFO - no previously-included directories found matching 'dist' 19:55:54 INFO - no previously-included directories found matching '.git*' 19:55:54 INFO - Successfully installed jsonschema functools32 19:55:54 INFO - Cleaning up... 19:55:54 INFO - Return code: 0 19:55:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f004cf7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d20>, '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 0x1063c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', '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 19:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:55:54 INFO - Using env: {'DISPLAY': ':0', 19:55:54 INFO - 'HOME': '/home/cltbld', 19:55:54 INFO - 'LANG': 'en_US.UTF-8', 19:55:54 INFO - 'LANGUAGE': 'en_US:en', 19:55:54 INFO - 'LOGNAME': 'cltbld', 19:55:54 INFO - 'MAIL': '/var/mail/cltbld', 19:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:54 INFO - 'MOZ_NO_REMOTE': '1', 19:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:54 INFO - 'NO_EM_RESTART': '1', 19:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:54 INFO - 'PWD': '/builds/slave/test', 19:55:54 INFO - 'SHELL': '/bin/bash', 19:55:54 INFO - 'SHLVL': '1', 19:55:54 INFO - 'TERM': 'linux', 19:55:54 INFO - 'TMOUT': '86400', 19:55:54 INFO - 'USER': 'cltbld', 19:55:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', 19:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:54 INFO - '_': '/tools/buildbot/bin/python'} 19:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:55:54 INFO - Cleaning up... 19:55:54 INFO - Return code: 0 19:55:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f004cf7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d20>, '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 0x1063c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', '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 19:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:55:54 INFO - Using env: {'DISPLAY': ':0', 19:55:54 INFO - 'HOME': '/home/cltbld', 19:55:54 INFO - 'LANG': 'en_US.UTF-8', 19:55:54 INFO - 'LANGUAGE': 'en_US:en', 19:55:54 INFO - 'LOGNAME': 'cltbld', 19:55:54 INFO - 'MAIL': '/var/mail/cltbld', 19:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:54 INFO - 'MOZ_NO_REMOTE': '1', 19:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:54 INFO - 'NO_EM_RESTART': '1', 19:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:54 INFO - 'PWD': '/builds/slave/test', 19:55:54 INFO - 'SHELL': '/bin/bash', 19:55:54 INFO - 'SHLVL': '1', 19:55:54 INFO - 'TERM': 'linux', 19:55:54 INFO - 'TMOUT': '86400', 19:55:54 INFO - 'USER': 'cltbld', 19:55:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', 19:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:54 INFO - '_': '/tools/buildbot/bin/python'} 19:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:54 INFO - Downloading/unpacking blobuploader==1.2.4 19:55:54 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 19:55:54 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 19:55:54 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 19:55:54 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 19:55:54 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 19:55:54 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 19:55:56 INFO - Downloading blobuploader-1.2.4.tar.gz 19:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:55:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:55:56 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 19:55:56 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 19:55:56 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 19:55:56 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 19:55:56 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 19:55:56 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 19:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:55:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:55: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 19:55: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 19:55: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 19:55: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 19:55: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 19:55: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 19:55:57 INFO - Downloading docopt-0.6.1.tar.gz 19:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:55:57 INFO - Installing collected packages: blobuploader, requests, docopt 19:55:57 INFO - Running setup.py install for blobuploader 19:55:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:55:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:55:57 INFO - Running setup.py install for requests 19:55:57 INFO - Running setup.py install for docopt 19:55:57 INFO - Successfully installed blobuploader requests docopt 19:55:57 INFO - Cleaning up... 19:55:57 INFO - Return code: 0 19:55:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:57 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 0x7f004cf7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d20>, '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 0x1063c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', '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 19:55:57 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 19:55:57 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 19:55:57 INFO - Using env: {'DISPLAY': ':0', 19:55:57 INFO - 'HOME': '/home/cltbld', 19:55:57 INFO - 'LANG': 'en_US.UTF-8', 19:55:57 INFO - 'LANGUAGE': 'en_US:en', 19:55:57 INFO - 'LOGNAME': 'cltbld', 19:55:57 INFO - 'MAIL': '/var/mail/cltbld', 19:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:57 INFO - 'MOZ_NO_REMOTE': '1', 19:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:57 INFO - 'NO_EM_RESTART': '1', 19:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:57 INFO - 'PWD': '/builds/slave/test', 19:55:57 INFO - 'SHELL': '/bin/bash', 19:55:57 INFO - 'SHLVL': '1', 19:55:57 INFO - 'TERM': 'linux', 19:55:57 INFO - 'TMOUT': '86400', 19:55:57 INFO - 'USER': 'cltbld', 19:55:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', 19:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:57 INFO - '_': '/tools/buildbot/bin/python'} 19:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:55:58 INFO - Running setup.py (path:/tmp/pip-2uG63q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:55:58 INFO - Running setup.py (path:/tmp/pip-igMxlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:55:58 INFO - Running setup.py (path:/tmp/pip-x3LR2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:55:58 INFO - Running setup.py (path:/tmp/pip-o_PAEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:55:58 INFO - Running setup.py (path:/tmp/pip-xrSADa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:55:58 INFO - Running setup.py (path:/tmp/pip-7vKAjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:55:58 INFO - Running setup.py (path:/tmp/pip-vTT2g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:55:58 INFO - Running setup.py (path:/tmp/pip-4BW1rJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:55:58 INFO - Running setup.py (path:/tmp/pip-fFVlKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:55:58 INFO - Running setup.py (path:/tmp/pip-1U6di2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:55:58 INFO - Running setup.py (path:/tmp/pip-DJHJUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:55:58 INFO - Running setup.py (path:/tmp/pip-oZ0uAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:55:59 INFO - Running setup.py (path:/tmp/pip-ULCdxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:55:59 INFO - Running setup.py (path:/tmp/pip-zcShgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:55:59 INFO - Running setup.py (path:/tmp/pip-GU_2_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:55:59 INFO - Running setup.py (path:/tmp/pip-wWhKN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:55:59 INFO - Running setup.py (path:/tmp/pip-nH6m5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:55:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:55:59 INFO - Running setup.py install for manifestparser 19:55:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for mozcrash 19:55:59 INFO - Running setup.py install for mozdebug 19:55:59 INFO - Running setup.py install for mozdevice 19:55:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for mozfile 19:55:59 INFO - Running setup.py install for mozhttpd 19:56:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Running setup.py install for mozinfo 19:56:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Running setup.py install for mozInstall 19:56:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Running setup.py install for mozleak 19:56:00 INFO - Running setup.py install for mozlog 19:56:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Running setup.py install for moznetwork 19:56:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Running setup.py install for mozprocess 19:56:00 INFO - Running setup.py install for mozprofile 19:56:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Running setup.py install for mozrunner 19:56:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Running setup.py install for mozscreenshot 19:56:00 INFO - Running setup.py install for moztest 19:56:01 INFO - Running setup.py install for mozversion 19:56:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:56:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:56:01 INFO - Cleaning up... 19:56:01 INFO - Return code: 0 19:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:01 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 0x7f004cf7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d20>, '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 0x1063c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', '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 19:56:01 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 19:56:01 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 19:56:01 INFO - Using env: {'DISPLAY': ':0', 19:56:01 INFO - 'HOME': '/home/cltbld', 19:56:01 INFO - 'LANG': 'en_US.UTF-8', 19:56:01 INFO - 'LANGUAGE': 'en_US:en', 19:56:01 INFO - 'LOGNAME': 'cltbld', 19:56:01 INFO - 'MAIL': '/var/mail/cltbld', 19:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:01 INFO - 'MOZ_NO_REMOTE': '1', 19:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:01 INFO - 'NO_EM_RESTART': '1', 19:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:01 INFO - 'PWD': '/builds/slave/test', 19:56:01 INFO - 'SHELL': '/bin/bash', 19:56:01 INFO - 'SHLVL': '1', 19:56:01 INFO - 'TERM': 'linux', 19:56:01 INFO - 'TMOUT': '86400', 19:56:01 INFO - 'USER': 'cltbld', 19:56:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', 19:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:01 INFO - '_': '/tools/buildbot/bin/python'} 19:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:56:01 INFO - Running setup.py (path:/tmp/pip-4iRRLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:56:01 INFO - Running setup.py (path:/tmp/pip-cKIELJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:56:01 INFO - Running setup.py (path:/tmp/pip-eOraCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:56:01 INFO - Running setup.py (path:/tmp/pip-BXDZsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:56:01 INFO - Running setup.py (path:/tmp/pip-GTRhnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:56:01 INFO - Running setup.py (path:/tmp/pip-dDpcr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:56:01 INFO - Running setup.py (path:/tmp/pip-ij5CPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:56:01 INFO - Running setup.py (path:/tmp/pip-bG0VZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:56:02 INFO - Running setup.py (path:/tmp/pip-kvRbBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:56:02 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)) 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:56:02 INFO - Running setup.py (path:/tmp/pip-0BB63H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:56:02 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)) 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:56:02 INFO - Running setup.py (path:/tmp/pip-t6U1o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:56:02 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)) 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:56:02 INFO - Running setup.py (path:/tmp/pip-UaAuy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:56:02 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)) 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:56:02 INFO - Running setup.py (path:/tmp/pip-QSz_lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:56:02 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)) 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:56:02 INFO - Running setup.py (path:/tmp/pip-l8XYfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:56:02 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)) 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:02 INFO - Running setup.py (path:/tmp/pip-ax8CkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:02 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)) 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:56:02 INFO - Running setup.py (path:/tmp/pip-OTe_vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:56:02 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)) 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:56:02 INFO - Running setup.py (path:/tmp/pip-NnIXxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:56:02 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)) 19:56:02 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)) 19:56:02 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)) 19:56:02 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)) 19:56:02 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)) 19:56:02 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)) 19:56:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:04 INFO - Downloading blessings-1.6.tar.gz 19:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:56:04 INFO - Installing collected packages: blessings 19:56:04 INFO - Running setup.py install for blessings 19:56:04 INFO - Successfully installed blessings 19:56:04 INFO - Cleaning up... 19:56:04 INFO - Return code: 0 19:56:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:56:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:04 INFO - Reading from file tmpfile_stdout 19:56:04 INFO - Current package versions: 19:56:04 INFO - argparse == 1.2.1 19:56:04 INFO - blessings == 1.6 19:56:04 INFO - blobuploader == 1.2.4 19:56:04 INFO - docopt == 0.6.1 19:56:04 INFO - functools32 == 3.2.3-2 19:56:04 INFO - jsonschema == 2.5.1 19:56:04 INFO - manifestparser == 1.1 19:56:04 INFO - mozInstall == 1.12 19:56:04 INFO - mozcrash == 0.17 19:56:04 INFO - mozdebug == 0.1 19:56:04 INFO - mozdevice == 0.48 19:56:04 INFO - mozfile == 1.2 19:56:04 INFO - mozhttpd == 0.7 19:56:04 INFO - mozinfo == 0.9 19:56:04 INFO - mozleak == 0.1 19:56:04 INFO - mozlog == 3.3 19:56:04 INFO - moznetwork == 0.27 19:56:04 INFO - mozprocess == 0.23 19:56:04 INFO - mozprofile == 0.28 19:56:04 INFO - mozrunner == 6.12 19:56:04 INFO - mozscreenshot == 0.1 19:56:04 INFO - mozsystemmonitor == 0.3 19:56:04 INFO - moztest == 0.7 19:56:04 INFO - mozversion == 1.4 19:56:04 INFO - psutil == 3.1.1 19:56:04 INFO - requests == 1.2.3 19:56:04 INFO - wsgiref == 0.1.2 19:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:04 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 0x7f004cf7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d20>, '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 0x1063c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', '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 19:56:04 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 19:56:04 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 19:56:04 INFO - Using env: {'DISPLAY': ':0', 19:56:04 INFO - 'HOME': '/home/cltbld', 19:56:04 INFO - 'LANG': 'en_US.UTF-8', 19:56:04 INFO - 'LANGUAGE': 'en_US:en', 19:56:04 INFO - 'LOGNAME': 'cltbld', 19:56:04 INFO - 'MAIL': '/var/mail/cltbld', 19:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:04 INFO - 'MOZ_NO_REMOTE': '1', 19:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:04 INFO - 'NO_EM_RESTART': '1', 19:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:04 INFO - 'PWD': '/builds/slave/test', 19:56:04 INFO - 'SHELL': '/bin/bash', 19:56:04 INFO - 'SHLVL': '1', 19:56:04 INFO - 'TERM': 'linux', 19:56:04 INFO - 'TMOUT': '86400', 19:56:04 INFO - 'USER': 'cltbld', 19:56:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', 19:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:04 INFO - '_': '/tools/buildbot/bin/python'} 19:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:05 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)) 19:56:05 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)) 19:56:05 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)) 19:56:05 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)) 19:56:05 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)) 19:56:05 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)) 19:56:05 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)) 19:56:05 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)) 19:56:05 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)) 19:56:05 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)) 19:56:05 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)) 19:56:05 INFO - Cleaning up... 19:56:05 INFO - Return code: 0 19:56:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f004cf7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d20>, '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 0x1063c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', '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 19:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:56:05 INFO - Using env: {'DISPLAY': ':0', 19:56:05 INFO - 'HOME': '/home/cltbld', 19:56:05 INFO - 'LANG': 'en_US.UTF-8', 19:56:05 INFO - 'LANGUAGE': 'en_US:en', 19:56:05 INFO - 'LOGNAME': 'cltbld', 19:56:05 INFO - 'MAIL': '/var/mail/cltbld', 19:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:05 INFO - 'MOZ_NO_REMOTE': '1', 19:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:05 INFO - 'NO_EM_RESTART': '1', 19:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:05 INFO - 'PWD': '/builds/slave/test', 19:56:05 INFO - 'SHELL': '/bin/bash', 19:56:05 INFO - 'SHLVL': '1', 19:56:05 INFO - 'TERM': 'linux', 19:56:05 INFO - 'TMOUT': '86400', 19:56:05 INFO - 'USER': 'cltbld', 19:56:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', 19:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:05 INFO - '_': '/tools/buildbot/bin/python'} 19:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:56:05 INFO - Cleaning up... 19:56:05 INFO - Return code: 0 19:56:05 INFO - Running post-action listener: _resource_record_post_action 19:56:05 INFO - Running post-action listener: _start_resource_monitoring 19:56:05 INFO - Starting resource monitoring. 19:56:05 INFO - [mozharness: 2016-08-26 02:56:05.455393Z] Finished create-virtualenv step (success) 19:56:05 INFO - [mozharness: 2016-08-26 02:56:05.455901Z] Running install step. 19:56:05 INFO - Running pre-action listener: _resource_record_pre_action 19:56:05 INFO - Running main action method: install 19:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:05 INFO - Reading from file tmpfile_stdout 19:56:05 INFO - Detecting whether we're running mozinstall >=1.0... 19:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:56:05 INFO - Reading from file tmpfile_stdout 19:56:05 INFO - Output received: 19:56:05 INFO - Usage: mozinstall [options] installer 19:56:05 INFO - Options: 19:56:05 INFO - -h, --help show this help message and exit 19:56:05 INFO - -d DEST, --destination=DEST 19:56:05 INFO - Directory to install application into. [default: 19:56:05 INFO - "/builds/slave/test"] 19:56:05 INFO - --app=APP Application being installed. [default: firefox] 19:56:05 INFO - mkdir: /builds/slave/test/build/application 19:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:56:21 INFO - Reading from file tmpfile_stdout 19:56:21 INFO - Output received: 19:56:21 INFO - /builds/slave/test/build/application/firefox/firefox 19:56:21 INFO - Running post-action listener: _resource_record_post_action 19:56:21 INFO - [mozharness: 2016-08-26 02:56:21.911665Z] Finished install step (success) 19:56:21 INFO - [mozharness: 2016-08-26 02:56:21.911913Z] Running run-tests step. 19:56:21 INFO - Running pre-action listener: _resource_record_pre_action 19:56:21 INFO - Running main action method: run_tests 19:56:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:56:21 INFO - Python 2.7.3 19:56:21 INFO - Return code: 0 19:56:21 INFO - grabbing minidump binary from tooltool 19:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:21 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 0x1062d20>, '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 0x1063c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:56:21 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 19:56:21 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 19:56:21 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 19:56:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:56:21 INFO - Return code: 0 19:56:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:56:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:56:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:56:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:56:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:56:21 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/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 19:56:21 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/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 19:56:21 INFO - Using env: {'DISPLAY': ':0', 19:56:21 INFO - 'HOME': '/home/cltbld', 19:56:21 INFO - 'LANG': 'en_US.UTF-8', 19:56:21 INFO - 'LANGUAGE': 'en_US:en', 19:56:21 INFO - 'LOGNAME': 'cltbld', 19:56:21 INFO - 'MAIL': '/var/mail/cltbld', 19:56:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:56:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:21 INFO - 'MOZ_NO_REMOTE': '1', 19:56:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:21 INFO - 'NO_EM_RESTART': '1', 19:56:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:21 INFO - 'PWD': '/builds/slave/test', 19:56:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:56:21 INFO - 'SHELL': '/bin/bash', 19:56:21 INFO - 'SHLVL': '1', 19:56:21 INFO - 'TERM': 'linux', 19:56:21 INFO - 'TMOUT': '86400', 19:56:21 INFO - 'USER': 'cltbld', 19:56:21 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472180126.900867-1842961609', 19:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:21 INFO - '_': '/tools/buildbot/bin/python'} 19:56:21 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/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 19:56:22 INFO - mozversion application_buildid: 20160825183618 19:56:22 INFO - mozversion application_changeset: ec1ebef4eb865b13b4320e87bab27786e1d424a5 19:56:22 INFO - mozversion application_display_name: Nightly 19:56:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:56:22 INFO - mozversion application_name: Firefox 19:56:22 INFO - mozversion application_remotingname: firefox 19:56:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:56:22 INFO - mozversion application_vendor: Mozilla 19:56:22 INFO - mozversion application_version: 51.0a1 19:56:22 INFO - mozversion platform_buildid: 20160825183618 19:56:22 INFO - mozversion platform_changeset: ec1ebef4eb865b13b4320e87bab27786e1d424a5 19:56:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:56:22 INFO - mozversion platform_version: 51.0a1 19:56:22 INFO - using testdate: 1472180182 19:56:22 INFO - actual date: 1472180182 19:56:22 INFO - starting webserver on 'localhost:37746' 19:56:22 INFO - SUITE-START | Running 2 tests 19:56:22 INFO - TEST-START | dromaeo_css 19:56:22 INFO - operating with platform_type : linux_ 19:56:22 INFO - Initialising browser for dromaeo_css test... 19:56:22 INFO - TEST-INFO | started process 8102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFJZ_Ra/profile http://localhost:37746/getInfo.html) 19:56:27 INFO - PROCESS | 8102 | __metrics Screen width/height:1600/1200 19:56:27 INFO - PROCESS | 8102 | colorDepth:24 19:56:27 INFO - PROCESS | 8102 | Browser inner width/height: 1024/697 19:56:27 INFO - PROCESS | 8102 | __metrics 19:56:28 INFO - PROCESS | 8102 | 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" 19:56:28 INFO - PROCESS | 8102 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:56:28 INFO - PROCESS | 8102 | console.error: PushService: 19:56:28 INFO - PROCESS | 8102 | stateChangeProcessEnqueue: Error transitioning state 19:56:28 INFO - PROCESS | 8102 | UnknownError 19:56:29 INFO - TEST-INFO | 8102: exit 0 19:56:29 INFO - Browser initialized. 19:56:29 INFO - Running cycle 1/1 for dromaeo_css test... 19:56:29 INFO - TEST-INFO | started process 8182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFJZ_Ra/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:41 INFO - PROCESS | 8182 | RSS: Main: 181596160 19:56:41 INFO - PROCESS | 8182 | 19:57:33 INFO - PROCESS | 8182 | 1472180253075 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] 19:59:46 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:37746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37746/tests/dromaeo/cssquery-ext.html) 19:59:47 INFO - PROCESS | 8182 | RSS: Main: 291368960 19:59:47 INFO - PROCESS | 8182 | 20:02:50 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:37746/tests/dromaeo/cssquery-ext.html (next: http://localhost:37746/tests/dromaeo/cssquery-jquery.html) 20:02:50 INFO - PROCESS | 8182 | RSS: Main: 277090304 20:02:50 INFO - PROCESS | 8182 | 20:05:53 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:37746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37746/tests/dromaeo/cssquery-mootools.html) 20:05:53 INFO - PROCESS | 8182 | RSS: Main: 219217920 20:05:53 INFO - PROCESS | 8182 | 20:08:56 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:37746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37746/tests/dromaeo/cssquery-prototype.html) 20:08:56 INFO - PROCESS | 8182 | RSS: Main: 227262464 20:08:56 INFO - PROCESS | 8182 | 20:11:59 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:37746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37746/tests/dromaeo/cssquery-yui.html) 20:12:00 INFO - PROCESS | 8182 | RSS: Main: 218935296 20:12:00 INFO - PROCESS | 8182 | 20:15:03 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:37746/tests/dromaeo/cssquery-yui.html (next: http://localhost:37746/tests/dromaeo/cssquery-dojo.html) 20:15:03 INFO - PROCESS | 8182 | RSS: Main: 313851904 20:15:03 INFO - PROCESS | 8182 | 20:15:03 INFO - PROCESS | 8182 | __start_tp_report 20:15:03 INFO - PROCESS | 8182 | _x_x_mozilla_page_load 20:15:03 INFO - PROCESS | 8182 | _x_x_mozilla_page_load_details 20:15:03 INFO - PROCESS | 8182 | |i|pagename|runs| 20:15:03 INFO - PROCESS | 8182 | |0;dojo.html;2577.6133579963002;2606.0487921908507;2610.7911367090646;2622.7508386703266;2628.8028397870166;4622.191116554598;4684.742339171345;4727.361806156168;4819.1325561398935;4862.927056094157;4787.329773831658;4830.227163653816;4834.492378300271;4837.226043832988;4880.5363490468435;4319.827206911736;4363.585459381369;4433.512313645497;4495.483019452756;4530.3204519322035;4450.688451808391;4490.865274041784;4493.168763778695;4517.232070548015;4536.705114167585;4247.723897946624;4287.314029755255;4364.738115713068;4428.4243048403505;4428.623566996809;4381.430414046185;4383.298672212431;4386.7367957922625;4493.348464472633;4495.527969563182;4398.186335527937;4407.933880991788;4413.315936029889;4416.977915110436;4462.576055274743;4662.696924699883;4812.109759694433;4824.348712923746;4848.781804818756;4868.878278043077;5191.610629202825;5207.817726379559;5213.530782229617;5218.817341393033;5254.31693879797;5213.4004589472315;5234.42421333653;5251.186066159751;5257.553107985826;5314.256004159421;4610.723356598614;4756.809727610926;4775.73733444657;4784;4842.491538388454;5249.2126181073145;5279.208118782137;5279.683219006872;5282.392524859613;5330.840074797685;5026.673266237683;5035.899282014412;5038;5040.294358789773;5095.439501654815;4945.258211268267;5072.746362681851;5119.718415487109;5150;5156.432792392834;5135.4094279157625;5135.87160320995;5137.049645815536;5137.33214682089;5179.300794392709;5113.258577506241;5113.821016264487;5114.795408183631;5119.744012799345;5179.300794392784;4091.774952377648;4125.443065186221;4264.211120942636;4285.357196420499;4296.763677997677;3744.213715119801;3750.306193354238;3783.2244389900006;3807.276617442677;3834.865779697753;4443.888902777392;4447.132809102194;4449.2658711312915;4454.37638730578;4511.3458548510935;4997.575206107522;5060.5951523878;5178.223266510054;5204.583633309402;5262.97368513155;4469.821207151743;4477.955220447754;4489.663275254369;4542.454905411372;4543.136804007228;4654.208784506642;4658.976705116453;4663.580277775017;4666.002986560477;4707.058588282289;4634.536546345338;4787.210110331756;4844.854654360375;4845.53967373099;4851.490593487633;5211.973940130275;5247.58019358458;5249.317588713443;5317.548008419173;5317.760700768397;4803.831865884677;4816.277558366273;4831.057943700945;4846.418429788307;4898.632602554894;4879.707217566957;5105.566026887607;5147.6654017488745;5151.278820965143;5159.613029022763;5193.428722840409;5259.368875734936;5261.316028916216;5301.469853014668;5317.734113294242;5065.442801291929;5088.185890257541;5101.311322971352;5105.438401775876;5124.590032797441;4816.397950256218;4935.605151587936;5046.722430266371;5046.9747651261505;5051.974740126276;4895.143349913822;4980.775865086152;4985.476524964826;5013.047520971004;5060.51925067118;5060.443351231288;5076.36545431821;5091.465396133352;5092.796288148433;5154.716490593053;4776.928346074881;4851.902961940812;4929.654924155275;4958.082754690394;4980.302757613865 20:15:03 INFO - PROCESS | 8182 | |1;ext.html;570.2273419516554;574.8246784730655;575.1286800497245;581.8050952930768;584.8888711144882;27907.441851162963;38257;39196.412053819215;39237.60762392375;43548.564514354846;41046.7947660262;41456.17087658245;41508.56617224328;41578.376324355086;41603.16793664125;7131.643417829114;7689.423293253;7830.725924592641;7843.686252549891;7846.176151504067;7080;7280.162781280168;7285.417166626684;10050.54772535234;10362.430066346347;10213.387196768217;10265.589376424934;10280.074793268604;10284.074433301;10291.404832250975;10109.54507047181;10160.390376577356;10172.89827101727;10174.949125254401;10190.796184076351;9840.803183936281;9906.108450239513;9907.752306192331;9910.20718342531;9922.206223502175;37003.4449483258;37158.81420592907;37350.81324593387;37357.62642373569;37417.625823741684;3063.5098384258636;3095.5356696495483;3375.1899544109483;3665;3776.9433458498142;29372.853135734185;29435;29509.852450737824;29580.520973951432;30878.691213087804;3155.794873333226;3229.3541291741744;3241.416545021895;3255.2675647979254;3289.6381398046196;256533.99999999814;257515;257584;257937;258022;53214;53473;53691;53696.731516342166;53769.1934620981;32137.67862321347;32804.67195328064;32932;34305.48541771875;34387.4841877372;15059.247037648074;15221.923890380478;15226.162561059247;15229.771553426708;15237;11449.656510304705;11555.653330399933;11578.47896844644;11579.942100289445;11592.130590205768;15571.610709732347;17284.395046173577;17844.375446859296;17977.280908763765;18449.446516604523;6733.562318449285;6768.69540870662;6795.626240556817;6806.931930680729;7018.964905175543;781.4061313401855;827.8385714785559;878.3193025405362;884.9469031858109;886.8093359927647;27439.314017149733;27458.17625471239;27758.306042349104;28139.859300703774;28215;957.7940742740344;994.5126887824914;997.5610731278215;1005.6982905128579;1048.5176818663347;14637.194954277616;14929.626759330886;14932.701345973237;15052.924735376471;15304.234788260543;372013;373372;374440;374487;375930;49419.50580494221;49929.251061234114;49953.75023124861;49963.25055124176;49994.25008624801;1072.367303291062;1117.5082963496197;1168.1355796710204;1183.4556104191995;1194.3729541990351;25656.74343256618;28695.426091477635;29009.274768130123;29345.266368340963;29382.70617293885;41558.376624351265;42141.36787948122;42172.789136054125;42192.578074220095;42220.577794222896;278761;279703;279994;280157;280773;24900.252992410256;25109.874450628362;25878.482430351665;25892.870535647955;26824.731752683005;40573.39139912845;40822.79588602038;40954.385684215355;41135.38296925608;42279.57720422879;35453.82273088618;35717.82141089278;35735;35745.28509429849;35762.463563046054;34616.13459663428;34807;34890;35584.28831423409;35602.643973559934;35020.64979350276;35579.466308004885;35812;35843.64156358403;36238.8188059058;30249;32870.67129328676;33062.17344566309;33126.834365828014;33171.66828331686;24309.878450607634;24979.500409992062;24989.250322490356;25222.054799952184;25432.364190895376 20:15:03 INFO - PROCESS | 8182 | |2;jquery.html;341.9826017597646;343.82808595702164;356.2892030399353;362.4508869063369;378.57788565749183;16544.751828722565;17561.912190439063;17757.733633995485;18577.90711046446;18928.5267868303;16608;17591.73612395815;18326.08369581519;18468.815311846913;18897.716534252;5513.61404701671;5822.1266809978415;5828.47543721065;5832.650040997532;5833.941660583382;5494.697791621459;5611.971940140294;5649.830505084854;5699.2306038684865;5702.429757024306;5689.374168841424;5700.173474846145;5705.600607957424;5706.486416222539;5706.773043795583;5696.202531645552;5696.344920334173;6499.610023398611;6827.52207345486;6871.518993670445;6453.386928241809;6697.330266973312;6715.6977935993;6740.045386837811;6740.629265390402;22631.32106036805;23202.3039308821;23432;23562.29313120592;23865.522689546284;1902.838258748008;1949.7172909928122;1988.5823976964855;1999.6500612392774;2032.9186832526682;13806.792898106536;14315.713685726227;14503.709925801424;14709.705805883823;15040.924795376062;1808.8604179366914;1839.1172237326025;1859.2098358197711;1883.802200768927;1948.9415317540354;81664.59167704183;81886;82064.17935820625;83706;84424;16035.19824008795;16157.980252468442;16194.595135121715;16228.918855405884;16895;28685.28286792847;28731.712682873324;28805.711942880724;28808.279793005342;28835;8907.55462226886;9172.35793494449;9321.60017490423;9432.19826314771;9595.90404095964;7100.751473698396;7171.713131474787;7350.963245183847;7369.1525474570035;7609.885851712229;7819;8033.799155021171;8133.918660813434;8172.550509721904;8179.918200818035;2986.7759918006236;3092.3196896682693;3189.7448204144075;3220.951685724716;3228.257500774835;759.3242014607005;795.9363250939911;833.3624777045565;908.7364664247426;921.3504479342048;16189.676206475804;16560.66878662444;16770.66458670844;17343.39298124585;17549.385771497935;838.0623284032575;840.3025488844245;863.6761214544546;889.8021885941714;902.1609902790336;8246.752597422086;8821.60302786376;9397.342186047048;9631.470269135265;9952.651657191964;272579;277202;277448;382407;382810;83818;83823.58088209642;86811.56594216988;88149;88166;881.7310720230263;905.791667916383;943.1323182671821;949.3117489819825;950.0404591362774;15570.9221453892;15776;16173;16343.427980020642;16614.169291535618;32000.51999219967;36257.63742362543;39607;39649;41071.17857642771;53307.470804671066;53602;53808.46191538191;54772.701139369485;55882;7551.358134558624;7646.350060244719;7675.04061992251;7815.29662330393;7839.529628222325;6272.372762723691;9136.543172841464;10630;11733.530658773894;11741.882581174079;10281;10423.895761042293;10459;10651.414172220293;10941.671749847517;9696.612135514782;10293.073623373932;10447.111995480165;10649.787004260026;10664.57341706354;10056.34633748804;10191.54138063774;10224.897751022394;10235.437050962268;10449.738756531147;7352.558846469229;7556.8866467001935;7766.417518686008;7777.183395743592;7787.727429539939;9394.530273486162;9599.904000959901;9704.660336888175;9718.805623887623;9967.40195588267 20:15:03 INFO - PROCESS | 8182 | |3;mootools.html;1225.466921888979;1338.263954824846;1387.2855479428092;1453.9563813085604;1688.8648908087346;7245.4928155029165;7651.120121186065;7678.27056429639;7798.376129909608;7813.101493328269;7710.768676939687;7826.178251283604;7828.334591559725;7831.451798374116;7831.765047048583;2196.670499425083;2222.8555143915673;2226.2319499772634;2227.1536816009893;2227.2984010036866;2160.8379371547117;2217.756046834847;2234.2850287907877;2237.127520267097;2239.585676649817;2169.4142581502983;2169.4901698100934;2202.0090959068402;2202.48241663209;2204.790544898232;2139.967900481494;2141.817945474621;2155.084089262073;2158.0720290275176;2159.8920053997235;2080.5318803269297;2113.144176608476;2119.98940005299;2123.755768086659;2126.393977716343;7496.212897645723;7701.653425595861;7711.228877112244;7765.029371328584;7790.649420776022;4224.683148763855;4377.058932329564;4381.561843815625;4383.276759334706;4386.429764130643;2798.790090743202;2913.7231962963483;2988.8655010524362;2989.4320079184886;2995.281132528199;984.194004002656;988.6885631026204;999.0259496990449;1009.581023875091;1009.8535712321673;10709.25035247533;10745.14038876888;10822.72943176419;10830.350178989207;10852.240343175901;3874.535055793323;3930.6462418382484;4020.3567429211184;4038.838446462167;4058.411530328086;8382.371322150862;8398.83202335962;8400.41197116196;8404.159584041547;8404.663813447516;4248.426462427595;4250.128723611652;4252.213340532012;4252.4046633471335;4256.9574304257185;3495;3859.4403811447746;3923.2153569286256;3930.7248492605245;4038.131801662598;3364.0748794081824;3387.305602351512;3482.721382289411;3485.6165821759587;3552.5559305086863;1015.7257540464034;1025.7281820317621;1026.4046852825343;1042.890496497872;1043.446973104256;792.4056957282038;799.3325573146371;799.8440304140753;811.809224832164;854.4744981836126;4850.781714822841;5122.129238029544;5170.663906846043;5257.237700533401;5318.22885681574;852.3181454836106;882.2941646682629;890.0832142892831;890.8552510024717;910.2717825739383;3413.8975830725117;3590.676839084495;3638.7634803737674;3657.2868290683596;3775.528058992626;9279.476527004012;9824.754381140528;9890.406575605486;9891.159251463707;9939.850902236472;9678.27412944032;9756.414615123116;9762.463064531377;9780;9781.90218097824;7183;7398;7484.5883476408235;7498.700051997968;7502.324790768857;5057.671251368649;5117.8464646060675;5148.431805246282;5173.948260517347;5197.194434862602;8895.555222238992;8980;8992.100789920956;8992.955035225044;9027;8841.867371989554;8965.327600430124;9010.414323068979;9065.592048357708;9123.361364704408;6039.094135879654;6540.8364790880605;6647.933520664925;6679.833004174934;6700.66496675174;7350.70597176107;7645.159032506531;7686.6541005656;7698.884516732365;7700.306972372289;6759.662016899234;6836.145481814773;6864;6920.30796920304;7128.607926564089;6754.459643228432;6802;6807.319268073153;6839.350261725128;6952.30476952321;6490.578112422678;6514.055461958084;6533.542652014314;6556.8360790978695;6559.180102487189;4480.977595112004;4500.302453119772;4566.88582785433;4628.583427491407;4670.579647831712;4513.7066090704;4561.749103799323;4611.631069514364;4673.602743766818;4855.732934688484 20:15:03 INFO - PROCESS | 8182 | |4;prototype.html;275.12784473219904;287.44953414211784;289.81451870802675;291.52772508536174;298.6580365481524;4586.495485496593;4760.8097975506125;4766.68916048087;4833.782479788413;4868.6348523860715;4573.977130114353;4702.200625893598;4721.268203428474;4729.533844508205;4743.952560474403;3776.8866933992026;3777.357849165635;3778.2821263959895;3782.470454136423;3782.8865134046023;3562.7684200526883;3675.4854320395166;3766.7928263945473;3781.90324805806;3792.924141517168;3422.931541369171;3661.4141737322034;3665.157013886808;3669.7614655047337;3685.7100014994808;3672.2839046385966;3673.81630918453;3680.245549662326;3686.9078273043256;3691.8523259069607;3248.96751032489;3255.788373755722;3264.314493956272;3266.70599646033;3267.5425440438357;4502.279635258343;4577.198990176706;4598.735347779354;4618.722876627379;4666.416697912761;4221.894452638709;4227.260229459832;4231.957680423187;4240.618344349024;4242.681798865097;4949.430815456232;4953.306537084811;4953.925691114636;4959.090750061217;4963.57809586182;3431.6225215226304;3571.499990001402;3585.910352241189;3596.7482276240676;3600.08197909534;5118.795248190068;5168.22476628505;5176.567013503647;5180.300659410969;5184.792608295701;3586.2110335726097;3606.5672119345845;3607.549056367954;3610.151614370621;3615.7830530168276;3659.688926441229;3670.559532856021;3676.904164626191;3685.2261025184475;3696;4011.3782363733667;4156.189543039139;4178.749275043507;4182.435371224907;4213.810378532973;4896.436909755353;4896.755162241945;4897.265410188429;4931.545194167729;4947.208446648519;1220.8534975802784;1253.9623811285676;1283.5635883799553;1296.1574976265504;1301.1802564384377;881.0836729800935;897.237348253992;900.2977677411629;903.8056817784208;904.1365495951351;4333.176696427731;4345.261305578059;4353.73877567347;4363.258246098171;4370.38814565961;5051.494850514992;5055.620828437882;5058.190689489664;5139.45816255122;5143.819966301162;4202.474690663667;4404.2512772828695;4415.823367065282;4466.821327146943;4481.7535035573355;2722.68689100752;2746.2722378569697;2753.3529620539157;2755.2836262571877;2758.0831322230856;4827.624127123823;4828.7102773833685;4834.444038935568;4839.3141806297135;4854.441739199967;5145.536901678867;5229.189475631283;5265.289185959923;5274.551663108602;5312.096943519611;4763.142634325785;4773.236282194832;4799.880002999953;4803.423589169252;4816.470188279286;5010.223415370623;5134.409542902465;5154;5154.716490593053;5164.7934082636275;4984.925226121539;5014.122528557561;5036.647434679538;5059.519345662156;5059.822906198266;4804;4805.303231031551;4809.302651115639;4814.638902082428;4822.324874517641;3531.2407832316176;3562.982185089058;3580.928381432409;3599.1362073101745;3605.675489205984;4893.388326459192;5115;5184.637075404837;5194.961007798531;5206.297149884868;4976.925346119883;5001.774565231542;5012.398512178562;5034.421041580119;5038.647294689336;4984.526469985346;4992.625553083606;4999.800007999785;5013.799448022184;5026.371703537058;4674.74288914113;4754.5245475452175;4791.448983366958;4909.361782968192;4948.010397920359;4990.675606085593;4995.750212489434;5008.949910500848;5016.968127908203;5025.572826309658;4922.704637721748;4935.975320123376;4939.580135688507;4940.407151141886;4968.527989840959 20:15:03 INFO - PROCESS | 8182 | |5;yui.html;637.2194062273716;645.5868244323632;669.2638098092096;677.6510097299888;730.4485113739127;13769.242691651954;14395.496157634485;14409.567712968614;14935.775963360531;14978.475753348635;14008.719825603483;14099.295035248222;14152.150870947724;14170.71658566828;14269.072510286824;733.915599706034;754.2758951406629;762.8398036412333;763.335897768939;765.9885101723479;767.8771396576549;768.323874990008;769.6575024114271;769.8498792735419;770.098984188498;808.3250485844297;809.5587904591982;809.8785182222655;810.4448452809844;812.6261919517029;795.932345750612;805.118395357083;810.631162820915;810.805406702393;811.0672726364699;587.8765459253561;588.2969851028023;588.5144755576623;588.6468119128532;592.037938350181;13689.794653080211;13693.863061369359;13714.382852771549;13742.93128534361;13766.724665506734;12682.175658582162;12926.707329267092;12979.156354836905;13605.387757550934;13848.684374984361;10517.894821051768;10629.72443306808;10686.946565267124;10722.839157412645;10814.945925270402;3266.4120458317493;3270.9509357359657;3285.2772390074147;3305.4545999909988;3358.966410335914;66758.66620666865;67784;68102.65948670275;69029;70318.29681703169;9167.12912273333;9320.114589114024;9870.21038316933;10135.34120282194;10269.74325641865;17422.912885435493;17431.912840435718;17445.040522771116;17455;17474.563135921704;6866.519343645897;6884.793456196322;6898.620575868275;7051.612161331073;7290.526115802456;3762.3792074307435;3796.1888733425526;3801.258754542838;3817.1220619257724;3915.7846318452757;3068.202267410489;3138.497840345534;3159.5418664293547;3169.793963392372;3183.904482865518;510.43086958041516;513.6609837507227;516.2746341390277;526.3473293116508;534.6364472158891;463.2821606607006;512.6155383462403;562.1623780567007;570.6062816656577;606.8755905039457;7720.652570634335;8156.388270879707;8345.791355216168;8366.330693544502;8661.263792577702;481.40546425164894;485.36174929967683;532.3771187710388;585.733491261475;625.6746491824317;3672.7429079964145;3812.447195156742;4050.918981620351;4393.626541743924;4447;88134.55932720295;94850;102745;106109;106263;81368.18631813607;85799;86853.13146868577;86964.13035869687;87902.56048719716;77537;77577.61211193907;77661.61169194117;78703;78882;8609.69866054685;9043;9114.954425228098;9127.817443651222;9143.3599648024;45323.09353812839;45936.31095533637;47329.29006064981;47664.761676191396;47919.76040119777;61334.38665613465;66178.33821661722;66837;68163.70807692452;72876.27123728907;11397.202195846212;11443.599474018369;11760.58837940668;11766;12116;13527.526536571173;13797.24115173675;13953.162810231419;14376.137431754129;14644.414223430944;12006.75986480248;12051;12587.874121259036;13071.542496012975;13215.074944753775;11890.227135236182;12094.334811585095;12338.259704417764;12344.876551234373;12364.381780911099;11690.88309116898;11950;12474.875251247371;12571.1200215984;12595.559155429515;10141.949290253502;10179.745506362104;10473.371597704163;10545.087083160215;10643.733906652085;9969.800603987735;10937.343759374464;11060.281081729661;11088.833667495155;11176.88823111791 20:15:03 INFO - PROCESS | 8182 | __end_tp_report 20:15:03 INFO - PROCESS | 8182 | __start_cc_report 20:15:03 INFO - PROCESS | 8182 | _x_x_mozilla_cycle_collect,951 20:15:03 INFO - PROCESS | 8182 | __end_cc_report 20:15:03 INFO - PROCESS | 8182 | __startTimestamp1472181303679__endTimestamp 20:15:03 INFO - PROCESS | 8182 | 20:15:03 INFO - PROCESS | 8182 | ------- Summary: start ------- 20:15:03 INFO - PROCESS | 8182 | Number of tests: 6 20:15:03 INFO - PROCESS | 8182 | 20:15:03 INFO - PROCESS | 8182 | [#0] dojo.html Cycles:165 Average:4761.26 Median:4851.49 stddev:525.30 (10.8%) stddev-sans-first:498.19 20:15:03 INFO - PROCESS | 8182 | Values: 2577.6 2606.0 2610.8 2622.8 2628.8 4622.2 4684.7 4727.4 4819.1 4862.9 4787.3 4830.2 4834.5 4837.2 4880.5 4319.8 4363.6 4433.5 4495.5 4530.3 4450.7 4490.9 4493.2 4517.2 4536.7 4247.7 4287.3 4364.7 4428.4 4428.6 4381.4 4383.3 4386.7 4493.3 4495.5 4398.2 4407.9 4413.3 4417.0 4462.6 4662.7 4812.1 4824.3 4848.8 4868.9 5191.6 5207.8 5213.5 5218.8 5254.3 5213.4 5234.4 5251.2 5257.6 5314.3 4610.7 4756.8 4775.7 4784.0 4842.5 5249.2 5279.2 5279.7 5282.4 5330.8 5026.7 5035.9 5038.0 5040.3 5095.4 4945.3 5072.7 5119.7 5150.0 5156.4 5135.4 5135.9 5137.0 5137.3 5179.3 5113.3 5113.8 5114.8 5119.7 5179.3 4091.8 4125.4 4264.2 4285.4 4296.8 3744.2 3750.3 3783.2 3807.3 3834.9 4443.9 4447.1 4449.3 4454.4 4511.3 4997.6 5060.6 5178.2 5204.6 5263.0 4469.8 4478.0 4489.7 4542.5 4543.1 4654.2 4659.0 4663.6 4666.0 4707.1 4634.5 4787.2 4844.9 4845.5 4851.5 5212.0 5247.6 5249.3 5317.5 5317.8 4803.8 4816.3 4831.1 4846.4 4898.6 4879.7 5105.6 5147.7 5151.3 5159.6 5193.4 5259.4 5261.3 5301.5 5317.7 5065.4 5088.2 5101.3 5105.4 5124.6 4816.4 4935.6 5046.7 5047.0 5052.0 4895.1 4980.8 4985.5 5013.0 5060.5 5060.4 5076.4 5091.5 5092.8 5154.7 4776.9 4851.9 4929.7 4958.1 4980.3 20:15:03 INFO - PROCESS | 8182 | 20:15:03 INFO - PROCESS | 8182 | [#1] ext.html Cycles:180 Average:45721.00 Median:18840.34 stddev:80809.35 (428.9%) stddev-sans-first:80964.94 20:15:03 INFO - PROCESS | 8182 | Values: 570.2 574.8 575.1 581.8 584.9 27907.4 38257.0 39196.4 39237.6 43548.6 41046.8 41456.2 41508.6 41578.4 41603.2 7131.6 7689.4 7830.7 7843.7 7846.2 7080.0 7280.2 7285.4 10050.5 10362.4 10213.4 10265.6 10280.1 10284.1 10291.4 10109.5 10160.4 10172.9 10174.9 10190.8 9840.8 9906.1 9907.8 9910.2 9922.2 37003.4 37158.8 37350.8 37357.6 37417.6 3063.5 3095.5 3375.2 3665.0 3776.9 29372.9 29435.0 29509.9 29580.5 30878.7 3155.8 3229.4 3241.4 3255.3 3289.6 256534.0 257515.0 257584.0 257937.0 258022.0 53214.0 53473.0 53691.0 53696.7 53769.2 32137.7 32804.7 32932.0 34305.5 34387.5 15059.2 15221.9 15226.2 15229.8 15237.0 11449.7 11555.7 11578.5 11579.9 11592.1 15571.6 17284.4 17844.4 17977.3 18449.4 6733.6 6768.7 6795.6 6806.9 7019.0 781.4 827.8 878.3 884.9 886.8 27439.3 27458.2 27758.3 28139.9 28215.0 957.8 994.5 997.6 1005.7 1048.5 14637.2 14929.6 14932.7 15052.9 15304.2 372013.0 373372.0 374440.0 374487.0 375930.0 49419.5 49929.3 49953.8 49963.3 49994.3 1072.4 1117.5 1168.1 1183.5 1194.4 25656.7 28695.4 29009.3 29345.3 29382.7 41558.4 42141.4 42172.8 42192.6 42220.6 278761.0 279703.0 279994.0 280157.0 280773.0 24900.3 25109.9 25878.5 25892.9 26824.7 40573.4 40822.8 40954.4 41135.4 42279.6 35453.8 35717.8 35735.0 35745.3 35762.5 34616.1 34807.0 34890.0 35584.3 35602.6 35020.6 35579.5 35812.0 35843.6 36238.8 30249.0 32870.7 33062.2 33126.8 33171.7 24309.9 24979.5 24989.3 25222.1 25432.4 20:15:03 INFO - PROCESS | 8182 | 20:15:03 INFO - PROCESS | 8182 | [#2] jquery.html Cycles:180 Average:24197.82 Median:30133.70 stddev:54393.81 (180.5%) stddev-sans-first:54516.91 20:15:03 INFO - PROCESS | 8182 | Values: 342.0 343.8 356.3 362.5 378.6 16544.8 17561.9 17757.7 18577.9 18928.5 16608.0 17591.7 18326.1 18468.8 18897.7 5513.6 5822.1 5828.5 5832.7 5833.9 5494.7 5612.0 5649.8 5699.2 5702.4 5689.4 5700.2 5705.6 5706.5 5706.8 5696.2 5696.3 6499.6 6827.5 6871.5 6453.4 6697.3 6715.7 6740.0 6740.6 22631.3 23202.3 23432.0 23562.3 23865.5 1902.8 1949.7 1988.6 1999.7 2032.9 13806.8 14315.7 14503.7 14709.7 15040.9 1808.9 1839.1 1859.2 1883.8 1948.9 81664.6 81886.0 82064.2 83706.0 84424.0 16035.2 16158.0 16194.6 16228.9 16895.0 28685.3 28731.7 28805.7 28808.3 28835.0 8907.6 9172.4 9321.6 9432.2 9595.9 7100.8 7171.7 7351.0 7369.2 7609.9 7819.0 8033.8 8133.9 8172.6 8179.9 2986.8 3092.3 3189.7 3221.0 3228.3 759.3 795.9 833.4 908.7 921.4 16189.7 16560.7 16770.7 17343.4 17549.4 838.1 840.3 863.7 889.8 902.2 8246.8 8821.6 9397.3 9631.5 9952.7 272579.0 277202.0 277448.0 382407.0 382810.0 83818.0 83823.6 86811.6 88149.0 88166.0 881.7 905.8 943.1 949.3 950.0 15570.9 15776.0 16173.0 16343.4 16614.2 32000.5 36257.6 39607.0 39649.0 41071.2 53307.5 53602.0 53808.5 54772.7 55882.0 7551.4 7646.4 7675.0 7815.3 7839.5 6272.4 9136.5 10630.0 11733.5 11741.9 10281.0 10423.9 10459.0 10651.4 10941.7 9696.6 10293.1 10447.1 10649.8 10664.6 10056.3 10191.5 10224.9 10235.4 10449.7 7352.6 7556.9 7766.4 7777.2 7787.7 9394.5 9599.9 9704.7 9718.8 9967.4 20:15:03 INFO - PROCESS | 8182 | 20:15:03 INFO - PROCESS | 8182 | [#3] mootools.html Cycles:180 Average:5100.32 Median:5135.28 stddev:2893.61 (56.3%) stddev-sans-first:2887.07 20:15:03 INFO - PROCESS | 8182 | Values: 1225.5 1338.3 1387.3 1454.0 1688.9 7245.5 7651.1 7678.3 7798.4 7813.1 7710.8 7826.2 7828.3 7831.5 7831.8 2196.7 2222.9 2226.2 2227.2 2227.3 2160.8 2217.8 2234.3 2237.1 2239.6 2169.4 2169.5 2202.0 2202.5 2204.8 2140.0 2141.8 2155.1 2158.1 2159.9 2080.5 2113.1 2120.0 2123.8 2126.4 7496.2 7701.7 7711.2 7765.0 7790.6 4224.7 4377.1 4381.6 4383.3 4386.4 2798.8 2913.7 2988.9 2989.4 2995.3 984.2 988.7 999.0 1009.6 1009.9 10709.3 10745.1 10822.7 10830.4 10852.2 3874.5 3930.6 4020.4 4038.8 4058.4 8382.4 8398.8 8400.4 8404.2 8404.7 4248.4 4250.1 4252.2 4252.4 4257.0 3495.0 3859.4 3923.2 3930.7 4038.1 3364.1 3387.3 3482.7 3485.6 3552.6 1015.7 1025.7 1026.4 1042.9 1043.4 792.4 799.3 799.8 811.8 854.5 4850.8 5122.1 5170.7 5257.2 5318.2 852.3 882.3 890.1 890.9 910.3 3413.9 3590.7 3638.8 3657.3 3775.5 9279.5 9824.8 9890.4 9891.2 9939.9 9678.3 9756.4 9762.5 9780.0 9781.9 7183.0 7398.0 7484.6 7498.7 7502.3 5057.7 5117.8 5148.4 5173.9 5197.2 8895.6 8980.0 8992.1 8993.0 9027.0 8841.9 8965.3 9010.4 9065.6 9123.4 6039.1 6540.8 6647.9 6679.8 6700.7 7350.7 7645.2 7686.7 7698.9 7700.3 6759.7 6836.1 6864.0 6920.3 7128.6 6754.5 6802.0 6807.3 6839.4 6952.3 6490.6 6514.1 6533.5 6556.8 6559.2 4481.0 4500.3 4566.9 4628.6 4670.6 4513.7 4561.7 4611.6 4673.6 4855.7 20:15:03 INFO - PROCESS | 8182 | 20:15:03 INFO - PROCESS | 8182 | [#4] prototype.html Cycles:180 Average:4131.15 Median:4736.74 stddev:1196.20 (25.3%) stddev-sans-first:1164.02 20:15:03 INFO - PROCESS | 8182 | Values: 275.1 287.4 289.8 291.5 298.7 4586.5 4760.8 4766.7 4833.8 4868.6 4574.0 4702.2 4721.3 4729.5 4744.0 3776.9 3777.4 3778.3 3782.5 3782.9 3562.8 3675.5 3766.8 3781.9 3792.9 3422.9 3661.4 3665.2 3669.8 3685.7 3672.3 3673.8 3680.2 3686.9 3691.9 3249.0 3255.8 3264.3 3266.7 3267.5 4502.3 4577.2 4598.7 4618.7 4666.4 4221.9 4227.3 4232.0 4240.6 4242.7 4949.4 4953.3 4953.9 4959.1 4963.6 3431.6 3571.5 3585.9 3596.7 3600.1 5118.8 5168.2 5176.6 5180.3 5184.8 3586.2 3606.6 3607.5 3610.2 3615.8 3659.7 3670.6 3676.9 3685.2 3696.0 4011.4 4156.2 4178.7 4182.4 4213.8 4896.4 4896.8 4897.3 4931.5 4947.2 1220.9 1254.0 1283.6 1296.2 1301.2 881.1 897.2 900.3 903.8 904.1 4333.2 4345.3 4353.7 4363.3 4370.4 5051.5 5055.6 5058.2 5139.5 5143.8 4202.5 4404.3 4415.8 4466.8 4481.8 2722.7 2746.3 2753.4 2755.3 2758.1 4827.6 4828.7 4834.4 4839.3 4854.4 5145.5 5229.2 5265.3 5274.6 5312.1 4763.1 4773.2 4799.9 4803.4 4816.5 5010.2 5134.4 5154.0 5154.7 5164.8 4984.9 5014.1 5036.6 5059.5 5059.8 4804.0 4805.3 4809.3 4814.6 4822.3 3531.2 3563.0 3580.9 3599.1 3605.7 4893.4 5115.0 5184.6 5195.0 5206.3 4976.9 5001.8 5012.4 5034.4 5038.6 4984.5 4992.6 4999.8 5013.8 5026.4 4674.7 4754.5 4791.4 4909.4 4948.0 4990.7 4995.8 5008.9 5017.0 5025.6 4922.7 4936.0 4939.6 4940.4 4968.5 20:15:03 INFO - PROCESS | 8182 | 20:15:03 INFO - PROCESS | 8182 | [#5] yui.html Cycles:180 Average:18551.97 Median:23199.80 stddev:26420.74 (113.9%) stddev-sans-first:26460.61 20:15:03 INFO - PROCESS | 8182 | Values: 637.2 645.6 669.3 677.7 730.4 13769.2 14395.5 14409.6 14935.8 14978.5 14008.7 14099.3 14152.2 14170.7 14269.1 733.9 754.3 762.8 763.3 766.0 767.9 768.3 769.7 769.8 770.1 808.3 809.6 809.9 810.4 812.6 795.9 805.1 810.6 810.8 811.1 587.9 588.3 588.5 588.6 592.0 13689.8 13693.9 13714.4 13742.9 13766.7 12682.2 12926.7 12979.2 13605.4 13848.7 10517.9 10629.7 10686.9 10722.8 10814.9 3266.4 3271.0 3285.3 3305.5 3359.0 66758.7 67784.0 68102.7 69029.0 70318.3 9167.1 9320.1 9870.2 10135.3 10269.7 17422.9 17431.9 17445.0 17455.0 17474.6 6866.5 6884.8 6898.6 7051.6 7290.5 3762.4 3796.2 3801.3 3817.1 3915.8 3068.2 3138.5 3159.5 3169.8 3183.9 510.4 513.7 516.3 526.3 534.6 463.3 512.6 562.2 570.6 606.9 7720.7 8156.4 8345.8 8366.3 8661.3 481.4 485.4 532.4 585.7 625.7 3672.7 3812.4 4050.9 4393.6 4447.0 88134.6 94850.0 102745.0 106109.0 106263.0 81368.2 85799.0 86853.1 86964.1 87902.6 77537.0 77577.6 77661.6 78703.0 78882.0 8609.7 9043.0 9115.0 9127.8 9143.4 45323.1 45936.3 47329.3 47664.8 47919.8 61334.4 66178.3 66837.0 68163.7 72876.3 11397.2 11443.6 11760.6 11766.0 12116.0 13527.5 13797.2 13953.2 14376.1 14644.4 12006.8 12051.0 12587.9 13071.5 13215.1 11890.2 12094.3 12338.3 12344.9 12364.4 11690.9 11950.0 12474.9 12571.1 12595.6 10141.9 10179.7 10473.4 10545.1 10643.7 9969.8 10937.3 11060.3 11088.8 11176.9 20:15:03 INFO - PROCESS | 8182 | -------- Summary: end -------- 20:15:03 INFO - PROCESS | 8182 | 20:15:04 INFO - TEST-INFO | 8182: exit 0 20:15:04 INFO - TEST-OK | dromaeo_css | took 1122545ms 20:15:04 INFO - TEST-START | kraken 20:15:04 INFO - operating with platform_type : linux_ 20:15:04 INFO - Initialising browser for kraken test... 20:15:04 INFO - TEST-INFO | started process 8489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpexeyoy/profile http://localhost:37746/getInfo.html) 20:15:09 INFO - PROCESS | 8489 | __metrics Screen width/height:1600/1200 20:15:09 INFO - PROCESS | 8489 | colorDepth:24 20:15:09 INFO - PROCESS | 8489 | Browser inner width/height: 1024/697 20:15:09 INFO - PROCESS | 8489 | __metrics 20:15:10 INFO - PROCESS | 8489 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:15:10 INFO - PROCESS | 8489 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:10 INFO - PROCESS | 8489 | console.error: PushService: 20:15:10 INFO - PROCESS | 8489 | stateChangeProcessEnqueue: Error transitioning state 20:15:10 INFO - PROCESS | 8489 | UnknownError 20:15:11 INFO - TEST-INFO | 8489: exit 0 20:15:11 INFO - Browser initialized. 20:15:11 INFO - Running cycle 1/1 for kraken test... 20:15:11 INFO - TEST-INFO | started process 8574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpexeyoy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:23 INFO - PROCESS | 8574 | RSS: Main: 180666368 20:15:23 INFO - PROCESS | 8574 | 20:15:26 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37746/tests/kraken/driver.html?testName=audio-beat-detection) 20:15:27 INFO - PROCESS | 8574 | RSS: Main: 234323968 20:15:27 INFO - PROCESS | 8574 | 20:15:30 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37746/tests/kraken/driver.html?testName=audio-dft) 20:15:30 INFO - PROCESS | 8574 | RSS: Main: 224931840 20:15:30 INFO - PROCESS | 8574 | 20:15:33 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37746/tests/kraken/driver.html?testName=audio-fft) 20:15:34 INFO - PROCESS | 8574 | RSS: Main: 302895104 20:15:34 INFO - PROCESS | 8574 | 20:15:36 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37746/tests/kraken/driver.html?testName=audio-oscillator) 20:15:37 INFO - PROCESS | 8574 | RSS: Main: 213200896 20:15:37 INFO - PROCESS | 8574 | 20:15:39 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:15:40 INFO - PROCESS | 8574 | RSS: Main: 215539712 20:15:40 INFO - PROCESS | 8574 | 20:15:43 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37746/tests/kraken/driver.html?testName=imaging-darkroom) 20:15:43 INFO - PROCESS | 8574 | RSS: Main: 254738432 20:15:43 INFO - PROCESS | 8574 | 20:15:47 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37746/tests/kraken/driver.html?testName=imaging-desaturate) 20:15:48 INFO - PROCESS | 8574 | RSS: Main: 249827328 20:15:48 INFO - PROCESS | 8574 | 20:15:50 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37746/tests/kraken/driver.html?testName=json-parse-financial) 20:15:51 INFO - PROCESS | 8574 | RSS: Main: 252825600 20:15:51 INFO - PROCESS | 8574 | 20:15:53 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:15:53 INFO - PROCESS | 8574 | RSS: Main: 216018944 20:15:53 INFO - PROCESS | 8574 | 20:15:55 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37746/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:15:56 INFO - PROCESS | 8574 | RSS: Main: 223150080 20:15:56 INFO - PROCESS | 8574 | 20:15:58 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:15:59 INFO - PROCESS | 8574 | RSS: Main: 221777920 20:15:59 INFO - PROCESS | 8574 | 20:16:02 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:16:02 INFO - PROCESS | 8574 | RSS: Main: 222314496 20:16:02 INFO - PROCESS | 8574 | 20:16:05 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:16:06 INFO - PROCESS | 8574 | RSS: Main: 220876800 20:16:06 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | Cycle 1(1): loaded http://localhost:37746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37746/tests/kraken/driver.html?testName=ai-astar) 20:16:08 INFO - PROCESS | 8574 | RSS: Main: 272637952 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | __start_tp_report 20:16:08 INFO - PROCESS | 8574 | _x_x_mozilla_page_load 20:16:08 INFO - PROCESS | 8574 | _x_x_mozilla_page_load_details 20:16:08 INFO - PROCESS | 8574 | |i|pagename|runs| 20:16:08 INFO - PROCESS | 8574 | |0;ai-astar;114;117;132;118;116;115;116;116;116;115 20:16:08 INFO - PROCESS | 8574 | |1;audio-beat-detection;149;122;151;195;122;149;144;127;181;129 20:16:08 INFO - PROCESS | 8574 | |2;audio-dft;162;163;162;163;163;163;162;164;162;162 20:16:08 INFO - PROCESS | 8574 | |3;audio-fft;77;76;77;172;77;76;77;76;171;77 20:16:08 INFO - PROCESS | 8574 | |4;audio-oscillator;85;84;141;84;83;83;146;83;84;152 20:16:08 INFO - PROCESS | 8574 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;118;117 20:16:08 INFO - PROCESS | 8574 | |6;imaging-darkroom;147;146;146;146;147;146;147;146;146;146 20:16:08 INFO - PROCESS | 8574 | |7;imaging-desaturate;95;95;95;96;94;95;95;95;95;95 20:16:08 INFO - PROCESS | 8574 | |8;json-parse-financial;63;64;63;63;63;78;67;67;69;69 20:16:08 INFO - PROCESS | 8574 | |9;json-stringify-tinderbox;65;65;66;66;66;66;67;66;66;66 20:16:08 INFO - PROCESS | 8574 | |10;stanford-crypto-aes;83;83;82;82;85;83;83;82;83;82 20:16:08 INFO - PROCESS | 8574 | |11;stanford-crypto-ccm;136;139;133;135;152;132;132;134;171;134 20:16:08 INFO - PROCESS | 8574 | |12;stanford-crypto-pbkdf2;175;182;174;176;175;175;175;175;174;173 20:16:08 INFO - PROCESS | 8574 | |13;stanford-crypto-sha256-iterative;73;69;69;68;69;69;68;67;69;68 20:16:08 INFO - PROCESS | 8574 | __end_tp_report 20:16:08 INFO - PROCESS | 8574 | __start_cc_report 20:16:08 INFO - PROCESS | 8574 | _x_x_mozilla_cycle_collect,2020 20:16:08 INFO - PROCESS | 8574 | __end_cc_report 20:16:08 INFO - PROCESS | 8574 | __startTimestamp1472181368487__endTimestamp 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | ------- Summary: start ------- 20:16:08 INFO - PROCESS | 8574 | Number of tests: 14 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#0] ai-astar Cycles:10 Average:117.50 Median:116.00 stddev:5.21 (4.5%) stddev-sans-first:5.37 20:16:08 INFO - PROCESS | 8574 | Values: 114.0 117.0 132.0 118.0 116.0 115.0 116.0 116.0 116.0 115.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:149.00 stddev:24.65 (16.5%) stddev-sans-first:26.13 20:16:08 INFO - PROCESS | 8574 | Values: 149.0 122.0 151.0 195.0 122.0 149.0 144.0 127.0 181.0 129.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 20:16:08 INFO - PROCESS | 8574 | Values: 162.0 163.0 162.0 163.0 163.0 163.0 162.0 164.0 162.0 162.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#3] audio-fft Cycles:10 Average:95.60 Median:77.00 stddev:40.01 (52.0%) stddev-sans-first:41.86 20:16:08 INFO - PROCESS | 8574 | Values: 77.0 76.0 77.0 172.0 77.0 76.0 77.0 76.0 171.0 77.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:83.50 stddev:30.37 (36.4%) stddev-sans-first:31.54 20:16:08 INFO - PROCESS | 8574 | Values: 85.0 84.0 141.0 84.0 83.0 83.0 146.0 83.0 84.0 152.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:16:08 INFO - PROCESS | 8574 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 20:16:08 INFO - PROCESS | 8574 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 20:16:08 INFO - PROCESS | 8574 | Values: 95.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:67.00 stddev:4.72 (7.0%) stddev-sans-first:4.82 20:16:08 INFO - PROCESS | 8574 | Values: 63.0 64.0 63.0 63.0 63.0 78.0 67.0 67.0 69.0 69.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 20:16:08 INFO - PROCESS | 8574 | Values: 65.0 65.0 66.0 66.0 66.0 66.0 67.0 66.0 66.0 66.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 20:16:08 INFO - PROCESS | 8574 | Values: 83.0 83.0 82.0 82.0 85.0 83.0 83.0 82.0 83.0 82.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:135.50 stddev:12.45 (9.2%) stddev-sans-first:13.13 20:16:08 INFO - PROCESS | 8574 | Values: 136.0 139.0 133.0 135.0 152.0 132.0 132.0 134.0 171.0 134.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:175.00 stddev:2.46 (1.4%) stddev-sans-first:2.60 20:16:08 INFO - PROCESS | 8574 | Values: 175.0 182.0 174.0 176.0 175.0 175.0 175.0 175.0 174.0 173.0 20:16:08 INFO - PROCESS | 8574 | 20:16:08 INFO - PROCESS | 8574 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.60 (2.3%) stddev-sans-first:0.73 20:16:08 INFO - PROCESS | 8574 | Values: 73.0 69.0 69.0 68.0 69.0 69.0 68.0 67.0 69.0 68.0 20:16:08 INFO - PROCESS | 8574 | -------- Summary: end -------- 20:16:08 INFO - PROCESS | 8574 | 20:16:09 INFO - TEST-INFO | 8574: exit 0 20:16:09 INFO - TEST-OK | kraken | took 65086ms 20:16:09 INFO - SUITE-END | took 1187s 20:16:10 INFO - Completed test suite (00:19:47) 20:16:10 INFO - javascript benchmark 20:16:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.6133579963002, 2606.0487921908507, 2610.7911367090646, 2622.7508386703266, 2628.8028397870166, 4622.191116554598, 4684.742339171345, 4727.361806156168, 4819.1325561398935, 4862.927056094157, 4787.329773831658, 4830.227163653816, 4834.492378300271, 4837.226043832988, 4880.5363490468435, 4319.827206911736, 4363.585459381369, 4433.512313645497, 4495.483019452756, 4530.3204519322035, 4450.688451808391, 4490.865274041784, 4493.168763778695, 4517.232070548015, 4536.705114167585, 4247.723897946624, 4287.314029755255, 4364.738115713068, 4428.4243048403505, 4428.623566996809, 4381.430414046185, 4383.298672212431, 4386.7367957922625, 4493.348464472633, 4495.527969563182, 4398.186335527937, 4407.933880991788, 4413.315936029889, 4416.977915110436, 4462.576055274743, 4662.696924699883, 4812.109759694433, 4824.348712923746, 4848.781804818756, 4868.878278043077, 5191.610629202825, 5207.817726379559, 5213.530782229617, 5218.817341393033, 5254.31693879797, 5213.4004589472315, 5234.42421333653, 5251.186066159751, 5257.553107985826, 5314.256004159421, 4610.723356598614, 4756.809727610926, 4775.73733444657, 4784.0, 4842.491538388454, 5249.2126181073145, 5279.208118782137, 5279.683219006872, 5282.392524859613, 5330.840074797685, 5026.673266237683, 5035.899282014412, 5038.0, 5040.294358789773, 5095.439501654815, 4945.258211268267, 5072.746362681851, 5119.718415487109, 5150.0, 5156.432792392834, 5135.4094279157625, 5135.87160320995, 5137.049645815536, 5137.33214682089, 5179.300794392709, 5113.258577506241, 5113.821016264487, 5114.795408183631, 5119.744012799345, 5179.300794392784, 4091.774952377648, 4125.443065186221, 4264.211120942636, 4285.357196420499, 4296.763677997677, 3744.213715119801, 3750.306193354238, 3783.2244389900006, 3807.276617442677, 3834.865779697753, 4443.888902777392, 4447.132809102194, 4449.2658711312915, 4454.37638730578, 4511.3458548510935, 4997.575206107522, 5060.5951523878, 5178.223266510054, 5204.583633309402, 5262.97368513155, 4469.821207151743, 4477.955220447754, 4489.663275254369, 4542.454905411372, 4543.136804007228, 4654.208784506642, 4658.976705116453, 4663.580277775017, 4666.002986560477, 4707.058588282289, 4634.536546345338, 4787.210110331756, 4844.854654360375, 4845.53967373099, 4851.490593487633, 5211.973940130275, 5247.58019358458, 5249.317588713443, 5317.548008419173, 5317.760700768397, 4803.831865884677, 4816.277558366273, 4831.057943700945, 4846.418429788307, 4898.632602554894, 4879.707217566957, 5105.566026887607, 5147.6654017488745, 5151.278820965143, 5159.613029022763, 5193.428722840409, 5259.368875734936, 5261.316028916216, 5301.469853014668, 5317.734113294242, 5065.442801291929, 5088.185890257541, 5101.311322971352, 5105.438401775876, 5124.590032797441, 4816.397950256218, 4935.605151587936, 5046.722430266371, 5046.9747651261505, 5051.974740126276, 4895.143349913822, 4980.775865086152, 4985.476524964826, 5013.047520971004, 5060.51925067118, 5060.443351231288, 5076.36545431821, 5091.465396133352, 5092.796288148433, 5154.716490593053, 4776.928346074881, 4851.902961940812, 4929.654924155275, 4958.082754690394, 4980.302757613865], "value": 4725.834268777222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.2273419516554, 574.8246784730655, 575.1286800497245, 581.8050952930768, 584.8888711144882, 27907.441851162963, 38257.0, 39196.412053819215, 39237.60762392375, 43548.564514354846, 41046.7947660262, 41456.17087658245, 41508.56617224328, 41578.376324355086, 41603.16793664125, 7131.643417829114, 7689.423293253, 7830.725924592641, 7843.686252549891, 7846.176151504067, 7080.0, 7280.162781280168, 7285.417166626684, 10050.54772535234, 10362.430066346347, 10213.387196768217, 10265.589376424934, 10280.074793268604, 10284.074433301, 10291.404832250975, 10109.54507047181, 10160.390376577356, 10172.89827101727, 10174.949125254401, 10190.796184076351, 9840.803183936281, 9906.108450239513, 9907.752306192331, 9910.20718342531, 9922.206223502175, 37003.4449483258, 37158.81420592907, 37350.81324593387, 37357.62642373569, 37417.625823741684, 3063.5098384258636, 3095.5356696495483, 3375.1899544109483, 3665.0, 3776.9433458498142, 29372.853135734185, 29435.0, 29509.852450737824, 29580.520973951432, 30878.691213087804, 3155.794873333226, 3229.3541291741744, 3241.416545021895, 3255.2675647979254, 3289.6381398046196, 256533.99999999814, 257515.0, 257584.0, 257937.0, 258022.0, 53214.0, 53473.0, 53691.0, 53696.731516342166, 53769.1934620981, 32137.67862321347, 32804.67195328064, 32932.0, 34305.48541771875, 34387.4841877372, 15059.247037648074, 15221.923890380478, 15226.162561059247, 15229.771553426708, 15237.0, 11449.656510304705, 11555.653330399933, 11578.47896844644, 11579.942100289445, 11592.130590205768, 15571.610709732347, 17284.395046173577, 17844.375446859296, 17977.280908763765, 18449.446516604523, 6733.562318449285, 6768.69540870662, 6795.626240556817, 6806.931930680729, 7018.964905175543, 781.4061313401855, 827.8385714785559, 878.3193025405362, 884.9469031858109, 886.8093359927647, 27439.314017149733, 27458.17625471239, 27758.306042349104, 28139.859300703774, 28215.0, 957.7940742740344, 994.5126887824914, 997.5610731278215, 1005.6982905128579, 1048.5176818663347, 14637.194954277616, 14929.626759330886, 14932.701345973237, 15052.924735376471, 15304.234788260543, 372013.0, 373372.0, 374440.0, 374487.0, 375930.0, 49419.50580494221, 49929.251061234114, 49953.75023124861, 49963.25055124176, 49994.25008624801, 1072.367303291062, 1117.5082963496197, 1168.1355796710204, 1183.4556104191995, 1194.3729541990351, 25656.74343256618, 28695.426091477635, 29009.274768130123, 29345.266368340963, 29382.70617293885, 41558.376624351265, 42141.36787948122, 42172.789136054125, 42192.578074220095, 42220.577794222896, 278761.0, 279703.0, 279994.0, 280157.0, 280773.0, 24900.252992410256, 25109.874450628362, 25878.482430351665, 25892.870535647955, 26824.731752683005, 40573.39139912845, 40822.79588602038, 40954.385684215355, 41135.38296925608, 42279.57720422879, 35453.82273088618, 35717.82141089278, 35735.0, 35745.28509429849, 35762.463563046054, 34616.13459663428, 34807.0, 34890.0, 35584.28831423409, 35602.643973559934, 35020.64979350276, 35579.466308004885, 35812.0, 35843.64156358403, 36238.8188059058, 30249.0, 32870.67129328676, 33062.17344566309, 33126.834365828014, 33171.66828331686, 24309.878450607634, 24979.500409992062, 24989.250322490356, 25222.054799952184, 25432.364190895376], "value": 17598.033101677698, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.9826017597646, 343.82808595702164, 356.2892030399353, 362.4508869063369, 378.57788565749183, 16544.751828722565, 17561.912190439063, 17757.733633995485, 18577.90711046446, 18928.5267868303, 16608.0, 17591.73612395815, 18326.08369581519, 18468.815311846913, 18897.716534252, 5513.61404701671, 5822.1266809978415, 5828.47543721065, 5832.650040997532, 5833.941660583382, 5494.697791621459, 5611.971940140294, 5649.830505084854, 5699.2306038684865, 5702.429757024306, 5689.374168841424, 5700.173474846145, 5705.600607957424, 5706.486416222539, 5706.773043795583, 5696.202531645552, 5696.344920334173, 6499.610023398611, 6827.52207345486, 6871.518993670445, 6453.386928241809, 6697.330266973312, 6715.6977935993, 6740.045386837811, 6740.629265390402, 22631.32106036805, 23202.3039308821, 23432.0, 23562.29313120592, 23865.522689546284, 1902.838258748008, 1949.7172909928122, 1988.5823976964855, 1999.6500612392774, 2032.9186832526682, 13806.792898106536, 14315.713685726227, 14503.709925801424, 14709.705805883823, 15040.924795376062, 1808.8604179366914, 1839.1172237326025, 1859.2098358197711, 1883.802200768927, 1948.9415317540354, 81664.59167704183, 81886.0, 82064.17935820625, 83706.0, 84424.0, 16035.19824008795, 16157.980252468442, 16194.595135121715, 16228.918855405884, 16895.0, 28685.28286792847, 28731.712682873324, 28805.711942880724, 28808.279793005342, 28835.0, 8907.55462226886, 9172.35793494449, 9321.60017490423, 9432.19826314771, 9595.90404095964, 7100.751473698396, 7171.713131474787, 7350.963245183847, 7369.1525474570035, 7609.885851712229, 7819.0, 8033.799155021171, 8133.918660813434, 8172.550509721904, 8179.918200818035, 2986.7759918006236, 3092.3196896682693, 3189.7448204144075, 3220.951685724716, 3228.257500774835, 759.3242014607005, 795.9363250939911, 833.3624777045565, 908.7364664247426, 921.3504479342048, 16189.676206475804, 16560.66878662444, 16770.66458670844, 17343.39298124585, 17549.385771497935, 838.0623284032575, 840.3025488844245, 863.6761214544546, 889.8021885941714, 902.1609902790336, 8246.752597422086, 8821.60302786376, 9397.342186047048, 9631.470269135265, 9952.651657191964, 272579.0, 277202.0, 277448.0, 382407.0, 382810.0, 83818.0, 83823.58088209642, 86811.56594216988, 88149.0, 88166.0, 881.7310720230263, 905.791667916383, 943.1323182671821, 949.3117489819825, 950.0404591362774, 15570.9221453892, 15776.0, 16173.0, 16343.427980020642, 16614.169291535618, 32000.51999219967, 36257.63742362543, 39607.0, 39649.0, 41071.17857642771, 53307.470804671066, 53602.0, 53808.46191538191, 54772.701139369485, 55882.0, 7551.358134558624, 7646.350060244719, 7675.04061992251, 7815.29662330393, 7839.529628222325, 6272.372762723691, 9136.543172841464, 10630.0, 11733.530658773894, 11741.882581174079, 10281.0, 10423.895761042293, 10459.0, 10651.414172220293, 10941.671749847517, 9696.612135514782, 10293.073623373932, 10447.111995480165, 10649.787004260026, 10664.57341706354, 10056.34633748804, 10191.54138063774, 10224.897751022394, 10235.437050962268, 10449.738756531147, 7352.558846469229, 7556.8866467001935, 7766.417518686008, 7777.183395743592, 7787.727429539939, 9394.530273486162, 9599.904000959901, 9704.660336888175, 9718.805623887623, 9967.40195588267], "value": 9175.084028354147, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.466921888979, 1338.263954824846, 1387.2855479428092, 1453.9563813085604, 1688.8648908087346, 7245.4928155029165, 7651.120121186065, 7678.27056429639, 7798.376129909608, 7813.101493328269, 7710.768676939687, 7826.178251283604, 7828.334591559725, 7831.451798374116, 7831.765047048583, 2196.670499425083, 2222.8555143915673, 2226.2319499772634, 2227.1536816009893, 2227.2984010036866, 2160.8379371547117, 2217.756046834847, 2234.2850287907877, 2237.127520267097, 2239.585676649817, 2169.4142581502983, 2169.4901698100934, 2202.0090959068402, 2202.48241663209, 2204.790544898232, 2139.967900481494, 2141.817945474621, 2155.084089262073, 2158.0720290275176, 2159.8920053997235, 2080.5318803269297, 2113.144176608476, 2119.98940005299, 2123.755768086659, 2126.393977716343, 7496.212897645723, 7701.653425595861, 7711.228877112244, 7765.029371328584, 7790.649420776022, 4224.683148763855, 4377.058932329564, 4381.561843815625, 4383.276759334706, 4386.429764130643, 2798.790090743202, 2913.7231962963483, 2988.8655010524362, 2989.4320079184886, 2995.281132528199, 984.194004002656, 988.6885631026204, 999.0259496990449, 1009.581023875091, 1009.8535712321673, 10709.25035247533, 10745.14038876888, 10822.72943176419, 10830.350178989207, 10852.240343175901, 3874.535055793323, 3930.6462418382484, 4020.3567429211184, 4038.838446462167, 4058.411530328086, 8382.371322150862, 8398.83202335962, 8400.41197116196, 8404.159584041547, 8404.663813447516, 4248.426462427595, 4250.128723611652, 4252.213340532012, 4252.4046633471335, 4256.9574304257185, 3495.0, 3859.4403811447746, 3923.2153569286256, 3930.7248492605245, 4038.131801662598, 3364.0748794081824, 3387.305602351512, 3482.721382289411, 3485.6165821759587, 3552.5559305086863, 1015.7257540464034, 1025.7281820317621, 1026.4046852825343, 1042.890496497872, 1043.446973104256, 792.4056957282038, 799.3325573146371, 799.8440304140753, 811.809224832164, 854.4744981836126, 4850.781714822841, 5122.129238029544, 5170.663906846043, 5257.237700533401, 5318.22885681574, 852.3181454836106, 882.2941646682629, 890.0832142892831, 890.8552510024717, 910.2717825739383, 3413.8975830725117, 3590.676839084495, 3638.7634803737674, 3657.2868290683596, 3775.528058992626, 9279.476527004012, 9824.754381140528, 9890.406575605486, 9891.159251463707, 9939.850902236472, 9678.27412944032, 9756.414615123116, 9762.463064531377, 9780.0, 9781.90218097824, 7183.0, 7398.0, 7484.5883476408235, 7498.700051997968, 7502.324790768857, 5057.671251368649, 5117.8464646060675, 5148.431805246282, 5173.948260517347, 5197.194434862602, 8895.555222238992, 8980.0, 8992.100789920956, 8992.955035225044, 9027.0, 8841.867371989554, 8965.327600430124, 9010.414323068979, 9065.592048357708, 9123.361364704408, 6039.094135879654, 6540.8364790880605, 6647.933520664925, 6679.833004174934, 6700.66496675174, 7350.70597176107, 7645.159032506531, 7686.6541005656, 7698.884516732365, 7700.306972372289, 6759.662016899234, 6836.145481814773, 6864.0, 6920.30796920304, 7128.607926564089, 6754.459643228432, 6802.0, 6807.319268073153, 6839.350261725128, 6952.30476952321, 6490.578112422678, 6514.055461958084, 6533.542652014314, 6556.8360790978695, 6559.180102487189, 4480.977595112004, 4500.302453119772, 4566.88582785433, 4628.583427491407, 4670.579647831712, 4513.7066090704, 4561.749103799323, 4611.631069514364, 4673.602743766818, 4855.732934688484], "value": 4094.15833225294, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.12784473219904, 287.44953414211784, 289.81451870802675, 291.52772508536174, 298.6580365481524, 4586.495485496593, 4760.8097975506125, 4766.68916048087, 4833.782479788413, 4868.6348523860715, 4573.977130114353, 4702.200625893598, 4721.268203428474, 4729.533844508205, 4743.952560474403, 3776.8866933992026, 3777.357849165635, 3778.2821263959895, 3782.470454136423, 3782.8865134046023, 3562.7684200526883, 3675.4854320395166, 3766.7928263945473, 3781.90324805806, 3792.924141517168, 3422.931541369171, 3661.4141737322034, 3665.157013886808, 3669.7614655047337, 3685.7100014994808, 3672.2839046385966, 3673.81630918453, 3680.245549662326, 3686.9078273043256, 3691.8523259069607, 3248.96751032489, 3255.788373755722, 3264.314493956272, 3266.70599646033, 3267.5425440438357, 4502.279635258343, 4577.198990176706, 4598.735347779354, 4618.722876627379, 4666.416697912761, 4221.894452638709, 4227.260229459832, 4231.957680423187, 4240.618344349024, 4242.681798865097, 4949.430815456232, 4953.306537084811, 4953.925691114636, 4959.090750061217, 4963.57809586182, 3431.6225215226304, 3571.499990001402, 3585.910352241189, 3596.7482276240676, 3600.08197909534, 5118.795248190068, 5168.22476628505, 5176.567013503647, 5180.300659410969, 5184.792608295701, 3586.2110335726097, 3606.5672119345845, 3607.549056367954, 3610.151614370621, 3615.7830530168276, 3659.688926441229, 3670.559532856021, 3676.904164626191, 3685.2261025184475, 3696.0, 4011.3782363733667, 4156.189543039139, 4178.749275043507, 4182.435371224907, 4213.810378532973, 4896.436909755353, 4896.755162241945, 4897.265410188429, 4931.545194167729, 4947.208446648519, 1220.8534975802784, 1253.9623811285676, 1283.5635883799553, 1296.1574976265504, 1301.1802564384377, 881.0836729800935, 897.237348253992, 900.2977677411629, 903.8056817784208, 904.1365495951351, 4333.176696427731, 4345.261305578059, 4353.73877567347, 4363.258246098171, 4370.38814565961, 5051.494850514992, 5055.620828437882, 5058.190689489664, 5139.45816255122, 5143.819966301162, 4202.474690663667, 4404.2512772828695, 4415.823367065282, 4466.821327146943, 4481.7535035573355, 2722.68689100752, 2746.2722378569697, 2753.3529620539157, 2755.2836262571877, 2758.0831322230856, 4827.624127123823, 4828.7102773833685, 4834.444038935568, 4839.3141806297135, 4854.441739199967, 5145.536901678867, 5229.189475631283, 5265.289185959923, 5274.551663108602, 5312.096943519611, 4763.142634325785, 4773.236282194832, 4799.880002999953, 4803.423589169252, 4816.470188279286, 5010.223415370623, 5134.409542902465, 5154.0, 5154.716490593053, 5164.7934082636275, 4984.925226121539, 5014.122528557561, 5036.647434679538, 5059.519345662156, 5059.822906198266, 4804.0, 4805.303231031551, 4809.302651115639, 4814.638902082428, 4822.324874517641, 3531.2407832316176, 3562.982185089058, 3580.928381432409, 3599.1362073101745, 3605.675489205984, 4893.388326459192, 5115.0, 5184.637075404837, 5194.961007798531, 5206.297149884868, 4976.925346119883, 5001.774565231542, 5012.398512178562, 5034.421041580119, 5038.647294689336, 4984.526469985346, 4992.625553083606, 4999.800007999785, 5013.799448022184, 5026.371703537058, 4674.74288914113, 4754.5245475452175, 4791.448983366958, 4909.361782968192, 4948.010397920359, 4990.675606085593, 4995.750212489434, 5008.949910500848, 5016.968127908203, 5025.572826309658, 4922.704637721748, 4935.975320123376, 4939.580135688507, 4940.407151141886, 4968.527989840959], "value": 3752.929974659831, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.2194062273716, 645.5868244323632, 669.2638098092096, 677.6510097299888, 730.4485113739127, 13769.242691651954, 14395.496157634485, 14409.567712968614, 14935.775963360531, 14978.475753348635, 14008.719825603483, 14099.295035248222, 14152.150870947724, 14170.71658566828, 14269.072510286824, 733.915599706034, 754.2758951406629, 762.8398036412333, 763.335897768939, 765.9885101723479, 767.8771396576549, 768.323874990008, 769.6575024114271, 769.8498792735419, 770.098984188498, 808.3250485844297, 809.5587904591982, 809.8785182222655, 810.4448452809844, 812.6261919517029, 795.932345750612, 805.118395357083, 810.631162820915, 810.805406702393, 811.0672726364699, 587.8765459253561, 588.2969851028023, 588.5144755576623, 588.6468119128532, 592.037938350181, 13689.794653080211, 13693.863061369359, 13714.382852771549, 13742.93128534361, 13766.724665506734, 12682.175658582162, 12926.707329267092, 12979.156354836905, 13605.387757550934, 13848.684374984361, 10517.894821051768, 10629.72443306808, 10686.946565267124, 10722.839157412645, 10814.945925270402, 3266.4120458317493, 3270.9509357359657, 3285.2772390074147, 3305.4545999909988, 3358.966410335914, 66758.66620666865, 67784.0, 68102.65948670275, 69029.0, 70318.29681703169, 9167.12912273333, 9320.114589114024, 9870.21038316933, 10135.34120282194, 10269.74325641865, 17422.912885435493, 17431.912840435718, 17445.040522771116, 17455.0, 17474.563135921704, 6866.519343645897, 6884.793456196322, 6898.620575868275, 7051.612161331073, 7290.526115802456, 3762.3792074307435, 3796.1888733425526, 3801.258754542838, 3817.1220619257724, 3915.7846318452757, 3068.202267410489, 3138.497840345534, 3159.5418664293547, 3169.793963392372, 3183.904482865518, 510.43086958041516, 513.6609837507227, 516.2746341390277, 526.3473293116508, 534.6364472158891, 463.2821606607006, 512.6155383462403, 562.1623780567007, 570.6062816656577, 606.8755905039457, 7720.652570634335, 8156.388270879707, 8345.791355216168, 8366.330693544502, 8661.263792577702, 481.40546425164894, 485.36174929967683, 532.3771187710388, 585.733491261475, 625.6746491824317, 3672.7429079964145, 3812.447195156742, 4050.918981620351, 4393.626541743924, 4447.0, 88134.55932720295, 94850.0, 102745.0, 106109.0, 106263.0, 81368.18631813607, 85799.0, 86853.13146868577, 86964.13035869687, 87902.56048719716, 77537.0, 77577.61211193907, 77661.61169194117, 78703.0, 78882.0, 8609.69866054685, 9043.0, 9114.954425228098, 9127.817443651222, 9143.3599648024, 45323.09353812839, 45936.31095533637, 47329.29006064981, 47664.761676191396, 47919.76040119777, 61334.38665613465, 66178.33821661722, 66837.0, 68163.70807692452, 72876.27123728907, 11397.202195846212, 11443.599474018369, 11760.58837940668, 11766.0, 12116.0, 13527.526536571173, 13797.24115173675, 13953.162810231419, 14376.137431754129, 14644.414223430944, 12006.75986480248, 12051.0, 12587.874121259036, 13071.542496012975, 13215.074944753775, 11890.227135236182, 12094.334811585095, 12338.259704417764, 12344.876551234373, 12364.381780911099, 11690.88309116898, 11950.0, 12474.875251247371, 12571.1200215984, 12595.559155429515, 10141.949290253502, 10179.745506362104, 10473.371597704163, 10545.087083160215, 10643.733906652085, 9969.800603987735, 10937.343759374464, 11060.281081729661, 11088.833667495155, 11176.88823111791], "value": 6734.923015746504, "unit": "score"}], "name": "dromaeo_css", "value": 6550.062722151303, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 132.0, 118.0, 116.0, 115.0, 116.0, 116.0, 116.0, 115.0], "value": 117.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 151.0, 195.0, 122.0, 149.0, 144.0, 127.0, 181.0, 129.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 163.0, 163.0, 162.0, 164.0, 162.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 172.0, 77.0, 76.0, 77.0, 76.0, 171.0, 77.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 141.0, 84.0, 83.0, 83.0, 146.0, 83.0, 84.0, 152.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 78.0, 67.0, 67.0, 69.0, 69.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 82.0, 85.0, 83.0, 83.0, 82.0, 83.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 139.0, 133.0, 135.0, 152.0, 132.0, 132.0, 134.0, 171.0, 134.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 182.0, 174.0, 176.0, 175.0, 175.0, 175.0, 175.0, 174.0, 173.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 67.0, 69.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1583.0000000000002, "alertThreshold": 2.0}]} 20:16:10 INFO - Return code: 0 20:16:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:16:10 INFO - # TBPL SUCCESS # 20:16:10 INFO - Running post-action listener: _resource_record_post_action 20:16:10 INFO - [mozharness: 2016-08-26 03:16:10.274819Z] Finished run-tests step (success) 20:16:10 INFO - Running post-run listener: _resource_record_post_run 20:16:10 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406114304; Read time: 12; Write time: 518036 20:16:10 INFO - TinderboxPrint: CPU usage
13.0% 20:16:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:16:10 INFO - TinderboxPrint: I/O write bytes / time
406,114,304 / 518,036 20:16:10 INFO - TinderboxPrint: CPU idle
8,353.3 (86.9%) 20:16:10 INFO - TinderboxPrint: CPU user
1,200.2 (12.5%) 20:16:10 INFO - TinderboxPrint: Swap in / out
0 / 0 20:16:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114417664; Read time: 0; Write time: 190824 20:16:10 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291696640; Read time: 0; Write time: 327212 20:16:10 INFO - Running post-run listener: _upload_blobber_files 20:16:10 INFO - Blob upload gear active. 20:16:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:16:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:16:10 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'] 20:16:10 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 20:16:11 INFO - (blobuploader) - INFO - Open directory for files ... 20:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:16:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:14 INFO - (blobuploader) - INFO - Done attempting. 20:16:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:16:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:16 INFO - (blobuploader) - INFO - Done attempting. 20:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:16 INFO - (blobuploader) - INFO - Done attempting. 20:16:16 INFO - (blobuploader) - INFO - Iteration through files over. 20:16:16 INFO - Return code: 0 20:16:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:16:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:16:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92e1f0530d26b2b637c4a4c84e0dd18ea9a35d2e0fb6853b5d934b6f2f5e63b882024ebfd2edc5c977700a1d9aeb82194a891fdd056025f0808db1f916faed74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/265fc60c9690744712ac237b6b81e62f53a05f347651362a18ebf7183ba6c7220558123f6adfcfdc46824d8ecc4d8501651680bc5f48e85822ee9ccef68f547d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9e6c183deef663e20b761346ed42b774457ffdc9d099226b0161b3b0f6df9e0c08f377a27556b1c99b5fe61902244cb69982dae14dca88f76075965e12e6daa"} 20:16:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:16:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:16:16 INFO - Contents: 20:16:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92e1f0530d26b2b637c4a4c84e0dd18ea9a35d2e0fb6853b5d934b6f2f5e63b882024ebfd2edc5c977700a1d9aeb82194a891fdd056025f0808db1f916faed74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/265fc60c9690744712ac237b6b81e62f53a05f347651362a18ebf7183ba6c7220558123f6adfcfdc46824d8ecc4d8501651680bc5f48e85822ee9ccef68f547d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9e6c183deef663e20b761346ed42b774457ffdc9d099226b0161b3b0f6df9e0c08f377a27556b1c99b5fe61902244cb69982dae14dca88f76075965e12e6daa"} 20:16:16 INFO - Running post-run listener: copy_logs_to_upload_dir 20:16:16 INFO - Copying logs to upload dir... 20:16:16 INFO - mkdir: /builds/slave/test/build/upload/logs 20:16:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.304621 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-25 20:16:16.490488) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 20:16:16.494460) ========= 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=745a4373a2a16df560f216e000000264-1472180126.900867-1842961609 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/92e1f0530d26b2b637c4a4c84e0dd18ea9a35d2e0fb6853b5d934b6f2f5e63b882024ebfd2edc5c977700a1d9aeb82194a891fdd056025f0808db1f916faed74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/265fc60c9690744712ac237b6b81e62f53a05f347651362a18ebf7183ba6c7220558123f6adfcfdc46824d8ecc4d8501651680bc5f48e85822ee9ccef68f547d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9e6c183deef663e20b761346ed42b774457ffdc9d099226b0161b3b0f6df9e0c08f377a27556b1c99b5fe61902244cb69982dae14dca88f76075965e12e6daa"} build_url:https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011518 build_url: 'https://queue.taskcluster.net/v1/task/Nhf4zaO0Sv-rii4MwN6_-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92e1f0530d26b2b637c4a4c84e0dd18ea9a35d2e0fb6853b5d934b6f2f5e63b882024ebfd2edc5c977700a1d9aeb82194a891fdd056025f0808db1f916faed74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/265fc60c9690744712ac237b6b81e62f53a05f347651362a18ebf7183ba6c7220558123f6adfcfdc46824d8ecc4d8501651680bc5f48e85822ee9ccef68f547d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9e6c183deef663e20b761346ed42b774457ffdc9d099226b0161b3b0f6df9e0c08f377a27556b1c99b5fe61902244cb69982dae14dca88f76075965e12e6daa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 20:16:16.519274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 20:16:16.519591) ========= 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=745a4373a2a16df560f216e000000264-1472180126.900867-1842961609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 20:16:16.604867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 20:16:16.605195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 20:16:16.605482) ========= ========= Total master_lag: 0.16 =========