builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0356 starttime: 1468865501.93 results: success (0) buildid: 20160718082851 builduid: 650ed7ebe76c4307beb604729a0363e6 revision: 0f4257230dffa106e90cf736df9dbe9859ac5274 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:41.934158) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:41.934662) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:41.934982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:41.958463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:41.958754) ========= 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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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-18 11:11:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.12M=0.001s 2016-07-18 11:11:42 (8.12 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079144 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:42.058429) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:42.058713) ========= 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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.021615 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:42.107341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 11:11:42.107652) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f4257230dffa106e90cf736df9dbe9859ac5274 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f4257230dffa106e90cf736df9dbe9859ac5274 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hjUaE40RMw/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.Vw97AU4ibQ/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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-18 11:11:42,188 truncating revision to first 12 chars 2016-07-18 11:11:42,189 Setting DEBUG logging. 2016-07-18 11:11:42,189 attempt 1/10 2016-07-18 11:11:42,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0f4257230dff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 11:11:43,169 unpacking tar archive at: mozilla-beta-0f4257230dff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.246684 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 11:11:43.375718) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:43.376044) ========= script_repo_revision: 0f4257230dffa106e90cf736df9dbe9859ac5274 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:43.376427) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:43.376685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:43.395110) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-18 11:11:43.395370) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hjUaE40RMw/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.Vw97AU4ibQ/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 11:11:43 INFO - MultiFileLogger online at 20160718 11:11:43 in /builds/slave/test 11:11:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:11:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:43 INFO - {'append_to_log': False, 11:11:43 INFO - 'base_work_dir': '/builds/slave/test', 11:11:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:11:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:43 INFO - 'branch': 'Mozilla-Beta', 11:11:43 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:43 INFO - 'config_files': ('talos/mac_config.py',), 11:11:43 INFO - 'default_actions': ('clobber', 11:11:43 INFO - 'read-buildbot-config', 11:11:43 INFO - 'download-and-extract', 11:11:43 INFO - 'populate-webroot', 11:11:43 INFO - 'create-virtualenv', 11:11:43 INFO - 'install', 11:11:43 INFO - 'run-tests'), 11:11:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:43 INFO - 'download_minidump_stackwalk': True, 11:11:43 INFO - 'download_symbols': 'ondemand', 11:11:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:43 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:43 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:43 INFO - 'installer_path': 'installer.exe', 11:11:43 INFO - 'log_level': 'info', 11:11:43 INFO - 'log_name': 'talos', 11:11:43 INFO - 'log_to_console': True, 11:11:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:11:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:11:43 INFO - 'opt_config_files': (), 11:11:43 INFO - 'pip_index': False, 11:11:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:43 INFO - 'cmd': ('bash', 11:11:43 INFO - '-c', 11:11:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:43 INFO - 'enabled': True, 11:11:43 INFO - 'halt_on_failure': False, 11:11:43 INFO - 'name': 'check_screen_resolution'},), 11:11:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:43 INFO - 'cmd': ('bash', 11:11:43 INFO - '-c', 11:11:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:43 INFO - 'enabled': True, 11:11:43 INFO - 'halt_on_failure': False, 11:11:43 INFO - 'name': 'check_screen_resolution'},), 11:11:43 INFO - 'run_cmd_checks_enabled': True, 11:11:43 INFO - 'sps_profile': False, 11:11:43 INFO - 'sps_profile_interval': 0, 11:11:43 INFO - 'suite': 'dromaeojs', 11:11:43 INFO - 'system_bits': '32', 11:11:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:43 INFO - 'title': 't-yosemite-r7-0356', 11:11:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:43 INFO - 'use_talos_json': True, 11:11:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:43 INFO - 'work_dir': 'build'} 11:11:43 INFO - ##### 11:11:43 INFO - ##### Running clobber step. 11:11:43 INFO - ##### 11:11:43 INFO - Running pre-action listener: _resource_record_pre_action 11:11:43 INFO - Running main action method: clobber 11:11:43 INFO - rmtree: /builds/slave/test/build 11:11:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:45 INFO - Running post-action listener: _resource_record_post_action 11:11:45 INFO - ##### 11:11:45 INFO - ##### Running read-buildbot-config step. 11:11:45 INFO - ##### 11:11:45 INFO - Running pre-action listener: _resource_record_pre_action 11:11:45 INFO - Running main action method: read_buildbot_config 11:11:45 INFO - Using buildbot properties: 11:11:45 INFO - { 11:11:45 INFO - "project": "", 11:11:45 INFO - "product": "firefox", 11:11:45 INFO - "script_repo_revision": "production", 11:11:45 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:11:45 INFO - "repository": "", 11:11:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:11:45 INFO - "buildid": "20160718082851", 11:11:45 INFO - "pgo_build": "False", 11:11:45 INFO - "basedir": "/builds/slave/test", 11:11:45 INFO - "buildnumber": 69, 11:11:45 INFO - "slavename": "t-yosemite-r7-0356", 11:11:45 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:11:45 INFO - "platform": "yosemite_r7", 11:11:45 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:11:45 INFO - "branch": "mozilla-beta", 11:11:45 INFO - "repo_path": "releases/mozilla-beta", 11:11:45 INFO - "revision": "0f4257230dffa106e90cf736df9dbe9859ac5274", 11:11:45 INFO - "stage_platform": "macosx64", 11:11:45 INFO - "builduid": "650ed7ebe76c4307beb604729a0363e6", 11:11:45 INFO - "slavebuilddir": "test" 11:11:45 INFO - } 11:11:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 11:11:45 INFO - Running post-action listener: _resource_record_post_action 11:11:45 INFO - ##### 11:11:45 INFO - ##### Running download-and-extract step. 11:11:45 INFO - ##### 11:11:45 INFO - Running pre-action listener: _resource_record_pre_action 11:11:45 INFO - Running main action method: download_and_extract 11:11:45 INFO - mkdir: /builds/slave/test/build/tests 11:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:45 INFO - https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:11:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 11:11:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 11:11:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 11:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 11:11:46 INFO - Downloaded 1165 bytes. 11:11:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 11:11:46 INFO - Using the following test package requirements: 11:11:46 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:11:46 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:46 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 11:11:46 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:46 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 11:11:46 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:11:46 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:46 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 11:11:46 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:11:46 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:46 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 11:11:46 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:46 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 11:11:46 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:46 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 11:11:46 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:46 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 11:11:46 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 11:11: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')]} 11:11:46 INFO - https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:11:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 11:11:47 INFO - Downloaded 18314770 bytes. 11:11:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:11:50 INFO - Return code: 0 11:11:50 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:50 INFO - https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:11:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 11:11:52 INFO - Downloaded 18314770 bytes. 11:11:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:11:55 INFO - Return code: 0 11:11: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')]} 11:11:55 INFO - https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:11:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 11:11:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 11:11:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 11:11:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 11:11:56 INFO - Downloaded 10840145 bytes. 11:11:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:11:56 INFO - Return code: 0 11:11:56 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')]} 11:11:56 INFO - https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 11:11:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:11:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:11:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 11:11:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 11:11:59 INFO - Downloaded 86190192 bytes. 11:11:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:11:59 INFO - mkdir: /builds/slave/test/properties 11:11:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:11:59 INFO - Writing to file /builds/slave/test/properties/build_url 11:11:59 INFO - Contents: 11:11:59 INFO - build_url:https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:12:00 INFO - Running post-action listener: _resource_record_post_action 11:12:00 INFO - Running post-action listener: set_extra_try_arguments 11:12:00 INFO - ##### 11:12:00 INFO - ##### Running populate-webroot step. 11:12:00 INFO - ##### 11:12:00 INFO - Running pre-action listener: _resource_record_pre_action 11:12:00 INFO - Running main action method: populate_webroot 11:12:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:00 INFO - '--tppagecycles', 11:12:00 INFO - '7'], 11:12:00 INFO - 'tests': ['tsvgm']}}, 11:12:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:12:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:12:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:12:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:12:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:00 INFO - 'talos_options': ['--disable-e10s'], 11:12:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:00 INFO - 'talos_options': ['--disable-e10s'], 11:12:00 INFO - 'tests': ['damp', 'tps']}, 11:12:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:00 INFO - 'tests': ['damp', 'tps']}, 11:12:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:12:00 INFO - 'tests': ['dromaeo_dom']}, 11:12:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:12:00 INFO - 'tests': ['a11yr', 11:12:00 INFO - 'ts_paint', 11:12:00 INFO - 'tpaint', 11:12:00 INFO - 'sessionrestore', 11:12:00 INFO - 'sessionrestore_no_auto_restore', 11:12:00 INFO - 'tabpaint']}, 11:12:00 INFO - 'other-e10s': {'tests': ['a11yr', 11:12:00 INFO - 'ts_paint', 11:12:00 INFO - 'tpaint', 11:12:00 INFO - 'sessionrestore', 11:12:00 INFO - 'sessionrestore_no_auto_restore', 11:12:00 INFO - 'tabpaint']}, 11:12:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:12:00 INFO - 'ts_paint', 11:12:00 INFO - 'tpaint', 11:12:00 INFO - 'sessionrestore', 11:12:00 INFO - 'sessionrestore_no_auto_restore', 11:12:00 INFO - 'tabpaint']}, 11:12:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:12:00 INFO - 'ts_paint', 11:12:00 INFO - 'tpaint', 11:12:00 INFO - 'sessionrestore', 11:12:00 INFO - 'sessionrestore_no_auto_restore', 11:12:00 INFO - 'tabpaint']}, 11:12:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:12:00 INFO - 'tests': ['a11yr', 11:12:00 INFO - 'ts_paint', 11:12:00 INFO - 'tpaint', 11:12:00 INFO - 'sessionrestore', 11:12:00 INFO - 'sessionrestore_no_auto_restore', 11:12:00 INFO - 'tabpaint']}, 11:12:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:12:00 INFO - 'tests': ['a11yr', 11:12:00 INFO - 'ts_paint', 11:12:00 INFO - 'tpaint', 11:12:00 INFO - 'sessionrestore', 11:12:00 INFO - 'sessionrestore_no_auto_restore', 11:12:00 INFO - 'tabpaint']}, 11:12:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:12:00 INFO - 'tests': ['tsvgx', 11:12:00 INFO - 'tsvgr_opacity', 11:12:00 INFO - 'tart', 11:12:00 INFO - 'tscrollx', 11:12:00 INFO - 'cart']}, 11:12:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:12:00 INFO - 'tsvgr_opacity', 11:12:00 INFO - 'tart', 11:12:00 INFO - 'tscrollx', 11:12:00 INFO - 'cart']}, 11:12:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:00 INFO - 'talos_options': ['--disable-e10s'], 11:12:00 INFO - 'tests': ['tp5o']}, 11:12:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:00 INFO - 'tests': ['tp5o']}, 11:12:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:00 INFO - 'talos_options': ['--disable-e10s', 11:12:00 INFO - '--xperf_path', 11:12:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:00 INFO - 'tests': ['tp5n']}, 11:12:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:00 INFO - 'talos_options': ['--xperf_path', 11:12:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:00 INFO - 'tests': ['tp5n']}}, 11:12:00 INFO - 'talos.zip': {'path': '', 11:12:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:00 INFO - Running post-action listener: _resource_record_post_action 11:12:00 INFO - ##### 11:12:00 INFO - ##### Running create-virtualenv step. 11:12:00 INFO - ##### 11:12:00 INFO - Running pre-action listener: _resource_record_pre_action 11:12:00 INFO - Running main action method: create_virtualenv 11:12:00 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:00 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 11:12:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:00 INFO - Using real prefix '/tools/python27' 11:12:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:01 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:04 INFO - Installing pip.................done. 11:12:04 INFO - Return code: 0 11:12:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:04 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 0x104136a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104146420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca8bdba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fd5e00>, '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 0x103e3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fd0b20>, '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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 11:12:04 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 11:12:04 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 11:12:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hjUaE40RMw/Render', 11:12:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:04 INFO - 'HOME': '/Users/cltbld', 11:12:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:04 INFO - 'LOGNAME': 'cltbld', 11:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:04 INFO - 'MOZ_NO_REMOTE': '1', 11:12:04 INFO - 'NO_EM_RESTART': '1', 11:12:04 INFO - 'PAGER': '/bin/cat', 11:12:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:04 INFO - 'PWD': '/builds/slave/test', 11:12:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:04 INFO - 'SHELL': '/bin/bash', 11:12:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vw97AU4ibQ/Listeners', 11:12:04 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 11:12:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:04 INFO - 'USER': 'cltbld', 11:12:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:04 INFO - 'XPC_FLAGS': '0x0', 11:12:04 INFO - 'XPC_SERVICE_NAME': '0', 11:12:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:04 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 11:12:04 INFO - Cleaning up... 11:12:04 INFO - Return code: 0 11:12:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:04 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104136a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104146420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca8bdba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fd5e00>, '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 0x103e3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fd0b20>, '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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 11:12:04 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>=0.7.1'] in /builds/slave/test/build 11:12:04 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>=0.7.1 11:12:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hjUaE40RMw/Render', 11:12:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:04 INFO - 'HOME': '/Users/cltbld', 11:12:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:04 INFO - 'LOGNAME': 'cltbld', 11:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:04 INFO - 'MOZ_NO_REMOTE': '1', 11:12:04 INFO - 'NO_EM_RESTART': '1', 11:12:04 INFO - 'PAGER': '/bin/cat', 11:12:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:04 INFO - 'PWD': '/builds/slave/test', 11:12:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:04 INFO - 'SHELL': '/bin/bash', 11:12:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vw97AU4ibQ/Listeners', 11:12:04 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 11:12:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:04 INFO - 'USER': 'cltbld', 11:12:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:04 INFO - 'XPC_FLAGS': '0x0', 11:12:04 INFO - 'XPC_SERVICE_NAME': '0', 11:12:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:04 INFO - Downloading/unpacking psutil>=0.7.1 11:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:07 INFO - Installing collected packages: psutil 11:12:07 INFO - Running setup.py install for psutil 11:12:08 INFO - building 'psutil._psutil_osx' extension 11:12:08 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 11:12:08 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 11:12:08 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 11:12:08 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 11:12:08 INFO - building 'psutil._psutil_posix' extension 11:12:08 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 11:12:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:12:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:12:08 INFO - ^ 11:12:08 INFO - 1 warning generated. 11:12:08 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 11:12:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:08 INFO - Successfully installed psutil 11:12:08 INFO - Cleaning up... 11:12:08 INFO - Return code: 0 11:12:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:08 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104136a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104146420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca8bdba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fd5e00>, '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 0x103e3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fd0b20>, '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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 11:12:08 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.0.0'] in /builds/slave/test/build 11:12:08 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.0.0 11:12:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hjUaE40RMw/Render', 11:12:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:08 INFO - 'HOME': '/Users/cltbld', 11:12:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:08 INFO - 'LOGNAME': 'cltbld', 11:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:08 INFO - 'MOZ_NO_REMOTE': '1', 11:12:08 INFO - 'NO_EM_RESTART': '1', 11:12:08 INFO - 'PAGER': '/bin/cat', 11:12:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:08 INFO - 'PWD': '/builds/slave/test', 11:12:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:08 INFO - 'SHELL': '/bin/bash', 11:12:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vw97AU4ibQ/Listeners', 11:12:08 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 11:12:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:08 INFO - 'USER': 'cltbld', 11:12:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:08 INFO - 'XPC_FLAGS': '0x0', 11:12:08 INFO - 'XPC_SERVICE_NAME': '0', 11:12:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:12:09 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 11:12:09 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 11:12:09 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 11:12:09 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 11:12:09 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 11:12:09 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 11:12:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:12:11 INFO - Installing collected packages: mozsystemmonitor 11:12:11 INFO - Running setup.py install for mozsystemmonitor 11:12:11 INFO - Successfully installed mozsystemmonitor 11:12:11 INFO - Cleaning up... 11:12:11 INFO - Return code: 0 11:12:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:11 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 0x104136a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104146420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca8bdba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fd5e00>, '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 0x103e3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fd0b20>, '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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 11:12:11 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 11:12:11 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 11:12:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hjUaE40RMw/Render', 11:12:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:11 INFO - 'HOME': '/Users/cltbld', 11:12:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:11 INFO - 'LOGNAME': 'cltbld', 11:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:11 INFO - 'MOZ_NO_REMOTE': '1', 11:12:11 INFO - 'NO_EM_RESTART': '1', 11:12:11 INFO - 'PAGER': '/bin/cat', 11:12:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:11 INFO - 'PWD': '/builds/slave/test', 11:12:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:11 INFO - 'SHELL': '/bin/bash', 11:12:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vw97AU4ibQ/Listeners', 11:12:11 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 11:12:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:11 INFO - 'USER': 'cltbld', 11:12:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:11 INFO - 'XPC_FLAGS': '0x0', 11:12:11 INFO - 'XPC_SERVICE_NAME': '0', 11:12:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:12 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:12 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 11:12:12 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 11:12:12 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 11:12:12 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 11:12:12 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 11:12:12 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 11:12:14 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:14 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 11:12:14 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 11:12:14 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 11:12:14 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 11:12:14 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 11:12:14 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 11:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:15 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 11:12:15 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 11:12:15 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 11:12:15 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 11:12:15 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 11:12:15 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 11:12:15 INFO - Downloading docopt-0.6.1.tar.gz 11:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:15 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:15 INFO - Running setup.py install for blobuploader 11:12:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:15 INFO - Running setup.py install for requests 11:12:16 INFO - Running setup.py install for docopt 11:12:16 INFO - Successfully installed blobuploader requests docopt 11:12:16 INFO - Cleaning up... 11:12:16 INFO - Return code: 0 11:12:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:16 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')]} 11:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:16 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')]} 11:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:16 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 0x104136a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104146420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca8bdba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fd5e00>, '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 0x103e3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fd0b20>, '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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 11:12:16 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 11:12:16 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 11:12:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hjUaE40RMw/Render', 11:12:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:16 INFO - 'HOME': '/Users/cltbld', 11:12:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:16 INFO - 'LOGNAME': 'cltbld', 11:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:16 INFO - 'MOZ_NO_REMOTE': '1', 11:12:16 INFO - 'NO_EM_RESTART': '1', 11:12:16 INFO - 'PAGER': '/bin/cat', 11:12:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:16 INFO - 'PWD': '/builds/slave/test', 11:12:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:16 INFO - 'SHELL': '/bin/bash', 11:12:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vw97AU4ibQ/Listeners', 11:12:16 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 11:12:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:16 INFO - 'USER': 'cltbld', 11:12:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:16 INFO - 'XPC_FLAGS': '0x0', 11:12:16 INFO - 'XPC_SERVICE_NAME': '0', 11:12:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:16 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-l40JY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:17 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-JpxL0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:17 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-evaaEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:17 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Hionyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:17 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-XkG80T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:17 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-4RMpKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:17 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-pwvsLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:17 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-jrsrc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:17 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-ID32sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:17 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Btb7xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:17 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-OEyNhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:18 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-_aXLMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:18 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-uy0Qs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:18 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-cNeG_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:18 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Tt61XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:18 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-AMEHoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:18 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-DgoxPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:18 INFO - Running setup.py install for manifestparser 11:12:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:18 INFO - Running setup.py install for mozcrash 11:12:18 INFO - Running setup.py install for mozdebug 11:12:19 INFO - Running setup.py install for mozdevice 11:12:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:19 INFO - Running setup.py install for mozfile 11:12:19 INFO - Running setup.py install for mozhttpd 11:12:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:19 INFO - Running setup.py install for mozinfo 11:12:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:19 INFO - Running setup.py install for mozInstall 11:12:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:19 INFO - Running setup.py install for mozleak 11:12:19 INFO - Running setup.py install for mozlog 11:12:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:20 INFO - Running setup.py install for moznetwork 11:12:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:20 INFO - Running setup.py install for mozprocess 11:12:20 INFO - Running setup.py install for mozprofile 11:12:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:20 INFO - Running setup.py install for mozrunner 11:12:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:20 INFO - Running setup.py install for mozscreenshot 11:12:20 INFO - Running setup.py install for moztest 11:12:21 INFO - Running setup.py install for mozversion 11:12:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:21 INFO - Cleaning up... 11:12:21 INFO - Return code: 0 11:12:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:21 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 0x104136a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104146420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca8bdba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fd5e00>, '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 0x103e3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fd0b20>, '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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 11:12:21 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 11:12:21 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 11:12:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hjUaE40RMw/Render', 11:12:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:21 INFO - 'HOME': '/Users/cltbld', 11:12:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:21 INFO - 'LOGNAME': 'cltbld', 11:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:21 INFO - 'MOZ_NO_REMOTE': '1', 11:12:21 INFO - 'NO_EM_RESTART': '1', 11:12:21 INFO - 'PAGER': '/bin/cat', 11:12:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:21 INFO - 'PWD': '/builds/slave/test', 11:12:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:21 INFO - 'SHELL': '/bin/bash', 11:12:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vw97AU4ibQ/Listeners', 11:12:21 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 11:12:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:21 INFO - 'USER': 'cltbld', 11:12:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:21 INFO - 'XPC_FLAGS': '0x0', 11:12:21 INFO - 'XPC_SERVICE_NAME': '0', 11:12:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:21 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-yiuldQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:21 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)) 11:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:21 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-uoPNuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:21 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)) 11:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:21 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-EwGqpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:21 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)) 11:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:21 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Xw0nox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:21 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)) 11:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:21 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-xnM292-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:22 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)) 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-9NYQgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:22 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)) 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-MGnVfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:22 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)) 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-YhWxig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:22 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)) 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-wjW1rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:22 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)) 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-yTC_pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-bQR1g7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:22 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)) 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-6_vDVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-PVoNN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:22 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)) 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-l4QhO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:23 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Iz1Ewv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:23 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-m5OlU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:23 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-91gAWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:23 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)) 11:12:23 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)) 11:12:23 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)) 11:12:23 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)) 11:12:23 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)) 11:12:23 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)) 11:12:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:23 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 11:12:23 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 11:12:23 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 11:12:23 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 11:12:23 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 11:12:23 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 11:12:25 INFO - Downloading blessings-1.6.tar.gz 11:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:25 INFO - Installing collected packages: blessings 11:12:25 INFO - Running setup.py install for blessings 11:12:26 INFO - Successfully installed blessings 11:12:26 INFO - Cleaning up... 11:12:26 INFO - Return code: 0 11:12:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:26 INFO - Reading from file tmpfile_stdout 11:12:26 INFO - Current package versions: 11:12:26 INFO - blessings == 1.6 11:12:26 INFO - blobuploader == 1.2.4 11:12:26 INFO - docopt == 0.6.1 11:12:26 INFO - manifestparser == 1.1 11:12:26 INFO - mozInstall == 1.12 11:12:26 INFO - mozcrash == 0.17 11:12:26 INFO - mozdebug == 0.1 11:12:26 INFO - mozdevice == 0.48 11:12:26 INFO - mozfile == 1.2 11:12:26 INFO - mozhttpd == 0.7 11:12:26 INFO - mozinfo == 0.9 11:12:26 INFO - mozleak == 0.1 11:12:26 INFO - mozlog == 3.1 11:12:26 INFO - moznetwork == 0.27 11:12:26 INFO - mozprocess == 0.22 11:12:26 INFO - mozprofile == 0.28 11:12:26 INFO - mozrunner == 6.11 11:12:26 INFO - mozscreenshot == 0.1 11:12:26 INFO - mozsystemmonitor == 0.0 11:12:26 INFO - moztest == 0.7 11:12:26 INFO - mozversion == 1.4 11:12:26 INFO - psutil == 3.1.1 11:12:26 INFO - requests == 1.2.3 11:12:26 INFO - wsgiref == 0.1.2 11:12:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:26 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 0x104136a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104146420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca8bdba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fd5e00>, '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 0x103e3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fd0b20>, '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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 11:12:26 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 11:12:26 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 11:12:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hjUaE40RMw/Render', 11:12:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:26 INFO - 'HOME': '/Users/cltbld', 11:12:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:26 INFO - 'LOGNAME': 'cltbld', 11:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:26 INFO - 'MOZ_NO_REMOTE': '1', 11:12:26 INFO - 'NO_EM_RESTART': '1', 11:12:26 INFO - 'PAGER': '/bin/cat', 11:12:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:26 INFO - 'PWD': '/builds/slave/test', 11:12:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:26 INFO - 'SHELL': '/bin/bash', 11:12:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vw97AU4ibQ/Listeners', 11:12:26 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 11:12:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:26 INFO - 'USER': 'cltbld', 11:12:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:26 INFO - 'XPC_FLAGS': '0x0', 11:12:26 INFO - 'XPC_SERVICE_NAME': '0', 11:12:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:12:26 INFO - Cleaning up... 11:12:26 INFO - Return code: 0 11:12:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:26 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 0x104136a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104146420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca8bdba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fd5e00>, '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 0x103e3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fd0b20>, '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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 11:12:26 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 11:12:26 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 11:12:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hjUaE40RMw/Render', 11:12:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:26 INFO - 'HOME': '/Users/cltbld', 11:12:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:26 INFO - 'LOGNAME': 'cltbld', 11:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:26 INFO - 'MOZ_NO_REMOTE': '1', 11:12:26 INFO - 'NO_EM_RESTART': '1', 11:12:26 INFO - 'PAGER': '/bin/cat', 11:12:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:26 INFO - 'PWD': '/builds/slave/test', 11:12:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:26 INFO - 'SHELL': '/bin/bash', 11:12:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vw97AU4ibQ/Listeners', 11:12:26 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 11:12:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:26 INFO - 'USER': 'cltbld', 11:12:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:26 INFO - 'XPC_FLAGS': '0x0', 11:12:26 INFO - 'XPC_SERVICE_NAME': '0', 11:12:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:26 INFO - Downloading/unpacking jsonschema 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:29 INFO - Downloading/unpacking functools32 (from jsonschema) 11:12:29 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 11:12:29 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 11:12:29 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 11:12:29 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 11:12:29 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 11:12:29 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 11:12:29 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:29 INFO - warning: no files found matching '*.txt' 11:12:29 INFO - no previously-included directories found matching 'build' 11:12:29 INFO - no previously-included directories found matching 'dist' 11:12:29 INFO - no previously-included directories found matching '.git*' 11:12:29 INFO - Installing collected packages: jsonschema, functools32 11:12:29 INFO - Running setup.py install for functools32 11:12:30 INFO - warning: no files found matching '*.txt' 11:12:30 INFO - no previously-included directories found matching 'build' 11:12:30 INFO - no previously-included directories found matching 'dist' 11:12:30 INFO - no previously-included directories found matching '.git*' 11:12:30 INFO - Successfully installed jsonschema functools32 11:12:30 INFO - Cleaning up... 11:12:30 INFO - Return code: 0 11:12:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:30 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104136a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104146420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca8bdba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fd5e00>, '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 0x103e3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fd0b20>, '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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 11:12:30 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', 'flake8'] in /builds/slave/test/build 11:12:30 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 flake8 11:12:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hjUaE40RMw/Render', 11:12:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:30 INFO - 'HOME': '/Users/cltbld', 11:12:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:30 INFO - 'LOGNAME': 'cltbld', 11:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:30 INFO - 'MOZ_NO_REMOTE': '1', 11:12:30 INFO - 'NO_EM_RESTART': '1', 11:12:30 INFO - 'PAGER': '/bin/cat', 11:12:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:30 INFO - 'PWD': '/builds/slave/test', 11:12:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:30 INFO - 'SHELL': '/bin/bash', 11:12:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vw97AU4ibQ/Listeners', 11:12:30 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 11:12:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:30 INFO - 'USER': 'cltbld', 11:12:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:30 INFO - 'XPC_FLAGS': '0x0', 11:12:30 INFO - 'XPC_SERVICE_NAME': '0', 11:12:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:30 INFO - Downloading/unpacking flake8 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:12:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:12:31 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 11:12:31 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 11:12:31 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 11:12:31 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 11:12:31 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 11:12:31 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 11:12:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:12:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:12:31 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 11:12:31 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 11:12:31 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 11:12:31 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 11:12:31 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 11:12:31 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 11:12:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:12:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:32 INFO - no previously-included directories found matching 'docs/_build' 11:12:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:12:32 INFO - Running setup.py install for pep8 11:12:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:32 INFO - no previously-included directories found matching 'docs/_build' 11:12:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:12:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:12:32 INFO - Cleaning up... 11:12:32 INFO - Return code: 0 11:12:32 INFO - Running post-action listener: _resource_record_post_action 11:12:32 INFO - Running post-action listener: _start_resource_monitoring 11:12:32 INFO - Starting resource monitoring. 11:12:32 INFO - ##### 11:12:32 INFO - ##### Running install step. 11:12:32 INFO - ##### 11:12:32 INFO - Running pre-action listener: _resource_record_pre_action 11:12:32 INFO - Running main action method: install 11:12:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:33 INFO - Reading from file tmpfile_stdout 11:12:33 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:33 INFO - Reading from file tmpfile_stdout 11:12:33 INFO - Output received: 11:12:33 INFO - Usage: mozinstall [options] installer 11:12:33 INFO - Options: 11:12:33 INFO - -h, --help show this help message and exit 11:12:33 INFO - -d DEST, --destination=DEST 11:12:33 INFO - Directory to install application into. [default: 11:12:33 INFO - "/builds/slave/test"] 11:12:33 INFO - --app=APP Application being installed. [default: firefox] 11:12:33 INFO - mkdir: /builds/slave/test/build/application 11:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:12:54 INFO - Reading from file tmpfile_stdout 11:12:54 INFO - Output received: 11:12:54 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:12:54 INFO - Running post-action listener: _resource_record_post_action 11:12:54 INFO - ##### 11:12:54 INFO - ##### Running run-tests step. 11:12:54 INFO - ##### 11:12:54 INFO - Running pre-action listener: _resource_record_pre_action 11:12:54 INFO - Running main action method: run_tests 11:12:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:12:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:12:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:12:54 INFO - 2016-07-18 11:12:54.948 screenresolution[1915:15468] starting screenresolution argv=screenresolution get 11:12:54 INFO - 2016-07-18 11:12:54.950 screenresolution[1915:15468] Display 0: 1600x1200x32@60 11:12:54 INFO - 2016-07-18 11:12:54.955 screenresolution[1916:15471] starting screenresolution argv=screenresolution list 11:12:54 INFO - Available Modes on Display 0 11:12:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:12:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:12:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:12:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:12:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:12:55 INFO - Intel Iris: 11:12:55 INFO - Chipset Model: Intel Iris 11:12:55 INFO - Type: GPU 11:12:55 INFO - Bus: Built-In 11:12:55 INFO - VRAM (Dynamic, Max): 1536 MB 11:12:55 INFO - Vendor: Intel (0x8086) 11:12:55 INFO - Device ID: 0x0a2e 11:12:55 INFO - Revision ID: 0x0009 11:12:55 INFO - Displays: 11:12:55 INFO - Display: 11:12:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:12:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:12:55 INFO - Display Serial Number: 1600x1200 60 11:12:55 INFO - Main Display: Yes 11:12:55 INFO - Mirror: Off 11:12:55 INFO - Online: Yes 11:12:55 INFO - Rotation: Supported 11:12:55 INFO - Return code: 0 11:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:12:55 INFO - Python 2.7.3 11:12:55 INFO - Return code: 0 11:12:55 INFO - grabbing minidump binary from tooltool 11:12: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')]} 11:12:55 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fd5e00>, '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 0x103e3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fd0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:12:55 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 11:12:55 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 11:12:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:55 INFO - Return code: 0 11:12:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:12:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:12:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:12:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:12:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:12:56 INFO - Return code: 0 11:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0356 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:12:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hjUaE40RMw/Render', 11:12:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:56 INFO - 'HOME': '/Users/cltbld', 11:12:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:56 INFO - 'LOGNAME': 'cltbld', 11:12:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:56 INFO - 'MOZ_NO_REMOTE': '1', 11:12:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:56 INFO - 'NO_EM_RESTART': '1', 11:12:56 INFO - 'PAGER': '/bin/cat', 11:12:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:56 INFO - 'PWD': '/builds/slave/test', 11:12:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:56 INFO - 'SHELL': '/bin/bash', 11:12:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vw97AU4ibQ/Listeners', 11:12:56 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 11:12:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:56 INFO - 'USER': 'cltbld', 11:12:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:56 INFO - 'XPC_FLAGS': '0x0', 11:12:56 INFO - 'XPC_SERVICE_NAME': '0', 11:12:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:12:56 INFO - mozversion application_buildid: 20160718082851 11:12:56 INFO - mozversion application_changeset: 0f4257230dffa106e90cf736df9dbe9859ac5274 11:12:56 INFO - mozversion application_display_name: Firefox 11:12:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:56 INFO - mozversion application_name: Firefox 11:12:56 INFO - mozversion application_remotingname: firefox 11:12:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:12:56 INFO - mozversion application_vendor: Mozilla 11:12:56 INFO - mozversion application_version: 48.0 11:12:56 INFO - mozversion platform_buildid: 20160718082851 11:12:56 INFO - mozversion platform_changeset: 0f4257230dffa106e90cf736df9dbe9859ac5274 11:12:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:12:56 INFO - mozversion platform_version: 48.0 11:12:56 INFO - using testdate: 1468865576 11:12:56 INFO - actual date: 1468865576 11:12:56 INFO - starting webserver on 'localhost:54496' 11:12:56 INFO - SUITE-START | Running 2 tests 11:12:56 INFO - TEST-START | dromaeo_css 11:12:56 INFO - operating with platform_type : mac_ 11:12:56 INFO - Initialising browser for dromaeo_css test... 11:12:56 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpA_uK26/profile http://localhost:54496/getInfo.html) 11:12:58 INFO - PROCESS | 1934 | __metrics Screen width/height:1600/1200 11:12:58 INFO - PROCESS | 1934 | colorDepth:24 11:12:58 INFO - PROCESS | 1934 | Browser inner width/height: 1024/689 11:12:58 INFO - PROCESS | 1934 | __metrics 11:12:59 INFO - PROCESS | 1934 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:12:59 ERROR - PROCESS | 1934 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:12:59 INFO - TEST-INFO | 1934: exit 0 11:12:59 INFO - Browser initialized. 11:12:59 INFO - Running cycle 1/1 for dromaeo_css test... 11:12:59 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpA_uK26/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:11 INFO - PROCESS | 1937 | RSS: Main: 160190464 11:13:11 INFO - PROCESS | 1937 | 11:14:02 INFO - PROCESS | 1937 | 1468865642693 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] 11:16:12 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:54496/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54496/tests/dromaeo/cssquery-ext.html) 11:16:14 INFO - PROCESS | 1937 | RSS: Main: 244158464 11:16:14 INFO - PROCESS | 1937 | 11:19:16 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:54496/tests/dromaeo/cssquery-ext.html (next: http://localhost:54496/tests/dromaeo/cssquery-jquery.html) 11:19:17 INFO - PROCESS | 1937 | RSS: Main: 301617152 11:19:17 INFO - PROCESS | 1937 | 11:22:19 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:54496/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54496/tests/dromaeo/cssquery-mootools.html) 11:22:20 INFO - PROCESS | 1937 | RSS: Main: 307056640 11:22:20 INFO - PROCESS | 1937 | 11:25:22 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:54496/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54496/tests/dromaeo/cssquery-prototype.html) 11:25:22 INFO - PROCESS | 1937 | RSS: Main: 305807360 11:25:22 INFO - PROCESS | 1937 | 11:28:25 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:54496/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54496/tests/dromaeo/cssquery-yui.html) 11:28:26 INFO - PROCESS | 1937 | RSS: Main: 272465920 11:28:26 INFO - PROCESS | 1937 | 11:31:29 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:54496/tests/dromaeo/cssquery-yui.html (next: http://localhost:54496/tests/dromaeo/cssquery-dojo.html) 11:31:29 INFO - PROCESS | 1937 | RSS: Main: 313597952 11:31:29 INFO - PROCESS | 1937 | 11:31:29 INFO - PROCESS | 1937 | __start_tp_report 11:31:29 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 11:31:29 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 11:31:29 INFO - PROCESS | 1937 | |i|pagename|runs| 11:31:29 INFO - PROCESS | 1937 | |0;dojo.html;3453.326601312744;3549.272399158173;3563.803990780507;3566.982165089176;3628.3468975584383;5838.328592211897;5845.269341332333;5849.561282903788;5899.764009439623;5918.940810591893;5113.233015047745;5582.715975325667;5699.68651724155;5820.156077368779;5860;5252.133397989327;5270.183121616155;5280.366356037281;5339.492748188935;5423.186522021689;5318.787248510055;5345.33183352081;5357.571394288448;5360.061989151903;5366.624336296461;5248.370195576536;5284.630075894689;5295.179247216687;5324.92012619811;5354.598405119612;5342.465753424665;5394.973025134849;5402;5422.593305502103;5430.70131142787;5176.352955880515;5210.348706411699;5297.258383826267;5316.0962636351915;5366.436524164946;5667.801626943078;5707.058335374658;5745.597808153431;5751;5812.447817457335;6237.251529816451;6254.7498100075945;6271.090691849702;6273.56085074045;6276.184096067527;6264.87470250597;6288.9056664150075;6311.936880631227;6328.810135695937;6346.873062538723;5981.175741398872;6017.699115044318;6031.276246850406;6060.30306514752;6061.181740465069;6446.419822216023;6450.677466126769;6467.159269294962;6472.126262954441;6473.611583305017;6118.771466971993;6168.475679567197;6178.814635560941;6193.380661933861;6282.560220784501;6267.71795269214;6317.96841015792;6329.3354197809485;6330.746770129235;6340.778072767431;6201.0388389799655;6261.592996455216;6270.655113968684;6274;6277.1525844011385;6231.781887633911;6259.499240060784;6272.498200143978;6288.5598008139905;6290.591111577824;5016.899662006739;5029.823956161516;5033.245013248042;5061.089003979246;5092.898142037138;4479.7984090716;4485.439320084989;4492.797824097858;4513.052259025576;4538.773061346919;5252.763625636855;5663.377028526858;5986.940130598726;5993.400659933972;5993.9700301498215;6268.623882567061;6308.936910630835;6326.019466982625;6327.335629758901;6339.2392912850755;5933.881322373529;5954.880902382015;5963.910541341883;5980.666636723385;5995.820125396245;4957.008598280287;5339.759710813023;5428.158635411439;5552.444755524415;5553.305836770403;6278.717457714322;6324.1146239527425;6385.776497822647;6402.199725034371;6431.614103153825;6307.779227727007;6332.556721029484;6333.746650134128;6335.683215839282;6343.175387199634;6470.28826829039;6514.446272066927;6516.413522782972;6524.836879078061;6527.67361631926;6213.502919766317;6220.471259942956;6241.438270555672;6254;6260.060990851409;6256.311805701278;6267.905981410374;6273.968630157003;6319.715612797343;6324.1146239527425;6214.4407003369915;6248.094026366242;6251;6255.186825712628;6255.874882502233;6139.416755408229;6248.406401392042;6254.155688981929;6255.280642726145;6268.498520118288;5997.16039754426;6070.271567411939;6081.361457046946;6129.264488261437;6146.477549408351;6105.8168254952425;6227.906581401373;6243.562950593415;6248.125262463168;6262.185915830913;6081.787137450168;6103.3591472894705;6123.668821788998;6136.079588061648;6151.200343955257 11:31:29 INFO - PROCESS | 1937 | |1;ext.html;516.1071346570433;518.8650950752805;588.4174667079591;608.0969759906541;620.1627802466668;32200.516992245106;40601.78194654161;41852.372214416806;41873.581264187385;41957.370639440356;44522;44777.32834007484;44977.55022449775;44988.550114498845;45067;8928.46429214246;9630.614775408976;9851.113399794018;9856.211503079736;9862.30963832532;11767.7646447071;12004.759904801898;12042.939785301061;12061.939690301537;12068.758624827498;11756.647300580997;11825.586104486345;11841.052715782716;11848.881511184907;11856.466459009365;11736.061115110771;11866.821997670042;11871.643850684493;11877.762444751143;11881.34652594107;11599.884001159964;11741.647750567497;11748.647540573797;11891.881081189164;11946.940265298705;41505;41828;41895.7905210472;41901;41909.58090419087;2789.846558439305;3549.4853246279145;3843.3658446356317;3913.3542965410675;3983.24318379507;28679;29416;29455.61014341733;29515.409691806042;29725.40549189026;2760.917172484829;2780.249332680165;2791.8464484453348;2795.2313113893842;2950.852457377144;696060;705023;705211;705333.9466605319;707252;37413.62586374156;65342;65584;65962.67018664876;66086;36496;36609.45085823715;36682.082947925985;36698.899033029054;36753.63246367555;15693.21533923322;15856.127912964897;15873.841261587468;15884.046957182605;15901.045937243802;12635;12709.110362274738;13409.865901341056;13603.931980340036;13657.453701851815;7281.162666293444;8299.626516806758;8334.12491688364;8351.08138104808;8436.409451338348;3511.9297614048087;3534.472851910896;3541.415666415064;3575.4100573405617;3635.9091022724115;1046.6289161198854;1055.577768892449;1106.2366966792888;1153.9076873850072;1197.7544603356291;29641;30039.69960300369;30145.849270753504;30845;30885.536716949264;855.4525103933488;1186.4067966016992;1190.3631557117073;1299.5581502289078;1334.7463981843614;14423.63940901465;15074.773878391832;15133.092014479167;15290.464833730766;15385.9230703848;570919;571541;572073;572272;572728;62437;64119.358806411336;64222.67888660527;64230.35769642337;64373;1435.8205224346957;1465.2014652014677;1590.9363625455085;1619.5708137343377;1668.6162182698047;24627.630585540872;29411;29854.850725747103;30041.248968775955;30678.846605766827;48301;48614;49097.75451122721;49119.01761964669;49151.75424122856;367735;370160;370659;370938;622216;23844.761552384254;27583.03459378912;28084;28404.147875563765;28408.431831362843;43596.34605480984;43941.78029109834;44393;44450;44722.55277447314;35702.821485892404;37255.6274437263;37453.43819842759;38149.23701526009;39135.41296880492;35977.82011090033;36162.27675446529;36239.45640815337;36657.90026299215;36748;35688.929332120075;36163.457548137325;36362.4545631821;36488.63511364959;38726.45094196201;33370.33259334848;33451.996440106836;33740.32519349649;33952.490712638835;34343.96968090961;25335.239942801745;25403.491930160922;25453.618195726707;25841.353966150997;25870.482590348463 11:31:29 INFO - PROCESS | 1937 | |2;jquery.html;416.7187148674644;417.211470321093;417.7472629059419;420.3904338708873;430.212710739347;20704.068316925735;21141.894290528566;21286.680699789496;21356.25253116141;22374.888125559348;20438.591228175428;20780.58438831226;21310.254141105066;21337.786622133775;21390.358289251308;5360.303160589118;5705.087186050233;5710.086386178213;5716.114002329625;5721.170430287606;4284.785760711968;4510.54894510548;5605.5515558755405;5728.16941543476;6072.210612620375;5465.426130256325;6353.428191462767;6360.077788720633;6365.52258580606;6373.13962615048;6111.694415279218;6259.937400625981;6293.779717709904;6324.652144132071;6332.715027823759;4175.123224122938;5865.384134665841;6101.786437474711;6136.509079273647;6155.569110162291;13916.30418479072;14119.717605647933;14126.940479464081;14130;26490.072847450247;2185.737711474633;2187.726534183227;2231.843770936035;2288.302067869299;2372.8694921779297;10097.444640544767;10205.081542661195;10352.275340726152;10436.582536698523;10578.788424231549;1834.1562881074722;1848.9630207395912;1882.5481884347794;1921.702136168896;1967.45894878908;118111;119628;120290;121450;129387.35306323408;11768.94115529434;11830.822537661941;11891.464884080237;11907.106966977339;11931.522739090338;15675.529734107995;15703.607409814846;15705.764413533807;15706.057636541844;15751.763723544156;7595.886061709079;8888.511131887808;9198.540072996324;9262.629494820267;9337.206337461255;9077.546122693971;9103.863442048374;9217.308701847254;9318.534073296309;9320.161185493202;4002.2795896738867;4734.479207287196;4801.135795556764;4814.109389762905;4863.513648635108;1816.344139036115;1941.2526177421794;2009.5277609761695;2031.9695204571942;2100.5063810004635;904.2178515583972;927.1609193679731;957.1577012229333;1047.1361127070197;1059.0733108530037;20208.49478763043;20222;20436.48908777263;20501.077451514717;20824.58350832975;949.2311227905419;987.4322264697828;1010.8079464901646;1017.954192061359;1025.1337619711333;11091.944540277247;11291.717707057225;11341.26281791681;11350.659480215607;11357.432128393713;527990;533146.3342683262;536202;588522;651747;133642.33178834044;136623.31688341495;137436;137861;141782;1033.379972016799;1065.1638463805875;1077.983830242547;1078.2398409121552;1082.8971247731454;18496.722549161503;18837.90581047086;19164.94592797354;19238.422847314603;19367.8063219366;35477;50416.991660167325;53101.7344913273;55229;56204;75623.86564201652;78077.219227807;80637;82089;83706.58146709227;8276.544790036605;8331.250187483156;8448.321332782632;8590.1839325264;8598.269147122564;9284.442933424016;11009.504572294105;12305.56930507428;12979.896708779483;13314.201147931155;11090.057345125755;11103.555857765921;11205.383703896365;11437.771244575228;11520.13598980063;8632.568371581521;10776.245662803529;11438.885611144115;11577.768444631229;11603.709907252387;11206.495707693337;11508.482118304864;11587.073034157416;11852.525898963944;11881.762364752829;8286.212809783061;8391.748247552583;8401.663933442594;8446.873296900429;8541.973490427079;11224.94387528057;11239.719007024563;11295.548178072784;11366.408702781451;11406.54373825071 11:31:29 INFO - PROCESS | 1937 | |3;mootools.html;1440.3158499712645;1610.7583862420636;1645.8271881452447;1919.7984211657777;2031.4413536277514;8214.38392120591;8874.689385871496;9026.277897768163;9028.187463128317;9041.909580904197;8294.875576866336;8342.165783421655;8789;9039.960404553478;9042.186203241707;2527.9494410111834;2564.3332733489333;2566.486702659466;2570.2803215099707;2582.2382397192778;2501.0746023971155;2568.948621027578;2569.755873192044;2573.3437973316873;2574;2536.4039450729156;2566.0377358490564;2572.7555882191164;2575.3175408516663;2584.095566551711;2529.051605647882;2549.8725063746833;2560;2561.807864410158;2571.4214301782135;2519.282004628672;2556.2714626331594;2562.782163516085;2565.961510577343;2568.6403903453534;8787.78030549235;9018.323625728097;9027.909720902773;9109.863352049724;9126.817463650756;5739.512141467981;5823.301203855522;5836.503897168745;5900.291964964232;5911.467967882868;3158.7788854780174;3305.8842940497207;3611.3138503684218;3770.830312635938;3811.2377524494937;1056.8846781577204;1081.728390174377;1094.6262440637029;1094.956201751937;1100.3233011697748;12205.023598112219;12394.690132746664;12438;12460.626181214579;12471.314077725721;4339.392485052095;5020.849374518771;5049.343585333883;5163.612729045337;5196.45437229093;10742.462876856125;10752.784944301227;10761.30051546647;10762.677119686421;10773.62292319765;5794;5857.326407463111;5860.179574859523;5860.413958604106;5865.912011319833;4241.533431322552;4665.5567721066445;4821.5178482151505;5226.608004399685;5285.709285989307;4198.832046718097;4232.068944832132;4279.700420970502;4320.142338794286;4330.523642399334;1390.7496650602786;1425.7291114688383;1434.4620767212296;1440.9351579178963;1458.482238805209;933.5099072986601;938.6010945348199;955.1260596554214;960.4621412009298;997.5760301871676;5967.254093238345;6030.819075427744;6122.295935967331;6134.2332208473945;6138.9256880046705;486.20748180465614;493.7629937629958;494.45609829187606;1049.040128282628;1051.5057922776282;3940.605939406094;3993.5407428146136;4016.0763024504527;4074.2869997750277;4089.7750623715388;10520.842187367196;10803.081738052353;10824.458777061272;10873.728156796144;10934.56261749521;10692.679219623424;10797.46012699362;10801.297915635458;10811.18916081297;10839.512221950032;8329.458585191944;8583.227509524173;8669.739907802776;8725.694600689072;8787.560621968876;5313.574914006947;5868.471837534642;5919.171316015847;5995.700214989321;6053.152558641706;9913.959034301583;9914.851277230702;10045.49772511386;10096.394216347042;10325.690229293134;9376.624935002523;10405.9479702601;10412.531436085546;10492.160627149657;10537.789244215226;7020.297970202939;7188.3171098747625;7212.350888419857;7727.884081738666;7884.053913530413;7896.921030789848;8134.75595732129;8332.208440198172;8333.833323333378;8373.581320933807;6874.175098987954;7173.246809084971;7364.66858991336;7420.851582968203;7571.091469023752;7273.709051638087;7316.268373162641;7334.889976650461;7359.852802944019;7403.444741644506;6968.686409111703;7051.5063945523325;7056.400205982549;7068.469864760266;7137.072180616487;4963.478834722447;4973.179425394914;5002.624803139852;5085.694858308513;5088.567471764942;4470.575295346936;4939.703617782944;4953.777080031336;5062.31658726082;5228.111221092499 11:31:29 INFO - PROCESS | 1937 | |4;prototype.html;330.3343762318927;332.9650386709395;338.05345033905076;342.58376073071213;345.4593561076913;5324.787008519665;6618.933810661892;6635.137432133828;6662.233843108044;6668.366505182006;6556.901646475295;6603.207615086184;6618.569792963454;6650.567713098645;6709.530332876689;4699.906001879969;4810.470848206712;4830.97584512077;4845.975770121145;4852.951470485303;4831.516848315158;4857.489963553811;4868.853934381974;4932.062908047459;4963.70217786934;4799.928001079987;4838.491958344376;4859.73271470069;4866.46468888422;4901.1177987962155;4842.878928026792;4848.587870031051;4864.854054378375;4879.658423910328;4885.438174609894;4007.5591684914634;4099.815508302134;4172.582741725833;4180.707350485467;4188.6649068074485;5169.767360468788;6465.612063276171;6469.93530064698;6470.320616335264;6471.579347342407;5788.0739081746715;5801.506871915893;5807.88384232313;5824.854378640568;5827.650340979555;5737.483626473638;7135.785926422215;7145.785626431215;7149.678264478059;7157.498975071747;4715.7877895494785;4726.881827954294;4728.030753695519;4728.763561821929;4733.3846599942135;7123.750668726621;7431.145418276913;7442.441816863703;7468.290512401313;7509.549427034341;4598.356230127785;4666.673332866667;4668.229742092584;4682.1103990241745;4694.2958556216845;4783.904321913612;4790.281457781361;4790.880227994328;4793.640476964241;4794.544518270759;5764.337101233412;5764.798232061858;5768.596198266165;5775.94224057754;5776.913346299809;6879.724811007603;7168.2831716827895;7174.641267936582;7188.28117188277;7194.352508274281;1623.1559589013882;1637.148682684997;1655.1062426289668;1666.924988375526;1669.3656410563908;1034.7723500829804;1036.9377837329635;1051.3534176481562;1054.46222426563;1061.8991195836384;6511.3163117871945;6615.37153970372;6687.1975362956755;6716.320919770057;6733.8989915151315;7470.36501897334;7476;7492.063492063492;7558.319751222416;7589.316961473494;6775.62734049632;6802.081718967975;6802.591844489347;6827.795166145023;6830.248672646005;3946.1713040261293;3996.4205190247253;4002.3796311571755;4003.199360127986;4004.7797371144284;6764.3573860483175;7660.264282556325;7796.844063118706;7897.210278972057;7923.484973476706;7703.576303303372;7708.576028318496;7733.188015258429;7762.6894924203525;7774.883376749353;7890.605469726605;7891.131975482693;7898.012748406564;7907.762767116996;7926.167752386032;7529.360004399688;7545.170031296663;7563.281488258606;7574.3183113520045;7586.468947173645;7103.82240443993;7350.545243735436;7390.334869861738;7407.629618518945;7411.147718012282;6679.098321726699;7242.493025488166;7851.371890248653;7867.803304917423;7869.527828330319;4697.577218050392;4708.764561771829;4712.340272361804;4717.858464246078;4720.45714742809;6069.241344831896;7492.7752167435065;7505.812354690958;7516.549007059594;7522.849543009219;6960.5127641066665;7239.371141493122;7240.52936559122;7272.381847543018;7272.745453909088;7165.498415110892;7222.530535515175;7227.674754636159;7235.612247958266;7262.273772622695;7069.646517674199;7084.149902011585;7084.822879427849;7091.503594748318;7094.148702155568;6924.723011079501;7245;7253.238409967089;7256.310650488195;7256.673449694882;6798.252192258947;6957.1651401832105;7052.5063245574365;7067.57594544329;7086.362227399559 11:31:29 INFO - PROCESS | 1937 | |5;yui.html;702.0627462337778;717.4762423430896;721.1238345410326;749.5465243527663;824.6206744897347;15409.229538523057;15460.536183914486;15826.841731582681;15845.811564132693;15847.811414143927;14711.558653240394;14793.40826366944;14804.259787010633;14805.407783688639;14808.55574332769;778.6651739751904;797.4258533855615;954.8949615542267;964.62379671928;972.1590823937279;957.5595226195958;984.6553706202843;987.0031268418912;987.6049580167954;988.461288597716;1016.0753714120152;1024.4723967156883;1025.1747343388606;1025.2823023883311;1025.676911772793;807.3984881263438;1000.6697789729371;1018.0786388318546;1020.0768304684273;1030.7835354575548;762.6911101004102;763.290140169642;765.3341592814231;765.4832987733314;766.2490759056101;15524.146171960538;15586.688266234725;15607.609809754733;15630.687386252212;15682.686346273125;13207.075504714674;13321.533746318832;13549.696551586254;13631.863681363158;13650.795238071438;10261.538230779634;10266.538005789758;10270.383776973405;10405.9479702601;10823.512941917554;3562.5546806649168;3591.9942416123527;3595.53258076451;3625.0920452962546;3817.1602247505502;82911;83475;84268.57865710693;85500;86007;9956.751081223027;9963.701088967342;10001.2999090063;10001.49992500372;10225.335353202017;23153.421164470685;23238.76761232366;23269.41826454352;23271.836408179523;23290.3012909613;7563.924360756322;7635.045619297588;7683.270089341504;7703.922960770433;7933.801654958556;4206.453161089039;4267.4025636410925;4349.978250108729;4388.670849686287;4555.794989225493;3807.143392736612;3872.0319920019997;3875.399313106473;3879.4180872869297;3880.611938806097;648.3127884442506;670.8691805098057;682.0485422835118;700.684691888642;713.2546488919093;556.577001478879;591.3642833953431;596.0373995996521;611.6635850282327;635.0949896397707;8461.45000574973;8462.323014158852;8465.195806398382;8600.956995214983;8648.1784230498;531.2297169104813;606.336062012096;620.8106527509062;629.3486241739778;632.6330728177646;3899.53205615328;3943.507061617298;3992.161646054303;4024.5170579530645;4044.919101617951;91350.54324728333;92239.07760922439;92470.15059698769;93056;93186;77714;77872;77971.44057118939;78920;79059.60470197727;68740.31259687438;70214;70506.64746676234;70741.64629176821;71391.64304178445;7766.262205090507;7976.481528700616;8054.395920305883;8113.675452982051;8253.298469630148;48419.757901210265;48423.27365089456;49355.50644493509;49703.502964969884;50355.496445036544;64119;64616.353836461036;64713;65496.34503654903;68441.65779171072;10374.585016599553;10445.425501597485;10503.579856805642;10615.363078215332;11309.773804523698;9738.951305243429;10871.891281087088;10980.615678451535;11109.555617775522;11335.546578137111;10436.686899393031;10622.150227981589;10627.9903409176;10635.89364106349;10808.891911081104;10403;10470;10476.580936762444;10766.977137171956;11464.484098215433;10298.485075746332;10366.948165259126;10447.791044179226;10501.842472363074;11251.662450126509;8998.415103018282;9081.409708368936;9156.267498599962;9233.538323083952;9248.72718241649;9047;9057.320700947323;9070.18368346852;9159.450432974043;9193.908060919573 11:31:29 INFO - PROCESS | 1937 | __end_tp_report 11:31:29 INFO - PROCESS | 1937 | __start_cc_report 11:31:29 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,1637 11:31:29 INFO - PROCESS | 1937 | __end_cc_report 11:31:29 INFO - PROCESS | 1937 | __startTimestamp1468866689301__endTimestamp 11:31:29 INFO - PROCESS | 1937 | 11:31:29 INFO - PROCESS | 1937 | ------- Summary: start ------- 11:31:29 INFO - PROCESS | 1937 | Number of tests: 6 11:31:29 INFO - PROCESS | 1937 | 11:31:29 INFO - PROCESS | 1937 | [#0] dojo.html Cycles:165 Average:5851.81 Median:6123.67 stddev:634.42 (10.4%) stddev-sans-first:607.83 11:31:29 INFO - PROCESS | 1937 | Values: 3453.3 3549.3 3563.8 3567.0 3628.3 5838.3 5845.3 5849.6 5899.8 5918.9 5113.2 5582.7 5699.7 5820.2 5860.0 5252.1 5270.2 5280.4 5339.5 5423.2 5318.8 5345.3 5357.6 5360.1 5366.6 5248.4 5284.6 5295.2 5324.9 5354.6 5342.5 5395.0 5402.0 5422.6 5430.7 5176.4 5210.3 5297.3 5316.1 5366.4 5667.8 5707.1 5745.6 5751.0 5812.4 6237.3 6254.7 6271.1 6273.6 6276.2 6264.9 6288.9 6311.9 6328.8 6346.9 5981.2 6017.7 6031.3 6060.3 6061.2 6446.4 6450.7 6467.2 6472.1 6473.6 6118.8 6168.5 6178.8 6193.4 6282.6 6267.7 6318.0 6329.3 6330.7 6340.8 6201.0 6261.6 6270.7 6274.0 6277.2 6231.8 6259.5 6272.5 6288.6 6290.6 5016.9 5029.8 5033.2 5061.1 5092.9 4479.8 4485.4 4492.8 4513.1 4538.8 5252.8 5663.4 5986.9 5993.4 5994.0 6268.6 6308.9 6326.0 6327.3 6339.2 5933.9 5954.9 5963.9 5980.7 5995.8 4957.0 5339.8 5428.2 5552.4 5553.3 6278.7 6324.1 6385.8 6402.2 6431.6 6307.8 6332.6 6333.7 6335.7 6343.2 6470.3 6514.4 6516.4 6524.8 6527.7 6213.5 6220.5 6241.4 6254.0 6260.1 6256.3 6267.9 6274.0 6319.7 6324.1 6214.4 6248.1 6251.0 6255.2 6255.9 6139.4 6248.4 6254.2 6255.3 6268.5 5997.2 6070.3 6081.4 6129.3 6146.5 6105.8 6227.9 6243.6 6248.1 6262.2 6081.8 6103.4 6123.7 6136.1 6151.2 11:31:29 INFO - PROCESS | 1937 | 11:31:29 INFO - PROCESS | 1937 | [#1] ext.html Cycles:180 Average:69044.19 Median:35695.88 stddev:155635.95 (436.0%) stddev-sans-first:155987.51 11:31:29 INFO - PROCESS | 1937 | Values: 516.1 518.9 588.4 608.1 620.2 32200.5 40601.8 41852.4 41873.6 41957.4 44522.0 44777.3 44977.6 44988.6 45067.0 8928.5 9630.6 9851.1 9856.2 9862.3 11767.8 12004.8 12042.9 12061.9 12068.8 11756.6 11825.6 11841.1 11848.9 11856.5 11736.1 11866.8 11871.6 11877.8 11881.3 11599.9 11741.6 11748.6 11891.9 11946.9 41505.0 41828.0 41895.8 41901.0 41909.6 2789.8 3549.5 3843.4 3913.4 3983.2 28679.0 29416.0 29455.6 29515.4 29725.4 2760.9 2780.2 2791.8 2795.2 2950.9 696060.0 705023.0 705211.0 705333.9 707252.0 37413.6 65342.0 65584.0 65962.7 66086.0 36496.0 36609.5 36682.1 36698.9 36753.6 15693.2 15856.1 15873.8 15884.0 15901.0 12635.0 12709.1 13409.9 13603.9 13657.5 7281.2 8299.6 8334.1 8351.1 8436.4 3511.9 3534.5 3541.4 3575.4 3635.9 1046.6 1055.6 1106.2 1153.9 1197.8 29641.0 30039.7 30145.8 30845.0 30885.5 855.5 1186.4 1190.4 1299.6 1334.7 14423.6 15074.8 15133.1 15290.5 15385.9 570919.0 571541.0 572073.0 572272.0 572728.0 62437.0 64119.4 64222.7 64230.4 64373.0 1435.8 1465.2 1590.9 1619.6 1668.6 24627.6 29411.0 29854.9 30041.2 30678.8 48301.0 48614.0 49097.8 49119.0 49151.8 367735.0 370160.0 370659.0 370938.0 622216.0 23844.8 27583.0 28084.0 28404.1 28408.4 43596.3 43941.8 44393.0 44450.0 44722.6 35702.8 37255.6 37453.4 38149.2 39135.4 35977.8 36162.3 36239.5 36657.9 36748.0 35688.9 36163.5 36362.5 36488.6 38726.5 33370.3 33452.0 33740.3 33952.5 34344.0 25335.2 25403.5 25453.6 25841.4 25870.5 11:31:29 INFO - PROCESS | 1937 | 11:31:29 INFO - PROCESS | 1937 | [#2] jquery.html Cycles:180 Average:34429.40 Median:21214.29 stddev:95740.17 (451.3%) stddev-sans-first:95974.69 11:31:29 INFO - PROCESS | 1937 | Values: 416.7 417.2 417.7 420.4 430.2 20704.1 21141.9 21286.7 21356.3 22374.9 20438.6 20780.6 21310.3 21337.8 21390.4 5360.3 5705.1 5710.1 5716.1 5721.2 4284.8 4510.5 5605.6 5728.2 6072.2 5465.4 6353.4 6360.1 6365.5 6373.1 6111.7 6259.9 6293.8 6324.7 6332.7 4175.1 5865.4 6101.8 6136.5 6155.6 13916.3 14119.7 14126.9 14130.0 26490.1 2185.7 2187.7 2231.8 2288.3 2372.9 10097.4 10205.1 10352.3 10436.6 10578.8 1834.2 1849.0 1882.5 1921.7 1967.5 118111.0 119628.0 120290.0 121450.0 129387.4 11768.9 11830.8 11891.5 11907.1 11931.5 15675.5 15703.6 15705.8 15706.1 15751.8 7595.9 8888.5 9198.5 9262.6 9337.2 9077.5 9103.9 9217.3 9318.5 9320.2 4002.3 4734.5 4801.1 4814.1 4863.5 1816.3 1941.3 2009.5 2032.0 2100.5 904.2 927.2 957.2 1047.1 1059.1 20208.5 20222.0 20436.5 20501.1 20824.6 949.2 987.4 1010.8 1018.0 1025.1 11091.9 11291.7 11341.3 11350.7 11357.4 527990.0 533146.3 536202.0 588522.0 651747.0 133642.3 136623.3 137436.0 137861.0 141782.0 1033.4 1065.2 1078.0 1078.2 1082.9 18496.7 18837.9 19164.9 19238.4 19367.8 35477.0 50417.0 53101.7 55229.0 56204.0 75623.9 78077.2 80637.0 82089.0 83706.6 8276.5 8331.3 8448.3 8590.2 8598.3 9284.4 11009.5 12305.6 12979.9 13314.2 11090.1 11103.6 11205.4 11437.8 11520.1 8632.6 10776.2 11438.9 11577.8 11603.7 11206.5 11508.5 11587.1 11852.5 11881.8 8286.2 8391.7 8401.7 8446.9 8542.0 11224.9 11239.7 11295.5 11366.4 11406.5 11:31:29 INFO - PROCESS | 1937 | 11:31:29 INFO - PROCESS | 1937 | [#3] mootools.html Cycles:180 Average:5872.17 Median:2716.73 stddev:3261.22 (120.0%) stddev-sans-first:3253.36 11:31:29 INFO - PROCESS | 1937 | Values: 1440.3 1610.8 1645.8 1919.8 2031.4 8214.4 8874.7 9026.3 9028.2 9041.9 8294.9 8342.2 8789.0 9040.0 9042.2 2527.9 2564.3 2566.5 2570.3 2582.2 2501.1 2568.9 2569.8 2573.3 2574.0 2536.4 2566.0 2572.8 2575.3 2584.1 2529.1 2549.9 2560.0 2561.8 2571.4 2519.3 2556.3 2562.8 2566.0 2568.6 8787.8 9018.3 9027.9 9109.9 9126.8 5739.5 5823.3 5836.5 5900.3 5911.5 3158.8 3305.9 3611.3 3770.8 3811.2 1056.9 1081.7 1094.6 1095.0 1100.3 12205.0 12394.7 12438.0 12460.6 12471.3 4339.4 5020.8 5049.3 5163.6 5196.5 10742.5 10752.8 10761.3 10762.7 10773.6 5794.0 5857.3 5860.2 5860.4 5865.9 4241.5 4665.6 4821.5 5226.6 5285.7 4198.8 4232.1 4279.7 4320.1 4330.5 1390.7 1425.7 1434.5 1440.9 1458.5 933.5 938.6 955.1 960.5 997.6 5967.3 6030.8 6122.3 6134.2 6138.9 486.2 493.8 494.5 1049.0 1051.5 3940.6 3993.5 4016.1 4074.3 4089.8 10520.8 10803.1 10824.5 10873.7 10934.6 10692.7 10797.5 10801.3 10811.2 10839.5 8329.5 8583.2 8669.7 8725.7 8787.6 5313.6 5868.5 5919.2 5995.7 6053.2 9914.0 9914.9 10045.5 10096.4 10325.7 9376.6 10405.9 10412.5 10492.2 10537.8 7020.3 7188.3 7212.4 7727.9 7884.1 7896.9 8134.8 8332.2 8333.8 8373.6 6874.2 7173.2 7364.7 7420.9 7571.1 7273.7 7316.3 7334.9 7359.9 7403.4 6968.7 7051.5 7056.4 7068.5 7137.1 4963.5 4973.2 5002.6 5085.7 5088.6 4470.6 4939.7 4953.8 5062.3 5228.1 11:31:29 INFO - PROCESS | 1937 | 11:31:29 INFO - PROCESS | 1937 | [#4] prototype.html Cycles:180 Average:5865.82 Median:6656.40 stddev:1887.90 (28.4%) stddev-sans-first:1846.91 11:31:29 INFO - PROCESS | 1937 | Values: 330.3 333.0 338.1 342.6 345.5 5324.8 6618.9 6635.1 6662.2 6668.4 6556.9 6603.2 6618.6 6650.6 6709.5 4699.9 4810.5 4831.0 4846.0 4853.0 4831.5 4857.5 4868.9 4932.1 4963.7 4799.9 4838.5 4859.7 4866.5 4901.1 4842.9 4848.6 4864.9 4879.7 4885.4 4007.6 4099.8 4172.6 4180.7 4188.7 5169.8 6465.6 6469.9 6470.3 6471.6 5788.1 5801.5 5807.9 5824.9 5827.7 5737.5 7135.8 7145.8 7149.7 7157.5 4715.8 4726.9 4728.0 4728.8 4733.4 7123.8 7431.1 7442.4 7468.3 7509.5 4598.4 4666.7 4668.2 4682.1 4694.3 4783.9 4790.3 4790.9 4793.6 4794.5 5764.3 5764.8 5768.6 5775.9 5776.9 6879.7 7168.3 7174.6 7188.3 7194.4 1623.2 1637.1 1655.1 1666.9 1669.4 1034.8 1036.9 1051.4 1054.5 1061.9 6511.3 6615.4 6687.2 6716.3 6733.9 7470.4 7476.0 7492.1 7558.3 7589.3 6775.6 6802.1 6802.6 6827.8 6830.2 3946.2 3996.4 4002.4 4003.2 4004.8 6764.4 7660.3 7796.8 7897.2 7923.5 7703.6 7708.6 7733.2 7762.7 7774.9 7890.6 7891.1 7898.0 7907.8 7926.2 7529.4 7545.2 7563.3 7574.3 7586.5 7103.8 7350.5 7390.3 7407.6 7411.1 6679.1 7242.5 7851.4 7867.8 7869.5 4697.6 4708.8 4712.3 4717.9 4720.5 6069.2 7492.8 7505.8 7516.5 7522.8 6960.5 7239.4 7240.5 7272.4 7272.7 7165.5 7222.5 7227.7 7235.6 7262.3 7069.6 7084.1 7084.8 7091.5 7094.1 6924.7 7245.0 7253.2 7256.3 7256.7 6798.3 6957.2 7052.5 7067.6 7086.4 11:31:29 INFO - PROCESS | 1937 | 11:31:29 INFO - PROCESS | 1937 | [#5] yui.html Cycles:180 Average:18401.60 Median:25443.36 stddev:25851.21 (101.6%) stddev-sans-first:25889.56 11:31:29 INFO - PROCESS | 1937 | Values: 702.1 717.5 721.1 749.5 824.6 15409.2 15460.5 15826.8 15845.8 15847.8 14711.6 14793.4 14804.3 14805.4 14808.6 778.7 797.4 954.9 964.6 972.2 957.6 984.7 987.0 987.6 988.5 1016.1 1024.5 1025.2 1025.3 1025.7 807.4 1000.7 1018.1 1020.1 1030.8 762.7 763.3 765.3 765.5 766.2 15524.1 15586.7 15607.6 15630.7 15682.7 13207.1 13321.5 13549.7 13631.9 13650.8 10261.5 10266.5 10270.4 10405.9 10823.5 3562.6 3592.0 3595.5 3625.1 3817.2 82911.0 83475.0 84268.6 85500.0 86007.0 9956.8 9963.7 10001.3 10001.5 10225.3 23153.4 23238.8 23269.4 23271.8 23290.3 7563.9 7635.0 7683.3 7703.9 7933.8 4206.5 4267.4 4350.0 4388.7 4555.8 3807.1 3872.0 3875.4 3879.4 3880.6 648.3 670.9 682.0 700.7 713.3 556.6 591.4 596.0 611.7 635.1 8461.5 8462.3 8465.2 8601.0 8648.2 531.2 606.3 620.8 629.3 632.6 3899.5 3943.5 3992.2 4024.5 4044.9 91350.5 92239.1 92470.2 93056.0 93186.0 77714.0 77872.0 77971.4 78920.0 79059.6 68740.3 70214.0 70506.6 70741.6 71391.6 7766.3 7976.5 8054.4 8113.7 8253.3 48419.8 48423.3 49355.5 49703.5 50355.5 64119.0 64616.4 64713.0 65496.3 68441.7 10374.6 10445.4 10503.6 10615.4 11309.8 9739.0 10871.9 10980.6 11109.6 11335.5 10436.7 10622.2 10628.0 10635.9 10808.9 10403.0 10470.0 10476.6 10767.0 11464.5 10298.5 10366.9 10447.8 10501.8 11251.7 8998.4 9081.4 9156.3 9233.5 9248.7 9047.0 9057.3 9070.2 9159.5 9193.9 11:31:29 INFO - PROCESS | 1937 | -------- Summary: end -------- 11:31:29 INFO - PROCESS | 1937 | 11:31:29 INFO - TEST-INFO | 1937: exit 0 11:31:29 INFO - TEST-OK | dromaeo_css | took 1113239ms 11:31:29 INFO - TEST-START | kraken 11:31:29 INFO - operating with platform_type : mac_ 11:31:29 INFO - Initialising browser for kraken test... 11:31:29 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpPDfg49/profile http://localhost:54496/getInfo.html) 11:31:32 INFO - PROCESS | 1942 | __metrics Screen width/height:1600/1200 11:31:32 INFO - PROCESS | 1942 | colorDepth:24 11:31:32 INFO - PROCESS | 1942 | Browser inner width/height: 1024/689 11:31:32 INFO - PROCESS | 1942 | __metrics 11:31:32 INFO - PROCESS | 1942 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:31:32 ERROR - PROCESS | 1942 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:31:32 INFO - TEST-INFO | 1942: exit 0 11:31:32 INFO - Browser initialized. 11:31:32 INFO - Running cycle 1/1 for kraken test... 11:31:32 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpPDfg49/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:44 INFO - PROCESS | 1945 | RSS: Main: 160329728 11:31:44 INFO - PROCESS | 1945 | 11:31:47 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54496/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:48 INFO - PROCESS | 1945 | RSS: Main: 224600064 11:31:48 INFO - PROCESS | 1945 | 11:31:50 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54496/tests/kraken/driver.html?testName=audio-dft) 11:31:51 INFO - PROCESS | 1945 | RSS: Main: 239730688 11:31:51 INFO - PROCESS | 1945 | 11:31:54 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54496/tests/kraken/driver.html?testName=audio-fft) 11:31:55 INFO - PROCESS | 1945 | RSS: Main: 326692864 11:31:55 INFO - PROCESS | 1945 | 11:31:57 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54496/tests/kraken/driver.html?testName=audio-oscillator) 11:31:57 INFO - PROCESS | 1945 | RSS: Main: 230887424 11:31:57 INFO - PROCESS | 1945 | 11:31:59 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54496/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:00 INFO - PROCESS | 1945 | RSS: Main: 232353792 11:32:00 INFO - PROCESS | 1945 | 11:32:03 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54496/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:04 INFO - PROCESS | 1945 | RSS: Main: 270176256 11:32:04 INFO - PROCESS | 1945 | 11:32:06 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54496/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:07 INFO - PROCESS | 1945 | RSS: Main: 270700544 11:32:07 INFO - PROCESS | 1945 | 11:32:10 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54496/tests/kraken/driver.html?testName=json-parse-financial) 11:32:11 INFO - PROCESS | 1945 | RSS: Main: 268853248 11:32:11 INFO - PROCESS | 1945 | 11:32:12 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54496/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:13 INFO - PROCESS | 1945 | RSS: Main: 260681728 11:32:13 INFO - PROCESS | 1945 | 11:32:15 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54496/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:15 INFO - PROCESS | 1945 | RSS: Main: 267952128 11:32:15 INFO - PROCESS | 1945 | 11:32:17 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54496/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:18 INFO - PROCESS | 1945 | RSS: Main: 271388672 11:32:18 INFO - PROCESS | 1945 | 11:32:21 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:21 INFO - PROCESS | 1945 | RSS: Main: 277651456 11:32:21 INFO - PROCESS | 1945 | 11:32:24 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:25 INFO - PROCESS | 1945 | RSS: Main: 274624512 11:32:25 INFO - PROCESS | 1945 | 11:32:26 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:54496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54496/tests/kraken/driver.html?testName=ai-astar) 11:32:27 INFO - PROCESS | 1945 | RSS: Main: 335446016 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | __start_tp_report 11:32:27 INFO - PROCESS | 1945 | _x_x_mozilla_page_load 11:32:27 INFO - PROCESS | 1945 | _x_x_mozilla_page_load_details 11:32:27 INFO - PROCESS | 1945 | |i|pagename|runs| 11:32:27 INFO - PROCESS | 1945 | |0;ai-astar;113;113;117;113;112;110;112;112;111;134 11:32:27 INFO - PROCESS | 1945 | |1;audio-beat-detection;159;121;143;164;115;147;171;144;164;117 11:32:27 INFO - PROCESS | 1945 | |2;audio-dft;188;186;190;222;184;185;182;182;187;184 11:32:27 INFO - PROCESS | 1945 | |3;audio-fft;70;81;72;155;56;57;55;63;130;55 11:32:27 INFO - PROCESS | 1945 | |4;audio-oscillator;95;95;142;79;78;82;124;80;76;124 11:32:27 INFO - PROCESS | 1945 | |5;imaging-gaussian-blur;90;86;88;86;95;128;133;86;89;86 11:32:27 INFO - PROCESS | 1945 | |6;imaging-darkroom;139;144;109;95;94;94;94;94;94;94 11:32:27 INFO - PROCESS | 1945 | |7;imaging-desaturate;126;131;94;87;83;83;83;84;84;85 11:32:27 INFO - PROCESS | 1945 | |8;json-parse-financial;58;62;63;64;62;63;63;79;59;55 11:32:27 INFO - PROCESS | 1945 | |9;json-stringify-tinderbox;62;62;65;78;72;70;65;65;65;68 11:32:27 INFO - PROCESS | 1945 | |10;stanford-crypto-aes;81;80;93;100;86;79;79;79;79;83 11:32:27 INFO - PROCESS | 1945 | |11;stanford-crypto-ccm;126;127;123;125;126;125;124;126;141;128 11:32:27 INFO - PROCESS | 1945 | |12;stanford-crypto-pbkdf2;166;165;163;164;165;163;162;163;167;164 11:32:27 INFO - PROCESS | 1945 | |13;stanford-crypto-sha256-iterative;66;67;67;67;65;66;66;68;65;67 11:32:27 INFO - PROCESS | 1945 | __end_tp_report 11:32:27 INFO - PROCESS | 1945 | __start_cc_report 11:32:27 INFO - PROCESS | 1945 | _x_x_mozilla_cycle_collect,1905 11:32:27 INFO - PROCESS | 1945 | __end_cc_report 11:32:27 INFO - PROCESS | 1945 | __startTimestamp1468866747130__endTimestamp 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | ------- Summary: start ------- 11:32:27 INFO - PROCESS | 1945 | Number of tests: 14 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#0] ai-astar Cycles:10 Average:114.70 Median:113.00 stddev:7.02 (6.2%) stddev-sans-first:7.42 11:32:27 INFO - PROCESS | 1945 | Values: 113.0 113.0 117.0 113.0 112.0 110.0 112.0 112.0 111.0 134.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:153.00 stddev:20.71 (13.5%) stddev-sans-first:21.29 11:32:27 INFO - PROCESS | 1945 | Values: 159.0 121.0 143.0 164.0 115.0 147.0 171.0 144.0 164.0 117.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#2] audio-dft Cycles:10 Average:189.00 Median:186.50 stddev:11.87 (6.4%) stddev-sans-first:12.58 11:32:27 INFO - PROCESS | 1945 | Values: 188.0 186.0 190.0 222.0 184.0 185.0 182.0 182.0 187.0 184.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#3] audio-fft Cycles:10 Average:79.40 Median:60.00 stddev:34.85 (58.1%) stddev-sans-first:36.80 11:32:27 INFO - PROCESS | 1945 | Values: 70.0 81.0 72.0 155.0 56.0 57.0 55.0 63.0 130.0 55.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:79.50 stddev:23.87 (30.0%) stddev-sans-first:25.30 11:32:27 INFO - PROCESS | 1945 | Values: 95.0 95.0 142.0 79.0 78.0 82.0 124.0 80.0 76.0 124.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#5] imaging-gaussian-blur Cycles:10 Average:96.70 Median:87.00 stddev:18.07 (20.8%) stddev-sans-first:19.00 11:32:27 INFO - PROCESS | 1945 | Values: 90.0 86.0 88.0 86.0 95.0 128.0 133.0 86.0 89.0 86.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#6] imaging-darkroom Cycles:10 Average:105.10 Median:94.00 stddev:19.77 (21.0%) stddev-sans-first:16.74 11:32:27 INFO - PROCESS | 1945 | Values: 139.0 144.0 109.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:84.00 stddev:18.52 (22.0%) stddev-sans-first:15.61 11:32:27 INFO - PROCESS | 1945 | Values: 126.0 131.0 94.0 87.0 83.0 83.0 83.0 84.0 84.0 85.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:6.36 (10.1%) stddev-sans-first:6.50 11:32:27 INFO - PROCESS | 1945 | Values: 58.0 62.0 63.0 64.0 62.0 63.0 63.0 79.0 59.0 55.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:66.50 stddev:4.96 (7.5%) stddev-sans-first:4.89 11:32:27 INFO - PROCESS | 1945 | Values: 62.0 62.0 65.0 78.0 72.0 70.0 65.0 65.0 65.0 68.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:80.50 stddev:7.20 (8.9%) stddev-sans-first:7.56 11:32:27 INFO - PROCESS | 1945 | Values: 81.0 80.0 93.0 100.0 86.0 79.0 79.0 79.0 79.0 83.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:126.00 stddev:5.09 (4.0%) stddev-sans-first:5.38 11:32:27 INFO - PROCESS | 1945 | Values: 126.0 127.0 123.0 125.0 126.0 125.0 124.0 126.0 141.0 128.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.50 stddev:1.55 (0.9%) stddev-sans-first:1.50 11:32:27 INFO - PROCESS | 1945 | Values: 166.0 165.0 163.0 164.0 165.0 163.0 162.0 163.0 167.0 164.0 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - PROCESS | 1945 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 11:32:27 INFO - PROCESS | 1945 | Values: 66.0 67.0 67.0 67.0 65.0 66.0 66.0 68.0 65.0 67.0 11:32:27 INFO - PROCESS | 1945 | -------- Summary: end -------- 11:32:27 INFO - PROCESS | 1945 | 11:32:27 INFO - TEST-INFO | 1945: exit 0 11:32:27 INFO - TEST-OK | kraken | took 58051ms 11:32:27 INFO - SUITE-END | took 1171s 11:32:28 INFO - Completed test suite (00:19:31) 11:32:28 INFO - javascript benchmark 11:32:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3453.326601312744, 3549.272399158173, 3563.803990780507, 3566.982165089176, 3628.3468975584383, 5838.328592211897, 5845.269341332333, 5849.561282903788, 5899.764009439623, 5918.940810591893, 5113.233015047745, 5582.715975325667, 5699.68651724155, 5820.156077368779, 5860.0, 5252.133397989327, 5270.183121616155, 5280.366356037281, 5339.492748188935, 5423.186522021689, 5318.787248510055, 5345.33183352081, 5357.571394288448, 5360.061989151903, 5366.624336296461, 5248.370195576536, 5284.630075894689, 5295.179247216687, 5324.92012619811, 5354.598405119612, 5342.465753424665, 5394.973025134849, 5402.0, 5422.593305502103, 5430.70131142787, 5176.352955880515, 5210.348706411699, 5297.258383826267, 5316.0962636351915, 5366.436524164946, 5667.801626943078, 5707.058335374658, 5745.597808153431, 5751.0, 5812.447817457335, 6237.251529816451, 6254.7498100075945, 6271.090691849702, 6273.56085074045, 6276.184096067527, 6264.87470250597, 6288.9056664150075, 6311.936880631227, 6328.810135695937, 6346.873062538723, 5981.175741398872, 6017.699115044318, 6031.276246850406, 6060.30306514752, 6061.181740465069, 6446.419822216023, 6450.677466126769, 6467.159269294962, 6472.126262954441, 6473.611583305017, 6118.771466971993, 6168.475679567197, 6178.814635560941, 6193.380661933861, 6282.560220784501, 6267.71795269214, 6317.96841015792, 6329.3354197809485, 6330.746770129235, 6340.778072767431, 6201.0388389799655, 6261.592996455216, 6270.655113968684, 6274.0, 6277.1525844011385, 6231.781887633911, 6259.499240060784, 6272.498200143978, 6288.5598008139905, 6290.591111577824, 5016.899662006739, 5029.823956161516, 5033.245013248042, 5061.089003979246, 5092.898142037138, 4479.7984090716, 4485.439320084989, 4492.797824097858, 4513.052259025576, 4538.773061346919, 5252.763625636855, 5663.377028526858, 5986.940130598726, 5993.400659933972, 5993.9700301498215, 6268.623882567061, 6308.936910630835, 6326.019466982625, 6327.335629758901, 6339.2392912850755, 5933.881322373529, 5954.880902382015, 5963.910541341883, 5980.666636723385, 5995.820125396245, 4957.008598280287, 5339.759710813023, 5428.158635411439, 5552.444755524415, 5553.305836770403, 6278.717457714322, 6324.1146239527425, 6385.776497822647, 6402.199725034371, 6431.614103153825, 6307.779227727007, 6332.556721029484, 6333.746650134128, 6335.683215839282, 6343.175387199634, 6470.28826829039, 6514.446272066927, 6516.413522782972, 6524.836879078061, 6527.67361631926, 6213.502919766317, 6220.471259942956, 6241.438270555672, 6254.0, 6260.060990851409, 6256.311805701278, 6267.905981410374, 6273.968630157003, 6319.715612797343, 6324.1146239527425, 6214.4407003369915, 6248.094026366242, 6251.0, 6255.186825712628, 6255.874882502233, 6139.416755408229, 6248.406401392042, 6254.155688981929, 6255.280642726145, 6268.498520118288, 5997.16039754426, 6070.271567411939, 6081.361457046946, 6129.264488261437, 6146.477549408351, 6105.8168254952425, 6227.906581401373, 6243.562950593415, 6248.125262463168, 6262.185915830913, 6081.787137450168, 6103.3591472894705, 6123.668821788998, 6136.079588061648, 6151.200343955257], "value": 5812.401250199284, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.1071346570433, 518.8650950752805, 588.4174667079591, 608.0969759906541, 620.1627802466668, 32200.516992245106, 40601.78194654161, 41852.372214416806, 41873.581264187385, 41957.370639440356, 44522.0, 44777.32834007484, 44977.55022449775, 44988.550114498845, 45067.0, 8928.46429214246, 9630.614775408976, 9851.113399794018, 9856.211503079736, 9862.30963832532, 11767.7646447071, 12004.759904801898, 12042.939785301061, 12061.939690301537, 12068.758624827498, 11756.647300580997, 11825.586104486345, 11841.052715782716, 11848.881511184907, 11856.466459009365, 11736.061115110771, 11866.821997670042, 11871.643850684493, 11877.762444751143, 11881.34652594107, 11599.884001159964, 11741.647750567497, 11748.647540573797, 11891.881081189164, 11946.940265298705, 41505.0, 41828.0, 41895.7905210472, 41901.0, 41909.58090419087, 2789.846558439305, 3549.4853246279145, 3843.3658446356317, 3913.3542965410675, 3983.24318379507, 28679.0, 29416.0, 29455.61014341733, 29515.409691806042, 29725.40549189026, 2760.917172484829, 2780.249332680165, 2791.8464484453348, 2795.2313113893842, 2950.852457377144, 696060.0, 705023.0, 705211.0, 705333.9466605319, 707252.0, 37413.62586374156, 65342.0, 65584.0, 65962.67018664876, 66086.0, 36496.0, 36609.45085823715, 36682.082947925985, 36698.899033029054, 36753.63246367555, 15693.21533923322, 15856.127912964897, 15873.841261587468, 15884.046957182605, 15901.045937243802, 12635.0, 12709.110362274738, 13409.865901341056, 13603.931980340036, 13657.453701851815, 7281.162666293444, 8299.626516806758, 8334.12491688364, 8351.08138104808, 8436.409451338348, 3511.9297614048087, 3534.472851910896, 3541.415666415064, 3575.4100573405617, 3635.9091022724115, 1046.6289161198854, 1055.577768892449, 1106.2366966792888, 1153.9076873850072, 1197.7544603356291, 29641.0, 30039.69960300369, 30145.849270753504, 30845.0, 30885.536716949264, 855.4525103933488, 1186.4067966016992, 1190.3631557117073, 1299.5581502289078, 1334.7463981843614, 14423.63940901465, 15074.773878391832, 15133.092014479167, 15290.464833730766, 15385.9230703848, 570919.0, 571541.0, 572073.0, 572272.0, 572728.0, 62437.0, 64119.358806411336, 64222.67888660527, 64230.35769642337, 64373.0, 1435.8205224346957, 1465.2014652014677, 1590.9363625455085, 1619.5708137343377, 1668.6162182698047, 24627.630585540872, 29411.0, 29854.850725747103, 30041.248968775955, 30678.846605766827, 48301.0, 48614.0, 49097.75451122721, 49119.01761964669, 49151.75424122856, 367735.0, 370160.0, 370659.0, 370938.0, 622216.0, 23844.761552384254, 27583.03459378912, 28084.0, 28404.147875563765, 28408.431831362843, 43596.34605480984, 43941.78029109834, 44393.0, 44450.0, 44722.55277447314, 35702.821485892404, 37255.6274437263, 37453.43819842759, 38149.23701526009, 39135.41296880492, 35977.82011090033, 36162.27675446529, 36239.45640815337, 36657.90026299215, 36748.0, 35688.929332120075, 36163.457548137325, 36362.4545631821, 36488.63511364959, 38726.45094196201, 33370.33259334848, 33451.996440106836, 33740.32519349649, 33952.490712638835, 34343.96968090961, 25335.239942801745, 25403.491930160922, 25453.618195726707, 25841.353966150997, 25870.482590348463], "value": 19422.55512417299, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.7187148674644, 417.211470321093, 417.7472629059419, 420.3904338708873, 430.212710739347, 20704.068316925735, 21141.894290528566, 21286.680699789496, 21356.25253116141, 22374.888125559348, 20438.591228175428, 20780.58438831226, 21310.254141105066, 21337.786622133775, 21390.358289251308, 5360.303160589118, 5705.087186050233, 5710.086386178213, 5716.114002329625, 5721.170430287606, 4284.785760711968, 4510.54894510548, 5605.5515558755405, 5728.16941543476, 6072.210612620375, 5465.426130256325, 6353.428191462767, 6360.077788720633, 6365.52258580606, 6373.13962615048, 6111.694415279218, 6259.937400625981, 6293.779717709904, 6324.652144132071, 6332.715027823759, 4175.123224122938, 5865.384134665841, 6101.786437474711, 6136.509079273647, 6155.569110162291, 13916.30418479072, 14119.717605647933, 14126.940479464081, 14130.0, 26490.072847450247, 2185.737711474633, 2187.726534183227, 2231.843770936035, 2288.302067869299, 2372.8694921779297, 10097.444640544767, 10205.081542661195, 10352.275340726152, 10436.582536698523, 10578.788424231549, 1834.1562881074722, 1848.9630207395912, 1882.5481884347794, 1921.702136168896, 1967.45894878908, 118111.0, 119628.0, 120290.0, 121450.0, 129387.35306323408, 11768.94115529434, 11830.822537661941, 11891.464884080237, 11907.106966977339, 11931.522739090338, 15675.529734107995, 15703.607409814846, 15705.764413533807, 15706.057636541844, 15751.763723544156, 7595.886061709079, 8888.511131887808, 9198.540072996324, 9262.629494820267, 9337.206337461255, 9077.546122693971, 9103.863442048374, 9217.308701847254, 9318.534073296309, 9320.161185493202, 4002.2795896738867, 4734.479207287196, 4801.135795556764, 4814.109389762905, 4863.513648635108, 1816.344139036115, 1941.2526177421794, 2009.5277609761695, 2031.9695204571942, 2100.5063810004635, 904.2178515583972, 927.1609193679731, 957.1577012229333, 1047.1361127070197, 1059.0733108530037, 20208.49478763043, 20222.0, 20436.48908777263, 20501.077451514717, 20824.58350832975, 949.2311227905419, 987.4322264697828, 1010.8079464901646, 1017.954192061359, 1025.1337619711333, 11091.944540277247, 11291.717707057225, 11341.26281791681, 11350.659480215607, 11357.432128393713, 527990.0, 533146.3342683262, 536202.0, 588522.0, 651747.0, 133642.33178834044, 136623.31688341495, 137436.0, 137861.0, 141782.0, 1033.379972016799, 1065.1638463805875, 1077.983830242547, 1078.2398409121552, 1082.8971247731454, 18496.722549161503, 18837.90581047086, 19164.94592797354, 19238.422847314603, 19367.8063219366, 35477.0, 50416.991660167325, 53101.7344913273, 55229.0, 56204.0, 75623.86564201652, 78077.219227807, 80637.0, 82089.0, 83706.58146709227, 8276.544790036605, 8331.250187483156, 8448.321332782632, 8590.1839325264, 8598.269147122564, 9284.442933424016, 11009.504572294105, 12305.56930507428, 12979.896708779483, 13314.201147931155, 11090.057345125755, 11103.555857765921, 11205.383703896365, 11437.771244575228, 11520.13598980063, 8632.568371581521, 10776.245662803529, 11438.885611144115, 11577.768444631229, 11603.709907252387, 11206.495707693337, 11508.482118304864, 11587.073034157416, 11852.525898963944, 11881.762364752829, 8286.212809783061, 8391.748247552583, 8401.663933442594, 8446.873296900429, 8541.973490427079, 11224.94387528057, 11239.719007024563, 11295.548178072784, 11366.408702781451, 11406.54373825071], "value": 9666.10708459507, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.3158499712645, 1610.7583862420636, 1645.8271881452447, 1919.7984211657777, 2031.4413536277514, 8214.38392120591, 8874.689385871496, 9026.277897768163, 9028.187463128317, 9041.909580904197, 8294.875576866336, 8342.165783421655, 8789.0, 9039.960404553478, 9042.186203241707, 2527.9494410111834, 2564.3332733489333, 2566.486702659466, 2570.2803215099707, 2582.2382397192778, 2501.0746023971155, 2568.948621027578, 2569.755873192044, 2573.3437973316873, 2574.0, 2536.4039450729156, 2566.0377358490564, 2572.7555882191164, 2575.3175408516663, 2584.095566551711, 2529.051605647882, 2549.8725063746833, 2560.0, 2561.807864410158, 2571.4214301782135, 2519.282004628672, 2556.2714626331594, 2562.782163516085, 2565.961510577343, 2568.6403903453534, 8787.78030549235, 9018.323625728097, 9027.909720902773, 9109.863352049724, 9126.817463650756, 5739.512141467981, 5823.301203855522, 5836.503897168745, 5900.291964964232, 5911.467967882868, 3158.7788854780174, 3305.8842940497207, 3611.3138503684218, 3770.830312635938, 3811.2377524494937, 1056.8846781577204, 1081.728390174377, 1094.6262440637029, 1094.956201751937, 1100.3233011697748, 12205.023598112219, 12394.690132746664, 12438.0, 12460.626181214579, 12471.314077725721, 4339.392485052095, 5020.849374518771, 5049.343585333883, 5163.612729045337, 5196.45437229093, 10742.462876856125, 10752.784944301227, 10761.30051546647, 10762.677119686421, 10773.62292319765, 5794.0, 5857.326407463111, 5860.179574859523, 5860.413958604106, 5865.912011319833, 4241.533431322552, 4665.5567721066445, 4821.5178482151505, 5226.608004399685, 5285.709285989307, 4198.832046718097, 4232.068944832132, 4279.700420970502, 4320.142338794286, 4330.523642399334, 1390.7496650602786, 1425.7291114688383, 1434.4620767212296, 1440.9351579178963, 1458.482238805209, 933.5099072986601, 938.6010945348199, 955.1260596554214, 960.4621412009298, 997.5760301871676, 5967.254093238345, 6030.819075427744, 6122.295935967331, 6134.2332208473945, 6138.9256880046705, 486.20748180465614, 493.7629937629958, 494.45609829187606, 1049.040128282628, 1051.5057922776282, 3940.605939406094, 3993.5407428146136, 4016.0763024504527, 4074.2869997750277, 4089.7750623715388, 10520.842187367196, 10803.081738052353, 10824.458777061272, 10873.728156796144, 10934.56261749521, 10692.679219623424, 10797.46012699362, 10801.297915635458, 10811.18916081297, 10839.512221950032, 8329.458585191944, 8583.227509524173, 8669.739907802776, 8725.694600689072, 8787.560621968876, 5313.574914006947, 5868.471837534642, 5919.171316015847, 5995.700214989321, 6053.152558641706, 9913.959034301583, 9914.851277230702, 10045.49772511386, 10096.394216347042, 10325.690229293134, 9376.624935002523, 10405.9479702601, 10412.531436085546, 10492.160627149657, 10537.789244215226, 7020.297970202939, 7188.3171098747625, 7212.350888419857, 7727.884081738666, 7884.053913530413, 7896.921030789848, 8134.75595732129, 8332.208440198172, 8333.833323333378, 8373.581320933807, 6874.175098987954, 7173.246809084971, 7364.66858991336, 7420.851582968203, 7571.091469023752, 7273.709051638087, 7316.268373162641, 7334.889976650461, 7359.852802944019, 7403.444741644506, 6968.686409111703, 7051.5063945523325, 7056.400205982549, 7068.469864760266, 7137.072180616487, 4963.478834722447, 4973.179425394914, 5002.624803139852, 5085.694858308513, 5088.567471764942, 4470.575295346936, 4939.703617782944, 4953.777080031336, 5062.31658726082, 5228.111221092499], "value": 4727.716953599435, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.3343762318927, 332.9650386709395, 338.05345033905076, 342.58376073071213, 345.4593561076913, 5324.787008519665, 6618.933810661892, 6635.137432133828, 6662.233843108044, 6668.366505182006, 6556.901646475295, 6603.207615086184, 6618.569792963454, 6650.567713098645, 6709.530332876689, 4699.906001879969, 4810.470848206712, 4830.97584512077, 4845.975770121145, 4852.951470485303, 4831.516848315158, 4857.489963553811, 4868.853934381974, 4932.062908047459, 4963.70217786934, 4799.928001079987, 4838.491958344376, 4859.73271470069, 4866.46468888422, 4901.1177987962155, 4842.878928026792, 4848.587870031051, 4864.854054378375, 4879.658423910328, 4885.438174609894, 4007.5591684914634, 4099.815508302134, 4172.582741725833, 4180.707350485467, 4188.6649068074485, 5169.767360468788, 6465.612063276171, 6469.93530064698, 6470.320616335264, 6471.579347342407, 5788.0739081746715, 5801.506871915893, 5807.88384232313, 5824.854378640568, 5827.650340979555, 5737.483626473638, 7135.785926422215, 7145.785626431215, 7149.678264478059, 7157.498975071747, 4715.7877895494785, 4726.881827954294, 4728.030753695519, 4728.763561821929, 4733.3846599942135, 7123.750668726621, 7431.145418276913, 7442.441816863703, 7468.290512401313, 7509.549427034341, 4598.356230127785, 4666.673332866667, 4668.229742092584, 4682.1103990241745, 4694.2958556216845, 4783.904321913612, 4790.281457781361, 4790.880227994328, 4793.640476964241, 4794.544518270759, 5764.337101233412, 5764.798232061858, 5768.596198266165, 5775.94224057754, 5776.913346299809, 6879.724811007603, 7168.2831716827895, 7174.641267936582, 7188.28117188277, 7194.352508274281, 1623.1559589013882, 1637.148682684997, 1655.1062426289668, 1666.924988375526, 1669.3656410563908, 1034.7723500829804, 1036.9377837329635, 1051.3534176481562, 1054.46222426563, 1061.8991195836384, 6511.3163117871945, 6615.37153970372, 6687.1975362956755, 6716.320919770057, 6733.8989915151315, 7470.36501897334, 7476.0, 7492.063492063492, 7558.319751222416, 7589.316961473494, 6775.62734049632, 6802.081718967975, 6802.591844489347, 6827.795166145023, 6830.248672646005, 3946.1713040261293, 3996.4205190247253, 4002.3796311571755, 4003.199360127986, 4004.7797371144284, 6764.3573860483175, 7660.264282556325, 7796.844063118706, 7897.210278972057, 7923.484973476706, 7703.576303303372, 7708.576028318496, 7733.188015258429, 7762.6894924203525, 7774.883376749353, 7890.605469726605, 7891.131975482693, 7898.012748406564, 7907.762767116996, 7926.167752386032, 7529.360004399688, 7545.170031296663, 7563.281488258606, 7574.3183113520045, 7586.468947173645, 7103.82240443993, 7350.545243735436, 7390.334869861738, 7407.629618518945, 7411.147718012282, 6679.098321726699, 7242.493025488166, 7851.371890248653, 7867.803304917423, 7869.527828330319, 4697.577218050392, 4708.764561771829, 4712.340272361804, 4717.858464246078, 4720.45714742809, 6069.241344831896, 7492.7752167435065, 7505.812354690958, 7516.549007059594, 7522.849543009219, 6960.5127641066665, 7239.371141493122, 7240.52936559122, 7272.381847543018, 7272.745453909088, 7165.498415110892, 7222.530535515175, 7227.674754636159, 7235.612247958266, 7262.273772622695, 7069.646517674199, 7084.149902011585, 7084.822879427849, 7091.503594748318, 7094.148702155568, 6924.723011079501, 7245.0, 7253.238409967089, 7256.310650488195, 7256.673449694882, 6798.252192258947, 6957.1651401832105, 7052.5063245574365, 7067.57594544329, 7086.362227399559], "value": 5232.4912210482935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.0627462337778, 717.4762423430896, 721.1238345410326, 749.5465243527663, 824.6206744897347, 15409.229538523057, 15460.536183914486, 15826.841731582681, 15845.811564132693, 15847.811414143927, 14711.558653240394, 14793.40826366944, 14804.259787010633, 14805.407783688639, 14808.55574332769, 778.6651739751904, 797.4258533855615, 954.8949615542267, 964.62379671928, 972.1590823937279, 957.5595226195958, 984.6553706202843, 987.0031268418912, 987.6049580167954, 988.461288597716, 1016.0753714120152, 1024.4723967156883, 1025.1747343388606, 1025.2823023883311, 1025.676911772793, 807.3984881263438, 1000.6697789729371, 1018.0786388318546, 1020.0768304684273, 1030.7835354575548, 762.6911101004102, 763.290140169642, 765.3341592814231, 765.4832987733314, 766.2490759056101, 15524.146171960538, 15586.688266234725, 15607.609809754733, 15630.687386252212, 15682.686346273125, 13207.075504714674, 13321.533746318832, 13549.696551586254, 13631.863681363158, 13650.795238071438, 10261.538230779634, 10266.538005789758, 10270.383776973405, 10405.9479702601, 10823.512941917554, 3562.5546806649168, 3591.9942416123527, 3595.53258076451, 3625.0920452962546, 3817.1602247505502, 82911.0, 83475.0, 84268.57865710693, 85500.0, 86007.0, 9956.751081223027, 9963.701088967342, 10001.2999090063, 10001.49992500372, 10225.335353202017, 23153.421164470685, 23238.76761232366, 23269.41826454352, 23271.836408179523, 23290.3012909613, 7563.924360756322, 7635.045619297588, 7683.270089341504, 7703.922960770433, 7933.801654958556, 4206.453161089039, 4267.4025636410925, 4349.978250108729, 4388.670849686287, 4555.794989225493, 3807.143392736612, 3872.0319920019997, 3875.399313106473, 3879.4180872869297, 3880.611938806097, 648.3127884442506, 670.8691805098057, 682.0485422835118, 700.684691888642, 713.2546488919093, 556.577001478879, 591.3642833953431, 596.0373995996521, 611.6635850282327, 635.0949896397707, 8461.45000574973, 8462.323014158852, 8465.195806398382, 8600.956995214983, 8648.1784230498, 531.2297169104813, 606.336062012096, 620.8106527509062, 629.3486241739778, 632.6330728177646, 3899.53205615328, 3943.507061617298, 3992.161646054303, 4024.5170579530645, 4044.919101617951, 91350.54324728333, 92239.07760922439, 92470.15059698769, 93056.0, 93186.0, 77714.0, 77872.0, 77971.44057118939, 78920.0, 79059.60470197727, 68740.31259687438, 70214.0, 70506.64746676234, 70741.64629176821, 71391.64304178445, 7766.262205090507, 7976.481528700616, 8054.395920305883, 8113.675452982051, 8253.298469630148, 48419.757901210265, 48423.27365089456, 49355.50644493509, 49703.502964969884, 50355.496445036544, 64119.0, 64616.353836461036, 64713.0, 65496.34503654903, 68441.65779171072, 10374.585016599553, 10445.425501597485, 10503.579856805642, 10615.363078215332, 11309.773804523698, 9738.951305243429, 10871.891281087088, 10980.615678451535, 11109.555617775522, 11335.546578137111, 10436.686899393031, 10622.150227981589, 10627.9903409176, 10635.89364106349, 10808.891911081104, 10403.0, 10470.0, 10476.580936762444, 10766.977137171956, 11464.484098215433, 10298.485075746332, 10366.948165259126, 10447.791044179226, 10501.842472363074, 11251.662450126509, 8998.415103018282, 9081.409708368936, 9156.267498599962, 9233.538323083952, 9248.72718241649, 9047.0, 9057.320700947323, 9070.18368346852, 9159.450432974043, 9193.908060919573], "value": 7024.656601487065, "unit": "score"}], "name": "dromaeo_css", "value": 7579.76234046397, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 117.0, 113.0, 112.0, 110.0, 112.0, 112.0, 111.0, 134.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 121.0, 143.0, 164.0, 115.0, 147.0, 171.0, 144.0, 164.0, 117.0], "value": 144.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 186.0, 190.0, 222.0, 184.0, 185.0, 182.0, 182.0, 187.0, 184.0], "value": 189.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 81.0, 72.0, 155.0, 56.0, 57.0, 55.0, 63.0, 130.0, 55.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 142.0, 79.0, 78.0, 82.0, 124.0, 80.0, 76.0, 124.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 88.0, 86.0, 95.0, 128.0, 133.0, 86.0, 89.0, 86.0], "value": 96.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 144.0, 109.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 105.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 94.0, 87.0, 83.0, 83.0, 83.0, 84.0, 84.0, 85.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 63.0, 64.0, 62.0, 63.0, 63.0, 79.0, 59.0, 55.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 65.0, 78.0, 72.0, 70.0, 65.0, 65.0, 65.0, 68.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 93.0, 100.0, 86.0, 79.0, 79.0, 79.0, 79.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 123.0, 125.0, 126.0, 125.0, 124.0, 126.0, 141.0, 128.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 163.0, 164.0, 165.0, 163.0, 162.0, 163.0, 167.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 65.0, 66.0, 66.0, 68.0, 65.0, 67.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1492.5000000000002, "alertThreshold": 2.0}]} 11:32:28 INFO - Return code: 0 11:32:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:32:28 ERROR - # TBPL SUCCESS # 11:32:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:32:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:32:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:32:28 INFO - 2016-07-18 11:32:28.472 screenresolution[1949:17463] starting screenresolution argv=screenresolution get 11:32:28 INFO - 2016-07-18 11:32:28.474 screenresolution[1949:17463] Display 0: 1600x1200x32@60 11:32:28 INFO - 2016-07-18 11:32:28.480 screenresolution[1950:17466] starting screenresolution argv=screenresolution list 11:32:28 INFO - Available Modes on Display 0 11:32:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:32:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:32:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:32:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:32:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:32:28 INFO - Intel Iris: 11:32:28 INFO - Chipset Model: Intel Iris 11:32:28 INFO - Type: GPU 11:32:28 INFO - Bus: Built-In 11:32:28 INFO - VRAM (Dynamic, Max): 1536 MB 11:32:28 INFO - Vendor: Intel (0x8086) 11:32:28 INFO - Device ID: 0x0a2e 11:32:28 INFO - Revision ID: 0x0009 11:32:28 INFO - Displays: 11:32:28 INFO - Display: 11:32:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:32:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:32:28 INFO - Display Serial Number: 1600x1200 60 11:32:28 INFO - Main Display: Yes 11:32:28 INFO - Mirror: Off 11:32:28 INFO - Online: Yes 11:32:28 INFO - Rotation: Supported 11:32:28 INFO - Return code: 0 11:32:28 INFO - Running post-action listener: _resource_record_post_action 11:32:28 INFO - Running post-run listener: _resource_record_post_run 11:32:29 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 512000; Write bytes: 492872192; Read time: 8; Write time: 1536 11:32:29 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193217024; Write bytes: 189175296; Read time: 17603; Write time: 426 11:32:29 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 512000; Write bytes: 295017472; Read time: 8; Write time: 1078 11:32:29 INFO - Running post-run listener: _upload_blobber_files 11:32:29 INFO - Blob upload gear active. 11:32:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:32:29 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 11:32:29 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:32:29 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:32:30 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:32:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:32:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:30 INFO - (blobuploader) - INFO - Done attempting. 11:32:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:32:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:32:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:31 INFO - (blobuploader) - INFO - Done attempting. 11:32:31 INFO - (blobuploader) - INFO - Iteration through files over. 11:32:31 INFO - Return code: 0 11:32:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:32:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:32:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e509258459c3803efb5d4abfdbffcf9c0b7ef4e5de5ae38c49a1a384cf38ad09cc493d16164d6c7b355e96da55ce82b1cffc78411225b47d871938d94b283e63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/904f81cb40cca92d1a3923e879fa89b70bbeb3bd6969158aea61ad87a31a00f54024d5d3599088d6a56ed6e8f1610adc52bf6c59d93bdb72982679bce08de893"} 11:32:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:32:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:32:31 INFO - Contents: 11:32:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e509258459c3803efb5d4abfdbffcf9c0b7ef4e5de5ae38c49a1a384cf38ad09cc493d16164d6c7b355e96da55ce82b1cffc78411225b47d871938d94b283e63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/904f81cb40cca92d1a3923e879fa89b70bbeb3bd6969158aea61ad87a31a00f54024d5d3599088d6a56ed6e8f1610adc52bf6c59d93bdb72982679bce08de893"} 11:32:31 INFO - Running post-run listener: copy_logs_to_upload_dir 11:32:31 INFO - Copying logs to upload dir... 11:32:31 INFO - mkdir: /builds/slave/test/build/upload/logs 11:32:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.615533 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-18 11:32:32.067190) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 11:32:32.070223) ========= 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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e509258459c3803efb5d4abfdbffcf9c0b7ef4e5de5ae38c49a1a384cf38ad09cc493d16164d6c7b355e96da55ce82b1cffc78411225b47d871938d94b283e63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/904f81cb40cca92d1a3923e879fa89b70bbeb3bd6969158aea61ad87a31a00f54024d5d3599088d6a56ed6e8f1610adc52bf6c59d93bdb72982679bce08de893"} build_url:https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010497 build_url: 'https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e509258459c3803efb5d4abfdbffcf9c0b7ef4e5de5ae38c49a1a384cf38ad09cc493d16164d6c7b355e96da55ce82b1cffc78411225b47d871938d94b283e63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/904f81cb40cca92d1a3923e879fa89b70bbeb3bd6969158aea61ad87a31a00f54024d5d3599088d6a56ed6e8f1610adc52bf6c59d93bdb72982679bce08de893"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 11:32:32.105021) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:32:32.105350) ========= 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.hjUaE40RMw/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.Vw97AU4ibQ/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.004980 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:32:32.153637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 11:32:32.154208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 11:32:32.154546) ========= ========= Total master_lag: 0.19 =========