builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0122 starttime: 1468502051.11 results: success (0) buildid: 20160714030744 builduid: 85678dd052cf465a9c6840c2d40bb34f revision: 49ef0b8c3cfa522e35ef2fb937da43cecba6b99c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:11.113111) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:11.113637) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:11.113944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:11.138236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:11.138659) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4t3odWYY3V/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-14 06:14:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 207M=0s 2016-07-14 06:14:11 (207 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.370928 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:11.531579) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:11.531912) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4t3odWYY3V/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.021139 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:11.581147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:14:11.581510) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 49ef0b8c3cfa522e35ef2fb937da43cecba6b99c --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 49ef0b8c3cfa522e35ef2fb937da43cecba6b99c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4t3odWYY3V/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-14 06:14:11,656 truncating revision to first 12 chars 2016-07-14 06:14:11,656 Setting DEBUG logging. 2016-07-14 06:14:11,656 attempt 1/10 2016-07-14 06:14:11,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/49ef0b8c3cfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 06:14:12,704 unpacking tar archive at: fx-team-49ef0b8c3cfa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322679 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:14:12.926588) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:12.926909) ========= script_repo_revision: 49ef0b8c3cfa522e35ef2fb937da43cecba6b99c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:12.927322) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:12.927605) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:14:12.946679) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-14 06:14:12.947057) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4t3odWYY3V/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:14:13 INFO - MultiFileLogger online at 20160714 06:14:13 in /builds/slave/test 06:14:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:14:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:13 INFO - {'append_to_log': False, 06:14:13 INFO - 'base_work_dir': '/builds/slave/test', 06:14:13 INFO - 'blob_upload_branch': 'Fx-Team', 06:14:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:13 INFO - 'branch': 'Fx-Team', 06:14:13 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:13 INFO - 'config_files': ('talos/mac_config.py',), 06:14:13 INFO - 'default_actions': ('clobber', 06:14:13 INFO - 'read-buildbot-config', 06:14:13 INFO - 'download-and-extract', 06:14:13 INFO - 'populate-webroot', 06:14:13 INFO - 'create-virtualenv', 06:14:13 INFO - 'install', 06:14:13 INFO - 'run-tests'), 06:14:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:13 INFO - 'download_minidump_stackwalk': True, 06:14:13 INFO - 'download_symbols': 'ondemand', 06:14:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:14:13 INFO - 'tooltool.py': '/tools/tooltool.py', 06:14:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:14:13 INFO - '/tools/misc-python/virtualenv.py')}, 06:14:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:13 INFO - 'installer_path': 'installer.exe', 06:14:13 INFO - 'log_level': 'info', 06:14:13 INFO - 'log_name': 'talos', 06:14:13 INFO - 'log_to_console': True, 06:14:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:14:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:14:13 INFO - 'opt_config_files': (), 06:14:13 INFO - 'pip_index': False, 06:14:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:14:13 INFO - 'cmd': ('bash', 06:14:13 INFO - '-c', 06:14:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:14:13 INFO - 'enabled': True, 06:14:13 INFO - 'halt_on_failure': False, 06:14:13 INFO - 'name': 'check_screen_resolution'},), 06:14:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:14:13 INFO - 'cmd': ('bash', 06:14:13 INFO - '-c', 06:14:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:14:13 INFO - 'enabled': True, 06:14:13 INFO - 'halt_on_failure': False, 06:14:13 INFO - 'name': 'check_screen_resolution'},), 06:14:13 INFO - 'run_cmd_checks_enabled': True, 06:14:13 INFO - 'sps_profile': False, 06:14:13 INFO - 'sps_profile_interval': 0, 06:14:13 INFO - 'suite': 'dromaeojs-e10s', 06:14:13 INFO - 'system_bits': '32', 06:14:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:13 INFO - 'title': 't-yosemite-r7-0122', 06:14:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:13 INFO - 'use_talos_json': True, 06:14:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:13 INFO - 'work_dir': 'build'} 06:14:13 INFO - ##### 06:14:13 INFO - ##### Running clobber step. 06:14:13 INFO - ##### 06:14:13 INFO - Running pre-action listener: _resource_record_pre_action 06:14:13 INFO - Running main action method: clobber 06:14:13 INFO - rmtree: /builds/slave/test/build 06:14:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:15 INFO - Running post-action listener: _resource_record_post_action 06:14:15 INFO - ##### 06:14:15 INFO - ##### Finished clobber step (success) 06:14:15 INFO - ##### 06:14:15 INFO - ##### 06:14:15 INFO - ##### Running read-buildbot-config step. 06:14:15 INFO - ##### 06:14:15 INFO - Running pre-action listener: _resource_record_pre_action 06:14:15 INFO - Running main action method: read_buildbot_config 06:14:15 INFO - Using buildbot properties: 06:14:15 INFO - { 06:14:15 INFO - "project": "", 06:14:15 INFO - "product": "firefox", 06:14:15 INFO - "script_repo_revision": "production", 06:14:15 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:14:15 INFO - "repository": "", 06:14:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:14:15 INFO - "buildid": "20160714030744", 06:14:15 INFO - "pgo_build": "False", 06:14:15 INFO - "basedir": "/builds/slave/test", 06:14:15 INFO - "buildnumber": 43, 06:14:15 INFO - "slavename": "t-yosemite-r7-0122", 06:14:15 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:14:15 INFO - "platform": "yosemite_r7", 06:14:15 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:14:15 INFO - "branch": "fx-team", 06:14:15 INFO - "repo_path": "integration/fx-team", 06:14:15 INFO - "revision": "49ef0b8c3cfa522e35ef2fb937da43cecba6b99c", 06:14:15 INFO - "stage_platform": "macosx64", 06:14:15 INFO - "builduid": "85678dd052cf465a9c6840c2d40bb34f", 06:14:15 INFO - "slavebuilddir": "test" 06:14:15 INFO - } 06:14:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 06:14:15 INFO - Running post-action listener: _resource_record_post_action 06:14:15 INFO - ##### 06:14:15 INFO - ##### Finished read-buildbot-config step (success) 06:14:15 INFO - ##### 06:14:15 INFO - ##### 06:14:15 INFO - ##### Running download-and-extract step. 06:14:15 INFO - ##### 06:14:15 INFO - Running pre-action listener: _resource_record_pre_action 06:14:15 INFO - Running main action method: download_and_extract 06:14:15 INFO - mkdir: /builds/slave/test/build/tests 06:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:15 INFO - https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:14:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:14:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:14:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 06:14:15 INFO - Downloaded 1199 bytes. 06:14:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:14:15 INFO - Using the following test package requirements: 06:14:15 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:14:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:14:15 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 06:14:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:14:15 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 06:14:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:14:15 INFO - u'jsshell-mac.zip'], 06:14:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:14:15 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 06:14:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:14:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:14:15 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 06:14:15 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:14:15 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 06:14:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:14:15 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 06:14:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:14:15 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 06:14:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:15 INFO - https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:14:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:14:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:14:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:14:16 INFO - Downloaded 18827241 bytes. 06:14:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:14:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:14:20 INFO - Return code: 0 06:14:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:20 INFO - https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:14:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:14:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:14:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:14:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:14:21 INFO - Downloaded 18827241 bytes. 06:14:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:14:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:14:25 INFO - Return code: 0 06:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:25 INFO - https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:14:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:14:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:14:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:14:26 INFO - Downloaded 14403317 bytes. 06:14:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:14:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:14:26 INFO - Return code: 0 06:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:26 INFO - https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:14:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:14:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:14:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 06:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 06:14:29 INFO - Downloaded 112760759 bytes. 06:14:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:14:29 INFO - mkdir: /builds/slave/test/properties 06:14:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:14:29 INFO - Writing to file /builds/slave/test/properties/build_url 06:14:29 INFO - Contents: 06:14:29 INFO - build_url:https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:14:31 INFO - Running post-action listener: _resource_record_post_action 06:14:31 INFO - Running post-action listener: set_extra_try_arguments 06:14:31 INFO - ##### 06:14:31 INFO - ##### Finished download-and-extract step (success) 06:14:31 INFO - ##### 06:14:31 INFO - ##### 06:14:31 INFO - ##### Running populate-webroot step. 06:14:31 INFO - ##### 06:14:31 INFO - Running pre-action listener: _resource_record_pre_action 06:14:31 INFO - Running main action method: populate_webroot 06:14:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:14:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:14:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:14:31 INFO - '--tppagecycles', 06:14:31 INFO - '7'], 06:14:31 INFO - 'tests': ['tsvgm']}}, 06:14:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:14:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:14:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:14:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:14:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:14:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:14:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:31 INFO - 'talos_options': ['--disable-e10s'], 06:14:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:31 INFO - 'talos_options': ['--disable-e10s'], 06:14:31 INFO - 'tests': ['damp', 'tps']}, 06:14:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:31 INFO - 'tests': ['damp', 'tps']}, 06:14:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:14:31 INFO - 'tests': ['dromaeo_dom']}, 06:14:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:14:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:14:31 INFO - 'tests': ['basic_compositor_video']}, 06:14:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:14:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:14:31 INFO - 'tests': ['a11yr', 06:14:31 INFO - 'ts_paint', 06:14:31 INFO - 'tpaint', 06:14:31 INFO - 'sessionrestore', 06:14:31 INFO - 'sessionrestore_no_auto_restore', 06:14:31 INFO - 'tabpaint']}, 06:14:31 INFO - 'other-e10s': {'tests': ['a11yr', 06:14:31 INFO - 'ts_paint', 06:14:31 INFO - 'tpaint', 06:14:31 INFO - 'sessionrestore', 06:14:31 INFO - 'sessionrestore_no_auto_restore', 06:14:31 INFO - 'tabpaint']}, 06:14:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:14:31 INFO - 'ts_paint', 06:14:31 INFO - 'tpaint', 06:14:31 INFO - 'sessionrestore', 06:14:31 INFO - 'sessionrestore_no_auto_restore', 06:14:31 INFO - 'tabpaint']}, 06:14:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:14:31 INFO - 'ts_paint', 06:14:31 INFO - 'tpaint', 06:14:31 INFO - 'sessionrestore', 06:14:31 INFO - 'sessionrestore_no_auto_restore', 06:14:31 INFO - 'tabpaint']}, 06:14:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:14:31 INFO - 'tests': ['a11yr', 06:14:31 INFO - 'ts_paint', 06:14:31 INFO - 'tpaint', 06:14:31 INFO - 'sessionrestore', 06:14:31 INFO - 'sessionrestore_no_auto_restore', 06:14:31 INFO - 'tabpaint']}, 06:14:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:14:31 INFO - 'tests': ['a11yr', 06:14:31 INFO - 'ts_paint', 06:14:31 INFO - 'tpaint', 06:14:31 INFO - 'sessionrestore', 06:14:31 INFO - 'sessionrestore_no_auto_restore', 06:14:31 INFO - 'tabpaint']}, 06:14:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:14:31 INFO - 'tests': ['tsvgx', 06:14:31 INFO - 'tsvgr_opacity', 06:14:31 INFO - 'tart', 06:14:31 INFO - 'tscrollx', 06:14:31 INFO - 'cart']}, 06:14:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:14:31 INFO - 'tsvgr_opacity', 06:14:31 INFO - 'tart', 06:14:31 INFO - 'tscrollx', 06:14:31 INFO - 'cart']}, 06:14:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:31 INFO - 'talos_options': ['--disable-e10s'], 06:14:31 INFO - 'tests': ['tp5o']}, 06:14:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:31 INFO - 'tests': ['tp5o']}, 06:14:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:31 INFO - 'talos_options': ['--disable-e10s', 06:14:31 INFO - '--xperf_path', 06:14:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:31 INFO - 'tests': ['tp5n']}, 06:14:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:31 INFO - 'talos_options': ['--xperf_path', 06:14:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:31 INFO - 'tests': ['tp5n']}}, 06:14:31 INFO - 'talos.zip': {'path': '', 06:14:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:14:31 INFO - Running post-action listener: _resource_record_post_action 06:14:31 INFO - ##### 06:14:31 INFO - ##### Finished populate-webroot step (success) 06:14:31 INFO - ##### 06:14:31 INFO - ##### 06:14:31 INFO - ##### Running create-virtualenv step. 06:14:31 INFO - ##### 06:14:31 INFO - Running pre-action listener: _resource_record_pre_action 06:14:31 INFO - Running main action method: create_virtualenv 06:14:31 INFO - Creating virtualenv /builds/slave/test/build/venv 06:14:31 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 06:14:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:14:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:14:31 INFO - Using real prefix '/tools/python27' 06:14:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:14:32 INFO - Installing distribute.............................................................................................................................................................................................done. 06:14:35 INFO - Installing pip.................done. 06:14:35 INFO - Return code: 0 06:14:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105af7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0ac94100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a5bd30>, '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 0x1057c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a53b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:14:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 06:14:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:35 INFO - 'HOME': '/Users/cltbld', 06:14:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:35 INFO - 'LOGNAME': 'cltbld', 06:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:35 INFO - 'MOZ_NO_REMOTE': '1', 06:14:35 INFO - 'NO_EM_RESTART': '1', 06:14:35 INFO - 'PAGER': '/bin/cat', 06:14:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:35 INFO - 'PWD': '/builds/slave/test', 06:14:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:35 INFO - 'SHELL': '/bin/bash', 06:14:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 06:14:35 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 06:14:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:35 INFO - 'USER': 'cltbld', 06:14:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:35 INFO - 'XPC_FLAGS': '0x0', 06:14:35 INFO - 'XPC_SERVICE_NAME': '0', 06:14:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:35 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 06:14:35 INFO - Cleaning up... 06:14:35 INFO - Return code: 0 06:14:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105af7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0ac94100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a5bd30>, '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 0x1057c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a53b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:14:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 06:14:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:35 INFO - 'HOME': '/Users/cltbld', 06:14:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:35 INFO - 'LOGNAME': 'cltbld', 06:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:35 INFO - 'MOZ_NO_REMOTE': '1', 06:14:35 INFO - 'NO_EM_RESTART': '1', 06:14:35 INFO - 'PAGER': '/bin/cat', 06:14:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:35 INFO - 'PWD': '/builds/slave/test', 06:14:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:35 INFO - 'SHELL': '/bin/bash', 06:14:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 06:14:35 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 06:14:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:35 INFO - 'USER': 'cltbld', 06:14:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:35 INFO - 'XPC_FLAGS': '0x0', 06:14:35 INFO - 'XPC_SERVICE_NAME': '0', 06:14:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:35 INFO - Downloading/unpacking psutil>=3.1.1 06:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:14:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:38 INFO - Installing collected packages: psutil 06:14:38 INFO - Running setup.py install for psutil 06:14:38 INFO - building 'psutil._psutil_osx' extension 06:14:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:14:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:14:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:14:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:14:39 INFO - building 'psutil._psutil_posix' extension 06:14:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:14:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:14:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:14:39 INFO - ^ 06:14:39 INFO - 1 warning generated. 06:14:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:14:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:39 INFO - Successfully installed psutil 06:14:39 INFO - Cleaning up... 06:14:39 INFO - Return code: 0 06:14:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:39 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 0x105af7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0ac94100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a5bd30>, '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 0x1057c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a53b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:39 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 06:14:39 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 06:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 06:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:39 INFO - 'HOME': '/Users/cltbld', 06:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:39 INFO - 'LOGNAME': 'cltbld', 06:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:39 INFO - 'MOZ_NO_REMOTE': '1', 06:14:39 INFO - 'NO_EM_RESTART': '1', 06:14:39 INFO - 'PAGER': '/bin/cat', 06:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:39 INFO - 'PWD': '/builds/slave/test', 06:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:39 INFO - 'SHELL': '/bin/bash', 06:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 06:14:39 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 06:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:39 INFO - 'USER': 'cltbld', 06:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:39 INFO - 'XPC_FLAGS': '0x0', 06:14:39 INFO - 'XPC_SERVICE_NAME': '0', 06:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:14:39 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 06:14:39 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 06:14:39 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 06:14:39 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 06:14:39 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 06:14:39 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 06:14:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:14:42 INFO - Installing collected packages: mozsystemmonitor 06:14:42 INFO - Running setup.py install for mozsystemmonitor 06:14:42 INFO - Successfully installed mozsystemmonitor 06:14:42 INFO - Cleaning up... 06:14:42 INFO - Return code: 0 06:14:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:42 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 0x105af7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0ac94100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a5bd30>, '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 0x1057c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a53b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:42 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 06:14:42 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 06:14:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 06:14:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:42 INFO - 'HOME': '/Users/cltbld', 06:14:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:42 INFO - 'LOGNAME': 'cltbld', 06:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:42 INFO - 'MOZ_NO_REMOTE': '1', 06:14:42 INFO - 'NO_EM_RESTART': '1', 06:14:42 INFO - 'PAGER': '/bin/cat', 06:14:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:42 INFO - 'PWD': '/builds/slave/test', 06:14:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:42 INFO - 'SHELL': '/bin/bash', 06:14:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 06:14:42 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 06:14:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:42 INFO - 'USER': 'cltbld', 06:14:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:42 INFO - 'XPC_FLAGS': '0x0', 06:14:42 INFO - 'XPC_SERVICE_NAME': '0', 06:14:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:42 INFO - Downloading/unpacking jsonschema==2.5.1 06:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:14:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:14:45 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 06:14:45 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 06:14:45 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 06:14:45 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 06:14:45 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 06:14:45 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 06:14:45 INFO - Downloading functools32-3.2.3-2.tar.gz 06:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:14:45 INFO - warning: no files found matching '*.txt' 06:14:45 INFO - no previously-included directories found matching 'build' 06:14:45 INFO - no previously-included directories found matching 'dist' 06:14:45 INFO - no previously-included directories found matching '.git*' 06:14:45 INFO - Installing collected packages: jsonschema, functools32 06:14:45 INFO - Running setup.py install for functools32 06:14:45 INFO - warning: no files found matching '*.txt' 06:14:45 INFO - no previously-included directories found matching 'build' 06:14:45 INFO - no previously-included directories found matching 'dist' 06:14:45 INFO - no previously-included directories found matching '.git*' 06:14:45 INFO - Successfully installed jsonschema functools32 06:14:45 INFO - Cleaning up... 06:14:46 INFO - Return code: 0 06:14:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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', '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 0x105af7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0ac94100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a5bd30>, '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 0x1057c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a53b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:14: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 blobuploader==1.2.4 06:14:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 06:14:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:46 INFO - 'HOME': '/Users/cltbld', 06:14:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:46 INFO - 'LOGNAME': 'cltbld', 06:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:46 INFO - 'MOZ_NO_REMOTE': '1', 06:14:46 INFO - 'NO_EM_RESTART': '1', 06:14:46 INFO - 'PAGER': '/bin/cat', 06:14:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:46 INFO - 'PWD': '/builds/slave/test', 06:14:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:46 INFO - 'SHELL': '/bin/bash', 06:14:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 06:14:46 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 06:14:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:46 INFO - 'USER': 'cltbld', 06:14:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:46 INFO - 'XPC_FLAGS': '0x0', 06:14:46 INFO - 'XPC_SERVICE_NAME': '0', 06:14:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:46 INFO - Downloading/unpacking blobuploader==1.2.4 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:14:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:14:48 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 06:14:48 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 06:14:48 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 06:14:48 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 06:14:48 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 06:14:48 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 06:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:14:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:50 INFO - Downloading docopt-0.6.1.tar.gz 06:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:14:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:14:50 INFO - Running setup.py install for blobuploader 06:14:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:14:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:14:50 INFO - Running setup.py install for requests 06:14:50 INFO - Running setup.py install for docopt 06:14:50 INFO - Successfully installed blobuploader requests docopt 06:14:50 INFO - Cleaning up... 06:14:51 INFO - Return code: 0 06:14:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:51 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 0x105af7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0ac94100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a5bd30>, '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 0x1057c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a53b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:51 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 06:14:51 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 06:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 06:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:51 INFO - 'HOME': '/Users/cltbld', 06:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:51 INFO - 'LOGNAME': 'cltbld', 06:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:51 INFO - 'MOZ_NO_REMOTE': '1', 06:14:51 INFO - 'NO_EM_RESTART': '1', 06:14:51 INFO - 'PAGER': '/bin/cat', 06:14:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:51 INFO - 'PWD': '/builds/slave/test', 06:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:51 INFO - 'SHELL': '/bin/bash', 06:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 06:14:51 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 06:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:51 INFO - 'USER': 'cltbld', 06:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:51 INFO - 'XPC_FLAGS': '0x0', 06:14:51 INFO - 'XPC_SERVICE_NAME': '0', 06:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:51 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-4jHlKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:51 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-JGs2AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:51 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-WalOqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:51 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-g2cUgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:51 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-nDAD9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:51 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-YAfBHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:51 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-hE9Y8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:52 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-ydAE84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:52 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-BmQS31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:52 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-JNWicR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:52 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-k4KhJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:52 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-pRIBcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:52 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-scCKbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:52 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-0riML5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:52 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-MUSPWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:52 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-vBBN6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:52 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-7zwymV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:14:53 INFO - Running setup.py install for manifestparser 06:14:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:14:53 INFO - Running setup.py install for mozcrash 06:14:53 INFO - Running setup.py install for mozdebug 06:14:53 INFO - Running setup.py install for mozdevice 06:14:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:14:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:14:53 INFO - Running setup.py install for mozfile 06:14:53 INFO - Running setup.py install for mozhttpd 06:14:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:14:53 INFO - Running setup.py install for mozinfo 06:14:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:14:54 INFO - Running setup.py install for mozInstall 06:14:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:14:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:14:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:14:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:14:54 INFO - Running setup.py install for mozleak 06:14:54 INFO - Running setup.py install for mozlog 06:14:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:14:54 INFO - Running setup.py install for moznetwork 06:14:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:14:54 INFO - Running setup.py install for mozprocess 06:14:54 INFO - Running setup.py install for mozprofile 06:14:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for mozrunner 06:14:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for mozscreenshot 06:14:55 INFO - Running setup.py install for moztest 06:14:55 INFO - Running setup.py install for mozversion 06:14:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:14:55 INFO - Cleaning up... 06:14:55 INFO - Return code: 0 06:14:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:55 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 0x105af7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0ac94100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a5bd30>, '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 0x1057c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a53b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:55 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 06:14:55 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 06:14:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 06:14:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:55 INFO - 'HOME': '/Users/cltbld', 06:14:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:55 INFO - 'LOGNAME': 'cltbld', 06:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:55 INFO - 'MOZ_NO_REMOTE': '1', 06:14:55 INFO - 'NO_EM_RESTART': '1', 06:14:55 INFO - 'PAGER': '/bin/cat', 06:14:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:55 INFO - 'PWD': '/builds/slave/test', 06:14:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:55 INFO - 'SHELL': '/bin/bash', 06:14:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 06:14:55 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 06:14:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:55 INFO - 'USER': 'cltbld', 06:14:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:55 INFO - 'XPC_FLAGS': '0x0', 06:14:55 INFO - 'XPC_SERVICE_NAME': '0', 06:14:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:55 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-EckCw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:56 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)) 06:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:56 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-TnmpIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:56 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)) 06:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:56 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-fZSyej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:56 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)) 06:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:56 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-kM3RYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:56 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)) 06:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:56 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-HeJeLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:56 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)) 06:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:56 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-UZ_Kpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:56 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)) 06:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:56 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-PbSXnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:56 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)) 06:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:56 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-jf0BZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:56 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)) 06:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:56 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-zFXvci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:56 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)) 06:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:56 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-xXVIzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:57 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-BroVWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:57 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Cztd2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:57 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-UmljKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:57 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-B4KBCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:57 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-67OkLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:57 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-YkNSzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:57 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-gjVw_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:57 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)) 06:14:57 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)) 06:14:57 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)) 06:14:57 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)) 06:14:57 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)) 06:14:57 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)) 06:14:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:15:00 INFO - Downloading blessings-1.6.tar.gz 06:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:00 INFO - Installing collected packages: blessings 06:15:00 INFO - Running setup.py install for blessings 06:15:00 INFO - Successfully installed blessings 06:15:00 INFO - Cleaning up... 06:15:00 INFO - Return code: 0 06:15:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:00 INFO - Reading from file tmpfile_stdout 06:15:00 INFO - Current package versions: 06:15:00 INFO - blessings == 1.6 06:15:00 INFO - blobuploader == 1.2.4 06:15:00 INFO - docopt == 0.6.1 06:15:00 INFO - functools32 == 3.2.3-2 06:15:00 INFO - jsonschema == 2.5.1 06:15:00 INFO - manifestparser == 1.1 06:15:00 INFO - mozInstall == 1.12 06:15:00 INFO - mozcrash == 0.17 06:15:00 INFO - mozdebug == 0.1 06:15:00 INFO - mozdevice == 0.48 06:15:00 INFO - mozfile == 1.2 06:15:00 INFO - mozhttpd == 0.7 06:15:00 INFO - mozinfo == 0.9 06:15:00 INFO - mozleak == 0.1 06:15:00 INFO - mozlog == 3.2 06:15:00 INFO - moznetwork == 0.27 06:15:00 INFO - mozprocess == 0.23 06:15:00 INFO - mozprofile == 0.28 06:15:00 INFO - mozrunner == 6.12 06:15:00 INFO - mozscreenshot == 0.1 06:15:00 INFO - mozsystemmonitor == 0.3 06:15:00 INFO - moztest == 0.7 06:15:00 INFO - mozversion == 1.4 06:15:00 INFO - psutil == 3.1.1 06:15:00 INFO - requests == 1.2.3 06:15:00 INFO - wsgiref == 0.1.2 06:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:00 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 0x105af7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0ac94100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a5bd30>, '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 0x1057c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a53b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:15:00 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 06:15:00 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 06:15:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 06:15:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:00 INFO - 'HOME': '/Users/cltbld', 06:15:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:00 INFO - 'LOGNAME': 'cltbld', 06:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:00 INFO - 'MOZ_NO_REMOTE': '1', 06:15:00 INFO - 'NO_EM_RESTART': '1', 06:15:00 INFO - 'PAGER': '/bin/cat', 06:15:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:00 INFO - 'PWD': '/builds/slave/test', 06:15:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:00 INFO - 'SHELL': '/bin/bash', 06:15:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 06:15:00 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 06:15:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:00 INFO - 'USER': 'cltbld', 06:15:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:00 INFO - 'XPC_FLAGS': '0x0', 06:15:00 INFO - 'XPC_SERVICE_NAME': '0', 06:15:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:01 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)) 06:15:01 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)) 06:15:01 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)) 06:15:01 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)) 06:15:01 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)) 06:15:01 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)) 06:15:01 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)) 06:15:01 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)) 06:15:01 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)) 06:15:01 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)) 06:15:01 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)) 06:15:01 INFO - Cleaning up... 06:15:01 INFO - Return code: 0 06:15:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:01 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 0x105af7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0ac94100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a5bd30>, '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 0x1057c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a53b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:15:01 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 06:15:01 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 06:15:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 06:15:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:01 INFO - 'HOME': '/Users/cltbld', 06:15:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:01 INFO - 'LOGNAME': 'cltbld', 06:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:01 INFO - 'MOZ_NO_REMOTE': '1', 06:15:01 INFO - 'NO_EM_RESTART': '1', 06:15:01 INFO - 'PAGER': '/bin/cat', 06:15:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:01 INFO - 'PWD': '/builds/slave/test', 06:15:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:01 INFO - 'SHELL': '/bin/bash', 06:15:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 06:15:01 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 06:15:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:01 INFO - 'USER': 'cltbld', 06:15:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:01 INFO - 'XPC_FLAGS': '0x0', 06:15:01 INFO - 'XPC_SERVICE_NAME': '0', 06:15:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:15:01 INFO - Cleaning up... 06:15:01 INFO - Return code: 0 06:15:01 INFO - Running post-action listener: _resource_record_post_action 06:15:01 INFO - Running post-action listener: _start_resource_monitoring 06:15:01 INFO - Starting resource monitoring. 06:15:01 INFO - ##### 06:15:01 INFO - ##### Finished create-virtualenv step (success) 06:15:01 INFO - ##### 06:15:01 INFO - ##### 06:15:01 INFO - ##### Running install step. 06:15:01 INFO - ##### 06:15:01 INFO - Running pre-action listener: _resource_record_pre_action 06:15:01 INFO - Running main action method: install 06:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:01 INFO - Reading from file tmpfile_stdout 06:15:01 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:01 INFO - Reading from file tmpfile_stdout 06:15:01 INFO - Output received: 06:15:01 INFO - Usage: mozinstall [options] installer 06:15:01 INFO - Options: 06:15:01 INFO - -h, --help show this help message and exit 06:15:01 INFO - -d DEST, --destination=DEST 06:15:01 INFO - Directory to install application into. [default: 06:15:01 INFO - "/builds/slave/test"] 06:15:01 INFO - --app=APP Application being installed. [default: firefox] 06:15:01 INFO - mkdir: /builds/slave/test/build/application 06:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:15:36 INFO - Reading from file tmpfile_stdout 06:15:36 INFO - Output received: 06:15:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:15:36 INFO - Running post-action listener: _resource_record_post_action 06:15:36 INFO - ##### 06:15:36 INFO - ##### Finished install step (success) 06:15:36 INFO - ##### 06:15:36 INFO - ##### 06:15:36 INFO - ##### Running run-tests step. 06:15:36 INFO - ##### 06:15:36 INFO - Running pre-action listener: _resource_record_pre_action 06:15:36 INFO - Running main action method: run_tests 06:15:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:15:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:15:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:15:36 INFO - 2016-07-14 06:15:36.298 screenresolution[2237:11590] starting screenresolution argv=screenresolution get 06:15:36 INFO - 2016-07-14 06:15:36.300 screenresolution[2237:11590] Display 0: 1600x1200x32@60 06:15:36 INFO - 2016-07-14 06:15:36.307 screenresolution[2238:11592] starting screenresolution argv=screenresolution list 06:15:36 INFO - Available Modes on Display 0 06:15:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:15:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:15:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:15:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:15:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:15:36 INFO - Intel Iris: 06:15:36 INFO - Chipset Model: Intel Iris 06:15:36 INFO - Type: GPU 06:15:36 INFO - Bus: Built-In 06:15:36 INFO - VRAM (Dynamic, Max): 1536 MB 06:15:36 INFO - Vendor: Intel (0x8086) 06:15:36 INFO - Device ID: 0x0a2e 06:15:36 INFO - Revision ID: 0x0009 06:15:36 INFO - Displays: 06:15:36 INFO - Display: 06:15:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:15:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:15:36 INFO - Display Serial Number: 1600x1200 60 06:15:36 INFO - Main Display: Yes 06:15:36 INFO - Mirror: Off 06:15:36 INFO - Online: Yes 06:15:36 INFO - Rotation: Supported 06:15:36 INFO - Return code: 0 06:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:15:36 INFO - Python 2.7.3 06:15:36 INFO - Return code: 0 06:15:36 INFO - grabbing minidump binary from tooltool 06:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:36 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/macosx64/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 0x105a5bd30>, '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 0x1057c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a53b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:15:36 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:15:36 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:15:36 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:15:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:15:36 INFO - Return code: 0 06:15:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:15:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:15:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:15:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:15:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0122 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:15:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4t3odWYY3V/Render', 06:15:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:36 INFO - 'HOME': '/Users/cltbld', 06:15:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:36 INFO - 'LOGNAME': 'cltbld', 06:15:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:36 INFO - 'MOZ_NO_REMOTE': '1', 06:15:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:36 INFO - 'NO_EM_RESTART': '1', 06:15:36 INFO - 'PAGER': '/bin/cat', 06:15:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:36 INFO - 'PWD': '/builds/slave/test', 06:15:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:36 INFO - 'SHELL': '/bin/bash', 06:15:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners', 06:15:36 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 06:15:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:36 INFO - 'USER': 'cltbld', 06:15:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:36 INFO - 'XPC_FLAGS': '0x0', 06:15:36 INFO - 'XPC_SERVICE_NAME': '0', 06:15:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:15:36 INFO - mozversion application_buildid: 20160714030744 06:15:36 INFO - mozversion application_changeset: 49ef0b8c3cfa522e35ef2fb937da43cecba6b99c 06:15:36 INFO - mozversion application_display_name: Nightly 06:15:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:15:36 INFO - mozversion application_name: Firefox 06:15:36 INFO - mozversion application_remotingname: firefox 06:15:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:15:36 INFO - mozversion application_vendor: Mozilla 06:15:36 INFO - mozversion application_version: 50.0a1 06:15:36 INFO - mozversion platform_buildid: 20160714030744 06:15:36 INFO - mozversion platform_changeset: 49ef0b8c3cfa522e35ef2fb937da43cecba6b99c 06:15:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:15:36 INFO - mozversion platform_version: 50.0a1 06:15:36 INFO - using testdate: 1468502136 06:15:36 INFO - actual date: 1468502136 06:15:36 INFO - starting webserver on 'localhost:49545' 06:15:36 INFO - SUITE-START | Running 2 tests 06:15:36 INFO - TEST-START | dromaeo_css 06:15:36 INFO - operating with platform_type : mac_ 06:15:36 INFO - Initialising browser for dromaeo_css test... 06:15:36 INFO - TEST-INFO | started process 2248 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmprM7jen/profile http://localhost:49545/getInfo.html) 06:15:40 INFO - PROCESS | 2248 | __metrics Screen width/height:1600/1200 06:15:40 INFO - PROCESS | 2248 | colorDepth:24 06:15:40 INFO - PROCESS | 2248 | Browser inner width/height: 1024/689 06:15:40 INFO - PROCESS | 2248 | __metrics 06:15:40 ERROR - PROCESS | 2248 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 06:15:40 INFO - TEST-INFO | 2248: exit 0 06:15:40 INFO - Browser initialized. 06:15:40 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:40 INFO - TEST-INFO | started process 2251 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmprM7jen/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:52 INFO - PROCESS | 2251 | RSS: Main: 254009344 06:15:52 INFO - PROCESS | 2251 | 06:16:42 INFO - PROCESS | 2251 | 1468502202346 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] 06:18:53 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49545/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49545/tests/dromaeo/cssquery-ext.html) 06:18:55 INFO - PROCESS | 2251 | RSS: Main: 266575872 06:18:55 INFO - PROCESS | 2251 | 06:21:57 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49545/tests/dromaeo/cssquery-ext.html (next: http://localhost:49545/tests/dromaeo/cssquery-jquery.html) 06:21:58 INFO - PROCESS | 2251 | RSS: Main: 275230720 06:21:58 INFO - PROCESS | 2251 | 06:24:59 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49545/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49545/tests/dromaeo/cssquery-mootools.html) 06:25:00 INFO - PROCESS | 2251 | RSS: Main: 279736320 06:25:00 INFO - PROCESS | 2251 | 06:28:02 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49545/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49545/tests/dromaeo/cssquery-prototype.html) 06:28:03 INFO - PROCESS | 2251 | RSS: Main: 278724608 06:28:03 INFO - PROCESS | 2251 | 06:31:05 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49545/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49545/tests/dromaeo/cssquery-yui.html) 06:31:06 INFO - PROCESS | 2251 | RSS: Main: 282591232 06:31:06 INFO - PROCESS | 2251 | 06:34:09 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49545/tests/dromaeo/cssquery-yui.html (next: http://localhost:49545/tests/dromaeo/cssquery-dojo.html) 06:34:09 INFO - PROCESS | 2251 | RSS: Main: 282738688 06:34:09 INFO - PROCESS | 2251 | 06:34:09 INFO - PROCESS | 2251 | __start_tp_report 06:34:09 INFO - PROCESS | 2251 | _x_x_mozilla_page_load 06:34:09 INFO - PROCESS | 2251 | _x_x_mozilla_page_load_details 06:34:09 INFO - PROCESS | 2251 | |i|pagename|runs| 06:34:09 INFO - PROCESS | 2251 | |0;dojo.html;3418.6068602110763;3426.657334266573;3450.5341778859847;3451.6203217646057;3464.064702530315;5746.281714785652;5821.864736376403;5836.095405212199;5843.883122337551;5850.970745146279;4451.399061126747;5491.395946445888;5844.824655260339;5847.941520584793;5862.970685146568;5249.448807875166;5290.709011004393;5316.9202461962905;5369.892602147955;5419.783208671648;5333.146696528556;5417.83746487606;5470.972645136789;5498.257735205756;5519.558435325164;5208.8958220835375;5266.7366631668265;5309.41596424393;5320.148776195829;5357.357117145929;5252.36971563411;5329.094054010789;5338.866528336823;5347.759350829222;5363.892722145574;5202.973985130088;5277.86805329866;5292;5304.946950530484;5367.2485851980755;5666.943330566683;5731;5806.274215723035;5873.706314684291;5901.852453688649;6145.754169833202;6189.6286222826775;6247.344028876948;6253.53098517613;6269.0909818076125;6146.385361463863;6166.07508873668;6239.438450539428;6247.4377306042215;6252.2809876864285;5879.911801322984;5961.374055724086;5964.314103878023;5966.671833049224;6005;6383.36166383358;6415.967920160369;6424.38968298011;6452.9677351612945;6475.676216189172;6084.239470066242;6127.158986117706;6146.508279337642;6242.032484964838;6264.498840092781;6217.626942383471;6244.562880598405;6265.686715664198;6273.1844860167885;6288.339724328971;6024.698765061817;6111.774065234738;6122.357152498924;6184.257889053342;6246.656433896179;6121.57491608479;6135.07973803933;6151.200343955257;6178.969105154535;6227.470664993436;5007.774650140753;5008.5993120550265;5021.121303771825;5023.79904803811;5035.571976382049;4486.1924853526025;4520.118576877478;4527.954720452819;4537.546245375502;4576.519465456146;5710.942890571124;5881.882442335943;5923.466887980103;5973.253343332083;5975.133605627159;6260.060990851318;6260.342664020212;6301.275353334334;6310.652914089677;6327.746890124344;5996.310424301174;6017.849553761191;6018.428249316308;6038.818835434944;6056.182415373868;5370.248165256867;5453.291072160594;5470.316210473611;5515.200295957064;5521.1442226454965;6401.679916004181;6411.96794016027;6453.128827608401;6453.838654033687;6477.578957367756;5325.4940780625775;6138.32709113608;6298.685065746786;6302.842428939313;6305.464035557029;6366.490680745436;6392.232932048184;6416.935830641821;6476.643784591893;6493.772717954849;6160.414760597736;6170.074488826533;6221.222347206599;6231.719572619152;6269.185005949197;5181.974090129525;6149.2620885494025;6165.321814600301;6256.31180570146;6277.148241268928;4451.910961780682;5091.007253585515;6138.0179171332375;6213.316535181036;6213.65824879636;6171.59884607499;6198.442140207403;6213.502919766498;6224.284207316216;6228.5951413158;5982.670953097448;6068.241469816273;6088;6140.293866205444;6143.815685529441;5620.8875822482505;5745.569082318759;6045.818625441244;6144.972159187368;6265.872143014301;6133.3866613338305;6141.385861413823;6146.661933593696;6169.84575385619;6170.969145154246 06:34:09 INFO - PROCESS | 2251 | |1;ext.html;446.2703479810511;495.20519566096414;520.6511637203074;523.6674711558164;559.3399788249865;35333;42724.57275427245;42729.57270427295;42782.78608606953;42860.14279714408;43427.34858977118;43475.91310217246;43771.12457750843;44097.7795111024;44185;9596.896356918975;9650.613975440974;9719.46542940138;9794.608215671364;9799.363041402321;9718.125368716814;9721.90278097217;9780;9805.509724513782;9843.114119729224;9848.16290615295;9852.90147098527;9876.40741555509;9876.60493580256;9893;9802.019798020212;9859.50702464874;9865.852012219822;9865.950670246675;9885;9574.760630984212;9657.130858222794;9711.36876103051;9733.270004749673;9748.366356186825;41227;41594.79202603998;41863.37204941928;42196.73409797711;42209;3418.574020229136;3539.2213712983103;3546.414841551141;3678.2643471305846;3973.4238535412205;31502.36995260082;33487.6651233487;33632;33646.65413383486;33708.662913371045;2702.297402675299;3325.617553981299;3427.674370934757;3446.172918499567;3447.9827600862086;447786;524238;528149.4370112615;538518.3074084644;538807;58493;69514.65242673755;70607;70623.58752825018;70830.64584677044;73941;74173.62913185508;74347.25652743512;74583.25416745871;74596;17451.47645570635;17635.29458821633;17651.646967060587;17656.735148972777;17673.381431649832;13150.342482875818;13223.73552528944;13313.201207927556;13322.66693332655;13334.266615336055;17901.297540453936;20367.4908127298;21376.931153442576;21446;21646.91765411723;3295.24209431832;3414.197663549064;3422.3155368926314;8901.287896968228;9112.134347237003;861.8190180062131;961.9711408657752;968.8885778135464;999.8550210219478;1061.1563806773634;30805.921792737594;31183.844080779905;31272.530912036338;31722.365552688818;31783;1029.5109822834095;1076.9030787229187;1078.6278733836814;1093.0217455377392;1149.3563604381573;13230.07389482727;13431.798523022162;15542.889058440362;16260.349586016428;17129.97220166794;594682;708765;717310;719525;720934;63653.04520432197;64238.67880660567;64532.67733661395;65009.34990650127;65666.01500977488;1396.727638110579;1435.1174027972722;1443.083641887388;1443.162965480019;1444.5377479206763;29382.706172937997;30397.240068998453;30618.693813061585;30623.693763062085;31887.6811231894;54515.72742136264;55672.72163639156;56253.437465626455;56624.15063773964;56637.71681141568;553189;653718;662412;665205;666815;27941;28126.43747125087;28289.292767680974;28664.14007579776;28742.568861466676;40748.592514075666;49034.264486033455;51494;51816.74091629518;51860.74069629628;35898.8205058973;41908.58091419047;42547.36178957256;43084.35373469338;43125.353119703854;41462;41765.95585110275;41848;42014.78992605017;42635.786821065696;39923.60076399199;40513.1897362057;40764.79617601893;40866.79566602267;41038.79480602578;34855.30289394147;36168.09579760527;36682.8165859169;36831.63168368282;36886.815565922;25256.747432526176;26465.073722419624;26509;26873.462530749668;26878.193654190407 06:34:09 INFO - PROCESS | 2251 | |2;jquery.html;317.25445203771136;379;383.57040115071123;396.83333000139936;410.29019795753345;20070.89964550177;20588.485287867774;21051.578968420643;21563.676544851838;21755.67366489502;20933.371998840023;21091.6836247456;21381.358559243246;21522.677159842617;22073.779262207372;5447.6731396116165;5975.880482390338;6155.72299246535;6158.230221222348;6171.321154672983;5112.565431938289;6051.606645568024;6070.696465176746;6106.603070800406;6112.419320164578;5299.973500132513;5435.239066530688;5993.820185394424;5999.13012613173;6005.669688167149;5533.75490514635;5864.032434648278;5930.199423077873;5976.057781221099;6035.939640603604;4926.334944782444;5255.6583822051825;5260.631755777097;5285.867853303698;5287.735613219362;25384.238472845846;26887;26914.46171076587;26982.460350792873;27104.32239194016;2308.90764369425;2328.5459335429596;2341.4731685370825;2470.407102295454;2526.633638122462;15939.282732276959;16140;16280.267387967451;16314.184290785532;16331.510054698378;1884.0014792160177;1885.5945971616168;1887.565859852228;1889.5465088378828;1930.3340347580063;89664.10335896688;111639;119440.40279798632;119447.99999999913;126099;9186.77033074165;9683.564239609093;10445.373277603368;10594.364338139736;11141.331520108819;14252.144871307755;14329.498467553585;14337.35481903317;14340.21128837903;14343.56969290902;8765.517896515752;8993.28053755711;8997.415168014059;9072.727818165333;9418.62325506972;9126.954365228132;9127.132922372364;9128.49793261377;9217.815643687089;9288.164065234027;7019.262977387403;7049.9647501762165;7119.75080872167;7131.679074441663;7168.74546954281;1673.3306677329165;1864.794872564017;1951.756030496188;1970.467973647136;1972.3392663457616;856.246503077288;961.7595601099725;973.7390079846616;995.5121990224737;1081.4971038467152;22213.000414981365;22822.543549128924;22855;23015.7698423017;23086.769132308462;907.600655711498;1013.9847902281472;1017.7455636090978;1021.6832781837654;1084.1976937066672;10518.947405263078;12161;12269.202501837352;12474.75050499003;12482.063845211645;541564;559412;560478;577214;585453;118746;119793;122071;122616.25513893084;123325.76674233322;1020.5203554329453;1021.9948900255451;1045.0646671229208;1049.239301506417;1050.485262221506;15687.843121568638;20135.89932050389;20294.898525507277;20621.865797381288;20790.376288711363;53328.73335633297;53657;53845.461545384045;54432;55356.169657455976;79958.4008319842;81019.78470322832;83083;84474.57762711147;85500;6528.804135875931;7107.502474826712;7853.646585903533;8103.87844182326;8174.509529428254;8579.399442038997;11817.581890173235;12009.699757506132;13119.409626567018;13400.865991339962;9300.906990930003;11138.164637652371;11140.665780026613;11157.609483668033;11200.327980321206;11152.16358773079;11358.432078395881;11381.260218085798;11414.771704566028;11505.309681419141;9632.181264592307;11108.833777413327;11473.598424055119;11627.709307267385;11882.465289062186;7112.57324560528;8385.245327920517;8462.830743384975;8556.486610803371;8702.347323950855;10758.784824303313;11344.20590558686;11390.886091139315;11412.258203216765;11648.184627076023 06:34:09 INFO - PROCESS | 2251 | |3;mootools.html;1527.1142737212417;1577.7475603903379;1672.3310675729706;1717.8404576910582;1847.2795609712223;8206.302464290527;8754.037055923844;8793.252573531257;9232.261419086473;9259.629614815407;8796.208341249287;8852.601632926519;8994.370394072417;8999.460032398061;9010.369274150811;2007.8393728501758;2399.3042017814814;2411.6141417373224;2415.5168966206743;2431.465077682907;2380.381100913766;2405.2303262955775;2407.8555286682767;2430.5989511730545;2448.959192343256;2395.5089206712582;2413.650020746991;2417.226487523993;2419.721732000825;2451.7915977141965;2380.357553288243;2386.4988352446007;2390.175389490623;2399.4961058177805;2406.338256979327;2363.527294541099;2376.9405764856015;2379.452725873042;2386.7016622922133;2387.2957477544164;8878.600462979182;8889.244414224799;9090.86363704545;9162.267018638493;9179.862302065474;5345.305110335631;5353.544948679367;5459.2902922619805;5531.502164805187;5538.501534861842;3595.496630471736;3679.871204507856;3748.11919198988;3748.538070152643;3750.3811871041244;1073.5920350266927;1078.3314345106085;1083.7615724540588;1087.4508373271447;1098.3025778630547;11681.883181168165;12086.818697719542;12173.573924912585;12297.69255768604;12309.569165079269;4458.464984201916;4472.843450479218;4672.112298663243;4690.437147542249;4713.222318317507;9377.578008989612;9513.476758778334;9522.666706665372;9535.952320238493;9539.570719317648;5326.493983071602;5333.413324534298;5335.973320133375;5342.091844386464;5351.304330437096;4454.1982443159895;4789.748818055508;4956.959038601934;4958.851234462972;4977.104121258209;3851.383778595411;3911.5697273299916;3940.4877365942243;3944.1914407546383;4035.6569691576547;1188.2751521572006;1197.0543270815958;1205.7769312677183;1206.1677442564603;1206.7224538356227;838.5471845203643;897.4121950122681;940.9717708468756;944.1596978688972;946.7680418297562;5354.437784032699;6051.8487037823525;6122.785702500391;6247.687615619201;6265.404786545271;434.41137259014215;447.4228245563252;449.0905915521031;462.55132521454135;463.11776066593194;4205.516365617932;4252;4271.594198551133;4318.050028993616;4326.956730432718;10779.407132607625;11158.386288754034;11167.776644467227;11261.66215013551;11298.830517542243;10692.89307106919;11065.004149626573;11133.276337038067;11206.413947536874;11208.04731597807;6662.83342916431;7276.381507571916;7728.729494467667;8424.957875210584;8539.23146916793;6119.541034422347;6336.049592561153;6378.968105159444;6401.839954001187;6423.669816011934;9681.51592420362;10250.128739056965;10263.384196948207;10517.316374435637;10526.473676316;10150.746231344276;10511.10655594283;10535.63125290611;10542.26204165701;10543.367397956146;6894.448444124358;7155.069840920647;7653;7853.764387068397;7999.400044996765;8795.868061979203;8827.646894124164;8877.955610221907;8882.200601945857;8895.288376929959;7599.848003039798;7778.338841198335;7843.490173138728;7872.252136047066;7875.094364147967;7566.924330756622;7597.734079307198;7620;7624.80937976555;7792.337651299703;7227.349538541556;7239.963800180965;7283.016792733125;7286.234945330664;7306.561606303639;5072.213806859942;5168.896622067613;5225.947740522698;5252.212168174804;5267.57859371257;4942.728149951788;5355.116405793001;5406.5945054121885;5406.675599464044;5588.441155884379 06:34:09 INFO - PROCESS | 2251 | |4;prototype.html;307.96150481189835;311.6276050120107;315.0941044497071;323.15817295944066;323.43399051659594;4658.347831303616;5394.32570928634;5418.458154184579;5494.780208791649;5598.888022239553;3997.460342853714;4561.908761824761;5079.2635067915135;5514.448555144483;5553.666779993203;3121.4069326827944;3422.709069729076;3780.546334439857;4205.897051474255;4226.366045093245;3747.288015277102;3956.3076461619244;4146.274401979656;4158.812853421603;4240.5547417521175;3403.557537520119;4114.7119701620895;4224.176285624305;4225.598568136023;4279.358096285567;3522.5772907251167;4209.326507758775;4239.915201695964;4244.686645778058;4289.6997210195295;3045.482268014443;3671.614480479538;3674.8713795017047;3679.0434487033294;3686.631336866292;4344.892052526586;4558.726476411426;4753.928691069636;4807.735574543399;5469.617126801126;4493.820247190109;4868.513148685139;4890.046440944017;4890.75546222691;4904.141775189328;5112.488751124895;5937.376575459558;5949.762009519614;5992.191054207669;6026.186464827236;3017.969820301791;3332.783369081002;3602.423612222032;3915.158240978203;3949.0917089069676;5363.383210930754;5875.648600821793;5921.348651648315;6296.181496405484;6299;4003.239384516991;4036.233115708006;4042.555318914917;4056.006278461796;4057.918841623151;3866.8646597368956;4066.9796651016554;4104.753714777123;4112.691548133902;4138.193052354762;4048.615381538808;4174.893653181909;4378.299472084451;4549.476810166807;4794.184988551954;5909.758950620418;5923.407659234128;6039.275286965592;6049.939500605025;6081.695915204222;1239.2254840724547;1273.961781146567;1300.7398520295978;1322.9007824413015;1354.6884216630033;884.4737381258141;907.2968449451596;928.03020843219;936.180841763457;936.7143021378545;4754.405699287589;5400.21696853954;5421.213923981;5480.698561579072;5481.479259470344;5684.658920464785;5956.374580669054;5969.432903874125;6037.396260373927;6063.090536419572;4332.436783218224;4661.673682842236;4804.918893249061;5265.8156964506825;5528.9723551381985;2301.5166814969043;2670.826396284235;2690.30052186429;2699.056679190979;2771.210205091539;4557.584480225486;4855.9074208303555;5188.860739252697;5236.6857988520815;5271.341082364705;4586.4266966629175;5178.559822415062;5647.6733001410685;6344.6827658616885;6377.999999999907;6414.935850641434;6422.81624247758;6441.326849357464;6441.64570948593;6479.935200647933;5657.387644521292;5903.852403689943;6100.938990610037;6169.629822210682;6177.779776089197;4903.264510323337;5761.251037365116;5865.530757539302;6009.098635204754;6027.547933904887;5293.894122117613;5444.754986025559;6098.725557349841;6411.294757576569;6437.485001199986;3274.950875736818;3390.2371966307383;3815.21788033458;4037.454943582579;4063.6139566741113;5542.196381524737;5783.537317014713;6071.241094863142;6138.907916381348;6149.2313460817395;4906;5172.948270517247;5239.476052394883;5759.58097599001;5909.911351329648;4685.765711714469;5626.156076588544;5647.119968815851;5816.749398879261;6021.765538064774;4871.269309603588;5353.955978584138;5567.69377684215;5593.328800543961;5842.357340692605;5955.553333500092;5972.671503067199;5979.641221526722;6012.458878700938;6037.335893051849;5111.616628752784;5180.912008478262;5785.479306862402;5819.912701309569;5836.620619659709 06:34:09 INFO - PROCESS | 2251 | |5;yui.html;694.4687314204638;717.9928200717991;720.5640587444595;788.3574886467528;863.6329559937027;15045.473408430707;15283.770743438843;15522.689546209069;15866.603334916634;15901.443449479271;12214.69463263419;13271.668208294797;14380.49668261611;14383.928080359583;14462.783058254134;877.4209022045467;893.9418937769057;897.3718397122008;902.2285945516587;905.108468158863;860.9053004169537;900.5362238447204;902.4044130873625;902.9909700903005;903.5978989349742;799.472348250155;905.0994260710602;933.8785957825473;940.5908429833011;954.3415043619915;908.2552307108174;914.8947870994854;930.2836815651943;947.3794664494733;950.7005293332578;694.6873906741986;702.9156501219835;710.3180946291566;712.0636363182399;713.6110819603276;10678.25252232344;12774.041946854024;12797;12805.935970320088;12903.612891613173;12132.272063676208;12155.270683758914;12329.321887296195;12339.444724987397;12439.626811195678;8951.328650351184;9660.37207581505;10177.440240786755;10254.846177307347;10826.783464330749;3252.869885204589;3763.9247215055548;3782;3785.3754130568423;3823.2926908521736;103158;103984;106226;106340;106719.46640266827;9436.811263774685;9472.431654100776;9566.091221333962;9632.373895696757;9796.020397960147;20388.184472621226;20562.074706638236;20645.380638580868;20752.896235518725;20989.68515472269;7899.526028438312;8112.878306825402;8157.1842815717955;8298.460600060977;8371.99536055665;4446.73319600825;4502.16709908668;4564.0871825635;4580.335851301543;4589;2877.510823160068;2960.9932622908314;3227.935441291208;3501.6673416025437;3576.2668652926086;663.6051549328142;670.6445583840572;690.1338819781242;701.6141122382669;704.5842952657854;599.9100134979788;687.779910428658;698.8608568034072;708.7094291340628;715.8210447388153;7824.921750782533;9049.457032578066;9362.251019918527;9395.812083758423;9567.569459374345;617.4072890025536;639.9584027038228;653.5784419049686;681.6762038031994;687.226869771507;3839.308924393636;4409.699138754076;4570.200214962435;4573.63410927125;4643.767811609406;98718;123479;145153.82269265968;149263.25368373087;153238.7014194788;94050.41647084775;114729.4263528677;131536;133080.3345983264;133165;95914.52042739742;97175;105337.41993870099;108247.45876270568;109063.45468272608;9598.616055357987;9646.035396460578;9750.366226195274;9818.607255709692;10035.799284014132;50854.23718644297;53877.92244155173;54816;60310;65399.71101011442;80130.19869801227;86380;97183;97391;99892;13217.858742720775;13264.53574124901;13277.734445311233;13395.263260520765;13493.73012539724;15227.228602577556;15328.463503777315;15447.0731756095;15459.84540154629;15748.527544173694;14174.858251417354;14433.134011959317;14686.706265874836;14810.111393316005;14864.405423782928;13786.862131378959;14105.576832695035;14580.927095364455;14608.269586520844;14698.632534186303;12403.75192496163;13553.93223033918;13892.861071389158;14498.05762625426;14531;11233.258844879058;11270.721535449118;11460.981616458055;11686.298822070703;11696.649100526998;11280.887191127984;11325.71685707864;11440.141989350666;11583.362915039754;11645 06:34:09 INFO - PROCESS | 2251 | __end_tp_report 06:34:09 INFO - PROCESS | 2251 | __start_cc_report 06:34:09 INFO - PROCESS | 2251 | _x_x_mozilla_cycle_collect,445 06:34:09 INFO - PROCESS | 2251 | __end_cc_report 06:34:09 INFO - PROCESS | 2251 | __startTimestamp1468503249423__endTimestamp 06:34:09 INFO - PROCESS | 2251 | 06:34:09 INFO - PROCESS | 2251 | ------- Summary: start ------- 06:34:09 INFO - PROCESS | 2251 | Number of tests: 6 06:34:09 INFO - PROCESS | 2251 | 06:34:09 INFO - PROCESS | 2251 | [#0] dojo.html Cycles:165 Average:5794.17 Median:6045.82 stddev:641.93 (10.6%) stddev-sans-first:616.26 06:34:09 INFO - PROCESS | 2251 | Values: 3418.6 3426.7 3450.5 3451.6 3464.1 5746.3 5821.9 5836.1 5843.9 5851.0 4451.4 5491.4 5844.8 5847.9 5863.0 5249.4 5290.7 5316.9 5369.9 5419.8 5333.1 5417.8 5471.0 5498.3 5519.6 5208.9 5266.7 5309.4 5320.1 5357.4 5252.4 5329.1 5338.9 5347.8 5363.9 5203.0 5277.9 5292.0 5304.9 5367.2 5666.9 5731.0 5806.3 5873.7 5901.9 6145.8 6189.6 6247.3 6253.5 6269.1 6146.4 6166.1 6239.4 6247.4 6252.3 5879.9 5961.4 5964.3 5966.7 6005.0 6383.4 6416.0 6424.4 6453.0 6475.7 6084.2 6127.2 6146.5 6242.0 6264.5 6217.6 6244.6 6265.7 6273.2 6288.3 6024.7 6111.8 6122.4 6184.3 6246.7 6121.6 6135.1 6151.2 6179.0 6227.5 5007.8 5008.6 5021.1 5023.8 5035.6 4486.2 4520.1 4528.0 4537.5 4576.5 5710.9 5881.9 5923.5 5973.3 5975.1 6260.1 6260.3 6301.3 6310.7 6327.7 5996.3 6017.8 6018.4 6038.8 6056.2 5370.2 5453.3 5470.3 5515.2 5521.1 6401.7 6412.0 6453.1 6453.8 6477.6 5325.5 6138.3 6298.7 6302.8 6305.5 6366.5 6392.2 6416.9 6476.6 6493.8 6160.4 6170.1 6221.2 6231.7 6269.2 5182.0 6149.3 6165.3 6256.3 6277.1 4451.9 5091.0 6138.0 6213.3 6213.7 6171.6 6198.4 6213.5 6224.3 6228.6 5982.7 6068.2 6088.0 6140.3 6143.8 5620.9 5745.6 6045.8 6145.0 6265.9 6133.4 6141.4 6146.7 6169.8 6171.0 06:34:09 INFO - PROCESS | 2251 | 06:34:09 INFO - PROCESS | 2251 | [#1] ext.html Cycles:180 Average:75800.50 Median:42202.87 stddev:166416.35 (394.3%) stddev-sans-first:166787.02 06:34:09 INFO - PROCESS | 2251 | Values: 446.3 495.2 520.7 523.7 559.3 35333.0 42724.6 42729.6 42782.8 42860.1 43427.3 43475.9 43771.1 44097.8 44185.0 9596.9 9650.6 9719.5 9794.6 9799.4 9718.1 9721.9 9780.0 9805.5 9843.1 9848.2 9852.9 9876.4 9876.6 9893.0 9802.0 9859.5 9865.9 9866.0 9885.0 9574.8 9657.1 9711.4 9733.3 9748.4 41227.0 41594.8 41863.4 42196.7 42209.0 3418.6 3539.2 3546.4 3678.3 3973.4 31502.4 33487.7 33632.0 33646.7 33708.7 2702.3 3325.6 3427.7 3446.2 3448.0 447786.0 524238.0 528149.4 538518.3 538807.0 58493.0 69514.7 70607.0 70623.6 70830.6 73941.0 74173.6 74347.3 74583.3 74596.0 17451.5 17635.3 17651.6 17656.7 17673.4 13150.3 13223.7 13313.2 13322.7 13334.3 17901.3 20367.5 21376.9 21446.0 21646.9 3295.2 3414.2 3422.3 8901.3 9112.1 861.8 962.0 968.9 999.9 1061.2 30805.9 31183.8 31272.5 31722.4 31783.0 1029.5 1076.9 1078.6 1093.0 1149.4 13230.1 13431.8 15542.9 16260.3 17130.0 594682.0 708765.0 717310.0 719525.0 720934.0 63653.0 64238.7 64532.7 65009.3 65666.0 1396.7 1435.1 1443.1 1443.2 1444.5 29382.7 30397.2 30618.7 30623.7 31887.7 54515.7 55672.7 56253.4 56624.2 56637.7 553189.0 653718.0 662412.0 665205.0 666815.0 27941.0 28126.4 28289.3 28664.1 28742.6 40748.6 49034.3 51494.0 51816.7 51860.7 35898.8 41908.6 42547.4 43084.4 43125.4 41462.0 41766.0 41848.0 42014.8 42635.8 39923.6 40513.2 40764.8 40866.8 41038.8 34855.3 36168.1 36682.8 36831.6 36886.8 25256.7 26465.1 26509.0 26873.5 26878.2 06:34:09 INFO - PROCESS | 2251 | 06:34:09 INFO - PROCESS | 2251 | [#2] jquery.html Cycles:180 Average:34338.39 Median:2335.01 stddev:94352.43 (4040.8%) stddev-sans-first:94582.53 06:34:09 INFO - PROCESS | 2251 | Values: 317.3 379.0 383.6 396.8 410.3 20070.9 20588.5 21051.6 21563.7 21755.7 20933.4 21091.7 21381.4 21522.7 22073.8 5447.7 5975.9 6155.7 6158.2 6171.3 5112.6 6051.6 6070.7 6106.6 6112.4 5300.0 5435.2 5993.8 5999.1 6005.7 5533.8 5864.0 5930.2 5976.1 6035.9 4926.3 5255.7 5260.6 5285.9 5287.7 25384.2 26887.0 26914.5 26982.5 27104.3 2308.9 2328.5 2341.5 2470.4 2526.6 15939.3 16140.0 16280.3 16314.2 16331.5 1884.0 1885.6 1887.6 1889.5 1930.3 89664.1 111639.0 119440.4 119448.0 126099.0 9186.8 9683.6 10445.4 10594.4 11141.3 14252.1 14329.5 14337.4 14340.2 14343.6 8765.5 8993.3 8997.4 9072.7 9418.6 9127.0 9127.1 9128.5 9217.8 9288.2 7019.3 7050.0 7119.8 7131.7 7168.7 1673.3 1864.8 1951.8 1970.5 1972.3 856.2 961.8 973.7 995.5 1081.5 22213.0 22822.5 22855.0 23015.8 23086.8 907.6 1014.0 1017.7 1021.7 1084.2 10518.9 12161.0 12269.2 12474.8 12482.1 541564.0 559412.0 560478.0 577214.0 585453.0 118746.0 119793.0 122071.0 122616.3 123325.8 1020.5 1022.0 1045.1 1049.2 1050.5 15687.8 20135.9 20294.9 20621.9 20790.4 53328.7 53657.0 53845.5 54432.0 55356.2 79958.4 81019.8 83083.0 84474.6 85500.0 6528.8 7107.5 7853.6 8103.9 8174.5 8579.4 11817.6 12009.7 13119.4 13400.9 9300.9 11138.2 11140.7 11157.6 11200.3 11152.2 11358.4 11381.3 11414.8 11505.3 9632.2 11108.8 11473.6 11627.7 11882.5 7112.6 8385.2 8462.8 8556.5 8702.3 10758.8 11344.2 11390.9 11412.3 11648.2 06:34:09 INFO - PROCESS | 2251 | 06:34:09 INFO - PROCESS | 2251 | [#3] mootools.html Cycles:180 Average:5844.04 Median:4866.24 stddev:3311.05 (68.0%) stddev-sans-first:3304.45 06:34:09 INFO - PROCESS | 2251 | Values: 1527.1 1577.7 1672.3 1717.8 1847.3 8206.3 8754.0 8793.3 9232.3 9259.6 8796.2 8852.6 8994.4 8999.5 9010.4 2007.8 2399.3 2411.6 2415.5 2431.5 2380.4 2405.2 2407.9 2430.6 2449.0 2395.5 2413.7 2417.2 2419.7 2451.8 2380.4 2386.5 2390.2 2399.5 2406.3 2363.5 2376.9 2379.5 2386.7 2387.3 8878.6 8889.2 9090.9 9162.3 9179.9 5345.3 5353.5 5459.3 5531.5 5538.5 3595.5 3679.9 3748.1 3748.5 3750.4 1073.6 1078.3 1083.8 1087.5 1098.3 11681.9 12086.8 12173.6 12297.7 12309.6 4458.5 4472.8 4672.1 4690.4 4713.2 9377.6 9513.5 9522.7 9536.0 9539.6 5326.5 5333.4 5336.0 5342.1 5351.3 4454.2 4789.7 4957.0 4958.9 4977.1 3851.4 3911.6 3940.5 3944.2 4035.7 1188.3 1197.1 1205.8 1206.2 1206.7 838.5 897.4 941.0 944.2 946.8 5354.4 6051.8 6122.8 6247.7 6265.4 434.4 447.4 449.1 462.6 463.1 4205.5 4252.0 4271.6 4318.1 4327.0 10779.4 11158.4 11167.8 11261.7 11298.8 10692.9 11065.0 11133.3 11206.4 11208.0 6662.8 7276.4 7728.7 8425.0 8539.2 6119.5 6336.0 6379.0 6401.8 6423.7 9681.5 10250.1 10263.4 10517.3 10526.5 10150.7 10511.1 10535.6 10542.3 10543.4 6894.4 7155.1 7653.0 7853.8 7999.4 8795.9 8827.6 8878.0 8882.2 8895.3 7599.8 7778.3 7843.5 7872.3 7875.1 7566.9 7597.7 7620.0 7624.8 7792.3 7227.3 7240.0 7283.0 7286.2 7306.6 5072.2 5168.9 5225.9 5252.2 5267.6 4942.7 5355.1 5406.6 5406.7 5588.4 06:34:09 INFO - PROCESS | 2251 | 06:34:09 INFO - PROCESS | 2251 | [#4] prototype.html Cycles:180 Average:4634.00 Median:5142.72 stddev:1497.46 (29.1%) stddev-sans-first:1466.04 06:34:09 INFO - PROCESS | 2251 | Values: 308.0 311.6 315.1 323.2 323.4 4658.3 5394.3 5418.5 5494.8 5598.9 3997.5 4561.9 5079.3 5514.4 5553.7 3121.4 3422.7 3780.5 4205.9 4226.4 3747.3 3956.3 4146.3 4158.8 4240.6 3403.6 4114.7 4224.2 4225.6 4279.4 3522.6 4209.3 4239.9 4244.7 4289.7 3045.5 3671.6 3674.9 3679.0 3686.6 4344.9 4558.7 4753.9 4807.7 5469.6 4493.8 4868.5 4890.0 4890.8 4904.1 5112.5 5937.4 5949.8 5992.2 6026.2 3018.0 3332.8 3602.4 3915.2 3949.1 5363.4 5875.6 5921.3 6296.2 6299.0 4003.2 4036.2 4042.6 4056.0 4057.9 3866.9 4067.0 4104.8 4112.7 4138.2 4048.6 4174.9 4378.3 4549.5 4794.2 5909.8 5923.4 6039.3 6049.9 6081.7 1239.2 1274.0 1300.7 1322.9 1354.7 884.5 907.3 928.0 936.2 936.7 4754.4 5400.2 5421.2 5480.7 5481.5 5684.7 5956.4 5969.4 6037.4 6063.1 4332.4 4661.7 4804.9 5265.8 5529.0 2301.5 2670.8 2690.3 2699.1 2771.2 4557.6 4855.9 5188.9 5236.7 5271.3 4586.4 5178.6 5647.7 6344.7 6378.0 6414.9 6422.8 6441.3 6441.6 6479.9 5657.4 5903.9 6100.9 6169.6 6177.8 4903.3 5761.3 5865.5 6009.1 6027.5 5293.9 5444.8 6098.7 6411.3 6437.5 3275.0 3390.2 3815.2 4037.5 4063.6 5542.2 5783.5 6071.2 6138.9 6149.2 4906.0 5172.9 5239.5 5759.6 5909.9 4685.8 5626.2 5647.1 5816.7 6021.8 4871.3 5354.0 5567.7 5593.3 5842.4 5955.6 5972.7 5979.6 6012.5 6037.3 5111.6 5180.9 5785.5 5819.9 5836.6 06:34:09 INFO - PROCESS | 2251 | 06:34:09 INFO - PROCESS | 2251 | [#5] yui.html Cycles:180 Average:23652.55 Median:4124.50 stddev:37270.73 (903.6%) stddev-sans-first:37335.42 06:34:09 INFO - PROCESS | 2251 | Values: 694.5 718.0 720.6 788.4 863.6 15045.5 15283.8 15522.7 15866.6 15901.4 12214.7 13271.7 14380.5 14383.9 14462.8 877.4 893.9 897.4 902.2 905.1 860.9 900.5 902.4 903.0 903.6 799.5 905.1 933.9 940.6 954.3 908.3 914.9 930.3 947.4 950.7 694.7 702.9 710.3 712.1 713.6 10678.3 12774.0 12797.0 12805.9 12903.6 12132.3 12155.3 12329.3 12339.4 12439.6 8951.3 9660.4 10177.4 10254.8 10826.8 3252.9 3763.9 3782.0 3785.4 3823.3 103158.0 103984.0 106226.0 106340.0 106719.5 9436.8 9472.4 9566.1 9632.4 9796.0 20388.2 20562.1 20645.4 20752.9 20989.7 7899.5 8112.9 8157.2 8298.5 8372.0 4446.7 4502.2 4564.1 4580.3 4589.0 2877.5 2961.0 3227.9 3501.7 3576.3 663.6 670.6 690.1 701.6 704.6 599.9 687.8 698.9 708.7 715.8 7824.9 9049.5 9362.3 9395.8 9567.6 617.4 640.0 653.6 681.7 687.2 3839.3 4409.7 4570.2 4573.6 4643.8 98718.0 123479.0 145153.8 149263.3 153238.7 94050.4 114729.4 131536.0 133080.3 133165.0 95914.5 97175.0 105337.4 108247.5 109063.5 9598.6 9646.0 9750.4 9818.6 10035.8 50854.2 53877.9 54816.0 60310.0 65399.7 80130.2 86380.0 97183.0 97391.0 99892.0 13217.9 13264.5 13277.7 13395.3 13493.7 15227.2 15328.5 15447.1 15459.8 15748.5 14174.9 14433.1 14686.7 14810.1 14864.4 13786.9 14105.6 14580.9 14608.3 14698.6 12403.8 13553.9 13892.9 14498.1 14531.0 11233.3 11270.7 11461.0 11686.3 11696.6 11280.9 11325.7 11440.1 11583.4 11645.0 06:34:09 INFO - PROCESS | 2251 | -------- Summary: end -------- 06:34:09 INFO - PROCESS | 2251 | 06:34:10 INFO - TEST-INFO | 2251: exit 0 06:34:10 INFO - TEST-OK | dromaeo_css | took 1113246ms 06:34:10 INFO - TEST-START | kraken 06:34:10 INFO - operating with platform_type : mac_ 06:34:10 INFO - Initialising browser for kraken test... 06:34:10 INFO - TEST-INFO | started process 2257 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpYFGus8/profile http://localhost:49545/getInfo.html) 06:34:13 INFO - PROCESS | 2257 | __metrics Screen width/height:1600/1200 06:34:13 INFO - PROCESS | 2257 | colorDepth:24 06:34:13 INFO - PROCESS | 2257 | Browser inner width/height: 1024/689 06:34:13 INFO - PROCESS | 2257 | __metrics 06:34:13 ERROR - PROCESS | 2257 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 06:34:13 INFO - TEST-INFO | 2257: exit 0 06:34:13 INFO - Browser initialized. 06:34:13 INFO - Running cycle 1/1 for kraken test... 06:34:13 INFO - TEST-INFO | started process 2259 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpYFGus8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:26 INFO - PROCESS | 2259 | RSS: Main: 254394368 06:34:26 INFO - PROCESS | 2259 | 06:34:28 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49545/tests/kraken/driver.html?testName=audio-beat-detection) 06:34:29 INFO - PROCESS | 2259 | RSS: Main: 267603968 06:34:29 INFO - PROCESS | 2259 | 06:34:32 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49545/tests/kraken/driver.html?testName=audio-dft) 06:34:32 INFO - PROCESS | 2259 | RSS: Main: 271290368 06:34:32 INFO - PROCESS | 2259 | 06:34:36 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49545/tests/kraken/driver.html?testName=audio-fft) 06:34:37 INFO - PROCESS | 2259 | RSS: Main: 271749120 06:34:37 INFO - PROCESS | 2259 | 06:34:39 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49545/tests/kraken/driver.html?testName=audio-oscillator) 06:34:39 INFO - PROCESS | 2259 | RSS: Main: 272695296 06:34:39 INFO - PROCESS | 2259 | 06:34:41 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49545/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:42 INFO - PROCESS | 2259 | RSS: Main: 273358848 06:34:42 INFO - PROCESS | 2259 | 06:34:45 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49545/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:46 INFO - PROCESS | 2259 | RSS: Main: 274264064 06:34:46 INFO - PROCESS | 2259 | 06:34:49 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49545/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:49 INFO - PROCESS | 2259 | RSS: Main: 274272256 06:34:49 INFO - PROCESS | 2259 | 06:34:52 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49545/tests/kraken/driver.html?testName=json-parse-financial) 06:34:53 INFO - PROCESS | 2259 | RSS: Main: 274468864 06:34:53 INFO - PROCESS | 2259 | 06:34:55 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49545/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:34:55 INFO - PROCESS | 2259 | RSS: Main: 273764352 06:34:55 INFO - PROCESS | 2259 | 06:34:57 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49545/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:34:58 INFO - PROCESS | 2259 | RSS: Main: 273743872 06:34:58 INFO - PROCESS | 2259 | 06:35:00 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49545/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:35:01 INFO - PROCESS | 2259 | RSS: Main: 274087936 06:35:01 INFO - PROCESS | 2259 | 06:35:04 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49545/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:35:05 INFO - PROCESS | 2259 | RSS: Main: 274444288 06:35:05 INFO - PROCESS | 2259 | 06:35:08 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49545/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:08 INFO - PROCESS | 2259 | RSS: Main: 274571264 06:35:08 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49545/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49545/tests/kraken/driver.html?testName=ai-astar) 06:35:10 INFO - PROCESS | 2259 | RSS: Main: 275824640 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | __start_tp_report 06:35:10 INFO - PROCESS | 2259 | _x_x_mozilla_page_load 06:35:10 INFO - PROCESS | 2259 | _x_x_mozilla_page_load_details 06:35:10 INFO - PROCESS | 2259 | |i|pagename|runs| 06:35:10 INFO - PROCESS | 2259 | |0;ai-astar;104;115;105;114;116;116;111;115;118;118 06:35:10 INFO - PROCESS | 2259 | |1;audio-beat-detection;151;135;118;184;143;155;131;107;158;103 06:35:10 INFO - PROCESS | 2259 | |2;audio-dft;198;275;213;259;180;263;196;262;217;244 06:35:10 INFO - PROCESS | 2259 | |3;audio-fft;71;83;78;146;57;57;59;60;129;50 06:35:10 INFO - PROCESS | 2259 | |4;audio-oscillator;82;87;132;100;101;104;116;87;103;145 06:35:10 INFO - PROCESS | 2259 | |5;imaging-gaussian-blur;89;99;90;80;134;86;96;130;115;85 06:35:10 INFO - PROCESS | 2259 | |6;imaging-darkroom;94;96;95;101;97;105;147;125;95;94 06:35:10 INFO - PROCESS | 2259 | |7;imaging-desaturate;90;93;98;89;140;88;148;131;83;151 06:35:10 INFO - PROCESS | 2259 | |8;json-parse-financial;56;57;58;57;62;57;59;58;56;62 06:35:10 INFO - PROCESS | 2259 | |9;json-stringify-tinderbox;67;72;74;70;81;78;77;105;107;108 06:35:10 INFO - PROCESS | 2259 | |10;stanford-crypto-aes;88;86;85;88;103;103;105;86;89;95 06:35:10 INFO - PROCESS | 2259 | |11;stanford-crypto-ccm;164;161;162;147;150;162;159;162;250;132 06:35:10 INFO - PROCESS | 2259 | |12;stanford-crypto-pbkdf2;180;163;176;198;228;248;205;172;179;208 06:35:10 INFO - PROCESS | 2259 | |13;stanford-crypto-sha256-iterative;70;68;77;88;98;91;92;86;79;68 06:35:10 INFO - PROCESS | 2259 | __end_tp_report 06:35:10 INFO - PROCESS | 2259 | __start_cc_report 06:35:10 INFO - PROCESS | 2259 | _x_x_mozilla_cycle_collect,1122 06:35:10 INFO - PROCESS | 2259 | __end_cc_report 06:35:10 INFO - PROCESS | 2259 | __startTimestamp1468503310967__endTimestamp 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | ------- Summary: start ------- 06:35:10 INFO - PROCESS | 2259 | Number of tests: 14 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#0] ai-astar Cycles:10 Average:113.20 Median:115.50 stddev:5.01 (4.3%) stddev-sans-first:4.06 06:35:10 INFO - PROCESS | 2259 | Values: 104.0 115.0 105.0 114.0 116.0 116.0 111.0 115.0 118.0 118.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:147.00 stddev:25.03 (17.0%) stddev-sans-first:26.14 06:35:10 INFO - PROCESS | 2259 | Values: 151.0 135.0 118.0 184.0 143.0 155.0 131.0 107.0 158.0 103.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#2] audio-dft Cycles:10 Average:230.70 Median:251.50 stddev:33.84 (13.5%) stddev-sans-first:33.76 06:35:10 INFO - PROCESS | 2259 | Values: 198.0 275.0 213.0 259.0 180.0 263.0 196.0 262.0 217.0 244.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#3] audio-fft Cycles:10 Average:79.00 Median:59.50 stddev:32.73 (55.0%) stddev-sans-first:34.58 06:35:10 INFO - PROCESS | 2259 | Values: 71.0 83.0 78.0 146.0 57.0 57.0 59.0 60.0 129.0 50.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#4] audio-oscillator Cycles:10 Average:105.70 Median:138.50 stddev:20.19 (14.6%) stddev-sans-first:19.51 06:35:10 INFO - PROCESS | 2259 | Values: 82.0 87.0 132.0 100.0 101.0 104.0 116.0 87.0 103.0 145.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#5] imaging-gaussian-blur Cycles:10 Average:100.40 Median:87.50 stddev:19.26 (22.0%) stddev-sans-first:19.98 06:35:10 INFO - PROCESS | 2259 | Values: 89.0 99.0 90.0 80.0 134.0 86.0 96.0 130.0 115.0 85.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#6] imaging-darkroom Cycles:10 Average:104.90 Median:94.50 stddev:17.53 (18.6%) stddev-sans-first:18.15 06:35:10 INFO - PROCESS | 2259 | Values: 94.0 96.0 95.0 101.0 97.0 105.0 147.0 125.0 95.0 94.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#7] imaging-desaturate Cycles:10 Average:111.10 Median:88.50 stddev:27.77 (31.4%) stddev-sans-first:28.39 06:35:10 INFO - PROCESS | 2259 | Values: 90.0 93.0 98.0 89.0 140.0 88.0 148.0 131.0 83.0 151.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:2.20 (3.8%) stddev-sans-first:2.19 06:35:10 INFO - PROCESS | 2259 | Values: 56.0 57.0 58.0 57.0 62.0 57.0 59.0 58.0 56.0 62.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#9] json-stringify-tinderbox Cycles:10 Average:83.90 Median:73.00 stddev:16.22 (22.2%) stddev-sans-first:16.01 06:35:10 INFO - PROCESS | 2259 | Values: 67.0 72.0 74.0 70.0 81.0 78.0 77.0 105.0 107.0 108.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#10] stanford-crypto-aes Cycles:10 Average:92.80 Median:87.00 stddev:8.00 (9.2%) stddev-sans-first:8.29 06:35:10 INFO - PROCESS | 2259 | Values: 88.0 86.0 85.0 88.0 103.0 103.0 105.0 86.0 89.0 95.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#11] stanford-crypto-ccm Cycles:10 Average:164.90 Median:162.00 stddev:31.52 (19.5%) stddev-sans-first:33.43 06:35:10 INFO - PROCESS | 2259 | Values: 164.0 161.0 162.0 147.0 150.0 162.0 159.0 162.0 250.0 132.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.70 Median:201.50 stddev:27.01 (13.4%) stddev-sans-first:28.05 06:35:10 INFO - PROCESS | 2259 | Values: 180.0 163.0 176.0 198.0 228.0 248.0 205.0 172.0 179.0 208.0 06:35:10 INFO - PROCESS | 2259 | 06:35:10 INFO - PROCESS | 2259 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.70 Median:87.00 stddev:10.84 (12.5%) stddev-sans-first:10.64 06:35:10 INFO - PROCESS | 2259 | Values: 70.0 68.0 77.0 88.0 98.0 91.0 92.0 86.0 79.0 68.0 06:35:10 INFO - PROCESS | 2259 | -------- Summary: end -------- 06:35:10 INFO - PROCESS | 2259 | 06:35:11 INFO - TEST-INFO | 2259: exit 0 06:35:11 INFO - TEST-OK | kraken | took 61670ms 06:35:11 INFO - SUITE-END | took 1174s 06:35:12 INFO - Completed test suite (00:19:35) 06:35:12 INFO - javascript benchmark 06:35:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7484.674790648588, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.6068602110763, 3426.657334266573, 3450.5341778859847, 3451.6203217646057, 3464.064702530315, 5746.281714785652, 5821.864736376403, 5836.095405212199, 5843.883122337551, 5850.970745146279, 4451.399061126747, 5491.395946445888, 5844.824655260339, 5847.941520584793, 5862.970685146568, 5249.448807875166, 5290.709011004393, 5316.9202461962905, 5369.892602147955, 5419.783208671648, 5333.146696528556, 5417.83746487606, 5470.972645136789, 5498.257735205756, 5519.558435325164, 5208.8958220835375, 5266.7366631668265, 5309.41596424393, 5320.148776195829, 5357.357117145929, 5252.36971563411, 5329.094054010789, 5338.866528336823, 5347.759350829222, 5363.892722145574, 5202.973985130088, 5277.86805329866, 5292.0, 5304.946950530484, 5367.2485851980755, 5666.943330566683, 5731.0, 5806.274215723035, 5873.706314684291, 5901.852453688649, 6145.754169833202, 6189.6286222826775, 6247.344028876948, 6253.53098517613, 6269.0909818076125, 6146.385361463863, 6166.07508873668, 6239.438450539428, 6247.4377306042215, 6252.2809876864285, 5879.911801322984, 5961.374055724086, 5964.314103878023, 5966.671833049224, 6005.0, 6383.36166383358, 6415.967920160369, 6424.38968298011, 6452.9677351612945, 6475.676216189172, 6084.239470066242, 6127.158986117706, 6146.508279337642, 6242.032484964838, 6264.498840092781, 6217.626942383471, 6244.562880598405, 6265.686715664198, 6273.1844860167885, 6288.339724328971, 6024.698765061817, 6111.774065234738, 6122.357152498924, 6184.257889053342, 6246.656433896179, 6121.57491608479, 6135.07973803933, 6151.200343955257, 6178.969105154535, 6227.470664993436, 5007.774650140753, 5008.5993120550265, 5021.121303771825, 5023.79904803811, 5035.571976382049, 4486.1924853526025, 4520.118576877478, 4527.954720452819, 4537.546245375502, 4576.519465456146, 5710.942890571124, 5881.882442335943, 5923.466887980103, 5973.253343332083, 5975.133605627159, 6260.060990851318, 6260.342664020212, 6301.275353334334, 6310.652914089677, 6327.746890124344, 5996.310424301174, 6017.849553761191, 6018.428249316308, 6038.818835434944, 6056.182415373868, 5370.248165256867, 5453.291072160594, 5470.316210473611, 5515.200295957064, 5521.1442226454965, 6401.679916004181, 6411.96794016027, 6453.128827608401, 6453.838654033687, 6477.578957367756, 5325.4940780625775, 6138.32709113608, 6298.685065746786, 6302.842428939313, 6305.464035557029, 6366.490680745436, 6392.232932048184, 6416.935830641821, 6476.643784591893, 6493.772717954849, 6160.414760597736, 6170.074488826533, 6221.222347206599, 6231.719572619152, 6269.185005949197, 5181.974090129525, 6149.2620885494025, 6165.321814600301, 6256.31180570146, 6277.148241268928, 4451.910961780682, 5091.007253585515, 6138.0179171332375, 6213.316535181036, 6213.65824879636, 6171.59884607499, 6198.442140207403, 6213.502919766498, 6224.284207316216, 6228.5951413158, 5982.670953097448, 6068.241469816273, 6088.0, 6140.293866205444, 6143.815685529441, 5620.8875822482505, 5745.569082318759, 6045.818625441244, 6144.972159187368, 6265.872143014301, 6133.3866613338305, 6141.385861413823, 6146.661933593696, 6169.84575385619, 6170.969145154246], "value": 5755.935680475841, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.2703479810511, 495.20519566096414, 520.6511637203074, 523.6674711558164, 559.3399788249865, 35333.0, 42724.57275427245, 42729.57270427295, 42782.78608606953, 42860.14279714408, 43427.34858977118, 43475.91310217246, 43771.12457750843, 44097.7795111024, 44185.0, 9596.896356918975, 9650.613975440974, 9719.46542940138, 9794.608215671364, 9799.363041402321, 9718.125368716814, 9721.90278097217, 9780.0, 9805.509724513782, 9843.114119729224, 9848.16290615295, 9852.90147098527, 9876.40741555509, 9876.60493580256, 9893.0, 9802.019798020212, 9859.50702464874, 9865.852012219822, 9865.950670246675, 9885.0, 9574.760630984212, 9657.130858222794, 9711.36876103051, 9733.270004749673, 9748.366356186825, 41227.0, 41594.79202603998, 41863.37204941928, 42196.73409797711, 42209.0, 3418.574020229136, 3539.2213712983103, 3546.414841551141, 3678.2643471305846, 3973.4238535412205, 31502.36995260082, 33487.6651233487, 33632.0, 33646.65413383486, 33708.662913371045, 2702.297402675299, 3325.617553981299, 3427.674370934757, 3446.172918499567, 3447.9827600862086, 447786.0, 524238.0, 528149.4370112615, 538518.3074084644, 538807.0, 58493.0, 69514.65242673755, 70607.0, 70623.58752825018, 70830.64584677044, 73941.0, 74173.62913185508, 74347.25652743512, 74583.25416745871, 74596.0, 17451.47645570635, 17635.29458821633, 17651.646967060587, 17656.735148972777, 17673.381431649832, 13150.342482875818, 13223.73552528944, 13313.201207927556, 13322.66693332655, 13334.266615336055, 17901.297540453936, 20367.4908127298, 21376.931153442576, 21446.0, 21646.91765411723, 3295.24209431832, 3414.197663549064, 3422.3155368926314, 8901.287896968228, 9112.134347237003, 861.8190180062131, 961.9711408657752, 968.8885778135464, 999.8550210219478, 1061.1563806773634, 30805.921792737594, 31183.844080779905, 31272.530912036338, 31722.365552688818, 31783.0, 1029.5109822834095, 1076.9030787229187, 1078.6278733836814, 1093.0217455377392, 1149.3563604381573, 13230.07389482727, 13431.798523022162, 15542.889058440362, 16260.349586016428, 17129.97220166794, 594682.0, 708765.0, 717310.0, 719525.0, 720934.0, 63653.04520432197, 64238.67880660567, 64532.67733661395, 65009.34990650127, 65666.01500977488, 1396.727638110579, 1435.1174027972722, 1443.083641887388, 1443.162965480019, 1444.5377479206763, 29382.706172937997, 30397.240068998453, 30618.693813061585, 30623.693763062085, 31887.6811231894, 54515.72742136264, 55672.72163639156, 56253.437465626455, 56624.15063773964, 56637.71681141568, 553189.0, 653718.0, 662412.0, 665205.0, 666815.0, 27941.0, 28126.43747125087, 28289.292767680974, 28664.14007579776, 28742.568861466676, 40748.592514075666, 49034.264486033455, 51494.0, 51816.74091629518, 51860.74069629628, 35898.8205058973, 41908.58091419047, 42547.36178957256, 43084.35373469338, 43125.353119703854, 41462.0, 41765.95585110275, 41848.0, 42014.78992605017, 42635.786821065696, 39923.60076399199, 40513.1897362057, 40764.79617601893, 40866.79566602267, 41038.79480602578, 34855.30289394147, 36168.09579760527, 36682.8165859169, 36831.63168368282, 36886.815565922, 25256.747432526176, 26465.073722419624, 26509.0, 26873.462530749668, 26878.193654190407], "value": 20864.51975337575, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.25445203771136, 379.0, 383.57040115071123, 396.83333000139936, 410.29019795753345, 20070.89964550177, 20588.485287867774, 21051.578968420643, 21563.676544851838, 21755.67366489502, 20933.371998840023, 21091.6836247456, 21381.358559243246, 21522.677159842617, 22073.779262207372, 5447.6731396116165, 5975.880482390338, 6155.72299246535, 6158.230221222348, 6171.321154672983, 5112.565431938289, 6051.606645568024, 6070.696465176746, 6106.603070800406, 6112.419320164578, 5299.973500132513, 5435.239066530688, 5993.820185394424, 5999.13012613173, 6005.669688167149, 5533.75490514635, 5864.032434648278, 5930.199423077873, 5976.057781221099, 6035.939640603604, 4926.334944782444, 5255.6583822051825, 5260.631755777097, 5285.867853303698, 5287.735613219362, 25384.238472845846, 26887.0, 26914.46171076587, 26982.460350792873, 27104.32239194016, 2308.90764369425, 2328.5459335429596, 2341.4731685370825, 2470.407102295454, 2526.633638122462, 15939.282732276959, 16140.0, 16280.267387967451, 16314.184290785532, 16331.510054698378, 1884.0014792160177, 1885.5945971616168, 1887.565859852228, 1889.5465088378828, 1930.3340347580063, 89664.10335896688, 111639.0, 119440.40279798632, 119447.99999999913, 126099.0, 9186.77033074165, 9683.564239609093, 10445.373277603368, 10594.364338139736, 11141.331520108819, 14252.144871307755, 14329.498467553585, 14337.35481903317, 14340.21128837903, 14343.56969290902, 8765.517896515752, 8993.28053755711, 8997.415168014059, 9072.727818165333, 9418.62325506972, 9126.954365228132, 9127.132922372364, 9128.49793261377, 9217.815643687089, 9288.164065234027, 7019.262977387403, 7049.9647501762165, 7119.75080872167, 7131.679074441663, 7168.74546954281, 1673.3306677329165, 1864.794872564017, 1951.756030496188, 1970.467973647136, 1972.3392663457616, 856.246503077288, 961.7595601099725, 973.7390079846616, 995.5121990224737, 1081.4971038467152, 22213.000414981365, 22822.543549128924, 22855.0, 23015.7698423017, 23086.769132308462, 907.600655711498, 1013.9847902281472, 1017.7455636090978, 1021.6832781837654, 1084.1976937066672, 10518.947405263078, 12161.0, 12269.202501837352, 12474.75050499003, 12482.063845211645, 541564.0, 559412.0, 560478.0, 577214.0, 585453.0, 118746.0, 119793.0, 122071.0, 122616.25513893084, 123325.76674233322, 1020.5203554329453, 1021.9948900255451, 1045.0646671229208, 1049.239301506417, 1050.485262221506, 15687.843121568638, 20135.89932050389, 20294.898525507277, 20621.865797381288, 20790.376288711363, 53328.73335633297, 53657.0, 53845.461545384045, 54432.0, 55356.169657455976, 79958.4008319842, 81019.78470322832, 83083.0, 84474.57762711147, 85500.0, 6528.804135875931, 7107.502474826712, 7853.646585903533, 8103.87844182326, 8174.509529428254, 8579.399442038997, 11817.581890173235, 12009.699757506132, 13119.409626567018, 13400.865991339962, 9300.906990930003, 11138.164637652371, 11140.665780026613, 11157.609483668033, 11200.327980321206, 11152.16358773079, 11358.432078395881, 11381.260218085798, 11414.771704566028, 11505.309681419141, 9632.181264592307, 11108.833777413327, 11473.598424055119, 11627.709307267385, 11882.465289062186, 7112.57324560528, 8385.245327920517, 8462.830743384975, 8556.486610803371, 8702.347323950855, 10758.784824303313, 11344.20590558686, 11390.886091139315, 11412.258203216765, 11648.184627076023], "value": 9909.40130248008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.1142737212417, 1577.7475603903379, 1672.3310675729706, 1717.8404576910582, 1847.2795609712223, 8206.302464290527, 8754.037055923844, 8793.252573531257, 9232.261419086473, 9259.629614815407, 8796.208341249287, 8852.601632926519, 8994.370394072417, 8999.460032398061, 9010.369274150811, 2007.8393728501758, 2399.3042017814814, 2411.6141417373224, 2415.5168966206743, 2431.465077682907, 2380.381100913766, 2405.2303262955775, 2407.8555286682767, 2430.5989511730545, 2448.959192343256, 2395.5089206712582, 2413.650020746991, 2417.226487523993, 2419.721732000825, 2451.7915977141965, 2380.357553288243, 2386.4988352446007, 2390.175389490623, 2399.4961058177805, 2406.338256979327, 2363.527294541099, 2376.9405764856015, 2379.452725873042, 2386.7016622922133, 2387.2957477544164, 8878.600462979182, 8889.244414224799, 9090.86363704545, 9162.267018638493, 9179.862302065474, 5345.305110335631, 5353.544948679367, 5459.2902922619805, 5531.502164805187, 5538.501534861842, 3595.496630471736, 3679.871204507856, 3748.11919198988, 3748.538070152643, 3750.3811871041244, 1073.5920350266927, 1078.3314345106085, 1083.7615724540588, 1087.4508373271447, 1098.3025778630547, 11681.883181168165, 12086.818697719542, 12173.573924912585, 12297.69255768604, 12309.569165079269, 4458.464984201916, 4472.843450479218, 4672.112298663243, 4690.437147542249, 4713.222318317507, 9377.578008989612, 9513.476758778334, 9522.666706665372, 9535.952320238493, 9539.570719317648, 5326.493983071602, 5333.413324534298, 5335.973320133375, 5342.091844386464, 5351.304330437096, 4454.1982443159895, 4789.748818055508, 4956.959038601934, 4958.851234462972, 4977.104121258209, 3851.383778595411, 3911.5697273299916, 3940.4877365942243, 3944.1914407546383, 4035.6569691576547, 1188.2751521572006, 1197.0543270815958, 1205.7769312677183, 1206.1677442564603, 1206.7224538356227, 838.5471845203643, 897.4121950122681, 940.9717708468756, 944.1596978688972, 946.7680418297562, 5354.437784032699, 6051.8487037823525, 6122.785702500391, 6247.687615619201, 6265.404786545271, 434.41137259014215, 447.4228245563252, 449.0905915521031, 462.55132521454135, 463.11776066593194, 4205.516365617932, 4252.0, 4271.594198551133, 4318.050028993616, 4326.956730432718, 10779.407132607625, 11158.386288754034, 11167.776644467227, 11261.66215013551, 11298.830517542243, 10692.89307106919, 11065.004149626573, 11133.276337038067, 11206.413947536874, 11208.04731597807, 6662.83342916431, 7276.381507571916, 7728.729494467667, 8424.957875210584, 8539.23146916793, 6119.541034422347, 6336.049592561153, 6378.968105159444, 6401.839954001187, 6423.669816011934, 9681.51592420362, 10250.128739056965, 10263.384196948207, 10517.316374435637, 10526.473676316, 10150.746231344276, 10511.10655594283, 10535.63125290611, 10542.26204165701, 10543.367397956146, 6894.448444124358, 7155.069840920647, 7653.0, 7853.764387068397, 7999.400044996765, 8795.868061979203, 8827.646894124164, 8877.955610221907, 8882.200601945857, 8895.288376929959, 7599.848003039798, 7778.338841198335, 7843.490173138728, 7872.252136047066, 7875.094364147967, 7566.924330756622, 7597.734079307198, 7620.0, 7624.80937976555, 7792.337651299703, 7227.349538541556, 7239.963800180965, 7283.016792733125, 7286.234945330664, 7306.561606303639, 5072.213806859942, 5168.896622067613, 5225.947740522698, 5252.212168174804, 5267.57859371257, 4942.728149951788, 5355.116405793001, 5406.5945054121885, 5406.675599464044, 5588.441155884379], "value": 4598.558164687038, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.96150481189835, 311.6276050120107, 315.0941044497071, 323.15817295944066, 323.43399051659594, 4658.347831303616, 5394.32570928634, 5418.458154184579, 5494.780208791649, 5598.888022239553, 3997.460342853714, 4561.908761824761, 5079.2635067915135, 5514.448555144483, 5553.666779993203, 3121.4069326827944, 3422.709069729076, 3780.546334439857, 4205.897051474255, 4226.366045093245, 3747.288015277102, 3956.3076461619244, 4146.274401979656, 4158.812853421603, 4240.5547417521175, 3403.557537520119, 4114.7119701620895, 4224.176285624305, 4225.598568136023, 4279.358096285567, 3522.5772907251167, 4209.326507758775, 4239.915201695964, 4244.686645778058, 4289.6997210195295, 3045.482268014443, 3671.614480479538, 3674.8713795017047, 3679.0434487033294, 3686.631336866292, 4344.892052526586, 4558.726476411426, 4753.928691069636, 4807.735574543399, 5469.617126801126, 4493.820247190109, 4868.513148685139, 4890.046440944017, 4890.75546222691, 4904.141775189328, 5112.488751124895, 5937.376575459558, 5949.762009519614, 5992.191054207669, 6026.186464827236, 3017.969820301791, 3332.783369081002, 3602.423612222032, 3915.158240978203, 3949.0917089069676, 5363.383210930754, 5875.648600821793, 5921.348651648315, 6296.181496405484, 6299.0, 4003.239384516991, 4036.233115708006, 4042.555318914917, 4056.006278461796, 4057.918841623151, 3866.8646597368956, 4066.9796651016554, 4104.753714777123, 4112.691548133902, 4138.193052354762, 4048.615381538808, 4174.893653181909, 4378.299472084451, 4549.476810166807, 4794.184988551954, 5909.758950620418, 5923.407659234128, 6039.275286965592, 6049.939500605025, 6081.695915204222, 1239.2254840724547, 1273.961781146567, 1300.7398520295978, 1322.9007824413015, 1354.6884216630033, 884.4737381258141, 907.2968449451596, 928.03020843219, 936.180841763457, 936.7143021378545, 4754.405699287589, 5400.21696853954, 5421.213923981, 5480.698561579072, 5481.479259470344, 5684.658920464785, 5956.374580669054, 5969.432903874125, 6037.396260373927, 6063.090536419572, 4332.436783218224, 4661.673682842236, 4804.918893249061, 5265.8156964506825, 5528.9723551381985, 2301.5166814969043, 2670.826396284235, 2690.30052186429, 2699.056679190979, 2771.210205091539, 4557.584480225486, 4855.9074208303555, 5188.860739252697, 5236.6857988520815, 5271.341082364705, 4586.4266966629175, 5178.559822415062, 5647.6733001410685, 6344.6827658616885, 6377.999999999907, 6414.935850641434, 6422.81624247758, 6441.326849357464, 6441.64570948593, 6479.935200647933, 5657.387644521292, 5903.852403689943, 6100.938990610037, 6169.629822210682, 6177.779776089197, 4903.264510323337, 5761.251037365116, 5865.530757539302, 6009.098635204754, 6027.547933904887, 5293.894122117613, 5444.754986025559, 6098.725557349841, 6411.294757576569, 6437.485001199986, 3274.950875736818, 3390.2371966307383, 3815.21788033458, 4037.454943582579, 4063.6139566741113, 5542.196381524737, 5783.537317014713, 6071.241094863142, 6138.907916381348, 6149.2313460817395, 4906.0, 5172.948270517247, 5239.476052394883, 5759.58097599001, 5909.911351329648, 4685.765711714469, 5626.156076588544, 5647.119968815851, 5816.749398879261, 6021.765538064774, 4871.269309603588, 5353.955978584138, 5567.69377684215, 5593.328800543961, 5842.357340692605, 5955.553333500092, 5972.671503067199, 5979.641221526722, 6012.458878700938, 6037.335893051849, 5111.616628752784, 5180.912008478262, 5785.479306862402, 5819.912701309569, 5836.620619659709], "value": 4161.890677302806, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.4687314204638, 717.9928200717991, 720.5640587444595, 788.3574886467528, 863.6329559937027, 15045.473408430707, 15283.770743438843, 15522.689546209069, 15866.603334916634, 15901.443449479271, 12214.69463263419, 13271.668208294797, 14380.49668261611, 14383.928080359583, 14462.783058254134, 877.4209022045467, 893.9418937769057, 897.3718397122008, 902.2285945516587, 905.108468158863, 860.9053004169537, 900.5362238447204, 902.4044130873625, 902.9909700903005, 903.5978989349742, 799.472348250155, 905.0994260710602, 933.8785957825473, 940.5908429833011, 954.3415043619915, 908.2552307108174, 914.8947870994854, 930.2836815651943, 947.3794664494733, 950.7005293332578, 694.6873906741986, 702.9156501219835, 710.3180946291566, 712.0636363182399, 713.6110819603276, 10678.25252232344, 12774.041946854024, 12797.0, 12805.935970320088, 12903.612891613173, 12132.272063676208, 12155.270683758914, 12329.321887296195, 12339.444724987397, 12439.626811195678, 8951.328650351184, 9660.37207581505, 10177.440240786755, 10254.846177307347, 10826.783464330749, 3252.869885204589, 3763.9247215055548, 3782.0, 3785.3754130568423, 3823.2926908521736, 103158.0, 103984.0, 106226.0, 106340.0, 106719.46640266827, 9436.811263774685, 9472.431654100776, 9566.091221333962, 9632.373895696757, 9796.020397960147, 20388.184472621226, 20562.074706638236, 20645.380638580868, 20752.896235518725, 20989.68515472269, 7899.526028438312, 8112.878306825402, 8157.1842815717955, 8298.460600060977, 8371.99536055665, 4446.73319600825, 4502.16709908668, 4564.0871825635, 4580.335851301543, 4589.0, 2877.510823160068, 2960.9932622908314, 3227.935441291208, 3501.6673416025437, 3576.2668652926086, 663.6051549328142, 670.6445583840572, 690.1338819781242, 701.6141122382669, 704.5842952657854, 599.9100134979788, 687.779910428658, 698.8608568034072, 708.7094291340628, 715.8210447388153, 7824.921750782533, 9049.457032578066, 9362.251019918527, 9395.812083758423, 9567.569459374345, 617.4072890025536, 639.9584027038228, 653.5784419049686, 681.6762038031994, 687.226869771507, 3839.308924393636, 4409.699138754076, 4570.200214962435, 4573.63410927125, 4643.767811609406, 98718.0, 123479.0, 145153.82269265968, 149263.25368373087, 153238.7014194788, 94050.41647084775, 114729.4263528677, 131536.0, 133080.3345983264, 133165.0, 95914.52042739742, 97175.0, 105337.41993870099, 108247.45876270568, 109063.45468272608, 9598.616055357987, 9646.035396460578, 9750.366226195274, 9818.607255709692, 10035.799284014132, 50854.23718644297, 53877.92244155173, 54816.0, 60310.0, 65399.71101011442, 80130.19869801227, 86380.0, 97183.0, 97391.0, 99892.0, 13217.858742720775, 13264.53574124901, 13277.734445311233, 13395.263260520765, 13493.73012539724, 15227.228602577556, 15328.463503777315, 15447.0731756095, 15459.84540154629, 15748.527544173694, 14174.858251417354, 14433.134011959317, 14686.706265874836, 14810.111393316005, 14864.405423782928, 13786.862131378959, 14105.576832695035, 14580.927095364455, 14608.269586520844, 14698.632534186303, 12403.75192496163, 13553.93223033918, 13892.861071389158, 14498.05762625426, 14531.0, 11233.258844879058, 11270.721535449118, 11460.981616458055, 11686.298822070703, 11696.649100526998, 11280.887191127984, 11325.71685707864, 11440.141989350666, 11583.362915039754, 11645.0], "value": 7718.031035907734, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1660.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 105.0, 114.0, 116.0, 116.0, 111.0, 115.0, 118.0, 118.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 135.0, 118.0, 184.0, 143.0, 155.0, 131.0, 107.0, 158.0, 103.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 275.0, 213.0, 259.0, 180.0, 263.0, 196.0, 262.0, 217.0, 244.0], "value": 230.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 78.0, 146.0, 57.0, 57.0, 59.0, 60.0, 129.0, 50.0], "value": 79.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 132.0, 100.0, 101.0, 104.0, 116.0, 87.0, 103.0, 145.0], "value": 105.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 99.0, 90.0, 80.0, 134.0, 86.0, 96.0, 130.0, 115.0, 85.0], "value": 100.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 101.0, 97.0, 105.0, 147.0, 125.0, 95.0, 94.0], "value": 104.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 98.0, 89.0, 140.0, 88.0, 148.0, 131.0, 83.0, 151.0], "value": 111.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 57.0, 62.0, 57.0, 59.0, 58.0, 56.0, 62.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 74.0, 70.0, 81.0, 78.0, 77.0, 105.0, 107.0, 108.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 85.0, 88.0, 103.0, 103.0, 105.0, 86.0, 89.0, 95.0], "value": 92.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 147.0, 150.0, 162.0, 159.0, 162.0, 250.0, 132.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 163.0, 176.0, 198.0, 228.0, 248.0, 205.0, 172.0, 179.0, 208.0], "value": 195.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 77.0, 88.0, 98.0, 91.0, 92.0, 86.0, 79.0, 68.0], "value": 81.7, "unit": "score"}]}]} 06:35:12 INFO - Return code: 0 06:35:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:35:12 ERROR - # TBPL SUCCESS # 06:35:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:35:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:35:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:35:12 INFO - 2016-07-14 06:35:12.309 screenresolution[2264:14182] starting screenresolution argv=screenresolution get 06:35:12 INFO - 2016-07-14 06:35:12.312 screenresolution[2264:14182] Display 0: 1600x1200x32@60 06:35:12 INFO - 2016-07-14 06:35:12.317 screenresolution[2265:14185] starting screenresolution argv=screenresolution list 06:35:12 INFO - Available Modes on Display 0 06:35:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:35:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:35:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:35:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:35:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:35:12 INFO - Intel Iris: 06:35:12 INFO - Chipset Model: Intel Iris 06:35:12 INFO - Type: GPU 06:35:12 INFO - Bus: Built-In 06:35:12 INFO - VRAM (Dynamic, Max): 1536 MB 06:35:12 INFO - Vendor: Intel (0x8086) 06:35:12 INFO - Device ID: 0x0a2e 06:35:12 INFO - Revision ID: 0x0009 06:35:12 INFO - Displays: 06:35:12 INFO - Display: 06:35:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:35:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:35:12 INFO - Display Serial Number: 1600x1200 60 06:35:12 INFO - Main Display: Yes 06:35:12 INFO - Mirror: Off 06:35:12 INFO - Online: Yes 06:35:12 INFO - Rotation: Supported 06:35:12 INFO - Return code: 0 06:35:12 INFO - Running post-action listener: _resource_record_post_action 06:35:12 INFO - ##### 06:35:12 INFO - ##### Finished run-tests step (success) 06:35:12 INFO - ##### 06:35:12 INFO - Running post-run listener: _resource_record_post_run 06:35:12 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 274432; Write bytes: 709608448; Read time: 6; Write time: 1959 06:35:12 INFO - TinderboxPrint: CPU usage
54.2% 06:35:12 INFO - TinderboxPrint: I/O read bytes / time
274,432 / 6 06:35:12 INFO - TinderboxPrint: I/O write bytes / time
709,608,448 / 1,959 06:35:12 INFO - TinderboxPrint: CPU idle
2,216.7 (45.8%) 06:35:12 INFO - TinderboxPrint: CPU system
976.8 (20.2%) 06:35:12 INFO - TinderboxPrint: CPU user
1,648.1 (34.0%) 06:35:12 INFO - TinderboxPrint: Swap in / out
407,547,904 / 0 06:35:12 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388160000; Write bytes: 383829504; Read time: 29220; Write time: 748 06:35:12 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 274432; Write bytes: 298520064; Read time: 6; Write time: 1158 06:35:13 INFO - Running post-run listener: _upload_blobber_files 06:35:13 INFO - Blob upload gear active. 06:35:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:13 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 06:35:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:35:13 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:35:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:35:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:14 INFO - (blobuploader) - INFO - Done attempting. 06:35:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:35:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:35:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:15 INFO - (blobuploader) - INFO - Done attempting. 06:35:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:35:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:35:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:17 INFO - (blobuploader) - INFO - Done attempting. 06:35:17 INFO - (blobuploader) - INFO - Iteration through files over. 06:35:17 INFO - Return code: 0 06:35:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:35:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:35:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/222c7dda88a948ebb0b07ef61c96fbf6552ce8a0ba769f575cdb986bb0e75217c73806bf0cea93b01651063f2a25237409ab605c1268895bfae5af4daeb506e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20d3cefd64861a12003685da6799218834b8bdae0117da6fa91a79937239b937608bc2924db15a6f340cd204de094a01da0985e63a8eb0e084251df713fa4e70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79fc72a595606d80f8f4d9e8ba2d2dd5847ebac5a275d3a904822000387a70df199169af9a5163a16dae4385d1a9b8e27df92164773373019e15d20db0842bbf"} 06:35:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:35:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:35:17 INFO - Contents: 06:35:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/222c7dda88a948ebb0b07ef61c96fbf6552ce8a0ba769f575cdb986bb0e75217c73806bf0cea93b01651063f2a25237409ab605c1268895bfae5af4daeb506e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20d3cefd64861a12003685da6799218834b8bdae0117da6fa91a79937239b937608bc2924db15a6f340cd204de094a01da0985e63a8eb0e084251df713fa4e70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79fc72a595606d80f8f4d9e8ba2d2dd5847ebac5a275d3a904822000387a70df199169af9a5163a16dae4385d1a9b8e27df92164773373019e15d20db0842bbf"} 06:35:17 INFO - Running post-run listener: copy_logs_to_upload_dir 06:35:17 INFO - Copying logs to upload dir... 06:35:17 INFO - mkdir: /builds/slave/test/build/upload/logs 06:35:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.040251 ========= master_lag: 0.58 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-14 06:35:18.566663) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:18.570452) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4t3odWYY3V/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/222c7dda88a948ebb0b07ef61c96fbf6552ce8a0ba769f575cdb986bb0e75217c73806bf0cea93b01651063f2a25237409ab605c1268895bfae5af4daeb506e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20d3cefd64861a12003685da6799218834b8bdae0117da6fa91a79937239b937608bc2924db15a6f340cd204de094a01da0985e63a8eb0e084251df713fa4e70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79fc72a595606d80f8f4d9e8ba2d2dd5847ebac5a275d3a904822000387a70df199169af9a5163a16dae4385d1a9b8e27df92164773373019e15d20db0842bbf"} build_url:https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/GZHB-WhoTlGWDo7BaxDGBQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/222c7dda88a948ebb0b07ef61c96fbf6552ce8a0ba769f575cdb986bb0e75217c73806bf0cea93b01651063f2a25237409ab605c1268895bfae5af4daeb506e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20d3cefd64861a12003685da6799218834b8bdae0117da6fa91a79937239b937608bc2924db15a6f340cd204de094a01da0985e63a8eb0e084251df713fa4e70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79fc72a595606d80f8f4d9e8ba2d2dd5847ebac5a275d3a904822000387a70df199169af9a5163a16dae4385d1a9b8e27df92164773373019e15d20db0842bbf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:18.603301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:18.603603) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4t3odWYY3V/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.02KA4eqB2b/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005143 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:18.652697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:35:18.653062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:35:18.653473) ========= ========= Total master_lag: 0.72 =========