builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0381 starttime: 1474081678.05 results: success (0) buildid: 20160916170818 builduid: 6bd9a6ebe2ab4851864d37519c0f9c93 revision: 60d0e1dbddc00e146462d067c56d79b7b51faf3f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:58.047736) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:58.048414) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:58.048689) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:58.078621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:58.078921) ========= 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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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-09-16 20:07:58-- 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% 56.2M=0s 2016-09-16 20:07:58 (56.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.559043 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:58.663490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:58.663922) ========= 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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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.020320 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:58.712638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:58.712997) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 60d0e1dbddc00e146462d067c56d79b7b51faf3f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 60d0e1dbddc00e146462d067c56d79b7b51faf3f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vD2s9CBMBh/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.HxPhaPIVsz/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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-09-16 20:07:58,789 truncating revision to first 12 chars 2016-09-16 20:07:58,790 Setting DEBUG logging. 2016-09-16 20:07:58,790 attempt 1/10 2016-09-16 20:07:58,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/60d0e1dbddc0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-16 20:07:59,087 unpacking tar archive at: autoland-60d0e1dbddc0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590393 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:59.325278) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:59.325576) ========= script_repo_revision: 60d0e1dbddc00e146462d067c56d79b7b51faf3f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:59.326022) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:59.326288) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-16 20:07:59.347966) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-16 20:07:59.348248) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vD2s9CBMBh/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.HxPhaPIVsz/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 20:07:59 INFO - MultiFileLogger online at 20160916 20:07:59 in /builds/slave/test 20:07:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 20:07:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:07:59 INFO - {'append_to_log': False, 20:07:59 INFO - 'base_work_dir': '/builds/slave/test', 20:07:59 INFO - 'blob_upload_branch': 'Autoland', 20:07:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:07:59 INFO - 'branch': 'Autoland', 20:07:59 INFO - 'buildbot_json_path': 'buildprops.json', 20:07:59 INFO - 'config_files': ('talos/mac_config.py',), 20:07:59 INFO - 'default_actions': ('clobber', 20:07:59 INFO - 'read-buildbot-config', 20:07:59 INFO - 'download-and-extract', 20:07:59 INFO - 'populate-webroot', 20:07:59 INFO - 'create-virtualenv', 20:07:59 INFO - 'install', 20:07:59 INFO - 'run-tests'), 20:07:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:07:59 INFO - 'download_minidump_stackwalk': True, 20:07:59 INFO - 'download_symbols': 'ondemand', 20:07:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:07:59 INFO - 'tooltool.py': '/tools/tooltool.py', 20:07:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:07:59 INFO - '/tools/misc-python/virtualenv.py')}, 20:07:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:07:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:07:59 INFO - 'installer_path': 'installer.exe', 20:07:59 INFO - 'log_level': 'info', 20:07:59 INFO - 'log_name': 'talos', 20:07:59 INFO - 'log_to_console': True, 20:07:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:07:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:07:59 INFO - 'opt_config_files': (), 20:07:59 INFO - 'pip_index': False, 20:07:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:07:59 INFO - 'cmd': ('bash', 20:07:59 INFO - '-c', 20:07:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:07:59 INFO - 'enabled': True, 20:07:59 INFO - 'halt_on_failure': False, 20:07:59 INFO - 'name': 'check_screen_resolution'},), 20:07:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:07:59 INFO - 'cmd': ('bash', 20:07:59 INFO - '-c', 20:07:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:07:59 INFO - 'enabled': True, 20:07:59 INFO - 'halt_on_failure': False, 20:07:59 INFO - 'name': 'check_screen_resolution'},), 20:07:59 INFO - 'run_cmd_checks_enabled': True, 20:07:59 INFO - 'sps_profile': False, 20:07:59 INFO - 'sps_profile_interval': 0, 20:07:59 INFO - 'suite': 'dromaeojs-e10s', 20:07:59 INFO - 'system_bits': '32', 20:07:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:07:59 INFO - 'title': 't-yosemite-r7-0381', 20:07:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:07:59 INFO - 'use_talos_json': True, 20:07:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:07:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:07:59 INFO - 'work_dir': 'build'} 20:07:59 INFO - [mozharness: 2016-09-17 03:07:59.536320Z] Running clobber step. 20:07:59 INFO - Running pre-action listener: _resource_record_pre_action 20:07:59 INFO - Running main action method: clobber 20:07:59 INFO - rmtree: /builds/slave/test/build 20:07:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:08:01 INFO - Running post-action listener: _resource_record_post_action 20:08:01 INFO - [mozharness: 2016-09-17 03:08:01.106212Z] Finished clobber step (success) 20:08:01 INFO - [mozharness: 2016-09-17 03:08:01.106350Z] Running read-buildbot-config step. 20:08:01 INFO - Running pre-action listener: _resource_record_pre_action 20:08:01 INFO - Running main action method: read_buildbot_config 20:08:01 INFO - Using buildbot properties: 20:08:01 INFO - { 20:08:01 INFO - "project": "", 20:08:01 INFO - "product": "firefox", 20:08:01 INFO - "script_repo_revision": "production", 20:08:01 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 20:08:01 INFO - "repository": "", 20:08:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 20:08:01 INFO - "buildid": "20160916170818", 20:08:01 INFO - "pgo_build": "False", 20:08:01 INFO - "basedir": "/builds/slave/test", 20:08:01 INFO - "buildnumber": 144, 20:08:01 INFO - "slavename": "t-yosemite-r7-0381", 20:08:01 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:08:01 INFO - "platform": "yosemite_r7", 20:08:01 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 20:08:01 INFO - "branch": "autoland", 20:08:01 INFO - "repo_path": "integration/autoland", 20:08:01 INFO - "revision": "60d0e1dbddc00e146462d067c56d79b7b51faf3f", 20:08:01 INFO - "stage_platform": "macosx64", 20:08:01 INFO - "builduid": "6bd9a6ebe2ab4851864d37519c0f9c93", 20:08:01 INFO - "slavebuilddir": "test" 20:08:01 INFO - } 20:08:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 20:08:01 INFO - Running post-action listener: _resource_record_post_action 20:08:01 INFO - [mozharness: 2016-09-17 03:08:01.109602Z] Finished read-buildbot-config step (success) 20:08:01 INFO - [mozharness: 2016-09-17 03:08:01.109741Z] Running download-and-extract step. 20:08:01 INFO - Running pre-action listener: _resource_record_pre_action 20:08:01 INFO - Running main action method: download_and_extract 20:08:01 INFO - mkdir: /builds/slave/test/build/tests 20:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:01 INFO - trying https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 20:08:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 20:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 20:08:02 INFO - Downloaded 1199 bytes. 20:08:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 20:08:02 INFO - Using the following test package requirements: 20:08:02 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:08:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 20:08:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 20:08:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'jsshell-mac.zip'], 20:08:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 20:08:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:08:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 20:08:02 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 20:08:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 20:08:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 20:08:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:08:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:08:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:08:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 20:08:03 INFO - Expected file size: 16427368 20:08:09 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:08:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:08:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:08:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 20:08:10 INFO - Expected file size: 16427368 20:08:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 20:08:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:08:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip into memory 20:08:18 INFO - Expected file size: 14414048 20:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:19 INFO - trying https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:08:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 20:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 20:08:22 INFO - Downloaded 111319657 bytes. 20:08:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:08:22 INFO - mkdir: /builds/slave/test/properties 20:08:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:08:22 INFO - Writing to file /builds/slave/test/properties/build_url 20:08:22 INFO - Contents: 20:08:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:08:23 INFO - Running post-action listener: _resource_record_post_action 20:08:23 INFO - Running post-action listener: set_extra_try_arguments 20:08:23 INFO - [mozharness: 2016-09-17 03:08:23.085604Z] Finished download-and-extract step (success) 20:08:23 INFO - [mozharness: 2016-09-17 03:08:23.085760Z] Running populate-webroot step. 20:08:23 INFO - Running pre-action listener: _resource_record_pre_action 20:08:23 INFO - Running main action method: populate_webroot 20:08:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:08:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:08:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:08:23 INFO - '--tppagecycles', 20:08:23 INFO - '7'], 20:08:23 INFO - 'tests': ['tsvgm']}}, 20:08:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:08:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:08:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:08:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:08:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:08:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:08:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:23 INFO - 'talos_options': ['--disable-e10s'], 20:08:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:23 INFO - 'talos_options': ['--disable-e10s'], 20:08:23 INFO - 'tests': ['damp', 'tps']}, 20:08:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:23 INFO - 'tests': ['damp', 'tps']}, 20:08:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:08:23 INFO - 'tests': ['dromaeo_dom']}, 20:08:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:08:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:08:23 INFO - 'tests': ['basic_compositor_video']}, 20:08:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:08:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:08:23 INFO - 'tests': ['a11yr', 20:08:23 INFO - 'ts_paint', 20:08:23 INFO - 'tpaint', 20:08:23 INFO - 'sessionrestore', 20:08:23 INFO - 'sessionrestore_no_auto_restore', 20:08:23 INFO - 'tabpaint']}, 20:08:23 INFO - 'other-e10s': {'tests': ['a11yr', 20:08:23 INFO - 'ts_paint', 20:08:23 INFO - 'tpaint', 20:08:23 INFO - 'sessionrestore', 20:08:23 INFO - 'sessionrestore_no_auto_restore', 20:08:23 INFO - 'tabpaint']}, 20:08:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:08:23 INFO - 'ts_paint', 20:08:23 INFO - 'tpaint', 20:08:23 INFO - 'sessionrestore', 20:08:23 INFO - 'sessionrestore_no_auto_restore', 20:08:23 INFO - 'tabpaint']}, 20:08:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:08:23 INFO - 'ts_paint', 20:08:23 INFO - 'tpaint', 20:08:23 INFO - 'sessionrestore', 20:08:23 INFO - 'sessionrestore_no_auto_restore', 20:08:23 INFO - 'tabpaint']}, 20:08:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:08:23 INFO - 'tests': ['a11yr', 20:08:23 INFO - 'ts_paint', 20:08:23 INFO - 'tpaint', 20:08:23 INFO - 'sessionrestore', 20:08:23 INFO - 'sessionrestore_no_auto_restore', 20:08:23 INFO - 'tabpaint']}, 20:08:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:08:23 INFO - 'tests': ['a11yr', 20:08:23 INFO - 'ts_paint', 20:08:23 INFO - 'tpaint', 20:08:23 INFO - 'sessionrestore', 20:08:23 INFO - 'sessionrestore_no_auto_restore', 20:08:23 INFO - 'tabpaint']}, 20:08:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:08:23 INFO - 'tests': ['tsvgx', 20:08:23 INFO - 'tsvgr_opacity', 20:08:23 INFO - 'tart', 20:08:23 INFO - 'tscrollx', 20:08:23 INFO - 'cart']}, 20:08:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:08:23 INFO - 'tsvgr_opacity', 20:08:23 INFO - 'tart', 20:08:23 INFO - 'tscrollx', 20:08:23 INFO - 'cart']}, 20:08:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:23 INFO - 'talos_options': ['--disable-e10s'], 20:08:23 INFO - 'tests': ['tp5o']}, 20:08:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:23 INFO - 'tests': ['tp5o']}, 20:08:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:23 INFO - 'talos_options': ['--disable-e10s', 20:08:23 INFO - '--xperf_path', 20:08:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:23 INFO - 'tests': ['tp5n']}, 20:08:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:23 INFO - 'talos_options': ['--xperf_path', 20:08:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:23 INFO - 'tests': ['tp5n']}}, 20:08:23 INFO - 'talos.zip': {'path': '', 20:08:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:08:23 INFO - Running post-action listener: _resource_record_post_action 20:08:23 INFO - [mozharness: 2016-09-17 03:08:23.104052Z] Finished populate-webroot step (success) 20:08:23 INFO - [mozharness: 2016-09-17 03:08:23.104180Z] Running create-virtualenv step. 20:08:23 INFO - Running pre-action listener: _resource_record_pre_action 20:08:23 INFO - Running main action method: create_virtualenv 20:08:23 INFO - Creating virtualenv /builds/slave/test/build/venv 20:08:23 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 20:08:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:08:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:08:23 INFO - Using real prefix '/tools/python27' 20:08:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:08:23 INFO - Installing distribute.............................................................................................................................................................................................done. 20:08:26 INFO - Installing pip.................done. 20:08:26 INFO - Return code: 0 20:08:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef38cc2c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b3d30>, '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 0x10d6d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8abb20>, '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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 20:08: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', 'pip>=1.5'] in /builds/slave/test/build 20:08: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 pip>=1.5 20:08:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vD2s9CBMBh/Render', 20:08:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:26 INFO - 'HOME': '/Users/cltbld', 20:08:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:26 INFO - 'LOGNAME': 'cltbld', 20:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:26 INFO - 'MOZ_NO_REMOTE': '1', 20:08:26 INFO - 'NO_EM_RESTART': '1', 20:08:26 INFO - 'PAGER': '/bin/cat', 20:08:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:26 INFO - 'PWD': '/builds/slave/test', 20:08:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:26 INFO - 'SHELL': '/bin/bash', 20:08:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HxPhaPIVsz/Listeners', 20:08:26 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 20:08:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:26 INFO - 'USER': 'cltbld', 20:08:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:26 INFO - 'XPC_FLAGS': '0x0', 20:08:26 INFO - 'XPC_SERVICE_NAME': '0', 20:08:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:27 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 20:08:27 INFO - Cleaning up... 20:08:27 INFO - Return code: 0 20:08:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef38cc2c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b3d30>, '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 0x10d6d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8abb20>, '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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 20:08:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:08:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vD2s9CBMBh/Render', 20:08:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:27 INFO - 'HOME': '/Users/cltbld', 20:08:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:27 INFO - 'LOGNAME': 'cltbld', 20:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:27 INFO - 'MOZ_NO_REMOTE': '1', 20:08:27 INFO - 'NO_EM_RESTART': '1', 20:08:27 INFO - 'PAGER': '/bin/cat', 20:08:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:27 INFO - 'PWD': '/builds/slave/test', 20:08:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:27 INFO - 'SHELL': '/bin/bash', 20:08:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HxPhaPIVsz/Listeners', 20:08:27 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 20:08:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:27 INFO - 'USER': 'cltbld', 20:08:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:27 INFO - 'XPC_FLAGS': '0x0', 20:08:27 INFO - 'XPC_SERVICE_NAME': '0', 20:08:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:27 INFO - Downloading/unpacking psutil>=3.1.1 20:08:27 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 20:08:27 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 20:08:27 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 20:08:27 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 20:08:27 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 20:08:27 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 20:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:08:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:30 INFO - Installing collected packages: psutil 20:08:30 INFO - Running setup.py install for psutil 20:08:30 INFO - building 'psutil._psutil_osx' extension 20:08:30 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 20:08:30 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 20:08:31 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 20:08:31 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 20:08:31 INFO - building 'psutil._psutil_posix' extension 20:08:31 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 20:08:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:08:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:08:31 INFO - ^ 20:08:31 INFO - 1 warning generated. 20:08:31 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 20:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:31 INFO - Successfully installed psutil 20:08:31 INFO - Cleaning up... 20:08:31 INFO - Return code: 0 20:08:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef38cc2c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b3d30>, '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 0x10d6d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8abb20>, '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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 20:08:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vD2s9CBMBh/Render', 20:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:31 INFO - 'HOME': '/Users/cltbld', 20:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:31 INFO - 'LOGNAME': 'cltbld', 20:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:31 INFO - 'MOZ_NO_REMOTE': '1', 20:08:31 INFO - 'NO_EM_RESTART': '1', 20:08:31 INFO - 'PAGER': '/bin/cat', 20:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:31 INFO - 'PWD': '/builds/slave/test', 20:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:31 INFO - 'SHELL': '/bin/bash', 20:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HxPhaPIVsz/Listeners', 20:08:31 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 20:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:31 INFO - 'USER': 'cltbld', 20:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:31 INFO - 'XPC_FLAGS': '0x0', 20:08:31 INFO - 'XPC_SERVICE_NAME': '0', 20:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:08:34 INFO - Installing collected packages: mozsystemmonitor 20:08:34 INFO - Running setup.py install for mozsystemmonitor 20:08:34 INFO - Successfully installed mozsystemmonitor 20:08:34 INFO - Cleaning up... 20:08:34 INFO - Return code: 0 20:08:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef38cc2c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b3d30>, '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 0x10d6d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8abb20>, '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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 20:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:08:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vD2s9CBMBh/Render', 20:08:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:34 INFO - 'HOME': '/Users/cltbld', 20:08:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:34 INFO - 'LOGNAME': 'cltbld', 20:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:34 INFO - 'MOZ_NO_REMOTE': '1', 20:08:34 INFO - 'NO_EM_RESTART': '1', 20:08:34 INFO - 'PAGER': '/bin/cat', 20:08:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:34 INFO - 'PWD': '/builds/slave/test', 20:08:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:34 INFO - 'SHELL': '/bin/bash', 20:08:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HxPhaPIVsz/Listeners', 20:08:34 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 20:08:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:34 INFO - 'USER': 'cltbld', 20:08:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:34 INFO - 'XPC_FLAGS': '0x0', 20:08:34 INFO - 'XPC_SERVICE_NAME': '0', 20:08:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:34 INFO - Downloading/unpacking jsonschema==2.5.1 20:08:34 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 20:08:34 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 20:08:34 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 20:08:34 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 20:08:34 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 20:08:34 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 20:08:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:08:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:08:37 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 20:08:37 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 20:08:37 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 20:08:37 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 20:08:37 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 20:08:37 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 20:08:37 INFO - Downloading functools32-3.2.3-2.tar.gz 20:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:08:37 INFO - warning: no files found matching '*.txt' 20:08:37 INFO - no previously-included directories found matching 'build' 20:08:37 INFO - no previously-included directories found matching 'dist' 20:08:37 INFO - no previously-included directories found matching '.git*' 20:08:37 INFO - Installing collected packages: jsonschema, functools32 20:08:37 INFO - Running setup.py install for functools32 20:08:38 INFO - warning: no files found matching '*.txt' 20:08:38 INFO - no previously-included directories found matching 'build' 20:08:38 INFO - no previously-included directories found matching 'dist' 20:08:38 INFO - no previously-included directories found matching '.git*' 20:08:38 INFO - Successfully installed jsonschema functools32 20:08:38 INFO - Cleaning up... 20:08:38 INFO - Return code: 0 20:08:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef38cc2c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b3d30>, '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 0x10d6d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8abb20>, '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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 20:08:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:08:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vD2s9CBMBh/Render', 20:08:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:38 INFO - 'HOME': '/Users/cltbld', 20:08:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:38 INFO - 'LOGNAME': 'cltbld', 20:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:38 INFO - 'MOZ_NO_REMOTE': '1', 20:08:38 INFO - 'NO_EM_RESTART': '1', 20:08:38 INFO - 'PAGER': '/bin/cat', 20:08:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:38 INFO - 'PWD': '/builds/slave/test', 20:08:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:38 INFO - 'SHELL': '/bin/bash', 20:08:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HxPhaPIVsz/Listeners', 20:08:38 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 20:08:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:38 INFO - 'USER': 'cltbld', 20:08:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:38 INFO - 'XPC_FLAGS': '0x0', 20:08:38 INFO - 'XPC_SERVICE_NAME': '0', 20:08:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:08:38 INFO - Cleaning up... 20:08:38 INFO - Return code: 0 20:08:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:38 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 0x10da9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef38cc2c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b3d30>, '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 0x10d6d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8abb20>, '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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 20:08:38 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 20:08:38 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 20:08:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vD2s9CBMBh/Render', 20:08:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:38 INFO - 'HOME': '/Users/cltbld', 20:08:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:38 INFO - 'LOGNAME': 'cltbld', 20:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:38 INFO - 'MOZ_NO_REMOTE': '1', 20:08:38 INFO - 'NO_EM_RESTART': '1', 20:08:38 INFO - 'PAGER': '/bin/cat', 20:08:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:38 INFO - 'PWD': '/builds/slave/test', 20:08:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:38 INFO - 'SHELL': '/bin/bash', 20:08:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HxPhaPIVsz/Listeners', 20:08:38 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 20:08:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:38 INFO - 'USER': 'cltbld', 20:08:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:38 INFO - 'XPC_FLAGS': '0x0', 20:08:38 INFO - 'XPC_SERVICE_NAME': '0', 20:08:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:38 INFO - Downloading/unpacking blobuploader==1.2.4 20:08:38 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 20:08:38 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 20:08:38 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 20:08:38 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 20:08:38 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 20:08:38 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 20:08:41 INFO - Downloading blobuploader-1.2.4.tar.gz 20:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:08:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:08:41 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 20:08:41 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 20:08:41 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 20:08:41 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 20:08:41 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 20:08:41 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 20:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:08:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:08:41 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 20:08:41 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 20:08:41 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 20:08:41 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 20:08:41 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 20:08:41 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 20:08:42 INFO - Downloading docopt-0.6.1.tar.gz 20:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:08:42 INFO - Installing collected packages: blobuploader, requests, docopt 20:08:42 INFO - Running setup.py install for blobuploader 20:08:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:08:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:08:42 INFO - Running setup.py install for requests 20:08:43 INFO - Running setup.py install for docopt 20:08:43 INFO - Successfully installed blobuploader requests docopt 20:08:43 INFO - Cleaning up... 20:08:43 INFO - Return code: 0 20:08:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:43 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 0x10da9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef38cc2c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b3d30>, '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 0x10d6d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8abb20>, '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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 20:08:43 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 20:08:43 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 20:08:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vD2s9CBMBh/Render', 20:08:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:43 INFO - 'HOME': '/Users/cltbld', 20:08:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:43 INFO - 'LOGNAME': 'cltbld', 20:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:43 INFO - 'MOZ_NO_REMOTE': '1', 20:08:43 INFO - 'NO_EM_RESTART': '1', 20:08:43 INFO - 'PAGER': '/bin/cat', 20:08:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:43 INFO - 'PWD': '/builds/slave/test', 20:08:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:43 INFO - 'SHELL': '/bin/bash', 20:08:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HxPhaPIVsz/Listeners', 20:08:43 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 20:08:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:43 INFO - 'USER': 'cltbld', 20:08:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:43 INFO - 'XPC_FLAGS': '0x0', 20:08:43 INFO - 'XPC_SERVICE_NAME': '0', 20:08:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:43 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-_tMiAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:43 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-z3OtR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:43 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Rl8Kon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:43 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-3sAMuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:43 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-PHq06Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:44 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-cEAh88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:44 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-nDgfZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:44 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-m2juMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:44 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-fvKow1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:44 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-s5hdpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:44 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-acpCGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:44 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-jkY2bV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:44 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-QYDc2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:44 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-MllgAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:44 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-qQNV9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:45 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-kwwYDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:45 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-z9Ttn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:08:45 INFO - Running setup.py install for manifestparser 20:08:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:08:45 INFO - Running setup.py install for mozcrash 20:08:45 INFO - Running setup.py install for mozdebug 20:08:45 INFO - Running setup.py install for mozdevice 20:08:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:08:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:08:45 INFO - Running setup.py install for mozfile 20:08:46 INFO - Running setup.py install for mozhttpd 20:08:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:08:46 INFO - Running setup.py install for mozinfo 20:08:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:08:46 INFO - Running setup.py install for mozInstall 20:08:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:08:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:08:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:08:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:08:46 INFO - Running setup.py install for mozleak 20:08:46 INFO - Running setup.py install for mozlog 20:08:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:08:46 INFO - Running setup.py install for moznetwork 20:08:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:08:46 INFO - Running setup.py install for mozprocess 20:08:47 INFO - Running setup.py install for mozprofile 20:08:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for mozrunner 20:08:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for mozscreenshot 20:08:47 INFO - Running setup.py install for moztest 20:08:47 INFO - Running setup.py install for mozversion 20:08:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:08:47 INFO - Cleaning up... 20:08:47 INFO - Return code: 0 20:08:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:47 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 0x10da9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef38cc2c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b3d30>, '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 0x10d6d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8abb20>, '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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 20:08:47 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 20:08:47 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 20:08:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vD2s9CBMBh/Render', 20:08:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:47 INFO - 'HOME': '/Users/cltbld', 20:08:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:47 INFO - 'LOGNAME': 'cltbld', 20:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:47 INFO - 'MOZ_NO_REMOTE': '1', 20:08:47 INFO - 'NO_EM_RESTART': '1', 20:08:47 INFO - 'PAGER': '/bin/cat', 20:08:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:47 INFO - 'PWD': '/builds/slave/test', 20:08:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:47 INFO - 'SHELL': '/bin/bash', 20:08:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HxPhaPIVsz/Listeners', 20:08:47 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 20:08:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:47 INFO - 'USER': 'cltbld', 20:08:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:47 INFO - 'XPC_FLAGS': '0x0', 20:08:47 INFO - 'XPC_SERVICE_NAME': '0', 20:08:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-ZABQ19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:48 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)) 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-o70K88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:48 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)) 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Ma9XOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:48 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)) 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-6RRpJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:48 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)) 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-ir1PuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:48 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)) 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-RqlwVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:48 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)) 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-hYYSKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:48 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)) 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-tpRqQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:48 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)) 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-HjpnKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Wbt5KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-E7upwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-HdhHi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-kTAG1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-YbgESA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-jpMwj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-c5iqvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-0uS9i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:49 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)) 20:08:49 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)) 20:08:49 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)) 20:08:49 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)) 20:08:49 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)) 20:08:49 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)) 20:08:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:52 INFO - Downloading blessings-1.6.tar.gz 20:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:08:52 INFO - Installing collected packages: blessings 20:08:52 INFO - Running setup.py install for blessings 20:08:52 INFO - Successfully installed blessings 20:08:52 INFO - Cleaning up... 20:08:52 INFO - Return code: 0 20:08:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:08:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:53 INFO - Reading from file tmpfile_stdout 20:08:53 INFO - Current package versions: 20:08:53 INFO - blessings == 1.6 20:08:53 INFO - blobuploader == 1.2.4 20:08:53 INFO - docopt == 0.6.1 20:08:53 INFO - functools32 == 3.2.3-2 20:08:53 INFO - jsonschema == 2.5.1 20:08:53 INFO - manifestparser == 1.1 20:08:53 INFO - mozInstall == 1.12 20:08:53 INFO - mozcrash == 0.17 20:08:53 INFO - mozdebug == 0.1 20:08:53 INFO - mozdevice == 0.48 20:08:53 INFO - mozfile == 1.2 20:08:53 INFO - mozhttpd == 0.7 20:08:53 INFO - mozinfo == 0.9 20:08:53 INFO - mozleak == 0.1 20:08:53 INFO - mozlog == 3.4 20:08:53 INFO - moznetwork == 0.27 20:08:53 INFO - mozprocess == 0.23 20:08:53 INFO - mozprofile == 0.28 20:08:53 INFO - mozrunner == 6.12 20:08:53 INFO - mozscreenshot == 0.1 20:08:53 INFO - mozsystemmonitor == 0.3 20:08:53 INFO - moztest == 0.7 20:08:53 INFO - mozversion == 1.4 20:08:53 INFO - psutil == 3.1.1 20:08:53 INFO - requests == 1.2.3 20:08:53 INFO - wsgiref == 0.1.2 20:08:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:53 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 0x10da9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef38cc2c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b3d30>, '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 0x10d6d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8abb20>, '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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 20:08:53 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 20:08:53 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 20:08:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vD2s9CBMBh/Render', 20:08:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:53 INFO - 'HOME': '/Users/cltbld', 20:08:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:53 INFO - 'LOGNAME': 'cltbld', 20:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:53 INFO - 'MOZ_NO_REMOTE': '1', 20:08:53 INFO - 'NO_EM_RESTART': '1', 20:08:53 INFO - 'PAGER': '/bin/cat', 20:08:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:53 INFO - 'PWD': '/builds/slave/test', 20:08:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:53 INFO - 'SHELL': '/bin/bash', 20:08:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HxPhaPIVsz/Listeners', 20:08:53 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 20:08:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:53 INFO - 'USER': 'cltbld', 20:08:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:53 INFO - 'XPC_FLAGS': '0x0', 20:08:53 INFO - 'XPC_SERVICE_NAME': '0', 20:08:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:53 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)) 20:08:53 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)) 20:08:53 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)) 20:08:53 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)) 20:08:53 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)) 20:08:53 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)) 20:08:53 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)) 20:08:53 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)) 20:08:53 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)) 20:08:53 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)) 20:08:53 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)) 20:08:53 INFO - Cleaning up... 20:08:53 INFO - Return code: 0 20:08:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:53 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 0x10da9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef38cc2c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b3d30>, '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 0x10d6d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8abb20>, '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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 20:08:53 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 20:08:53 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 20:08:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vD2s9CBMBh/Render', 20:08:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:53 INFO - 'HOME': '/Users/cltbld', 20:08:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:53 INFO - 'LOGNAME': 'cltbld', 20:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:53 INFO - 'MOZ_NO_REMOTE': '1', 20:08:53 INFO - 'NO_EM_RESTART': '1', 20:08:53 INFO - 'PAGER': '/bin/cat', 20:08:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:53 INFO - 'PWD': '/builds/slave/test', 20:08:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:53 INFO - 'SHELL': '/bin/bash', 20:08:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HxPhaPIVsz/Listeners', 20:08:53 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 20:08:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:53 INFO - 'USER': 'cltbld', 20:08:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:53 INFO - 'XPC_FLAGS': '0x0', 20:08:53 INFO - 'XPC_SERVICE_NAME': '0', 20:08:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:08:53 INFO - Cleaning up... 20:08:53 INFO - Return code: 0 20:08:53 INFO - Running post-action listener: _resource_record_post_action 20:08:53 INFO - Running post-action listener: _start_resource_monitoring 20:08:53 INFO - Starting resource monitoring. 20:08:53 INFO - [mozharness: 2016-09-17 03:08:53.623327Z] Finished create-virtualenv step (success) 20:08:53 INFO - [mozharness: 2016-09-17 03:08:53.624280Z] Running install step. 20:08:53 INFO - Running pre-action listener: _resource_record_pre_action 20:08:53 INFO - Running main action method: install 20:08:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:53 INFO - Reading from file tmpfile_stdout 20:08:53 INFO - Detecting whether we're running mozinstall >=1.0... 20:08:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:08:53 INFO - Reading from file tmpfile_stdout 20:08:53 INFO - Output received: 20:08:53 INFO - Usage: mozinstall [options] installer 20:08:53 INFO - Options: 20:08:53 INFO - -h, --help show this help message and exit 20:08:53 INFO - -d DEST, --destination=DEST 20:08:53 INFO - Directory to install application into. [default: 20:08:53 INFO - "/builds/slave/test"] 20:08:53 INFO - --app=APP Application being installed. [default: firefox] 20:08:53 INFO - mkdir: /builds/slave/test/build/application 20:08:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:09:28 INFO - Reading from file tmpfile_stdout 20:09:28 INFO - Output received: 20:09:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:09:28 INFO - Running post-action listener: _resource_record_post_action 20:09:28 INFO - [mozharness: 2016-09-17 03:09:28.973548Z] Finished install step (success) 20:09:28 INFO - [mozharness: 2016-09-17 03:09:28.973669Z] Running run-tests step. 20:09:28 INFO - Running pre-action listener: _resource_record_pre_action 20:09:28 INFO - Running main action method: run_tests 20:09:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:09:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:09:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:09:28 INFO - 2016-09-16 20:09:28.988 screenresolution[1939:25732] starting screenresolution argv=screenresolution get 20:09:28 INFO - 2016-09-16 20:09:28.990 screenresolution[1939:25732] Display 0: 1600x1200x32@60 20:09:28 INFO - 2016-09-16 20:09:28.996 screenresolution[1940:25736] starting screenresolution argv=screenresolution list 20:09:28 INFO - Available Modes on Display 0 20:09:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:09:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:09:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:09:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:09:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:09:29 INFO - Intel Iris: 20:09:29 INFO - Chipset Model: Intel Iris 20:09:29 INFO - Type: GPU 20:09:29 INFO - Bus: Built-In 20:09:29 INFO - VRAM (Dynamic, Max): 1536 MB 20:09:29 INFO - Vendor: Intel (0x8086) 20:09:29 INFO - Device ID: 0x0a2e 20:09:29 INFO - Revision ID: 0x0009 20:09:29 INFO - Displays: 20:09:29 INFO - Display: 20:09:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:09:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:09:29 INFO - Display Serial Number: 1600x1200 60 20:09:29 INFO - Main Display: Yes 20:09:29 INFO - Mirror: Off 20:09:29 INFO - Online: Yes 20:09:29 INFO - Rotation: Supported 20:09:29 INFO - Return code: 0 20:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:29 INFO - Python 2.7.3 20:09:29 INFO - Return code: 0 20:09:29 INFO - grabbing minidump binary from tooltool 20:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b3d30>, '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 0x10d6d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8abb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:29 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 20:09:29 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 20:09:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:09:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:29 INFO - Return code: 0 20:09:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:09:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:09:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0381', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0381 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:09:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vD2s9CBMBh/Render', 20:09:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:29 INFO - 'HOME': '/Users/cltbld', 20:09:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:29 INFO - 'LOGNAME': 'cltbld', 20:09:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:29 INFO - 'MOZ_NO_REMOTE': '1', 20:09:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:29 INFO - 'NO_EM_RESTART': '1', 20:09:29 INFO - 'PAGER': '/bin/cat', 20:09:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:29 INFO - 'PWD': '/builds/slave/test', 20:09:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:29 INFO - 'SHELL': '/bin/bash', 20:09:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HxPhaPIVsz/Listeners', 20:09:29 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 20:09:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:29 INFO - 'USER': 'cltbld', 20:09:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:29 INFO - 'XPC_FLAGS': '0x0', 20:09:29 INFO - 'XPC_SERVICE_NAME': '0', 20:09:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0381', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:09:29 INFO - mozversion application_buildid: 20160916170818 20:09:29 INFO - mozversion application_changeset: 60d0e1dbddc00e146462d067c56d79b7b51faf3f 20:09:29 INFO - mozversion application_display_name: Nightly 20:09:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:29 INFO - mozversion application_name: Firefox 20:09:29 INFO - mozversion application_remotingname: firefox 20:09:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:09:29 INFO - mozversion application_vendor: Mozilla 20:09:29 INFO - mozversion application_version: 51.0a1 20:09:29 INFO - mozversion platform_buildid: 20160916170818 20:09:29 INFO - mozversion platform_changeset: 60d0e1dbddc00e146462d067c56d79b7b51faf3f 20:09:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:09:29 INFO - mozversion platform_version: 51.0a1 20:09:29 INFO - using testdate: 1474081769 20:09:29 INFO - actual date: 1474081769 20:09:29 INFO - starting webserver on 'localhost:56577' 20:09:29 INFO - SUITE-START | Running 2 tests 20:09:29 INFO - TEST-START | dromaeo_css 20:09:29 INFO - operating with platform_type : mac_ 20:09:29 INFO - Initialising browser for dromaeo_css test... 20:09:29 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpK1Y7WD/profile http://localhost:56577/getInfo.html) 20:09:32 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 20:09:32 INFO - PROCESS | 1950 | colorDepth:24 20:09:32 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 20:09:32 INFO - PROCESS | 1950 | __metrics 20:09:32 ERROR - PROCESS | 1950 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3016: TypeError: this.tabs is undefined 20:09:32 INFO - PROCESS | 1950 | 20:09:32 INFO - PROCESS | 1950 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x10C0011,name=PVRManager::Msg_NotifyVSync) Channel error: cannot send/recv 20:09:32 INFO - PROCESS | 1950 | 20:09:32 INFO - TEST-INFO | 1950: exit 0 20:09:32 INFO - Browser initialized. 20:09:32 INFO - Running cycle 1/1 for dromaeo_css test... 20:09:32 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpK1Y7WD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:45 INFO - PROCESS | 1953 | RSS: Main: 238866432 20:09:45 INFO - PROCESS | 1953 | 20:10:34 INFO - PROCESS | 1953 | 1474081834710 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] 20:12:45 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56577/tests/dromaeo/cssquery-ext.html) 20:12:47 INFO - PROCESS | 1953 | RSS: Main: 257871872 20:12:47 INFO - PROCESS | 1953 | 20:15:49 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-ext.html (next: http://localhost:56577/tests/dromaeo/cssquery-jquery.html) 20:15:50 INFO - PROCESS | 1953 | RSS: Main: 269225984 20:15:50 INFO - PROCESS | 1953 | 20:18:52 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56577/tests/dromaeo/cssquery-mootools.html) 20:18:52 INFO - PROCESS | 1953 | RSS: Main: 270757888 20:18:52 INFO - PROCESS | 1953 | 20:21:54 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56577/tests/dromaeo/cssquery-prototype.html) 20:21:55 INFO - PROCESS | 1953 | RSS: Main: 268337152 20:21:55 INFO - PROCESS | 1953 | 20:24:58 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56577/tests/dromaeo/cssquery-yui.html) 20:24:58 INFO - PROCESS | 1953 | RSS: Main: 273731584 20:24:58 INFO - PROCESS | 1953 | 20:28:01 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-yui.html (next: http://localhost:56577/tests/dromaeo/cssquery-dojo.html) 20:28:01 INFO - PROCESS | 1953 | RSS: Main: 276398080 20:28:01 INFO - PROCESS | 1953 | 20:28:01 INFO - PROCESS | 1953 | __start_tp_report 20:28:01 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 20:28:01 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 20:28:01 INFO - PROCESS | 1953 | |i|pagename|runs| 20:28:01 INFO - PROCESS | 1953 | |0;dojo.html;3294.9505757413635;3321.3357328534294;3328.334333133371;3333.8833140840075;3353.8658453661856;5435.4564543545675;5455;5467.17992301154;5517.503424691782;5526.917096243559;5381.515663590276;5443.074677304858;5485.835424937249;5523.392426833045;5545.889082218353;5052.570531504835;5052.974735126338;5115.2071428928575;5127.487251274862;5156.53591176794;196.05381436154445;5089.46560611136;5108.208227724708;5152.330197074394;5194.8441546753465;5013.922006768562;5032.018756342514;5045.990801839646;5065.062963351773;5125.769340379673;4041.333180025292;4221.662267018631;4229.788510574459;5053.444121146707;5126.5898728101665;4041.4341992121126;4937.259411088366;4964.15609346412;5029.748512574393;5066.670666406671;5148.845534633967;5401.001629397109;5414.83755487336;5478.780848766045;5490.231367608538;5997.160397544348;6003.219581454427;6004.0693692477735;6042.57701960863;6067.7572897084065;5979.701014949235;6011.939880601226;6053.848653783647;6054.848628784272;6093.146959425684;5567.860803479864;5570.526505247059;5612.326520817487;5638.154276858463;5664.376918538957;6185.721642526097;6190.690465476709;6206.441420272197;6212.72042758077;6220.688965551704;5707.514861236841;5750.626209296466;5912.733926973297;5934;5977.193078934375;5424.810131645373;6031.577789554777;6069.848253793602;6098.129681996294;6142.447179753844;5953;5989.460948514655;6008.24896887889;6012.969935150384;6022.3676513966275;5835.44563266489;5888.617239879394;5930.318013428425;6028.849278768066;6030.638161710223;4738.4787673356595;4792.448868380111;4802.327674125625;4838.927416088762;4850.078485087822;4292.377605247221;4297.140571885635;4299.892502687458;4334.9783251083545;4337.327714204303;5425.593080518976;5563.805266815723;5577.386487486373;5586.944130558723;5684.63049901755;4661.440627124699;6059.575829691879;6061.242344706911;6064.939350606437;6081.300650425169;5618.297712785902;5620.690862002547;5624.550035997192;5628.240187574707;5643.604947653625;5225.921611175835;5266.0257852297445;5268.894622107537;5279.234510995884;5323.387810401853;6153.600015999035;6216.471599913967;6246.906296405557;6250.968745156336;6271.686415679289;5913.704314784158;6078.6048906820915;6101.359357267601;6124.816255512342;6139.570230083851;6132.4166970161305;6148.846278843064;6171.59884607499;6210.503159747119;6239.96880015597;6003.6397816131175;6005.699715014319;6035.064564992434;6041.246581085675;6063.727132279147;6102.115193296859;6109.786157484645;6114.052321890114;6120.510359171345;6128.1726966858905;5722.513586345207;5767.769289228384;5825.097109947965;5846.707664616837;5882.441168089024;5050.84847454577;5538.335399752055;5774.87389958954;5946.5540084494705;5960.284765828128;4739.763011849463;4781.856544303677;5713.285839270091;5781.219535362672;5838.854028649318;5613.764971706218;5747.1379293106365;5757.539396848326;5846.707664616667;5886.852828679146;4905.166121759381;5639.577031722555;5704.80033198836;5735;5756.280464941882 20:28:01 INFO - PROCESS | 1953 | |1;ext.html;454.87718316054685;458.763736675612;502.07868561190213;525.8185925855579;542.2435702195437;28168.577471337947;40106.7994660027;40172.59827401725;42553.57446425535;42710.78644606772;42032.159356812845;42349.576504234945;42413.57586424135;42475.78762106193;42510.93722656935;8239.752807415773;9966.800663986716;10011.849822252672;10016.54925528353;10019.549120289568;9686.079822416894;9798.559064842098;9810.264230182729;9826.90173098267;9827.606895724199;9761.316707830454;9766.902330976705;9785.902140978571;9820.410775353466;9843.507824608776;9750.804983900352;9764.609415623367;9774;9780.266480013992;9831.459269740197;9709.271804614682;9759.756006099833;9775.90224097757;9804.117629413317;9850.950745246228;31627;40456.39315410271;40485.79757101196;40489;40561.79719101386;3258.332041931398;3335.633080361158;3474.3746125697367;3539.681428671406;3759.5488541374934;30506.84746576253;30508.847455762578;31269.8436507816;31441.05676829676;31467.685323146703;3242.497755155707;3277.115178901683;3351.078453425303;3394.5247665326874;3397.3375191837604;406514;423333.9999999969;431976;432498;433005;55536.444635553125;55600;55809.72095139579;55854.72072639611;63761;65733.34266657368;65861.67069164719;67982.9802552962;68978.31021689718;69042;15385.769213461806;15474.303656335493;15606;15636.530904072895;15638.765418518731;12160.331181785086;12241.265524068584;12339.814902776465;12348.938255308665;12365.010799136047;19045.80954190468;20278.188872445233;20376.65668448118;20542.07560659774;20575.691364629543;8344.874826877602;8402.915970840335;8432;8457.746267611981;8463.195996380335;858.4806192253596;871.516308448817;994.7065615643403;1024.457037769968;1032.7521394865178;21694;29666.406671866444;29715.21708697485;30330.241743956136;30346.241343966136;1012.8075665623655;1068.156156636264;1069.6897899609182;1122.119136477861;1123.8089524780808;15305.099205260402;15417.845821541865;15558.844411555965;15887.920560397124;16009.919950400174;610617;616449;617234;619117;621626;55060.72469637626;55406.16890746642;55836.88326233534;55952.72023639937;55980.880382392126;1277.527314893514;1279.5585522994552;1313.2317594207304;1342.1410297409666;1375.071826517097;26028.219153425427;26367.340816478973;27525.31186720268;29539.261518462212;30249;47751.044979100916;47875.04249915052;47937.04125917532;48006.519934800206;48170;449550;548445;549229;550307;551982;34117.488237675956;39303.41044884272;41682.957926050876;41780.791096044326;42388.36417453802;42454.57545424506;45160.54839451564;45879.54120458753;46229;46463.30305045359;28690.56964145581;38486.42270366003;38639.6136038636;39059;39624.40563391609;38336.233275333776;38338.80830595829;38404.615953840104;39054.6094539051;39628.40557391699;31911.84044079765;37564.74093626949;37900.81049594734;38487.807560962014;39811.80094099511;30983;34350.14124646904;34997.82501087478;35024;35196.648033519334;25351;25382.49235015326;25637.615435768104;25718.87140564285;26147.607785882847 20:28:01 INFO - PROCESS | 1953 | |2;jquery.html;356.4297124600639;370.10065540736;372.3781285253627;374.8069744081798;387.3086540525163;19624.41126766196;19658.90170549147;20088.799112008914;20439.48901277467;20626.793732062673;11715.297082175075;11864.881351186486;11906.285622862635;12089.214201076924;12092.818607720892;5181.430042695291;5507.228987941691;5510.614257002011;5521.944780552183;5525.4474552544825;3876.3022655921923;4075.4090656854737;5436.320459942507;5748.338941021773;6027.879442411149;5897.115432685088;6060.939390606081;6093.268807743055;6096.11606317086;6102.96948515259;4965.950340496585;5867.794627188049;5930.584859059867;6107.236595425572;6114.449699527042;5730.312362516483;5734.856628584319;5812.854678633025;5875.324337701177;5880.9411905880825;13178.275194864278;13387.732245355135;13390.397432115578;13398;15629;2133.7012818205462;2146.2380854796634;2312.6531020346915;2531.9620205696747;2848.0031988803753;5533.612647114704;9641.807163856754;9797.80404391908;10071.136839684681;10371.481425928674;1642.9507114786575;1811.031098362383;1859.460756380648;1860.2001139510005;1866.9626607467774;117050.41474792571;119131.40434297774;119615.4019229907;120626.58746825102;121470.35588932346;11182.105431565618;11247.718807029725;11264.267822591506;11491;11508.482118304697;14370;14380;14406;14424.855751442561;14429.92785036068;8210.507369557845;8483.533405662747;8500.659973600987;8547.572621368907;8634.913650863537;6830.282820303896;7578.696852125853;7641;8362.8327433451;8422.83154336922;3480.269143479847;3841.769493830379;4495.57292057254;4528.207563676344;4551.431071116111;1576.4246050191598;1657.9419720309972;1672.765812786211;1893.8484921206546;1952.2386269354963;793.4604468961162;804.7545498622976;876.7895705030746;973.6056896956744;1025.266934142092;20276.594468110554;20302.69545956812;20834.79165208359;20874.791252087587;20980.89509552473;863.9740807775651;916.9174774270215;931.8602209668604;932.1796818799413;945.8486642137225;8973.820523589491;9920.553575089138;9925.15636170919;10947.50736216872;10965;502989;521505;525247;536135;537583;68992;70233;78074;113369;115689.4215528917;939.8768471676418;974.9902500974899;982.2976571751232;997.0777031246068;997.5660587644398;18181.363652272106;18226.90886545559;18504.444866654023;18604.99970025804;18774.812251877305;50889;51353.22970155376;51714;52805.47194528159;53383.4661653394;71103.64448177932;72503.27496725177;73801.6309918447;73967.630161851;81700.18299816926;7750.341220996278;7985.241402066795;7991.480553763987;8415.158484151536;8461.40770146084;8255.793605159679;9195.356325057182;12157.635270941886;12898.290594017419;13247.867521324664;10744.775675943536;11279.379634119874;11380.715482113013;11384;11513.712157196138;5362.758675859518;9196.58615362297;9370.67202647904;11245.156613253876;11604.941975290407;11480.598179063692;11506;11805.881941180822;11960.940195298968;11971;8265.173482651686;8302.232763474589;8340.332773378237;8396.370272229486;8448.66205351779;9410.95294523523;10827.051130796217;11603.303801771921;11700.47347869331;11738.295702257892 20:28:01 INFO - PROCESS | 1953 | |3;mootools.html;1526.1834918318698;1563.0543521169693;1759.12923103064;1858.3402891973358;1876.8404685601715;8180.795480112985;8459.365547583926;8675.69635062773;9178.86231706524;9184.12750788674;7411.4070874330055;7712.807179820507;8912.796772435719;8950.283977281819;8981.640734370618;2383.082513232405;2425.927222183337;2427.2718184544656;2431.197704757426;2441.755824417553;2351.8941647625898;2384.654225137354;2387.9761202388013;2396.04158336665;2422.3701837522285;2428.8178386620984;2434.3427274635837;2439.475512764764;2440.0849681369486;2444.4499987502845;2401.5437066957397;2431.0518897630027;2431.258466167818;2434.172381390327;2456.2140115163156;2395.9520809583887;2414.2395145529104;2415.7946574541184;2418;2421.2978236311446;9058.77353066172;9070.63717451301;9106.77233069172;9115.316351273616;9145.405548639385;5328.733563321857;5399.514043736082;5524.392316845144;5532.225488431623;5533.584981126432;2988.5068963620975;3714.5542534895717;3783.8297276622343;3784.8486060557543;3786.810659467043;1084.6879539156353;1090.231386872253;1096.8903109689047;1103.61925135828;1106.0985296983013;10085.445300508469;11860.288382697066;11893.167478276524;11945.940270298594;11992.940035299855;3436.896893093211;4362.625772881533;4536.7523930918605;4672.976635116871;4710.929336059962;9174.541272936327;9209.95395023034;9219.723408297628;9237.168654821098;9568.808623827485;4341.196878577473;5305.602079844027;5308.309919710413;5309.070912590281;5312.92030619541;4486.932696009562;4647.55848194421;4823.348847905558;4935.383077115361;4987.875303117451;3708.313961917054;3737.2151848111657;3807.1433927366675;3842.0971071798103;3897.3569361055675;961.2310151878469;1002.904724051214;1134.6369161868122;1150.930944143354;1152.7982603044434;787.3937068457255;908.6410867707218;920.9769755756025;938.5870217104589;952.2049089010753;5885.882282354329;5899.144624029492;5966.015607424813;6099.7137642494645;6162.845928851725;429.49534297200665;441.8961544037149;442.312204521965;445.3253321218357;463.4994206257234;3473.7494501979268;3768.510093687858;3942.586028467027;4020.979895100506;4155.792210389468;10525.36847789135;10791.136709063414;10907.454627268764;10911.890881091247;10920.726981825359;10852.511636976355;10854.077403420797;10870.402127883042;10872.238943273895;10881.12950963921;7748.961255193801;8215.548144852091;8278.83442331162;8288.544130072903;8309.376796740147;5762.855928601651;5898.64608123514;5975.492083172979;5990.820275391745;6049.274087109575;9634.373765705206;10125.987401259816;10144.087032166844;10191.541380638037;10221;10161.136303414292;10236.129928956123;10254.897451025394;10295.691129266133;10303.3817970922;6944.652767361713;6946.9652651736415;7471.290227428385;7488.513246638951;7646.235376462309;8322.625481853453;8467.153284671484;8488.193621605938;8504.617292221988;8515.148485151436;7373.8156546086775;7506.924930750841;7520.323170914644;7598.430117741302;7606.467547271638;6131.8467038322615;7322.340989310987;7373.004644372941;7509.249075092447;7535.8116047099265;7000.299970002959;7015.298470152944;7103.325184107502;7103.751368702071;7112.039874617068;5015.774290157025;5047.293378927026;5066.9359434519165;5151.484851514819;5195.11683013881;5106.948930510647;5115.411727651219;5227.215917612389;5232.712200828991;5245.763940622604 20:28:01 INFO - PROCESS | 1953 | |4;prototype.html;296.4515646054799;298.5223642172524;306.01920843695956;309.34882073235855;309.9008317338453;5147.38231412231;5266.5786737061035;5408.621396502246;5465.890682186354;5480.49248480972;5097.745112744366;5300.549453296474;5308.70802105884;5330.680159190451;5369.167778994262;3020.003398878365;3535.840887160071;4103.701926920927;4127.587241275878;4137.296659567881;3358.0261724099983;3971.5631280559114;4100.979495102521;4136.0147129377765;4152.252594532983;3037.8936737214203;3173.04808557433;3358.706897844323;3599.3701102307123;4062.7811656503077;3314.71824894883;4046.210988857174;4075.470188875427;4090.502620259665;4102.856400025985;2798.8460634665084;3282.655321191264;3575.410057340536;3607.3687104756564;3617.4212126059706;3773.2076263984595;4253.851115210984;5154.407243167008;5232.581393488512;5275.736213189325;4595.425571803525;4613.35413042171;4630.374899388573;4633.72197668141;4647.837325693585;4389.012472193763;5166.250893620441;5425.457454254582;5574.303212098488;5619.178958308349;3518.2435776308216;3769.4722738816586;3891.9102651257695;3898.9920191101605;3904.629060239273;5894.345505786397;5896.528277737771;5898.292204935392;5911.349751527328;5919.112133180014;3833.4058220975794;3839.846406143779;3905.082305658168;3907.4529565860803;3910.804459777;3717.328744771146;3938.4879965604287;3955.6044395560216;3959;3963.088489647397;4089.670856971496;4550.13547425988;4558.430196225472;4599.3672246352735;4609.916669582645;4656.393544227304;5621.915671264935;5625.128105143709;5660.29246344207;5693.430656934273;1208.9361362001557;1256.66070161056;1261.3819228577931;1305.719270356859;1318.7494376068516;706.5442789400807;765.8053436638861;825.1748251748252;883.5273128876149;888.4047688049022;4570.3829982951875;4754.358161648133;5054.570361519239;5114.4374118847645;5175.81884634036;5402.540784033401;5725.2843394575675;5726.341470730919;5727.427257274239;5750.993576124161;5086.431352167206;5184.766685499161;5206.816482348771;5271.523973287485;5281.630285879952;2128.2867291830225;2203.7135172427484;2285.845647947776;2365.4677697518264;2458.9016439342586;4292.463442069741;4933;4998.850034498971;5059.671121377172;5065;3865.936867361498;4085.834507710918;4724.71651700899;4809;4878.560929516289;4949.876253093701;4993.750312484434;5006.374203224597;5029.7736601853;5111.667741596784;4807.423109226916;4811.254255590389;4846.39420072491;4862.107046307441;4868.123737727243;4127.504699435966;4483.529229430993;4734.188977872708;4756.88107797294;4770.89891570482;4759.524047595212;4787.92271738856;4897.971426000579;5038.470960549236;5042.84871453857;2890;3354.8658053677577;3362.7814192077435;3363.1255873472583;3369.629340772464;4169.541350451508;4325.956740432555;4419.337099435111;4831.980012492192;4833.202521583899;4203.55862634419;4898.951010489849;4948.505149485167;4977.950220497749;5658;4433.889152771207;5308.575313974796;5437.429069947599;5527.585431092603;5652.265205523256;4780.45024822136;5180.637355385087;5233.581313494988;5528.479668091307;5558.833235002957;4822.9758851205515;5374.813305160539;5618.747156377891;5673.8297851064535;5738.885222295614;5152.793888244578;5536;5580.888382232251;5612.494875461228;5633.746481408264 20:28:01 INFO - PROCESS | 1953 | |5;yui.html;715.6207210178607;742.3022358982557;759.0739298056372;793.8094857234265;794.3049831397525;15626.14056226907;16243.51269461915;16274.75587866183;16298.674026519462;16335.673286534262;14463.276836158177;14516.854831451683;14543.92728036361;14575.34410951507;14610.342534585943;673.7406098652006;689.4897775646036;823.1398188892591;836.4772017489084;854.9444286121383;843.8902942617451;844.4215712237107;855.4097672605882;855.589317127779;856.7301300090483;916.4776077635751;916.9266458683289;918.4076270805326;918.7978644698155;919.6965001549506;905.8097799462121;909.068205089785;909.3316412436853;910.544727636182;910.5720311453639;662.3078882567728;676.3270545806954;677.2685499660355;679.0968012543306;681.4548361310931;15269.465568705153;15302.693946121015;15548.222588870623;15562.922185389001;15623.296951637203;12096.81854772179;14786.18675972821;14787.556373308818;14790.926045369704;14891.404343826234;11823;12102.455389507406;12333.383330833512;12337.69155771104;12500.687482812911;3762.705967144684;3776.4712940188397;3962.8612998544913;4011.2980228460196;4011.65900898424;77374;120675.9324067595;121470;121922;123940.84532392128;11141.888581114084;11216.439178041066;11298.548058077586;11491.3679747613;11570.537178512765;23874.641880371808;23910.64134037991;23952.760472395054;23954.760452395603;23964.281071567882;8012.479188852706;8073.86965824785;8184.590770461572;8207.917920820835;8380;4355;4384.430024096847;4392.736435813861;4474.686771925999;4486.887827804331;3590.3716849551224;3668.211334563082;3701.130234394915;3722.16251343451;3724.677739402527;569.7379205565403;646.8609249011391;648.672420427681;663.3134705579702;664.4617859533793;548.6214511986716;554.7032337699311;626.7868924565579;643.3373625166087;648.5200951296007;9203.723888283363;9440.008799075998;9515.345479237316;9590.90409095914;9836.06557377048;506.9163588007937;628.8585068359582;652.1391762873056;662.2847324889108;713.390051505955;3812.4281357796553;4494.10117976406;4688.595161282299;4725.125851717443;4774.761261936889;129648;142410;143202;143209;145502.27248863687;134521;134924;135613.6438635621;136262.3186884059;138199.09004549732;103262.48368758109;105724.47137764262;117244;121008;124291;7507.324340809353;8869.71389148557;8888.822223555364;9083.45499270046;9188.40275382098;44978.65064048084;50660.24009639932;53561.12536061219;57004.85990280254;58168;74297;82361;86812;93570.06429935613;105198.94801052197;9981.800363992534;11818.113641476752;11911.642650720492;12005.63983080509;12446.190997585129;13097.803532946822;13125.278109704059;13134.080614356903;13183.736325273248;13189.736205275649;12114.030877529953;12289.56986505468;12398.194117382342;12479.750404992032;12665.430055647334;11747.236429632047;12052.758944820878;12105.092118091003;12148.271103733805;12363.69090772738;11867.76264474723;12074.45664945062;12155.331456769962;12189.512419503475;12335.568255111028;9904.900950990397;10359.94820025895;10468.319559228627;10572.682819515427;10752.0323170915;10326.896731032593;10607.734806629587;10635.8936410638;10639.202059845697;10651.680449586525 20:28:01 INFO - PROCESS | 1953 | __end_tp_report 20:28:01 INFO - PROCESS | 1953 | __start_cc_report 20:28:01 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,361 20:28:01 INFO - PROCESS | 1953 | __end_cc_report 20:28:01 INFO - PROCESS | 1953 | __startTimestamp1474082881953__endTimestamp 20:28:01 INFO - PROCESS | 1953 | 20:28:01 INFO - PROCESS | 1953 | ------- Summary: start ------- 20:28:01 INFO - PROCESS | 1953 | Number of tests: 6 20:28:01 INFO - PROCESS | 1953 | 20:28:01 INFO - PROCESS | 1953 | [#0] dojo.html Cycles:165 Average:5487.59 Median:5664.38 stddev:773.26 (13.7%) stddev-sans-first:756.26 20:28:01 INFO - PROCESS | 1953 | Values: 3295.0 3321.3 3328.3 3333.9 3353.9 5435.5 5455.0 5467.2 5517.5 5526.9 5381.5 5443.1 5485.8 5523.4 5545.9 5052.6 5053.0 5115.2 5127.5 5156.5 196.1 5089.5 5108.2 5152.3 5194.8 5013.9 5032.0 5046.0 5065.1 5125.8 4041.3 4221.7 4229.8 5053.4 5126.6 4041.4 4937.3 4964.2 5029.7 5066.7 5148.8 5401.0 5414.8 5478.8 5490.2 5997.2 6003.2 6004.1 6042.6 6067.8 5979.7 6011.9 6053.8 6054.8 6093.1 5567.9 5570.5 5612.3 5638.2 5664.4 6185.7 6190.7 6206.4 6212.7 6220.7 5707.5 5750.6 5912.7 5934.0 5977.2 5424.8 6031.6 6069.8 6098.1 6142.4 5953.0 5989.5 6008.2 6013.0 6022.4 5835.4 5888.6 5930.3 6028.8 6030.6 4738.5 4792.4 4802.3 4838.9 4850.1 4292.4 4297.1 4299.9 4335.0 4337.3 5425.6 5563.8 5577.4 5586.9 5684.6 4661.4 6059.6 6061.2 6064.9 6081.3 5618.3 5620.7 5624.6 5628.2 5643.6 5225.9 5266.0 5268.9 5279.2 5323.4 6153.6 6216.5 6246.9 6251.0 6271.7 5913.7 6078.6 6101.4 6124.8 6139.6 6132.4 6148.8 6171.6 6210.5 6240.0 6003.6 6005.7 6035.1 6041.2 6063.7 6102.1 6109.8 6114.1 6120.5 6128.2 5722.5 5767.8 5825.1 5846.7 5882.4 5050.8 5538.3 5774.9 5946.6 5960.3 4739.8 4781.9 5713.3 5781.2 5838.9 5613.8 5747.1 5757.5 5846.7 5886.9 4905.2 5639.6 5704.8 5735.0 5756.3 20:28:01 INFO - PROCESS | 1953 | 20:28:01 INFO - PROCESS | 1953 | [#1] ext.html Cycles:180 Average:66586.32 Median:40314.50 stddev:141484.64 (351.0%) stddev-sans-first:141794.42 20:28:01 INFO - PROCESS | 1953 | Values: 454.9 458.8 502.1 525.8 542.2 28168.6 40106.8 40172.6 42553.6 42710.8 42032.2 42349.6 42413.6 42475.8 42510.9 8239.8 9966.8 10011.8 10016.5 10019.5 9686.1 9798.6 9810.3 9826.9 9827.6 9761.3 9766.9 9785.9 9820.4 9843.5 9750.8 9764.6 9774.0 9780.3 9831.5 9709.3 9759.8 9775.9 9804.1 9851.0 31627.0 40456.4 40485.8 40489.0 40561.8 3258.3 3335.6 3474.4 3539.7 3759.5 30506.8 30508.8 31269.8 31441.1 31467.7 3242.5 3277.1 3351.1 3394.5 3397.3 406514.0 423334.0 431976.0 432498.0 433005.0 55536.4 55600.0 55809.7 55854.7 63761.0 65733.3 65861.7 67983.0 68978.3 69042.0 15385.8 15474.3 15606.0 15636.5 15638.8 12160.3 12241.3 12339.8 12348.9 12365.0 19045.8 20278.2 20376.7 20542.1 20575.7 8344.9 8402.9 8432.0 8457.7 8463.2 858.5 871.5 994.7 1024.5 1032.8 21694.0 29666.4 29715.2 30330.2 30346.2 1012.8 1068.2 1069.7 1122.1 1123.8 15305.1 15417.8 15558.8 15887.9 16009.9 610617.0 616449.0 617234.0 619117.0 621626.0 55060.7 55406.2 55836.9 55952.7 55980.9 1277.5 1279.6 1313.2 1342.1 1375.1 26028.2 26367.3 27525.3 29539.3 30249.0 47751.0 47875.0 47937.0 48006.5 48170.0 449550.0 548445.0 549229.0 550307.0 551982.0 34117.5 39303.4 41683.0 41780.8 42388.4 42454.6 45160.5 45879.5 46229.0 46463.3 28690.6 38486.4 38639.6 39059.0 39624.4 38336.2 38338.8 38404.6 39054.6 39628.4 31911.8 37564.7 37900.8 38487.8 39811.8 30983.0 34350.1 34997.8 35024.0 35196.6 25351.0 25382.5 25637.6 25718.9 26147.6 20:28:01 INFO - PROCESS | 1953 | 20:28:01 INFO - PROCESS | 1953 | [#2] jquery.html Cycles:180 Average:31077.84 Median:4511.89 stddev:87609.80 (1941.8%) stddev-sans-first:87825.20 20:28:01 INFO - PROCESS | 1953 | Values: 356.4 370.1 372.4 374.8 387.3 19624.4 19658.9 20088.8 20439.5 20626.8 11715.3 11864.9 11906.3 12089.2 12092.8 5181.4 5507.2 5510.6 5521.9 5525.4 3876.3 4075.4 5436.3 5748.3 6027.9 5897.1 6060.9 6093.3 6096.1 6103.0 4966.0 5867.8 5930.6 6107.2 6114.4 5730.3 5734.9 5812.9 5875.3 5880.9 13178.3 13387.7 13390.4 13398.0 15629.0 2133.7 2146.2 2312.7 2532.0 2848.0 5533.6 9641.8 9797.8 10071.1 10371.5 1643.0 1811.0 1859.5 1860.2 1867.0 117050.4 119131.4 119615.4 120626.6 121470.4 11182.1 11247.7 11264.3 11491.0 11508.5 14370.0 14380.0 14406.0 14424.9 14429.9 8210.5 8483.5 8500.7 8547.6 8634.9 6830.3 7578.7 7641.0 8362.8 8422.8 3480.3 3841.8 4495.6 4528.2 4551.4 1576.4 1657.9 1672.8 1893.8 1952.2 793.5 804.8 876.8 973.6 1025.3 20276.6 20302.7 20834.8 20874.8 20980.9 864.0 916.9 931.9 932.2 945.8 8973.8 9920.6 9925.2 10947.5 10965.0 502989.0 521505.0 525247.0 536135.0 537583.0 68992.0 70233.0 78074.0 113369.0 115689.4 939.9 975.0 982.3 997.1 997.6 18181.4 18226.9 18504.4 18605.0 18774.8 50889.0 51353.2 51714.0 52805.5 53383.5 71103.6 72503.3 73801.6 73967.6 81700.2 7750.3 7985.2 7991.5 8415.2 8461.4 8255.8 9195.4 12157.6 12898.3 13247.9 10744.8 11279.4 11380.7 11384.0 11513.7 5362.8 9196.6 9370.7 11245.2 11604.9 11480.6 11506.0 11805.9 11960.9 11971.0 8265.2 8302.2 8340.3 8396.4 8448.7 9411.0 10827.1 11603.3 11700.5 11738.3 20:28:01 INFO - PROCESS | 1953 | 20:28:01 INFO - PROCESS | 1953 | [#3] mootools.html Cycles:180 Average:5702.21 Median:4767.14 stddev:3222.34 (67.6%) stddev-sans-first:3216.10 20:28:01 INFO - PROCESS | 1953 | Values: 1526.2 1563.1 1759.1 1858.3 1876.8 8180.8 8459.4 8675.7 9178.9 9184.1 7411.4 7712.8 8912.8 8950.3 8981.6 2383.1 2425.9 2427.3 2431.2 2441.8 2351.9 2384.7 2388.0 2396.0 2422.4 2428.8 2434.3 2439.5 2440.1 2444.4 2401.5 2431.1 2431.3 2434.2 2456.2 2396.0 2414.2 2415.8 2418.0 2421.3 9058.8 9070.6 9106.8 9115.3 9145.4 5328.7 5399.5 5524.4 5532.2 5533.6 2988.5 3714.6 3783.8 3784.8 3786.8 1084.7 1090.2 1096.9 1103.6 1106.1 10085.4 11860.3 11893.2 11945.9 11992.9 3436.9 4362.6 4536.8 4673.0 4710.9 9174.5 9210.0 9219.7 9237.2 9568.8 4341.2 5305.6 5308.3 5309.1 5312.9 4486.9 4647.6 4823.3 4935.4 4987.9 3708.3 3737.2 3807.1 3842.1 3897.4 961.2 1002.9 1134.6 1150.9 1152.8 787.4 908.6 921.0 938.6 952.2 5885.9 5899.1 5966.0 6099.7 6162.8 429.5 441.9 442.3 445.3 463.5 3473.7 3768.5 3942.6 4021.0 4155.8 10525.4 10791.1 10907.5 10911.9 10920.7 10852.5 10854.1 10870.4 10872.2 10881.1 7749.0 8215.5 8278.8 8288.5 8309.4 5762.9 5898.6 5975.5 5990.8 6049.3 9634.4 10126.0 10144.1 10191.5 10221.0 10161.1 10236.1 10254.9 10295.7 10303.4 6944.7 6947.0 7471.3 7488.5 7646.2 8322.6 8467.2 8488.2 8504.6 8515.1 7373.8 7506.9 7520.3 7598.4 7606.5 6131.8 7322.3 7373.0 7509.2 7535.8 7000.3 7015.3 7103.3 7103.8 7112.0 5015.8 5047.3 5066.9 5151.5 5195.1 5106.9 5115.4 5227.2 5232.7 5245.8 20:28:01 INFO - PROCESS | 1953 | 20:28:01 INFO - PROCESS | 1953 | [#4] prototype.html Cycles:180 Average:4291.42 Median:4775.67 stddev:1343.93 (28.1%) stddev-sans-first:1313.82 20:28:01 INFO - PROCESS | 1953 | Values: 296.5 298.5 306.0 309.3 309.9 5147.4 5266.6 5408.6 5465.9 5480.5 5097.7 5300.5 5308.7 5330.7 5369.2 3020.0 3535.8 4103.7 4127.6 4137.3 3358.0 3971.6 4101.0 4136.0 4152.3 3037.9 3173.0 3358.7 3599.4 4062.8 3314.7 4046.2 4075.5 4090.5 4102.9 2798.8 3282.7 3575.4 3607.4 3617.4 3773.2 4253.9 5154.4 5232.6 5275.7 4595.4 4613.4 4630.4 4633.7 4647.8 4389.0 5166.3 5425.5 5574.3 5619.2 3518.2 3769.5 3891.9 3899.0 3904.6 5894.3 5896.5 5898.3 5911.3 5919.1 3833.4 3839.8 3905.1 3907.5 3910.8 3717.3 3938.5 3955.6 3959.0 3963.1 4089.7 4550.1 4558.4 4599.4 4609.9 4656.4 5621.9 5625.1 5660.3 5693.4 1208.9 1256.7 1261.4 1305.7 1318.7 706.5 765.8 825.2 883.5 888.4 4570.4 4754.4 5054.6 5114.4 5175.8 5402.5 5725.3 5726.3 5727.4 5751.0 5086.4 5184.8 5206.8 5271.5 5281.6 2128.3 2203.7 2285.8 2365.5 2458.9 4292.5 4933.0 4998.9 5059.7 5065.0 3865.9 4085.8 4724.7 4809.0 4878.6 4949.9 4993.8 5006.4 5029.8 5111.7 4807.4 4811.3 4846.4 4862.1 4868.1 4127.5 4483.5 4734.2 4756.9 4770.9 4759.5 4787.9 4898.0 5038.5 5042.8 2890.0 3354.9 3362.8 3363.1 3369.6 4169.5 4326.0 4419.3 4832.0 4833.2 4203.6 4899.0 4948.5 4978.0 5658.0 4433.9 5308.6 5437.4 5527.6 5652.3 4780.5 5180.6 5233.6 5528.5 5558.8 4823.0 5374.8 5618.7 5673.8 5738.9 5152.8 5536.0 5580.9 5612.5 5633.7 20:28:01 INFO - PROCESS | 1953 | 20:28:01 INFO - PROCESS | 1953 | [#5] yui.html Cycles:180 Average:24593.16 Median:3711.65 stddev:39760.46 (1071.2%) stddev-sans-first:39831.58 20:28:01 INFO - PROCESS | 1953 | Values: 715.6 742.3 759.1 793.8 794.3 15626.1 16243.5 16274.8 16298.7 16335.7 14463.3 14516.9 14543.9 14575.3 14610.3 673.7 689.5 823.1 836.5 854.9 843.9 844.4 855.4 855.6 856.7 916.5 916.9 918.4 918.8 919.7 905.8 909.1 909.3 910.5 910.6 662.3 676.3 677.3 679.1 681.5 15269.5 15302.7 15548.2 15562.9 15623.3 12096.8 14786.2 14787.6 14790.9 14891.4 11823.0 12102.5 12333.4 12337.7 12500.7 3762.7 3776.5 3962.9 4011.3 4011.7 77374.0 120675.9 121470.0 121922.0 123940.8 11141.9 11216.4 11298.5 11491.4 11570.5 23874.6 23910.6 23952.8 23954.8 23964.3 8012.5 8073.9 8184.6 8207.9 8380.0 4355.0 4384.4 4392.7 4474.7 4486.9 3590.4 3668.2 3701.1 3722.2 3724.7 569.7 646.9 648.7 663.3 664.5 548.6 554.7 626.8 643.3 648.5 9203.7 9440.0 9515.3 9590.9 9836.1 506.9 628.9 652.1 662.3 713.4 3812.4 4494.1 4688.6 4725.1 4774.8 129648.0 142410.0 143202.0 143209.0 145502.3 134521.0 134924.0 135613.6 136262.3 138199.1 103262.5 105724.5 117244.0 121008.0 124291.0 7507.3 8869.7 8888.8 9083.5 9188.4 44978.7 50660.2 53561.1 57004.9 58168.0 74297.0 82361.0 86812.0 93570.1 105198.9 9981.8 11818.1 11911.6 12005.6 12446.2 13097.8 13125.3 13134.1 13183.7 13189.7 12114.0 12289.6 12398.2 12479.8 12665.4 11747.2 12052.8 12105.1 12148.3 12363.7 11867.8 12074.5 12155.3 12189.5 12335.6 9904.9 10359.9 10468.3 10572.7 10752.0 10326.9 10607.7 10635.9 10639.2 10651.7 20:28:01 INFO - PROCESS | 1953 | -------- Summary: end -------- 20:28:01 INFO - PROCESS | 1953 | 20:28:02 INFO - TEST-INFO | 1953: exit 0 20:28:02 INFO - TEST-OK | dromaeo_css | took 1113016ms 20:28:02 INFO - TEST-START | kraken 20:28:02 INFO - operating with platform_type : mac_ 20:28:02 INFO - Initialising browser for kraken test... 20:28:02 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmp6kdZlT/profile http://localhost:56577/getInfo.html) 20:28:05 INFO - PROCESS | 1959 | __metrics Screen width/height:1600/1200 20:28:05 INFO - PROCESS | 1959 | colorDepth:24 20:28:05 INFO - PROCESS | 1959 | Browser inner width/height: 1024/689 20:28:05 INFO - PROCESS | 1959 | __metrics 20:28:05 ERROR - PROCESS | 1959 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3016: TypeError: this.tabs is undefined 20:28:06 INFO - TEST-INFO | 1959: exit 0 20:28:06 INFO - Browser initialized. 20:28:06 INFO - Running cycle 1/1 for kraken test... 20:28:06 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmp6kdZlT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:18 INFO - PROCESS | 1961 | RSS: Main: 238743552 20:28:18 INFO - PROCESS | 1961 | 20:28:21 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56577/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:22 INFO - PROCESS | 1961 | RSS: Main: 252256256 20:28:22 INFO - PROCESS | 1961 | 20:28:24 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56577/tests/kraken/driver.html?testName=audio-dft) 20:28:25 INFO - PROCESS | 1961 | RSS: Main: 259813376 20:28:25 INFO - PROCESS | 1961 | 20:28:28 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56577/tests/kraken/driver.html?testName=audio-fft) 20:28:29 INFO - PROCESS | 1961 | RSS: Main: 260575232 20:28:29 INFO - PROCESS | 1961 | 20:28:31 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56577/tests/kraken/driver.html?testName=audio-oscillator) 20:28:32 INFO - PROCESS | 1961 | RSS: Main: 262819840 20:28:32 INFO - PROCESS | 1961 | 20:28:34 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56577/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:28:34 INFO - PROCESS | 1961 | RSS: Main: 263131136 20:28:34 INFO - PROCESS | 1961 | 20:28:37 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56577/tests/kraken/driver.html?testName=imaging-darkroom) 20:28:38 INFO - PROCESS | 1961 | RSS: Main: 264085504 20:28:38 INFO - PROCESS | 1961 | 20:28:41 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56577/tests/kraken/driver.html?testName=imaging-desaturate) 20:28:42 INFO - PROCESS | 1961 | RSS: Main: 264355840 20:28:42 INFO - PROCESS | 1961 | 20:28:45 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56577/tests/kraken/driver.html?testName=json-parse-financial) 20:28:45 INFO - PROCESS | 1961 | RSS: Main: 264626176 20:28:45 INFO - PROCESS | 1961 | 20:28:47 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56577/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:28:48 INFO - PROCESS | 1961 | RSS: Main: 264658944 20:28:48 INFO - PROCESS | 1961 | 20:28:50 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:28:50 INFO - PROCESS | 1961 | RSS: Main: 264011776 20:28:50 INFO - PROCESS | 1961 | 20:28:52 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:28:53 INFO - PROCESS | 1961 | RSS: Main: 264122368 20:28:53 INFO - PROCESS | 1961 | 20:28:56 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:28:57 INFO - PROCESS | 1961 | RSS: Main: 264404992 20:28:57 INFO - PROCESS | 1961 | 20:29:00 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:00 INFO - PROCESS | 1961 | RSS: Main: 264187904 20:29:00 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56577/tests/kraken/driver.html?testName=ai-astar) 20:29:02 INFO - PROCESS | 1961 | RSS: Main: 265961472 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | __start_tp_report 20:29:02 INFO - PROCESS | 1961 | _x_x_mozilla_page_load 20:29:02 INFO - PROCESS | 1961 | _x_x_mozilla_page_load_details 20:29:02 INFO - PROCESS | 1961 | |i|pagename|runs| 20:29:02 INFO - PROCESS | 1961 | |0;ai-astar;116;118;118;117;118;117;117;116;117;115 20:29:02 INFO - PROCESS | 1961 | |1;audio-beat-detection;143;119;143;186;111;114;110;108;138;111 20:29:02 INFO - PROCESS | 1961 | |2;audio-dft;260;247;239;214;209;167;267;225;264;184 20:29:02 INFO - PROCESS | 1961 | |3;audio-fft;84;60;62;88;60;61;60;60;83;73 20:29:02 INFO - PROCESS | 1961 | |4;audio-oscillator;102;102;120;102;70;72;88;72;70;88 20:29:02 INFO - PROCESS | 1961 | |5;imaging-gaussian-blur;135;87;104;117;133;113;90;86;89;119 20:29:02 INFO - PROCESS | 1961 | |6;imaging-darkroom;105;151;148;96;95;105;123;95;95;96 20:29:02 INFO - PROCESS | 1961 | |7;imaging-desaturate;86;107;84;129;150;136;128;127;149;137 20:29:02 INFO - PROCESS | 1961 | |8;json-parse-financial;56;56;56;59;58;58;61;57;58;56 20:29:02 INFO - PROCESS | 1961 | |9;json-stringify-tinderbox;70;71;75;82;76;73;69;72;78;104 20:29:02 INFO - PROCESS | 1961 | |10;stanford-crypto-aes;89;86;87;88;87;86;90;89;86;80 20:29:02 INFO - PROCESS | 1961 | |11;stanford-crypto-ccm;142;140;139;157;164;155;163;143;179;166 20:29:02 INFO - PROCESS | 1961 | |12;stanford-crypto-pbkdf2;178;174;175;171;173;165;163;160;214;227 20:29:02 INFO - PROCESS | 1961 | |13;stanford-crypto-sha256-iterative;67;71;70;71;72;69;66;69;71;67 20:29:02 INFO - PROCESS | 1961 | __end_tp_report 20:29:02 INFO - PROCESS | 1961 | __start_cc_report 20:29:02 INFO - PROCESS | 1961 | _x_x_mozilla_cycle_collect,918 20:29:02 INFO - PROCESS | 1961 | __end_cc_report 20:29:02 INFO - PROCESS | 1961 | __startTimestamp1474082942801__endTimestamp 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | ------- Summary: start ------- 20:29:02 INFO - PROCESS | 1961 | Number of tests: 14 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#0] ai-astar Cycles:10 Average:116.90 Median:117.00 stddev:0.99 (0.8%) stddev-sans-first:1.00 20:29:02 INFO - PROCESS | 1961 | Values: 116.0 118.0 118.0 117.0 118.0 117.0 117.0 116.0 117.0 115.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:128.50 stddev:24.70 (19.2%) stddev-sans-first:25.62 20:29:02 INFO - PROCESS | 1961 | Values: 143.0 119.0 143.0 186.0 111.0 114.0 110.0 108.0 138.0 111.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#2] audio-dft Cycles:10 Average:227.60 Median:243.00 stddev:34.23 (14.1%) stddev-sans-first:34.24 20:29:02 INFO - PROCESS | 1961 | Values: 260.0 247.0 239.0 214.0 209.0 167.0 267.0 225.0 264.0 184.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#3] audio-fft Cycles:10 Average:69.10 Median:67.50 stddev:11.71 (17.4%) stddev-sans-first:11.11 20:29:02 INFO - PROCESS | 1961 | Values: 84.0 60.0 62.0 88.0 60.0 61.0 60.0 60.0 83.0 73.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:71.00 stddev:17.54 (24.7%) stddev-sans-first:17.92 20:29:02 INFO - PROCESS | 1961 | Values: 102.0 102.0 120.0 102.0 70.0 72.0 88.0 72.0 70.0 88.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#5] imaging-gaussian-blur Cycles:10 Average:107.30 Median:110.50 stddev:18.86 (17.1%) stddev-sans-first:17.14 20:29:02 INFO - PROCESS | 1961 | Values: 135.0 87.0 104.0 117.0 133.0 113.0 90.0 86.0 89.0 119.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#6] imaging-darkroom Cycles:10 Average:110.90 Median:95.00 stddev:22.12 (23.3%) stddev-sans-first:23.36 20:29:02 INFO - PROCESS | 1961 | Values: 105.0 151.0 148.0 96.0 95.0 105.0 123.0 95.0 95.0 96.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#7] imaging-desaturate Cycles:10 Average:123.30 Median:143.00 stddev:23.55 (16.5%) stddev-sans-first:20.76 20:29:02 INFO - PROCESS | 1961 | Values: 86.0 107.0 84.0 129.0 150.0 136.0 128.0 127.0 149.0 137.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.00 stddev:1.65 (2.8%) stddev-sans-first:1.66 20:29:02 INFO - PROCESS | 1961 | Values: 56.0 56.0 56.0 59.0 58.0 58.0 61.0 57.0 58.0 56.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#9] json-stringify-tinderbox Cycles:10 Average:77.00 Median:74.00 stddev:10.27 (13.9%) stddev-sans-first:10.58 20:29:02 INFO - PROCESS | 1961 | Values: 70.0 71.0 75.0 82.0 76.0 73.0 69.0 72.0 78.0 104.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.50 stddev:2.78 (3.2%) stddev-sans-first:2.83 20:29:02 INFO - PROCESS | 1961 | Values: 89.0 86.0 87.0 88.0 87.0 86.0 90.0 89.0 86.0 80.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:160.00 stddev:13.50 (8.4%) stddev-sans-first:13.50 20:29:02 INFO - PROCESS | 1961 | Values: 142.0 140.0 139.0 157.0 164.0 155.0 163.0 143.0 179.0 166.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:174.50 stddev:22.30 (12.8%) stddev-sans-first:23.64 20:29:02 INFO - PROCESS | 1961 | Values: 178.0 174.0 175.0 171.0 173.0 165.0 163.0 160.0 214.0 227.0 20:29:02 INFO - PROCESS | 1961 | 20:29:02 INFO - PROCESS | 1961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.50 stddev:2.06 (2.9%) stddev-sans-first:2.01 20:29:02 INFO - PROCESS | 1961 | Values: 67.0 71.0 70.0 71.0 72.0 69.0 66.0 69.0 71.0 67.0 20:29:02 INFO - PROCESS | 1961 | -------- Summary: end -------- 20:29:02 INFO - PROCESS | 1961 | 20:29:03 INFO - TEST-INFO | 1961: exit 0 20:29:03 INFO - TEST-OK | kraken | took 61162ms 20:29:03 INFO - SUITE-END | took 1174s 20:29:03 INFO - Completed test suite (00:19:34) 20:29:03 INFO - javascript benchmark 20:29:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7113.9578617364705, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.9505757413635, 3321.3357328534294, 3328.334333133371, 3333.8833140840075, 3353.8658453661856, 5435.4564543545675, 5455.0, 5467.17992301154, 5517.503424691782, 5526.917096243559, 5381.515663590276, 5443.074677304858, 5485.835424937249, 5523.392426833045, 5545.889082218353, 5052.570531504835, 5052.974735126338, 5115.2071428928575, 5127.487251274862, 5156.53591176794, 196.05381436154445, 5089.46560611136, 5108.208227724708, 5152.330197074394, 5194.8441546753465, 5013.922006768562, 5032.018756342514, 5045.990801839646, 5065.062963351773, 5125.769340379673, 4041.333180025292, 4221.662267018631, 4229.788510574459, 5053.444121146707, 5126.5898728101665, 4041.4341992121126, 4937.259411088366, 4964.15609346412, 5029.748512574393, 5066.670666406671, 5148.845534633967, 5401.001629397109, 5414.83755487336, 5478.780848766045, 5490.231367608538, 5997.160397544348, 6003.219581454427, 6004.0693692477735, 6042.57701960863, 6067.7572897084065, 5979.701014949235, 6011.939880601226, 6053.848653783647, 6054.848628784272, 6093.146959425684, 5567.860803479864, 5570.526505247059, 5612.326520817487, 5638.154276858463, 5664.376918538957, 6185.721642526097, 6190.690465476709, 6206.441420272197, 6212.72042758077, 6220.688965551704, 5707.514861236841, 5750.626209296466, 5912.733926973297, 5934.0, 5977.193078934375, 5424.810131645373, 6031.577789554777, 6069.848253793602, 6098.129681996294, 6142.447179753844, 5953.0, 5989.460948514655, 6008.24896887889, 6012.969935150384, 6022.3676513966275, 5835.44563266489, 5888.617239879394, 5930.318013428425, 6028.849278768066, 6030.638161710223, 4738.4787673356595, 4792.448868380111, 4802.327674125625, 4838.927416088762, 4850.078485087822, 4292.377605247221, 4297.140571885635, 4299.892502687458, 4334.9783251083545, 4337.327714204303, 5425.593080518976, 5563.805266815723, 5577.386487486373, 5586.944130558723, 5684.63049901755, 4661.440627124699, 6059.575829691879, 6061.242344706911, 6064.939350606437, 6081.300650425169, 5618.297712785902, 5620.690862002547, 5624.550035997192, 5628.240187574707, 5643.604947653625, 5225.921611175835, 5266.0257852297445, 5268.894622107537, 5279.234510995884, 5323.387810401853, 6153.600015999035, 6216.471599913967, 6246.906296405557, 6250.968745156336, 6271.686415679289, 5913.704314784158, 6078.6048906820915, 6101.359357267601, 6124.816255512342, 6139.570230083851, 6132.4166970161305, 6148.846278843064, 6171.59884607499, 6210.503159747119, 6239.96880015597, 6003.6397816131175, 6005.699715014319, 6035.064564992434, 6041.246581085675, 6063.727132279147, 6102.115193296859, 6109.786157484645, 6114.052321890114, 6120.510359171345, 6128.1726966858905, 5722.513586345207, 5767.769289228384, 5825.097109947965, 5846.707664616837, 5882.441168089024, 5050.84847454577, 5538.335399752055, 5774.87389958954, 5946.5540084494705, 5960.284765828128, 4739.763011849463, 4781.856544303677, 5713.285839270091, 5781.219535362672, 5838.854028649318, 5613.764971706218, 5747.1379293106365, 5757.539396848326, 5846.707664616667, 5886.852828679146, 4905.166121759381, 5639.577031722555, 5704.80033198836, 5735.0, 5756.280464941882], "value": 5441.659564942577, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.87718316054685, 458.763736675612, 502.07868561190213, 525.8185925855579, 542.2435702195437, 28168.577471337947, 40106.7994660027, 40172.59827401725, 42553.57446425535, 42710.78644606772, 42032.159356812845, 42349.576504234945, 42413.57586424135, 42475.78762106193, 42510.93722656935, 8239.752807415773, 9966.800663986716, 10011.849822252672, 10016.54925528353, 10019.549120289568, 9686.079822416894, 9798.559064842098, 9810.264230182729, 9826.90173098267, 9827.606895724199, 9761.316707830454, 9766.902330976705, 9785.902140978571, 9820.410775353466, 9843.507824608776, 9750.804983900352, 9764.609415623367, 9774.0, 9780.266480013992, 9831.459269740197, 9709.271804614682, 9759.756006099833, 9775.90224097757, 9804.117629413317, 9850.950745246228, 31627.0, 40456.39315410271, 40485.79757101196, 40489.0, 40561.79719101386, 3258.332041931398, 3335.633080361158, 3474.3746125697367, 3539.681428671406, 3759.5488541374934, 30506.84746576253, 30508.847455762578, 31269.8436507816, 31441.05676829676, 31467.685323146703, 3242.497755155707, 3277.115178901683, 3351.078453425303, 3394.5247665326874, 3397.3375191837604, 406514.0, 423333.9999999969, 431976.0, 432498.0, 433005.0, 55536.444635553125, 55600.0, 55809.72095139579, 55854.72072639611, 63761.0, 65733.34266657368, 65861.67069164719, 67982.9802552962, 68978.31021689718, 69042.0, 15385.769213461806, 15474.303656335493, 15606.0, 15636.530904072895, 15638.765418518731, 12160.331181785086, 12241.265524068584, 12339.814902776465, 12348.938255308665, 12365.010799136047, 19045.80954190468, 20278.188872445233, 20376.65668448118, 20542.07560659774, 20575.691364629543, 8344.874826877602, 8402.915970840335, 8432.0, 8457.746267611981, 8463.195996380335, 858.4806192253596, 871.516308448817, 994.7065615643403, 1024.457037769968, 1032.7521394865178, 21694.0, 29666.406671866444, 29715.21708697485, 30330.241743956136, 30346.241343966136, 1012.8075665623655, 1068.156156636264, 1069.6897899609182, 1122.119136477861, 1123.8089524780808, 15305.099205260402, 15417.845821541865, 15558.844411555965, 15887.920560397124, 16009.919950400174, 610617.0, 616449.0, 617234.0, 619117.0, 621626.0, 55060.72469637626, 55406.16890746642, 55836.88326233534, 55952.72023639937, 55980.880382392126, 1277.527314893514, 1279.5585522994552, 1313.2317594207304, 1342.1410297409666, 1375.071826517097, 26028.219153425427, 26367.340816478973, 27525.31186720268, 29539.261518462212, 30249.0, 47751.044979100916, 47875.04249915052, 47937.04125917532, 48006.519934800206, 48170.0, 449550.0, 548445.0, 549229.0, 550307.0, 551982.0, 34117.488237675956, 39303.41044884272, 41682.957926050876, 41780.791096044326, 42388.36417453802, 42454.57545424506, 45160.54839451564, 45879.54120458753, 46229.0, 46463.30305045359, 28690.56964145581, 38486.42270366003, 38639.6136038636, 39059.0, 39624.40563391609, 38336.233275333776, 38338.80830595829, 38404.615953840104, 39054.6094539051, 39628.40557391699, 31911.84044079765, 37564.74093626949, 37900.81049594734, 38487.807560962014, 39811.80094099511, 30983.0, 34350.14124646904, 34997.82501087478, 35024.0, 35196.648033519334, 25351.0, 25382.49235015326, 25637.615435768104, 25718.87140564285, 26147.607785882847], "value": 19980.405632816226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.4297124600639, 370.10065540736, 372.3781285253627, 374.8069744081798, 387.3086540525163, 19624.41126766196, 19658.90170549147, 20088.799112008914, 20439.48901277467, 20626.793732062673, 11715.297082175075, 11864.881351186486, 11906.285622862635, 12089.214201076924, 12092.818607720892, 5181.430042695291, 5507.228987941691, 5510.614257002011, 5521.944780552183, 5525.4474552544825, 3876.3022655921923, 4075.4090656854737, 5436.320459942507, 5748.338941021773, 6027.879442411149, 5897.115432685088, 6060.939390606081, 6093.268807743055, 6096.11606317086, 6102.96948515259, 4965.950340496585, 5867.794627188049, 5930.584859059867, 6107.236595425572, 6114.449699527042, 5730.312362516483, 5734.856628584319, 5812.854678633025, 5875.324337701177, 5880.9411905880825, 13178.275194864278, 13387.732245355135, 13390.397432115578, 13398.0, 15629.0, 2133.7012818205462, 2146.2380854796634, 2312.6531020346915, 2531.9620205696747, 2848.0031988803753, 5533.612647114704, 9641.807163856754, 9797.80404391908, 10071.136839684681, 10371.481425928674, 1642.9507114786575, 1811.031098362383, 1859.460756380648, 1860.2001139510005, 1866.9626607467774, 117050.41474792571, 119131.40434297774, 119615.4019229907, 120626.58746825102, 121470.35588932346, 11182.105431565618, 11247.718807029725, 11264.267822591506, 11491.0, 11508.482118304697, 14370.0, 14380.0, 14406.0, 14424.855751442561, 14429.92785036068, 8210.507369557845, 8483.533405662747, 8500.659973600987, 8547.572621368907, 8634.913650863537, 6830.282820303896, 7578.696852125853, 7641.0, 8362.8327433451, 8422.83154336922, 3480.269143479847, 3841.769493830379, 4495.57292057254, 4528.207563676344, 4551.431071116111, 1576.4246050191598, 1657.9419720309972, 1672.765812786211, 1893.8484921206546, 1952.2386269354963, 793.4604468961162, 804.7545498622976, 876.7895705030746, 973.6056896956744, 1025.266934142092, 20276.594468110554, 20302.69545956812, 20834.79165208359, 20874.791252087587, 20980.89509552473, 863.9740807775651, 916.9174774270215, 931.8602209668604, 932.1796818799413, 945.8486642137225, 8973.820523589491, 9920.553575089138, 9925.15636170919, 10947.50736216872, 10965.0, 502989.0, 521505.0, 525247.0, 536135.0, 537583.0, 68992.0, 70233.0, 78074.0, 113369.0, 115689.4215528917, 939.8768471676418, 974.9902500974899, 982.2976571751232, 997.0777031246068, 997.5660587644398, 18181.363652272106, 18226.90886545559, 18504.444866654023, 18604.99970025804, 18774.812251877305, 50889.0, 51353.22970155376, 51714.0, 52805.47194528159, 53383.4661653394, 71103.64448177932, 72503.27496725177, 73801.6309918447, 73967.630161851, 81700.18299816926, 7750.341220996278, 7985.241402066795, 7991.480553763987, 8415.158484151536, 8461.40770146084, 8255.793605159679, 9195.356325057182, 12157.635270941886, 12898.290594017419, 13247.867521324664, 10744.775675943536, 11279.379634119874, 11380.715482113013, 11384.0, 11513.712157196138, 5362.758675859518, 9196.58615362297, 9370.67202647904, 11245.156613253876, 11604.941975290407, 11480.598179063692, 11506.0, 11805.881941180822, 11960.940195298968, 11971.0, 8265.173482651686, 8302.232763474589, 8340.332773378237, 8396.370272229486, 8448.66205351779, 9410.95294523523, 10827.051130796217, 11603.303801771921, 11700.47347869331, 11738.295702257892], "value": 8898.36055500787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.1834918318698, 1563.0543521169693, 1759.12923103064, 1858.3402891973358, 1876.8404685601715, 8180.795480112985, 8459.365547583926, 8675.69635062773, 9178.86231706524, 9184.12750788674, 7411.4070874330055, 7712.807179820507, 8912.796772435719, 8950.283977281819, 8981.640734370618, 2383.082513232405, 2425.927222183337, 2427.2718184544656, 2431.197704757426, 2441.755824417553, 2351.8941647625898, 2384.654225137354, 2387.9761202388013, 2396.04158336665, 2422.3701837522285, 2428.8178386620984, 2434.3427274635837, 2439.475512764764, 2440.0849681369486, 2444.4499987502845, 2401.5437066957397, 2431.0518897630027, 2431.258466167818, 2434.172381390327, 2456.2140115163156, 2395.9520809583887, 2414.2395145529104, 2415.7946574541184, 2418.0, 2421.2978236311446, 9058.77353066172, 9070.63717451301, 9106.77233069172, 9115.316351273616, 9145.405548639385, 5328.733563321857, 5399.514043736082, 5524.392316845144, 5532.225488431623, 5533.584981126432, 2988.5068963620975, 3714.5542534895717, 3783.8297276622343, 3784.8486060557543, 3786.810659467043, 1084.6879539156353, 1090.231386872253, 1096.8903109689047, 1103.61925135828, 1106.0985296983013, 10085.445300508469, 11860.288382697066, 11893.167478276524, 11945.940270298594, 11992.940035299855, 3436.896893093211, 4362.625772881533, 4536.7523930918605, 4672.976635116871, 4710.929336059962, 9174.541272936327, 9209.95395023034, 9219.723408297628, 9237.168654821098, 9568.808623827485, 4341.196878577473, 5305.602079844027, 5308.309919710413, 5309.070912590281, 5312.92030619541, 4486.932696009562, 4647.55848194421, 4823.348847905558, 4935.383077115361, 4987.875303117451, 3708.313961917054, 3737.2151848111657, 3807.1433927366675, 3842.0971071798103, 3897.3569361055675, 961.2310151878469, 1002.904724051214, 1134.6369161868122, 1150.930944143354, 1152.7982603044434, 787.3937068457255, 908.6410867707218, 920.9769755756025, 938.5870217104589, 952.2049089010753, 5885.882282354329, 5899.144624029492, 5966.015607424813, 6099.7137642494645, 6162.845928851725, 429.49534297200665, 441.8961544037149, 442.312204521965, 445.3253321218357, 463.4994206257234, 3473.7494501979268, 3768.510093687858, 3942.586028467027, 4020.979895100506, 4155.792210389468, 10525.36847789135, 10791.136709063414, 10907.454627268764, 10911.890881091247, 10920.726981825359, 10852.511636976355, 10854.077403420797, 10870.402127883042, 10872.238943273895, 10881.12950963921, 7748.961255193801, 8215.548144852091, 8278.83442331162, 8288.544130072903, 8309.376796740147, 5762.855928601651, 5898.64608123514, 5975.492083172979, 5990.820275391745, 6049.274087109575, 9634.373765705206, 10125.987401259816, 10144.087032166844, 10191.541380638037, 10221.0, 10161.136303414292, 10236.129928956123, 10254.897451025394, 10295.691129266133, 10303.3817970922, 6944.652767361713, 6946.9652651736415, 7471.290227428385, 7488.513246638951, 7646.235376462309, 8322.625481853453, 8467.153284671484, 8488.193621605938, 8504.617292221988, 8515.148485151436, 7373.8156546086775, 7506.924930750841, 7520.323170914644, 7598.430117741302, 7606.467547271638, 6131.8467038322615, 7322.340989310987, 7373.004644372941, 7509.249075092447, 7535.8116047099265, 7000.299970002959, 7015.298470152944, 7103.325184107502, 7103.751368702071, 7112.039874617068, 5015.774290157025, 5047.293378927026, 5066.9359434519165, 5151.484851514819, 5195.11683013881, 5106.948930510647, 5115.411727651219, 5227.215917612389, 5232.712200828991, 5245.763940622604], "value": 4499.80711050488, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.4515646054799, 298.5223642172524, 306.01920843695956, 309.34882073235855, 309.9008317338453, 5147.38231412231, 5266.5786737061035, 5408.621396502246, 5465.890682186354, 5480.49248480972, 5097.745112744366, 5300.549453296474, 5308.70802105884, 5330.680159190451, 5369.167778994262, 3020.003398878365, 3535.840887160071, 4103.701926920927, 4127.587241275878, 4137.296659567881, 3358.0261724099983, 3971.5631280559114, 4100.979495102521, 4136.0147129377765, 4152.252594532983, 3037.8936737214203, 3173.04808557433, 3358.706897844323, 3599.3701102307123, 4062.7811656503077, 3314.71824894883, 4046.210988857174, 4075.470188875427, 4090.502620259665, 4102.856400025985, 2798.8460634665084, 3282.655321191264, 3575.410057340536, 3607.3687104756564, 3617.4212126059706, 3773.2076263984595, 4253.851115210984, 5154.407243167008, 5232.581393488512, 5275.736213189325, 4595.425571803525, 4613.35413042171, 4630.374899388573, 4633.72197668141, 4647.837325693585, 4389.012472193763, 5166.250893620441, 5425.457454254582, 5574.303212098488, 5619.178958308349, 3518.2435776308216, 3769.4722738816586, 3891.9102651257695, 3898.9920191101605, 3904.629060239273, 5894.345505786397, 5896.528277737771, 5898.292204935392, 5911.349751527328, 5919.112133180014, 3833.4058220975794, 3839.846406143779, 3905.082305658168, 3907.4529565860803, 3910.804459777, 3717.328744771146, 3938.4879965604287, 3955.6044395560216, 3959.0, 3963.088489647397, 4089.670856971496, 4550.13547425988, 4558.430196225472, 4599.3672246352735, 4609.916669582645, 4656.393544227304, 5621.915671264935, 5625.128105143709, 5660.29246344207, 5693.430656934273, 1208.9361362001557, 1256.66070161056, 1261.3819228577931, 1305.719270356859, 1318.7494376068516, 706.5442789400807, 765.8053436638861, 825.1748251748252, 883.5273128876149, 888.4047688049022, 4570.3829982951875, 4754.358161648133, 5054.570361519239, 5114.4374118847645, 5175.81884634036, 5402.540784033401, 5725.2843394575675, 5726.341470730919, 5727.427257274239, 5750.993576124161, 5086.431352167206, 5184.766685499161, 5206.816482348771, 5271.523973287485, 5281.630285879952, 2128.2867291830225, 2203.7135172427484, 2285.845647947776, 2365.4677697518264, 2458.9016439342586, 4292.463442069741, 4933.0, 4998.850034498971, 5059.671121377172, 5065.0, 3865.936867361498, 4085.834507710918, 4724.71651700899, 4809.0, 4878.560929516289, 4949.876253093701, 4993.750312484434, 5006.374203224597, 5029.7736601853, 5111.667741596784, 4807.423109226916, 4811.254255590389, 4846.39420072491, 4862.107046307441, 4868.123737727243, 4127.504699435966, 4483.529229430993, 4734.188977872708, 4756.88107797294, 4770.89891570482, 4759.524047595212, 4787.92271738856, 4897.971426000579, 5038.470960549236, 5042.84871453857, 2890.0, 3354.8658053677577, 3362.7814192077435, 3363.1255873472583, 3369.629340772464, 4169.541350451508, 4325.956740432555, 4419.337099435111, 4831.980012492192, 4833.202521583899, 4203.55862634419, 4898.951010489849, 4948.505149485167, 4977.950220497749, 5658.0, 4433.889152771207, 5308.575313974796, 5437.429069947599, 5527.585431092603, 5652.265205523256, 4780.45024822136, 5180.637355385087, 5233.581313494988, 5528.479668091307, 5558.833235002957, 4822.9758851205515, 5374.813305160539, 5618.747156377891, 5673.8297851064535, 5738.885222295614, 5152.793888244578, 5536.0, 5580.888382232251, 5612.494875461228, 5633.746481408264], "value": 3866.0134463048216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.6207210178607, 742.3022358982557, 759.0739298056372, 793.8094857234265, 794.3049831397525, 15626.14056226907, 16243.51269461915, 16274.75587866183, 16298.674026519462, 16335.673286534262, 14463.276836158177, 14516.854831451683, 14543.92728036361, 14575.34410951507, 14610.342534585943, 673.7406098652006, 689.4897775646036, 823.1398188892591, 836.4772017489084, 854.9444286121383, 843.8902942617451, 844.4215712237107, 855.4097672605882, 855.589317127779, 856.7301300090483, 916.4776077635751, 916.9266458683289, 918.4076270805326, 918.7978644698155, 919.6965001549506, 905.8097799462121, 909.068205089785, 909.3316412436853, 910.544727636182, 910.5720311453639, 662.3078882567728, 676.3270545806954, 677.2685499660355, 679.0968012543306, 681.4548361310931, 15269.465568705153, 15302.693946121015, 15548.222588870623, 15562.922185389001, 15623.296951637203, 12096.81854772179, 14786.18675972821, 14787.556373308818, 14790.926045369704, 14891.404343826234, 11823.0, 12102.455389507406, 12333.383330833512, 12337.69155771104, 12500.687482812911, 3762.705967144684, 3776.4712940188397, 3962.8612998544913, 4011.2980228460196, 4011.65900898424, 77374.0, 120675.9324067595, 121470.0, 121922.0, 123940.84532392128, 11141.888581114084, 11216.439178041066, 11298.548058077586, 11491.3679747613, 11570.537178512765, 23874.641880371808, 23910.64134037991, 23952.760472395054, 23954.760452395603, 23964.281071567882, 8012.479188852706, 8073.86965824785, 8184.590770461572, 8207.917920820835, 8380.0, 4355.0, 4384.430024096847, 4392.736435813861, 4474.686771925999, 4486.887827804331, 3590.3716849551224, 3668.211334563082, 3701.130234394915, 3722.16251343451, 3724.677739402527, 569.7379205565403, 646.8609249011391, 648.672420427681, 663.3134705579702, 664.4617859533793, 548.6214511986716, 554.7032337699311, 626.7868924565579, 643.3373625166087, 648.5200951296007, 9203.723888283363, 9440.008799075998, 9515.345479237316, 9590.90409095914, 9836.06557377048, 506.9163588007937, 628.8585068359582, 652.1391762873056, 662.2847324889108, 713.390051505955, 3812.4281357796553, 4494.10117976406, 4688.595161282299, 4725.125851717443, 4774.761261936889, 129648.0, 142410.0, 143202.0, 143209.0, 145502.27248863687, 134521.0, 134924.0, 135613.6438635621, 136262.3186884059, 138199.09004549732, 103262.48368758109, 105724.47137764262, 117244.0, 121008.0, 124291.0, 7507.324340809353, 8869.71389148557, 8888.822223555364, 9083.45499270046, 9188.40275382098, 44978.65064048084, 50660.24009639932, 53561.12536061219, 57004.85990280254, 58168.0, 74297.0, 82361.0, 86812.0, 93570.06429935613, 105198.94801052197, 9981.800363992534, 11818.113641476752, 11911.642650720492, 12005.63983080509, 12446.190997585129, 13097.803532946822, 13125.278109704059, 13134.080614356903, 13183.736325273248, 13189.736205275649, 12114.030877529953, 12289.56986505468, 12398.194117382342, 12479.750404992032, 12665.430055647334, 11747.236429632047, 12052.758944820878, 12105.092118091003, 12148.271103733805, 12363.69090772738, 11867.76264474723, 12074.45664945062, 12155.331456769962, 12189.512419503475, 12335.568255111028, 9904.900950990397, 10359.94820025895, 10468.319559228627, 10572.682819515427, 10752.0323170915, 10326.896731032593, 10607.734806629587, 10635.8936410638, 10639.202059845697, 10651.680449586525], "value": 7700.439387763276, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 115.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 143.0, 186.0, 111.0, 114.0, 110.0, 108.0, 138.0, 111.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [260.0, 247.0, 239.0, 214.0, 209.0, 167.0, 267.0, 225.0, 264.0, 184.0], "value": 227.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 62.0, 88.0, 60.0, 61.0, 60.0, 60.0, 83.0, 73.0], "value": 69.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 102.0, 120.0, 102.0, 70.0, 72.0, 88.0, 72.0, 70.0, 88.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 87.0, 104.0, 117.0, 133.0, 113.0, 90.0, 86.0, 89.0, 119.0], "value": 107.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 151.0, 148.0, 96.0, 95.0, 105.0, 123.0, 95.0, 95.0, 96.0], "value": 110.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 107.0, 84.0, 129.0, 150.0, 136.0, 128.0, 127.0, 149.0, 137.0], "value": 123.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 59.0, 58.0, 58.0, 61.0, 57.0, 58.0, 56.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 75.0, 82.0, 76.0, 73.0, 69.0, 72.0, 78.0, 104.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 87.0, 88.0, 87.0, 86.0, 90.0, 89.0, 86.0, 80.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 139.0, 157.0, 164.0, 155.0, 163.0, 143.0, 179.0, 166.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 174.0, 175.0, 171.0, 173.0, 165.0, 163.0, 160.0, 214.0, 227.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 70.0, 71.0, 72.0, 69.0, 66.0, 69.0, 71.0, 67.0], "value": 69.3, "unit": "score"}]}]} 20:29:04 INFO - Return code: 0 20:29:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:29:04 ERROR - # TBPL SUCCESS # 20:29:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:29:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:29:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:29:04 INFO - 2016-09-16 20:29:04.110 screenresolution[1966:28318] starting screenresolution argv=screenresolution get 20:29:04 INFO - 2016-09-16 20:29:04.113 screenresolution[1966:28318] Display 0: 1600x1200x32@60 20:29:04 INFO - 2016-09-16 20:29:04.120 screenresolution[1967:28321] starting screenresolution argv=screenresolution list 20:29:04 INFO - Available Modes on Display 0 20:29:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:29:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:29:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:29:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:29:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:29:04 INFO - Intel Iris: 20:29:04 INFO - Chipset Model: Intel Iris 20:29:04 INFO - Type: GPU 20:29:04 INFO - Bus: Built-In 20:29:04 INFO - VRAM (Dynamic, Max): 1536 MB 20:29:04 INFO - Vendor: Intel (0x8086) 20:29:04 INFO - Device ID: 0x0a2e 20:29:04 INFO - Revision ID: 0x0009 20:29:04 INFO - Displays: 20:29:04 INFO - Display: 20:29:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:29:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:29:04 INFO - Display Serial Number: 1600x1200 60 20:29:04 INFO - Main Display: Yes 20:29:04 INFO - Mirror: Off 20:29:04 INFO - Online: Yes 20:29:04 INFO - Rotation: Supported 20:29:04 INFO - Return code: 0 20:29:04 INFO - Running post-action listener: _resource_record_post_action 20:29:04 INFO - [mozharness: 2016-09-17 03:29:04.360164Z] Finished run-tests step (success) 20:29:04 INFO - Running post-run listener: _resource_record_post_run 20:29:04 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 671744; Write bytes: 708617728; Read time: 5; Write time: 2037 20:29:04 INFO - TinderboxPrint: CPU usage
54.3% 20:29:04 INFO - TinderboxPrint: I/O read bytes / time
671,744 / 5 20:29:04 INFO - TinderboxPrint: I/O write bytes / time
708,617,728 / 2,037 20:29:04 INFO - TinderboxPrint: CPU idle
2,214.8 (45.7%) 20:29:04 INFO - TinderboxPrint: CPU system
971.1 (20.1%) 20:29:04 INFO - TinderboxPrint: CPU user
1,655.9 (34.2%) 20:29:04 INFO - TinderboxPrint: Swap in / out
405,434,368 / 0 20:29:04 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 401515008; Write bytes: 397242880; Read time: 31406; Write time: 862 20:29:04 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 634880; Write bytes: 298644480; Read time: 5; Write time: 1135 20:29:04 INFO - Running post-run listener: _upload_blobber_files 20:29:04 INFO - Blob upload gear active. 20:29:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:29:04 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:29:04 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:29:05 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:29:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:29:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:06 INFO - (blobuploader) - INFO - Done attempting. 20:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:07 INFO - (blobuploader) - INFO - Done attempting. 20:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:09 INFO - (blobuploader) - INFO - Done attempting. 20:29:09 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:09 INFO - Return code: 0 20:29:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5f9fe2910f67bfb97be6d5bcb519782d0f47b5be5fcaed93d55f01adc8ba4b301f4d657ae57c477fdccfcd9291f1ed236bc514e6154ac9d303ce221f8baccf70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/25a72b448720f5adebae56d25766644a75dc47d354123389c60145c3fb3b05ecc2a71f3b715673d61e927b7a9d09566787d02d161b6e5f9eab9f9d0303eecf51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22bca853e6320129a66bd8e53d26b2ff924fd32572eb4e6054824c80965321ef584955e8ddafd91c6031bd3ad4ef4850b9a1e6cd5a704e74175f165bae7c41f2"} 20:29:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:09 INFO - Contents: 20:29:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5f9fe2910f67bfb97be6d5bcb519782d0f47b5be5fcaed93d55f01adc8ba4b301f4d657ae57c477fdccfcd9291f1ed236bc514e6154ac9d303ce221f8baccf70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/25a72b448720f5adebae56d25766644a75dc47d354123389c60145c3fb3b05ecc2a71f3b715673d61e927b7a9d09566787d02d161b6e5f9eab9f9d0303eecf51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22bca853e6320129a66bd8e53d26b2ff924fd32572eb4e6054824c80965321ef584955e8ddafd91c6031bd3ad4ef4850b9a1e6cd5a704e74175f165bae7c41f2"} 20:29:09 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:09 INFO - Copying logs to upload dir... 20:29:09 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.163115 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-16 20:29:09.563572) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-16 20:29:09.567768) ========= 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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5f9fe2910f67bfb97be6d5bcb519782d0f47b5be5fcaed93d55f01adc8ba4b301f4d657ae57c477fdccfcd9291f1ed236bc514e6154ac9d303ce221f8baccf70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/25a72b448720f5adebae56d25766644a75dc47d354123389c60145c3fb3b05ecc2a71f3b715673d61e927b7a9d09566787d02d161b6e5f9eab9f9d0303eecf51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22bca853e6320129a66bd8e53d26b2ff924fd32572eb4e6054824c80965321ef584955e8ddafd91c6031bd3ad4ef4850b9a1e6cd5a704e74175f165bae7c41f2"} build_url:https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/Znf9y-VST_-zxSSwDxuGog/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5f9fe2910f67bfb97be6d5bcb519782d0f47b5be5fcaed93d55f01adc8ba4b301f4d657ae57c477fdccfcd9291f1ed236bc514e6154ac9d303ce221f8baccf70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/25a72b448720f5adebae56d25766644a75dc47d354123389c60145c3fb3b05ecc2a71f3b715673d61e927b7a9d09566787d02d161b6e5f9eab9f9d0303eecf51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22bca853e6320129a66bd8e53d26b2ff924fd32572eb4e6054824c80965321ef584955e8ddafd91c6031bd3ad4ef4850b9a1e6cd5a704e74175f165bae7c41f2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-16 20:29:09.605836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 20:29:09.606186) ========= 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.vD2s9CBMBh/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.HxPhaPIVsz/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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.005158 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 20:29:09.655162) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-16 20:29:09.655528) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-16 20:29:09.655920) ========= ========= Total master_lag: 0.20 =========