builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0262 starttime: 1488478335.95 results: success (0) buildid: 20170302074351 builduid: e86f8fb5939b4ca3892987b3aab9ef0f revision: d29f84406483c721a13cf9a52936ecced0c5c98a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:15.951129) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:15.954665) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:15.955243) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:15.987915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:15.988496) ========= 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.8hCdrcV6do/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.j2KKVf3UNu/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 --2017-03-02 10:12:16-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2017-03-02 10:12:16 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122147 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:16.137184) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:16.137678) ========= 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.8hCdrcV6do/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.j2KKVf3UNu/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.025176 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:16.188390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-02 10:12:16.188973) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d29f84406483c721a13cf9a52936ecced0c5c98a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d29f84406483c721a13cf9a52936ecced0c5c98a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8hCdrcV6do/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.j2KKVf3UNu/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 2017-03-02 10:12:16,297 truncating revision to first 12 chars 2017-03-02 10:12:16,297 Setting DEBUG logging. 2017-03-02 10:12:16,297 attempt 1/10 2017-03-02 10:12:16,297 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d29f84406483?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-02 10:12:18,009 unpacking tar archive at: mozilla-central-d29f84406483/testing/mozharness/ program finished with exit code 0 elapsedTime=2.006104 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-02 10:12:18.219705) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:18.220032) ========= script_repo_revision: d29f84406483c721a13cf9a52936ecced0c5c98a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:18.220426) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:18.220696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 10:12:18.240503) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-02 10:12:18.240864) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8hCdrcV6do/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.j2KKVf3UNu/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 10:12:18 INFO - MultiFileLogger online at 20170302 10:12:18 in /builds/slave/test 10:12:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:12:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:18 INFO - {'append_to_log': False, 10:12:18 INFO - 'base_work_dir': '/builds/slave/test', 10:12:18 INFO - 'blob_upload_branch': 'Firefox', 10:12:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:18 INFO - 'branch': 'Firefox', 10:12:18 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:18 INFO - 'config_files': ('talos/mac_config.py',), 10:12:18 INFO - 'default_actions': ('clobber', 10:12:18 INFO - 'read-buildbot-config', 10:12:18 INFO - 'download-and-extract', 10:12:18 INFO - 'populate-webroot', 10:12:18 INFO - 'create-virtualenv', 10:12:18 INFO - 'install', 10:12:18 INFO - 'run-tests'), 10:12:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:18 INFO - 'download_minidump_stackwalk': True, 10:12:18 INFO - 'download_symbols': 'ondemand', 10:12:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:18 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:18 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:18 INFO - 'gecko_profile': False, 10:12:18 INFO - 'gecko_profile_interval': 0, 10:12:18 INFO - 'installer_path': 'installer.exe', 10:12:18 INFO - 'log_level': 'info', 10:12:18 INFO - 'log_name': 'talos', 10:12:18 INFO - 'log_to_console': True, 10:12:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:12:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:12:18 INFO - 'opt_config_files': (), 10:12:18 INFO - 'pip_index': False, 10:12:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:18 INFO - 'cmd': ('bash', 10:12:18 INFO - '-c', 10:12:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:18 INFO - 'enabled': True, 10:12:18 INFO - 'halt_on_failure': False, 10:12:18 INFO - 'name': 'check_screen_resolution'},), 10:12:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:18 INFO - 'cmd': ('bash', 10:12:18 INFO - '-c', 10:12:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:18 INFO - 'enabled': True, 10:12:18 INFO - 'halt_on_failure': False, 10:12:18 INFO - 'name': 'check_screen_resolution'},), 10:12:18 INFO - 'run_cmd_checks_enabled': True, 10:12:18 INFO - 'suite': 'dromaeojs-e10s', 10:12:18 INFO - 'system_bits': '32', 10:12:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:18 INFO - 'title': 't-yosemite-r7-0262', 10:12:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:18 INFO - 'use_talos_json': True, 10:12:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:18 INFO - 'work_dir': 'build'} 10:12:18 INFO - [mozharness: 2017-03-02 18:12:18.454948Z] Running clobber step. 10:12:18 INFO - Running pre-action listener: _resource_record_pre_action 10:12:18 INFO - Running main action method: clobber 10:12:18 INFO - rmtree: /builds/slave/test/build 10:12:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:20 INFO - Running post-action listener: _resource_record_post_action 10:12:20 INFO - [mozharness: 2017-03-02 18:12:20.856786Z] Finished clobber step (success) 10:12:20 INFO - [mozharness: 2017-03-02 18:12:20.856956Z] Running read-buildbot-config step. 10:12:20 INFO - Running pre-action listener: _resource_record_pre_action 10:12:20 INFO - Running main action method: read_buildbot_config 10:12:20 INFO - Using buildbot properties: 10:12:20 INFO - { 10:12:20 INFO - "project": "", 10:12:20 INFO - "product": "firefox", 10:12:20 INFO - "script_repo_revision": "production", 10:12:20 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:12:20 INFO - "repository": "", 10:12:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:12:20 INFO - "buildid": "20170302074351", 10:12:20 INFO - "pgo_build": "False", 10:12:20 INFO - "basedir": "/builds/slave/test", 10:12:20 INFO - "buildnumber": 162, 10:12:20 INFO - "slavename": "t-yosemite-r7-0262", 10:12:20 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:12:20 INFO - "platform": "yosemite_r7", 10:12:20 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:12:20 INFO - "branch": "mozilla-central", 10:12:20 INFO - "repo_path": "mozilla-central", 10:12:20 INFO - "revision": "d29f84406483c721a13cf9a52936ecced0c5c98a", 10:12:20 INFO - "stage_platform": "macosx64", 10:12:20 INFO - "builduid": "e86f8fb5939b4ca3892987b3aab9ef0f", 10:12:20 INFO - "slavebuilddir": "test" 10:12:20 INFO - } 10:12:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 10:12:20 INFO - Running post-action listener: _resource_record_post_action 10:12:20 INFO - [mozharness: 2017-03-02 18:12:20.860287Z] Finished read-buildbot-config step (success) 10:12:20 INFO - [mozharness: 2017-03-02 18:12:20.860423Z] Running download-and-extract step. 10:12:20 INFO - Running pre-action listener: _resource_record_pre_action 10:12:20 INFO - Running main action method: download_and_extract 10:12:20 INFO - mkdir: /builds/slave/test/build/tests 10:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:20 INFO - trying https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 10:12:20 INFO - Downloading https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 10:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 10:12:21 INFO - Downloaded 1199 bytes. 10:12:21 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 10:12:21 INFO - Using the following test package requirements: 10:12:21 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 10:12:21 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:12:21 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 10:12:21 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:12:21 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 10:12:21 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:12:21 INFO - u'jsshell-mac.zip'], 10:12:21 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:12:21 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 10:12:21 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 10:12:21 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:12:21 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 10:12:21 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:12:21 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 10:12:21 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:12:21 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 10:12:21 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:12:21 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 10:12:21 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:12:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 10:12:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:12:21 INFO - Fetch https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 10:12:23 INFO - Expected file size: 51771274 10:12:23 INFO - Obtained file size: 51771274 10:12:39 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:12:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 10:12:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:12:39 INFO - Fetch https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 10:12:41 INFO - Expected file size: 51771274 10:12:41 INFO - Obtained file size: 51771274 10:12:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 10:12:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:12:55 INFO - Fetch https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 10:12:57 INFO - Expected file size: 14404424 10:12:57 INFO - Obtained file size: 14404424 10:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:57 INFO - trying https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 10:12:57 INFO - Downloading https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 10:12:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 10:12:59 INFO - Downloaded 75028894 bytes. 10:12:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 10:12:59 INFO - mkdir: /builds/slave/test/properties 10:12:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:59 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:59 INFO - Contents: 10:12:59 INFO - build_url:https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 10:13:00 INFO - Running post-action listener: _resource_record_post_action 10:13:00 INFO - Running post-action listener: set_extra_try_arguments 10:13:00 INFO - [mozharness: 2017-03-02 18:13:00.346425Z] Finished download-and-extract step (success) 10:13:00 INFO - [mozharness: 2017-03-02 18:13:00.346531Z] Running populate-webroot step. 10:13:00 INFO - Running pre-action listener: _resource_record_pre_action 10:13:00 INFO - Running main action method: populate_webroot 10:13:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:00 INFO - '--tppagecycles', 10:13:00 INFO - '7'], 10:13:00 INFO - 'tests': ['tsvgm']}}, 10:13:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:13:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:13:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['damp', 'tps']}, 10:13:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'tests': ['damp', 'tps']}, 10:13:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['dromaeo_dom']}, 10:13:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['basic_compositor_video']}, 10:13:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:13:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'other-e10s': {'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['tsvgx', 10:13:00 INFO - 'tsvgr_opacity', 10:13:00 INFO - 'tart', 10:13:00 INFO - 'tscrollx', 10:13:00 INFO - 'cart', 10:13:00 INFO - 'tsvg_static']}, 10:13:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:13:00 INFO - 'tsvgr_opacity', 10:13:00 INFO - 'tart', 10:13:00 INFO - 'tscrollx', 10:13:00 INFO - 'cart', 10:13:00 INFO - 'tsvg_static']}, 10:13:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['tp5o']}, 10:13:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:13:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'talos_options': ['--disable-e10s', 10:13:00 INFO - '--xperf_path', 10:13:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:00 INFO - 'tests': ['tp5n']}, 10:13:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'talos_options': ['--xperf_path', 10:13:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:00 INFO - 'tests': ['tp5n']}}, 10:13:00 INFO - 'talos.zip': {'path': '', 10:13:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:00 INFO - Running post-action listener: _resource_record_post_action 10:13:00 INFO - [mozharness: 2017-03-02 18:13:00.364436Z] Finished populate-webroot step (success) 10:13:00 INFO - [mozharness: 2017-03-02 18:13:00.364550Z] Running create-virtualenv step. 10:13:00 INFO - Running pre-action listener: _resource_record_pre_action 10:13:00 INFO - Running main action method: create_virtualenv 10:13:00 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:13:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:00 INFO - Using real prefix '/tools/python27' 10:13:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:01 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:04 INFO - Installing pip.................done. 10:13:04 INFO - Return code: 0 10:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:13:04 INFO - Reading from file tmpfile_stdout 10:13:04 INFO - Output received: 10:13:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:13:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10528bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8acd1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105069d30>, '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 0x104f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10505ebe8>, '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.8hCdrcV6do/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.j2KKVf3UNu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 10:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:13:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hCdrcV6do/Render', 10:13:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:04 INFO - 'HOME': '/Users/cltbld', 10:13:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:04 INFO - 'LOGNAME': 'cltbld', 10:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:04 INFO - 'MOZ_NO_REMOTE': '1', 10:13:04 INFO - 'NO_EM_RESTART': '1', 10:13:04 INFO - 'PAGER': '/bin/cat', 10:13:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:04 INFO - 'PWD': '/builds/slave/test', 10:13:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:04 INFO - 'SHELL': '/bin/bash', 10:13:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j2KKVf3UNu/Listeners', 10:13:04 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 10:13:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:04 INFO - 'USER': 'cltbld', 10:13:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:04 INFO - 'XPC_FLAGS': '0x0', 10:13:04 INFO - 'XPC_SERVICE_NAME': '0', 10:13:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:13:04 INFO - Cleaning up... 10:13:04 INFO - Return code: 0 10:13:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10528bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8acd1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105069d30>, '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 0x104f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10505ebe8>, '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.8hCdrcV6do/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.j2KKVf3UNu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 10:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:13:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hCdrcV6do/Render', 10:13:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:04 INFO - 'HOME': '/Users/cltbld', 10:13:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:04 INFO - 'LOGNAME': 'cltbld', 10:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:04 INFO - 'MOZ_NO_REMOTE': '1', 10:13:04 INFO - 'NO_EM_RESTART': '1', 10:13:04 INFO - 'PAGER': '/bin/cat', 10:13:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:04 INFO - 'PWD': '/builds/slave/test', 10:13:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:04 INFO - 'SHELL': '/bin/bash', 10:13:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j2KKVf3UNu/Listeners', 10:13:04 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 10:13:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:04 INFO - 'USER': 'cltbld', 10:13:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:04 INFO - 'XPC_FLAGS': '0x0', 10:13:04 INFO - 'XPC_SERVICE_NAME': '0', 10:13:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:04 INFO - Downloading/unpacking psutil>=3.1.1 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:08 INFO - Installing collected packages: psutil 10:13:08 INFO - Running setup.py install for psutil 10:13:08 INFO - building 'psutil._psutil_osx' extension 10:13:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:13:09 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 10:13:09 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 10:13:09 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 10:13:09 INFO - building 'psutil._psutil_posix' extension 10:13:09 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 10:13:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:13:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:13:09 INFO - ^ 10:13:09 INFO - 1 warning generated. 10:13:09 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 10:13:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:09 INFO - Successfully installed psutil 10:13:09 INFO - Cleaning up... 10:13:09 INFO - Return code: 0 10:13:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:13:09 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')]} 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:09 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')]} 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:09 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 0x10528bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8acd1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105069d30>, '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 0x104f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10505ebe8>, '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.8hCdrcV6do/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.j2KKVf3UNu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 10:13:09 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 10:13:09 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 10:13:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hCdrcV6do/Render', 10:13:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:09 INFO - 'HOME': '/Users/cltbld', 10:13:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:09 INFO - 'LOGNAME': 'cltbld', 10:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:09 INFO - 'MOZ_NO_REMOTE': '1', 10:13:09 INFO - 'NO_EM_RESTART': '1', 10:13:09 INFO - 'PAGER': '/bin/cat', 10:13:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:09 INFO - 'PWD': '/builds/slave/test', 10:13:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:09 INFO - 'SHELL': '/bin/bash', 10:13:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j2KKVf3UNu/Listeners', 10:13:09 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 10:13:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:09 INFO - 'USER': 'cltbld', 10:13:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:09 INFO - 'XPC_FLAGS': '0x0', 10:13:09 INFO - 'XPC_SERVICE_NAME': '0', 10:13:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:13:13 INFO - Installing collected packages: mozsystemmonitor 10:13:13 INFO - Running setup.py install for mozsystemmonitor 10:13:13 INFO - Successfully installed mozsystemmonitor 10:13:13 INFO - Cleaning up... 10:13:13 INFO - Return code: 0 10:13:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:13:13 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')]} 10:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:13 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')]} 10:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:13 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 0x10528bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8acd1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105069d30>, '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 0x104f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10505ebe8>, '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.8hCdrcV6do/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.j2KKVf3UNu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 10:13:13 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 10:13:13 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 10:13:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hCdrcV6do/Render', 10:13:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:13 INFO - 'HOME': '/Users/cltbld', 10:13:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:13 INFO - 'LOGNAME': 'cltbld', 10:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:13 INFO - 'MOZ_NO_REMOTE': '1', 10:13:13 INFO - 'NO_EM_RESTART': '1', 10:13:13 INFO - 'PAGER': '/bin/cat', 10:13:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:13 INFO - 'PWD': '/builds/slave/test', 10:13:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:13 INFO - 'SHELL': '/bin/bash', 10:13:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j2KKVf3UNu/Listeners', 10:13:13 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 10:13:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:13 INFO - 'USER': 'cltbld', 10:13:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:13 INFO - 'XPC_FLAGS': '0x0', 10:13:13 INFO - 'XPC_SERVICE_NAME': '0', 10:13:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:13 INFO - Downloading/unpacking jsonschema==2.5.1 10:13:13 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 10:13:13 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 10:13:13 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 10:13:13 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 10:13:13 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 10:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:13:16 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 10:13:16 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 10:13:16 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 10:13:16 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 10:13:16 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 10:13:16 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 10:13:17 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:17 INFO - warning: no files found matching '*.txt' 10:13:17 INFO - no previously-included directories found matching 'build' 10:13:17 INFO - no previously-included directories found matching 'dist' 10:13:17 INFO - no previously-included directories found matching '.git*' 10:13:17 INFO - Installing collected packages: jsonschema, functools32 10:13:17 INFO - Running setup.py install for functools32 10:13:17 INFO - warning: no files found matching '*.txt' 10:13:17 INFO - no previously-included directories found matching 'build' 10:13:17 INFO - no previously-included directories found matching 'dist' 10:13:17 INFO - no previously-included directories found matching '.git*' 10:13:17 INFO - Successfully installed jsonschema functools32 10:13:17 INFO - Cleaning up... 10:13:17 INFO - Return code: 0 10:13:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:13:17 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')]} 10:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:17 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')]} 10:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:17 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 0x10528bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8acd1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105069d30>, '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 0x104f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10505ebe8>, '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.8hCdrcV6do/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.j2KKVf3UNu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 10:13:17 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 10:13:17 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 10:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hCdrcV6do/Render', 10:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:17 INFO - 'HOME': '/Users/cltbld', 10:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:17 INFO - 'LOGNAME': 'cltbld', 10:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:17 INFO - 'MOZ_NO_REMOTE': '1', 10:13:17 INFO - 'NO_EM_RESTART': '1', 10:13:17 INFO - 'PAGER': '/bin/cat', 10:13:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:17 INFO - 'PWD': '/builds/slave/test', 10:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:17 INFO - 'SHELL': '/bin/bash', 10:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j2KKVf3UNu/Listeners', 10:13:17 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 10:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:17 INFO - 'USER': 'cltbld', 10:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:17 INFO - 'XPC_FLAGS': '0x0', 10:13:17 INFO - 'XPC_SERVICE_NAME': '0', 10:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:13:17 INFO - Cleaning up... 10:13:17 INFO - Return code: 0 10:13:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:13:17 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')]} 10:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:17 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')]} 10:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:17 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 0x10528bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8acd1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105069d30>, '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 0x104f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10505ebe8>, '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.8hCdrcV6do/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.j2KKVf3UNu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 10:13:17 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 10:13:17 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 10:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hCdrcV6do/Render', 10:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:17 INFO - 'HOME': '/Users/cltbld', 10:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:17 INFO - 'LOGNAME': 'cltbld', 10:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:17 INFO - 'MOZ_NO_REMOTE': '1', 10:13:17 INFO - 'NO_EM_RESTART': '1', 10:13:17 INFO - 'PAGER': '/bin/cat', 10:13:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:17 INFO - 'PWD': '/builds/slave/test', 10:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:17 INFO - 'SHELL': '/bin/bash', 10:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j2KKVf3UNu/Listeners', 10:13:17 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 10:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:17 INFO - 'USER': 'cltbld', 10:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:17 INFO - 'XPC_FLAGS': '0x0', 10:13:17 INFO - 'XPC_SERVICE_NAME': '0', 10:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:17 INFO - Downloading/unpacking blobuploader==1.2.4 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:20 INFO - Downloading blobuploader-1.2.4.tar.gz 10:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:13:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:13:20 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 10:13:20 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 10:13:20 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 10:13:20 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 10:13:20 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 10:13:20 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 10:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:13:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:13:21 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 10:13:21 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 10:13:21 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 10:13:21 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 10:13:21 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 10:13:21 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 10:13:21 INFO - Downloading docopt-0.6.1.tar.gz 10:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:13:21 INFO - Installing collected packages: blobuploader, requests, docopt 10:13:21 INFO - Running setup.py install for blobuploader 10:13:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:13:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:13:21 INFO - Running setup.py install for requests 10:13:22 INFO - Running setup.py install for docopt 10:13:22 INFO - Successfully installed blobuploader requests docopt 10:13:22 INFO - Cleaning up... 10:13:22 INFO - Return code: 0 10:13:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:22 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')]} 10:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:22 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')]} 10:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:22 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 0x10528bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8acd1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105069d30>, '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 0x104f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10505ebe8>, '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.8hCdrcV6do/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.j2KKVf3UNu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 10:13:22 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 10:13:22 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 10:13:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hCdrcV6do/Render', 10:13:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:22 INFO - 'HOME': '/Users/cltbld', 10:13:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:22 INFO - 'LOGNAME': 'cltbld', 10:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:22 INFO - 'MOZ_NO_REMOTE': '1', 10:13:22 INFO - 'NO_EM_RESTART': '1', 10:13:22 INFO - 'PAGER': '/bin/cat', 10:13:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:22 INFO - 'PWD': '/builds/slave/test', 10:13:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:22 INFO - 'SHELL': '/bin/bash', 10:13:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j2KKVf3UNu/Listeners', 10:13:22 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 10:13:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:22 INFO - 'USER': 'cltbld', 10:13:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:22 INFO - 'XPC_FLAGS': '0x0', 10:13:22 INFO - 'XPC_SERVICE_NAME': '0', 10:13:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:23 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-8xPluA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:23 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-VXjrVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:23 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-4umJ6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:23 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-VPAvBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:23 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-yj1whW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:23 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-IaAWMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:23 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-OKthSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:23 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-XsVePT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:23 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-aYcqXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:23 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-iAVPx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:24 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-7wYxsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:24 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-0UXDVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:24 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-y5knis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:24 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-sPbiUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:24 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-GnuMpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:24 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-1xXXTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:24 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-82k8YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:24 INFO - Running setup.py install for manifestparser 10:13:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:13:24 INFO - Running setup.py install for mozcrash 10:13:25 INFO - Running setup.py install for mozdebug 10:13:25 INFO - Running setup.py install for mozdevice 10:13:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:13:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:13:25 INFO - Running setup.py install for mozfile 10:13:25 INFO - Running setup.py install for mozhttpd 10:13:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:13:25 INFO - Running setup.py install for mozinfo 10:13:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:13:25 INFO - Running setup.py install for mozInstall 10:13:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:13:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:13:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:13:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:13:25 INFO - Running setup.py install for mozleak 10:13:26 INFO - Running setup.py install for mozlog 10:13:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:13:26 INFO - Running setup.py install for moznetwork 10:13:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:13:26 INFO - Running setup.py install for mozprocess 10:13:26 INFO - Running setup.py install for mozprofile 10:13:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:13:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:13:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:13:26 INFO - Running setup.py install for mozrunner 10:13:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:13:26 INFO - Running setup.py install for mozscreenshot 10:13:27 INFO - Running setup.py install for moztest 10:13:27 INFO - Running setup.py install for mozversion 10:13:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:13:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:13:27 INFO - Cleaning up... 10:13:27 INFO - Return code: 0 10:13:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:27 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 0x10528bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8acd1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105069d30>, '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 0x104f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10505ebe8>, '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.8hCdrcV6do/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.j2KKVf3UNu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 10:13:27 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 10:13:27 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 10:13:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hCdrcV6do/Render', 10:13:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:27 INFO - 'HOME': '/Users/cltbld', 10:13:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:27 INFO - 'LOGNAME': 'cltbld', 10:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:27 INFO - 'MOZ_NO_REMOTE': '1', 10:13:27 INFO - 'NO_EM_RESTART': '1', 10:13:27 INFO - 'PAGER': '/bin/cat', 10:13:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:27 INFO - 'PWD': '/builds/slave/test', 10:13:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:27 INFO - 'SHELL': '/bin/bash', 10:13:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j2KKVf3UNu/Listeners', 10:13:27 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 10:13:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:27 INFO - 'USER': 'cltbld', 10:13:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:27 INFO - 'XPC_FLAGS': '0x0', 10:13:27 INFO - 'XPC_SERVICE_NAME': '0', 10:13:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-GkzpiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:27 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)) 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-WP4JYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-6lzPUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:27 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)) 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-WRL6yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:28 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-VD6EkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:28 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)) 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:28 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-d9BWxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:28 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)) 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:28 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-aKCCLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:28 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)) 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:28 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-QOI9Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:28 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)) 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:28 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-0r_V8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:28 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)) 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:28 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-joaIj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:28 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)) 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:28 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-ALgqVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:28 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)) 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:28 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-nNTmXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:28 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-W4Rito-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:29 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-0Q5_Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:29 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-ooGmVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:29 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-VvFA34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:29 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Jln4g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:29 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)) 10:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:13:29 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)) 10:13:29 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:13:29 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:13:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:32 INFO - Downloading blessings-1.6.tar.gz 10:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:13:32 INFO - Installing collected packages: blessings 10:13:32 INFO - Running setup.py install for blessings 10:13:32 INFO - Successfully installed blessings 10:13:32 INFO - Cleaning up... 10:13:32 INFO - Return code: 0 10:13:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:13:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:32 INFO - Reading from file tmpfile_stdout 10:13:32 INFO - Current package versions: 10:13:32 INFO - blessings == 1.6 10:13:32 INFO - blobuploader == 1.2.4 10:13:32 INFO - docopt == 0.6.1 10:13:32 INFO - functools32 == 3.2.3-2 10:13:32 INFO - jsonschema == 2.5.1 10:13:32 INFO - manifestparser == 1.1 10:13:32 INFO - mozInstall == 1.12 10:13:32 INFO - mozcrash == 1.0 10:13:32 INFO - mozdebug == 0.1 10:13:32 INFO - mozdevice == 0.49 10:13:32 INFO - mozfile == 1.2 10:13:32 INFO - mozhttpd == 0.7 10:13:32 INFO - mozinfo == 0.9 10:13:32 INFO - mozleak == 0.1 10:13:32 INFO - mozlog == 3.4 10:13:32 INFO - moznetwork == 0.27 10:13:32 INFO - mozprocess == 0.25 10:13:32 INFO - mozprofile == 0.28 10:13:32 INFO - mozrunner == 6.13 10:13:32 INFO - mozscreenshot == 0.1 10:13:32 INFO - mozsystemmonitor == 0.3 10:13:32 INFO - moztest == 0.8 10:13:32 INFO - mozversion == 1.4 10:13:32 INFO - psutil == 3.1.1 10:13:32 INFO - requests == 1.2.3 10:13:32 INFO - wsgiref == 0.1.2 10:13:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:32 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 0x10528bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8acd1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105069d30>, '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 0x104f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10505ebe8>, '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.8hCdrcV6do/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.j2KKVf3UNu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 10:13:32 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 10:13:32 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 10:13:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hCdrcV6do/Render', 10:13:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:32 INFO - 'HOME': '/Users/cltbld', 10:13:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:32 INFO - 'LOGNAME': 'cltbld', 10:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:32 INFO - 'MOZ_NO_REMOTE': '1', 10:13:32 INFO - 'NO_EM_RESTART': '1', 10:13:32 INFO - 'PAGER': '/bin/cat', 10:13:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:32 INFO - 'PWD': '/builds/slave/test', 10:13:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:32 INFO - 'SHELL': '/bin/bash', 10:13:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j2KKVf3UNu/Listeners', 10:13:32 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 10:13:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:32 INFO - 'USER': 'cltbld', 10:13:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:32 INFO - 'XPC_FLAGS': '0x0', 10:13:32 INFO - 'XPC_SERVICE_NAME': '0', 10:13:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 INFO - Cleaning up... 10:13:32 INFO - Return code: 0 10:13:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10528bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8acd1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105069d30>, '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 0x104f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10505ebe8>, '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.8hCdrcV6do/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.j2KKVf3UNu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 10:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:13:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hCdrcV6do/Render', 10:13:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:32 INFO - 'HOME': '/Users/cltbld', 10:13:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:32 INFO - 'LOGNAME': 'cltbld', 10:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:32 INFO - 'MOZ_NO_REMOTE': '1', 10:13:32 INFO - 'NO_EM_RESTART': '1', 10:13:32 INFO - 'PAGER': '/bin/cat', 10:13:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:32 INFO - 'PWD': '/builds/slave/test', 10:13:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:32 INFO - 'SHELL': '/bin/bash', 10:13:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j2KKVf3UNu/Listeners', 10:13:32 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 10:13:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:32 INFO - 'USER': 'cltbld', 10:13:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:32 INFO - 'XPC_FLAGS': '0x0', 10:13:32 INFO - 'XPC_SERVICE_NAME': '0', 10:13:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:13:33 INFO - Cleaning up... 10:13:33 INFO - Return code: 0 10:13:33 INFO - Running post-action listener: _resource_record_post_action 10:13:33 INFO - Running post-action listener: _start_resource_monitoring 10:13:33 INFO - Starting resource monitoring. 10:13:33 INFO - [mozharness: 2017-03-02 18:13:33.222294Z] Finished create-virtualenv step (success) 10:13:33 INFO - [mozharness: 2017-03-02 18:13:33.223230Z] Running install step. 10:13:33 INFO - Running pre-action listener: _resource_record_pre_action 10:13:33 INFO - Running main action method: install 10:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:33 INFO - Reading from file tmpfile_stdout 10:13:33 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:33 INFO - Reading from file tmpfile_stdout 10:13:33 INFO - Output received: 10:13:33 INFO - Usage: mozinstall [options] installer 10:13:33 INFO - Options: 10:13:33 INFO - -h, --help show this help message and exit 10:13:33 INFO - -d DEST, --destination=DEST 10:13:33 INFO - Directory to install application into. [default: 10:13:33 INFO - "/builds/slave/test"] 10:13:33 INFO - --app=APP Application being installed. [default: firefox] 10:13:33 INFO - mkdir: /builds/slave/test/build/application 10:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:13:54 INFO - Reading from file tmpfile_stdout 10:13:54 INFO - Output received: 10:13:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:13:54 INFO - Running post-action listener: _resource_record_post_action 10:13:54 INFO - [mozharness: 2017-03-02 18:13:54.071775Z] Finished install step (success) 10:13:54 INFO - [mozharness: 2017-03-02 18:13:54.071935Z] Running run-tests step. 10:13:54 INFO - Running pre-action listener: _resource_record_pre_action 10:13:54 INFO - Running main action method: run_tests 10:13:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:13:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:13:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:13:54 INFO - 2017-03-02 10:13:54.086 screenresolution[1624:7302] starting screenresolution argv=screenresolution get 10:13:54 INFO - 2017-03-02 10:13:54.089 screenresolution[1624:7302] Display 0: 1600x1200x32@60 10:13:54 INFO - 2017-03-02 10:13:54.094 screenresolution[1625:7304] starting screenresolution argv=screenresolution list 10:13:54 INFO - Available Modes on Display 0 10:13:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:13:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:13:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:13:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:13:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:13:54 INFO - Intel Iris: 10:13:54 INFO - Chipset Model: Intel Iris 10:13:54 INFO - Type: GPU 10:13:54 INFO - Bus: Built-In 10:13:54 INFO - VRAM (Dynamic, Max): 1536 MB 10:13:54 INFO - Vendor: Intel (0x8086) 10:13:54 INFO - Device ID: 0x0a2e 10:13:54 INFO - Revision ID: 0x0009 10:13:54 INFO - Displays: 10:13:54 INFO - Display: 10:13:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:13:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:13:54 INFO - Display Serial Number: 1600x1200 60 10:13:54 INFO - Main Display: Yes 10:13:54 INFO - Mirror: Off 10:13:54 INFO - Online: Yes 10:13:54 INFO - Rotation: Supported 10:13:54 INFO - Return code: 0 10:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:54 INFO - Python 2.7.3 10:13:54 INFO - Return code: 0 10:13:54 INFO - grabbing minidump binary from tooltool 10:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:54 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 0x105069d30>, '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 0x104f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10505ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:54 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 10:13:54 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 10:13:54 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 10:13:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:54 INFO - Return code: 0 10:13:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:13:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:54 INFO - ENV: RUST_BACKTRACE is now 1 10:13:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:13:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--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 10:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0262 --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 10:13:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hCdrcV6do/Render', 10:13:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:54 INFO - 'HOME': '/Users/cltbld', 10:13:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:54 INFO - 'LOGNAME': 'cltbld', 10:13:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:54 INFO - 'MOZ_NO_REMOTE': '1', 10:13:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:54 INFO - 'NO_EM_RESTART': '1', 10:13:54 INFO - 'PAGER': '/bin/cat', 10:13:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:54 INFO - 'PWD': '/builds/slave/test', 10:13:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:54 INFO - 'RUST_BACKTRACE': '1', 10:13:54 INFO - 'SHELL': '/bin/bash', 10:13:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j2KKVf3UNu/Listeners', 10:13:54 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 10:13:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:54 INFO - 'USER': 'cltbld', 10:13:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:54 INFO - 'XPC_FLAGS': '0x0', 10:13:54 INFO - 'XPC_SERVICE_NAME': '0', 10:13:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--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 10:13:54 INFO - mozversion application_buildid: 20170302074351 10:13:54 INFO - mozversion application_changeset: d29f84406483c721a13cf9a52936ecced0c5c98a 10:13:54 INFO - mozversion application_display_name: Nightly 10:13:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:54 INFO - mozversion application_name: Firefox 10:13:54 INFO - mozversion application_remotingname: firefox 10:13:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:13:54 INFO - mozversion application_vendor: Mozilla 10:13:54 INFO - mozversion application_version: 54.0a1 10:13:54 INFO - mozversion platform_buildid: 20170302074351 10:13:54 INFO - mozversion platform_changeset: d29f84406483c721a13cf9a52936ecced0c5c98a 10:13:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:13:54 INFO - mozversion platform_version: 54.0a1 10:13:54 INFO - using testdate: 1488478434 10:13:54 INFO - actual date: 1488478434 10:13:54 INFO - starting webserver on 'localhost:49236' 10:13:54 INFO - SUITE-START | Running 2 tests 10:13:54 INFO - TEST-START | dromaeo_css 10:13:54 INFO - operating with platform_type : mac_ 10:13:54 INFO - Initialising browser for dromaeo_css test... 10:13:54 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpOT4KjW/profile http://localhost:49236/getInfo.html) 10:13:57 INFO - PROCESS | 1635 | 2017-03-02 10:13:57.771 plugin-container[1637:7479] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b47, name = 'com.apple.tsm.portname' 10:13:57 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:13:57 INFO - PROCESS | 1635 | 2017-03-02 10:13:57.774 plugin-container[1637:7479] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x941f, name = 'com.apple.CFPasteboardClient' 10:13:57 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:13:57 INFO - PROCESS | 1635 | 2017-03-02 10:13:57.775 plugin-container[1637:7479] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:13:57 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 10:13:57 INFO - PROCESS | 1635 | colorDepth:24 10:13:57 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 10:13:57 INFO - PROCESS | 1635 | __metrics 10:13:57 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3354: TypeError: this.tabs is undefined 10:13:58 INFO - TEST-INFO | 1635: exit 0 10:13:58 INFO - Browser initialized. 10:13:58 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:58 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpOT4KjW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:01 INFO - PROCESS | 1638 | 2017-03-02 10:14:01.154 plugin-container[1639:7622] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 10:14:01 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:14:01 INFO - PROCESS | 1638 | 2017-03-02 10:14:01.155 plugin-container[1639:7622] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 10:14:01 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:14:01 INFO - PROCESS | 1638 | 2017-03-02 10:14:01.155 plugin-container[1639:7622] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:14:10 INFO - PROCESS | 1638 | RSS: Main: 226922496 10:14:10 INFO - PROCESS | 1638 | 10:17:15 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 10:17:16 INFO - PROCESS | 1638 | RSS: Main: 249430016 10:17:16 INFO - PROCESS | 1638 | 10:18:59 INFO - PROCESS | 1638 | ************************* 10:18:59 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 10:18:59 INFO - PROCESS | 1638 | 10:18:59 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:18:59 INFO - PROCESS | 1638 | Full stack: 10:18:59 INFO - PROCESS | 1638 | ************************* 10:20:18 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 10:20:19 INFO - PROCESS | 1638 | RSS: Main: 257396736 10:20:19 INFO - PROCESS | 1638 | 10:23:21 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 10:23:22 INFO - PROCESS | 1638 | RSS: Main: 269205504 10:23:22 INFO - PROCESS | 1638 | 10:26:24 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 10:26:25 INFO - PROCESS | 1638 | RSS: Main: 262889472 10:26:25 INFO - PROCESS | 1638 | 10:29:28 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 10:29:28 INFO - PROCESS | 1638 | RSS: Main: 272490496 10:29:28 INFO - PROCESS | 1638 | 10:32:32 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 10:32:32 INFO - PROCESS | 1638 | RSS: Main: 267046912 10:32:32 INFO - PROCESS | 1638 | 10:32:32 INFO - PROCESS | 1638 | __start_tp_report 10:32:32 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 10:32:32 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 10:32:32 INFO - PROCESS | 1638 | |i|pagename|runs| 10:32:32 INFO - PROCESS | 1638 | |0;dojo.html;3442.0190245779972;3458.9135271618206;3491.807950562719;3494.8951531454063;3495.947560786587;5398.055340315449;5402.837914862561;5956.4341387568165;5977.163197152397;6000.489958353534;5806.361300256968;5999.700014999244;6072.423119803622;6082.178905847709;6129.205975626773;4562.311944580493;5174.3790745110455;5356.0894647909945;5453.318335208099;5499.3675727291275;5381.0852155133525;5459.3994660587305;5525;5536.390996990328;5538.556915446755;5463.071277882769;5463.699496527689;5503.20203570482;5508.394076651565;5533.584981126432;5327.200919862013;5338.279332290169;5352.357717073976;5398.811041613525;5430.755615997289;5355.410904800468;5370.677759334452;5389.380221274564;5442.755076021549;5476.151196564539;5791.305043394777;5912.526997840162;6063.9090413643835;6080.179175811298;6085.208922840046;6282.96858515709;6291.591046581958;6341.651209183493;6346.397092276226;6388.616682999035;6358;6450.516211284125;6459.773907913201;6461;6469.708863101125;6164.044573091178;6168.414000669929;6172.382761723837;6188.752449901954;6210.254769427697;6271.43557079865;6338.176037115238;6465.515086368541;6488.708008139645;6530.8040758777315;6329.841753956096;6337.588056776295;6354.205724284465;6373.71318290678;6398.392152745481;6437.742490300336;6454.548181627335;6459.418652321314;6461.64460954652;6479.8056058318325;6173.629582225081;6232.18981532407;6275.090111933744;6354.26925903527;6374.330695277022;6308.116863639094;6335.429811317003;6352.428281454599;6352.872942541216;6356.364363563606;5144.768485418165;5149.382074151051;5162.535371816554;5175.818846340435;5203.063448579292;4500.054988452462;4563.201439748031;4643.953560464352;4663.836765713184;4668.393108895822;5995.670238136944;6054.39456054391;6088.786892458743;6102.671035646872;6118.95422233728;6394.936050639527;6466.062420948936;6466.870662586722;6476.996065609838;6485.319041500669;5990.73041713124;6014.428629280212;6120.234970628671;6136.447719705248;6140.508759299245;5527.917081243784;5578.358488773762;5581.413951535112;5625.971870140705;5637.26715526987;6494.318096599884;6575.80272591823;6576.901346479903;6582.275949645439;6590.209174899042;6403.327650596807;6412.551121421642;6414;6428.839279018062;6433.163688720437;6309.1167236586;6353.5870168438905;6518.608883467007;6572.868542629025;6594.307597702364;6268.4671802897265;6274.937250627435;6304.968475157778;6346.650934198663;6382.6170429774365;6366.299707032315;6402.839929001812;6405.551611387345;6412.775552855627;6419.2296924369375;6180.783672571439;6245.250569931637;6265.185525881606;6321.11504389395;6349.777757778455;6228.532860035425;6269.216347956505;6289.591176573508;6301.590396624205;6360.809175724736;6179.28938172116;6240.812775616739;6314.589551679126;6319.3364696706185;6324.430801227912;5253.868653283698;6193.81418557444;6224.688765561795;6235.844103897439;6240.188775459162;6074.119252708421;6278.591891527219;6292.244930608356;6294.968525157345;6307.905381419374 10:32:32 INFO - PROCESS | 1638 | |1;ext.html;735.283098978496;758.5562445969109;796.7928338631956;924.2005665099691;924.9722508324744;36138.63861361385;36906.261874762524;38414.423783643266;38417.423738643905;38460.42309365362;37093.629063709355;37288.81355593225;37313.440298395544;37333.439998399976;37401.064973375614;7533.886991695129;7702.46082774206;10115.949420252888;10427.895721042807;10490.108340791043;10038.196944244442;10114.241431892637;10120.696379108602;10150.03574660406;10151.644692435766;10107.797844043114;10132.696019119438;10166.339187952797;10177.08406243438;10183.28716989811;10104.797904041914;10124.443155626437;10133.341332813343;10133.746656333577;10138.087572118508;10055.849162262572;10119.139873110795;10173.796524069478;10174.847377289347;10183.847242291371;32337.191570210696;32403.6759632403;32427.189320266945;32596;32697.673023269937;3089;3108.6580476147833;3116.781825272232;3135.451296023187;3230.353929214167;24932.626010609856;25492.745072549224;25505.489890202276;25506.617400739004;25652.23043308685;2974.301039255773;2981.6272965879266;3055.2139938915484;3099.5970523831984;3118.485449900764;307216.4639176812;308016;308617;309797;310303.4484827584;32495.51256731151;33887.66112338894;42001.36997945033;42007;42007.949801255214;43369;43417.34873976893;43521;43555;43580.346294805604;12645.557405490763;12736.80894786579;12741.55404560836;12775.105742598114;12785.936070319589;10761.730956726144;10782.083522900484;10784.406857622906;10796.56813727442;10799.974002469753;9191;10855.511501982272;11508.59719909799;11571.594994175332;11657.883421165849;5538.446155384429;5600.215969764236;5621.4659607337235;5680.914786278209;5691.487766100988;945.3146468810057;1121.4448847820217;1140.5152810055692;1165.6794381544973;1206.849143857018;23119.768802311763;25099.37251568689;25350.619740703904;25547.87226063895;25558.361040974123;1090.7000574841982;1236.3262022197923;1259.8929091027364;1269.1940617707637;1317.8879795217322;12818.166819156724;13017.544385946447;13038.41327140262;13051.804222936664;13095.410706518229;409600;412118;412576;412901.87098128634;413924.7215055682;51476.742616286676;51955.103367246855;52039.47960520422;52098.47901521012;52195.21707174395;1351.8783309502192;1353.9593812185453;1389.9374528146257;1390.4577214886;1397.9510717124851;18062.729059063862;24709;25091.121810736535;25850.61224081678;25900.35249118787;36990.63009369872;37168.814155929045;37202.06994825151;37301.6269837309;37477;420789;421150;422755;422788;423145;21103.472413189178;21191.364259072252;21196.57606847885;21203.575928481034;21206.893965530075;35673.46489802707;35872;37697.05757355978;37739.81130094332;37946.8102659496;29577.704222957494;30788.230294241926;30942.38115237728;31999.520007200375;33311.83344083264;31050.68949310478;31258.843705781324;31508.376536697655;31976.520352195203;33354;31565;32030.35939281248;32151.839240803645;32215.51676724898;32311.35377292488;26835.597466038416;27155.59266611042;28807.847686092322;28902.843886245155;28981.275468113465;17772.822271777117;20047.298344557872;22143.889280553492;22324.330270091923;22622.321330360115 10:32:32 INFO - PROCESS | 1638 | |2;jquery.html;381.4945197613163;386.59986913544486;398.42427691985085;409.75005246799464;414.5398607545625;12800.80798788019;14292.071015383994;19852.90073549632;21192.13906122673;21205.045772940215;20470;20717.585648287026;21003.684944725843;21049.789502104974;21333.719976801403;5881.323647780518;6380.138681278037;6402.487800975934;6406.199225096863;6590.143281373439;6433.292337842833;6576.408123268905;6591;6592.307807680197;6887.621180835052;7238.927610723878;7318.231585683507;7326.523775954573;7328.706851725925;7341.045664063691;6068.848278793022;6992.580445173306;7134.643267836587;7251.927480725178;7299.087614048244;6082.327359975998;6938.618375989318;6970.965145174292;6994.930050699479;7040.225575186725;24364.634530482057;24421.267361979168;24435.144769933144;24735.87632061828;24748.5050298993;2465.8767061646845;2691.8250313729545;2818.591304260871;2861.1130549529503;2862.141357592714;11983.700407489883;15136.621584460367;15303.928724989255;15818.525444236691;15885.523434296989;1913.9617207655908;1932.2271091563346;1974.9111289991986;1980.8019198080076;1989.4926793667667;140183;146539.53460465366;150944.245278774;157515.63726544226;163798;16681;18947.621047579247;19064.904675476533;19177.137028833735;19287.807121928883;29532.261693457836;29991.250218744706;29999.550006749916;30003;30158.944436944603;9457.479838608804;9486.810263794685;9703.514824258758;9768.267379946532;9791.657291994889;7999.040115186099;8026.237507436784;8026.317762990211;8167.509949403055;8186.222308880647;8943.642254309885;9023.548822558978;9083.772905677411;9113.954430227806;9130.634774609074;3817.828197731109;3867.3425517662067;3868.7485313454536;3891.377379619247;3895.2988462076532;851.9148085191555;961.9038096190465;977.2719324103447;1016.2378216337746;1032.2877214721818;16068.43760468378;17256.65486690284;19876.70184947227;20090.296839610837;20518.89740551288;828.5981299069946;848.2281124176969;877.8156587116777;913.6710784117712;919.8298314811781;5597.74810133545;6524.184476940382;6534.248561415403;6697.196336439659;6768.661566921634;675786;678089;688138;693369;694347;154702.4529754688;159508.20245898695;160440.9319880382;161735;162248;990.8810942686923;1009.4649835587151;1040.3393844908387;1043.5773511727762;1046.9110125639406;10076.345037572535;10156.238282128723;11535.192536522698;11827.881721183023;11961.940190298992;60596.39403606084;61171.38828611657;61186.08220876601;62059.1382258533;63738;81751.95620109545;81922;82006.58996704979;84596.57701711453;84982.15017849742;8144.75565733029;9845.89854195926;10356.689299321033;10414.323069000491;10982.06652434552;11423.657290281304;12081.154319197924;12255.938720306342;12583.93708031454;12615.747685046432;5942.58401911862;10590;10660;10704.518296676513;10742.677719668422;8927.24118449939;9357.689923410591;9557.904420955701;10573.2598718089;10760.139188865029;10093.899061009295;10729.248952573245;10741.248112632353;10888.40113793749;11042.227044106836;10764.784704306026;10969.57395538575;10987.230893837355;11023.944880275547;11076.556937722724;10740.516676749408;10820;10849.837252441377;11054.502547385548;11054.949779770908 10:32:32 INFO - PROCESS | 1638 | |3;mootools.html;1344.159900062461;1359.7688392973193;1374.6975665353623;1565.3425561264262;1604.9759253611194;9429.81140377192;10189.08298253157;10691.518881650325;11007.119430445566;11169.776604467916;10965.50655220515;11052.723681907957;11164.832527512093;11166.944165279163;11249.775004499925;2318.3045086474076;2345.3901985483726;2350.5533948549805;2354.82338824588;2362.11420717231;1970.4975231316066;2306.7808558186944;2345.495718420539;2350.9059637614473;2360.7403185649564;2289.9313020609407;2300.148944890393;2308.3882771065682;2318.6174281243575;2324.651302304651;1919.3282351177115;2251.79733823955;2320.5590937721777;2321.9883900580558;2327.7788610082016;2260.457490202356;2326.9767302326927;2329.114936324186;2334.7315058768118;2343.730470995823;10848.78302433947;10866.239363244576;10934.617288394948;10945.56217751289;10965.122790176847;5243.161094224905;5358.91961620576;5409.9459005409835;5418.0789265824515;5422.15956526739;3282.556854824616;3381.2561236527927;3561.71506279497;3583.229605634775;3591.1560783215923;1133.5465813674514;1176.923499972499;1179.5222934711455;1210.334316126127;1226.533917111492;13632.182069075887;14090.872730181562;14716.779248311284;14753.33609987553;14819.555413337617;4537.410136682211;4673.135469938073;4687.648426368036;4715.976420117878;4720.858374248778;11227.045701115334;11472.426378681033;11497.482613282255;11499;11503.07975361969;5372.764721289601;5587.273654424899;5625.54995600351;5627.887442251132;5646;5242.790288388498;5243.213517972258;5246.580273578104;5249.317588713443;5255.369355677267;3657.8719744808805;3859.5947425520476;3875.6705680017512;3883.5533913600298;3903.6291552302487;1031.1544533482472;1036.2797855490512;1037.4708898461688;1044.8798388185303;1047.9318844275099;769.2499812682589;805.5247404031533;904.9185573298435;906.723449347942;936.4334577580465;6248.4688801452385;6282.748690052438;6426.260979987268;6557.737690492327;6635.10426092481;930.2325581395295;989.811935732223;1002;1015.5984741057441;1035.8342665173536;3394.9660503395144;3555.6977656898935;3877.495925529663;4081.2041651878194;4111.60939710727;9805.80388392228;11942;12183.817242741366;13055.608331749872;13275.867241327656;12840.678983025498;12939.353032348345;12983.480660773652;13001.479940802263;13014.804777928339;8459;9798.902010979942;9874.555644995993;10106.29255952091;10117.038881306264;5593.412691667317;6033.939660603513;6061.242344706911;6149.84625384369;6231;9644.662436814679;11719.355435451133;12107.031437485157;12133.09001824849;12153.392330383622;12071.795940027761;12086.395680215777;12288.877111228774;12331.630051098482;12333.568325108577;8773.692920747742;9093.272538196796;9157;9228.077192280987;9236.445813251226;9957.103860652576;10077.395356278354;10104.595816167564;10173.186145108226;10224;8272.33821294283;8914.37599368038;8918.152775486318;8928.330375221754;9034.3675942686;8699.564571845574;8925.464472131693;9008.549572521479;9023.142801433853;9043.773905652411;7385.519941204019;7600.201978792368;7699.191584883507;7741.961290193513;7788.415868809749;4710;5501.229827824188;5658.179563963285;5688.544916406595;5793.94206057934;5609.242752228397;5729.427057294404;5764.337101233412;5861.3845546217035;6007.669578173242 10:32:32 INFO - PROCESS | 1638 | |4;prototype.html;345.844370033485;370.22437992405906;370.4517314374727;371.69335298378843;381.77475289579144;5076.5684916782075;5156.948430515694;5299.489645451047;5415.296011518497;5566.582506312027;4313.7843107844565;5350.785968561263;5445.809396671118;5446.700431476267;5466.180072989054;4380.71525350852;4538.7503687297185;4562.703424277412;4606.239970404879;4617.5613316735025;4588.22000259955;4598.241290187115;4604.769761511911;4607.539246075383;4639.747268237574;3786.6522755891388;4580.129775342674;4603.700759450642;4610.469795973456;4620.768961551926;3806.2768074066116;3832.2910261601555;4296.63478604319;4430.430350396762;4500.559820857327;3254.30032543002;3953.7348048624453;4180.895477613054;4182.498100227992;4208.642265407444;4461.776911154429;5342.0651386007685;5358.758855851496;5364.436734142937;5367.725687330725;4434.556544345572;4973.701577905337;5217.165253559412;5289.41317604717;5294.52349288562;4871.902561948777;5042.470540593222;5571.415001424833;5870.941290587082;5948.821535353946;4317.179735850178;4697.906041879143;4705.247160454311;4711.835085772016;4740.217864052427;5450.454954504517;5791.768329266824;5888;6153.2000839890525;6208.534359922979;4046.291898917678;4768.809247630125;4796.544328288807;4809.927851082237;4812.037592481448;4364.3017117261725;4886.214857531244;4893.853184404474;4902.240152776254;4959.652824302337;4386.7367957922625;5034.320366750442;5197.896042079137;5246.976839516334;5303.178007408857;4757.26262429324;5161.793528258902;5374.355077390738;5824.51474873913;5920.851978700567;1342.0203251626367;1426.785982102693;1591.880608954333;1603.8957467764558;1604.5078077387907;1109.6560066379448;1190.4761904761876;1195.838561794164;1200.6758175292623;1211.582448535216;4807.375041244686;4875.6840500761855;5058.494150584912;5178.508041736029;5194.831152996669;5346.7861285548925;5796.536277097822;5801.882312955825;5847.736851841677;5851.473367396955;4508.752018638941;4540.932880773015;4939.110960027229;5172.120739474299;5172.870678232999;2491.2152671908293;2631.6973098316457;2673.812833101664;2868.913932582026;3022.2897619059504;5477.534409575231;5799.623024503394;5877.617954832922;6023.578349515492;6054.3966094579755;4685.742284174335;4803.613452515968;5252.185911183773;5801.042827933344;5959.897418977503;5087.923681144785;5562.860928476821;5676.290463692038;6068.453839154409;6270.592411493239;5146.76839542214;6012.158297838394;6028.608140470856;6034.517238620812;6050.969745151246;5423.945760542502;5581.720913954205;6007.038873780349;6011.489023433057;6039.879202415839;5252.579793616425;6204;6217.854840080166;6219;6306.873862522815;3971.4042893566198;4250.086231460251;4250.851220207278;4579.780270107438;4667.996380778149;4790.688380457616;5959.798342168674;5972.820815375546;6113.266408031065;6181.690915454299;5401.810936617357;5462.317210348707;5831.241938547962;5855.214159681338;5871.324797648325;4959.975200123977;4961.3798275215595;5022.673526220784;5831.620944638755;5894.734736936763;5064.5819170632285;5505.311836020497;5768.2501274834;5779.248697669276;5783.277090363705;5739.20340456134;5821.417858214145;5864.237649105589;5941.435563621449;5965.970170149121;4692.967547139624;4811.663183577116;5373.5609210104785;5684.635687435069;5736.483716465538 10:32:32 INFO - PROCESS | 1638 | |5;yui.html;727.2218725963219;771.8687823070078;807.9515229086259;818.7257268814947;821.4373154389242;14856.777148342784;15661.765073523906;15735.685286294267;15744.60638484037;15762.92118539407;13388.397522111503;14653.853461465382;14784.556463306119;14809.92595037026;14813.888958328114;893.3255392178896;927.0775578299601;942.5334459442586;948.4546385828141;953.3898305084751;818.7625588579334;834.2200042959821;947.8199142162968;948.127722495306;983.4394395194706;937.2876613773514;1003.5183112106193;1012.084063922148;1012.2559918459926;1012.266107072374;1001.2240513601944;1007.3653598233067;1007.5516395204137;1009.2531526670284;1009.9546968887166;744.8659241336558;746.3544034410196;746.8431629357841;748.805310619243;748.9063867016623;13606.843418309456;14067.507637232648;15679.921600391925;15807.762883556756;16173.110478923654;13562.118462299919;13633.454661813515;13800.516981905585;13985.230812305319;14055.929720351332;9946.806383233987;10727.40413651081;11400.771984560346;11551.480183391683;12158.270503769714;3580.445031020196;3606.4229723244157;3698.556173259226;3726.5341832270965;3736.831842567091;92983.56040818946;95751;96576.64643572626;97001;98523.50738246334;10153.13698335635;10390.48047597617;10473.528691208914;10520.10579100785;10676.092532134855;21527.246546370803;21596.352109436742;21786.455338616346;21859.781402186094;21911.12355505762;7316.707331706672;7316.817079573053;7371.6682749276415;7534;7539.472236943471;4039.171969746195;4088.6933479988525;4134.669226461876;4145.585441455831;4152.294110001307;3371.831408429569;3451.6720911513366;3461.7749846259912;3523.365794157025;3707.5550933887566;657.1850904877917;658.1312667279145;661.9602823830586;675.2302375292171;677.6747161362573;600.495583709686;622.700816055372;627.9497640188774;665.2316574356626;688.1432616392623;9566.786101574658;9957.651482198089;10004.349717268355;10077.748056298651;10324.277300589038;620.7423919073534;667.4293479075418;692.5706062241443;695.0623875343489;701.6073094906607;4471.5995028228335;4630.120277147331;4908.092002979461;4939.6542242042715;5018.774155163026;96791;98088.50955745176;99519;99569;100979.49510252548;55643;58972.41027589669;65174.67412662906;78486.21513784904;83065;59207.111893321635;59610.91361802316;67734.9839752414;68199;69558.26104347431;10383;10488.213383996383;10515.57937682484;10523.315984460985;10606.628767993083;36454.8177259112;45414.18343266232;45847.541524584325;47152.52847471481;47552;37779.62220377871;60307.26646354841;60647.02559205571;61031;61864;12000.57997970067;12018;12019.579314723942;12188.695282618006;12521;13876.514321998682;13979.370928308048;14021;14240.643983900485;14414.639634009234;11495.711972492412;12243.653198148375;12744.10791244641;13060;13549.187048777105;12445.75108497843;13156.80264796048;13214.537491187762;13406.664833379244;13585.45658173662;12470.625881223577;12639.431225594686;13019;13070.54253101137;13505.189688618715;10563.471826408802;10895.891041089488;10924.235303528676;11154.107671386431;11324.37715925632;8995.730128096167;9352.29857760657;11170.776584468103;11317.20779545457;11457.484413201259 10:32:32 INFO - PROCESS | 1638 | __end_tp_report 10:32:32 INFO - PROCESS | 1638 | __start_cc_report 10:32:32 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,441 10:32:32 INFO - PROCESS | 1638 | __end_cc_report 10:32:32 INFO - PROCESS | 1638 | __startTimestamp1488479552390__endTimestamp 10:32:32 INFO - PROCESS | 1638 | 10:32:32 INFO - PROCESS | 1638 | ------- Summary: start ------- 10:32:32 INFO - PROCESS | 1638 | Number of tests: 6 10:32:32 INFO - PROCESS | 1638 | 10:32:32 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5947.52 Median:6228.53 stddev:653.82 (10.5%) stddev-sans-first:625.58 10:32:32 INFO - PROCESS | 1638 | Values: 3442.0 3458.9 3491.8 3494.9 3495.9 5398.1 5402.8 5956.4 5977.2 6000.5 5806.4 5999.7 6072.4 6082.2 6129.2 4562.3 5174.4 5356.1 5453.3 5499.4 5381.1 5459.4 5525.0 5536.4 5538.6 5463.1 5463.7 5503.2 5508.4 5533.6 5327.2 5338.3 5352.4 5398.8 5430.8 5355.4 5370.7 5389.4 5442.8 5476.2 5791.3 5912.5 6063.9 6080.2 6085.2 6283.0 6291.6 6341.7 6346.4 6388.6 6358.0 6450.5 6459.8 6461.0 6469.7 6164.0 6168.4 6172.4 6188.8 6210.3 6271.4 6338.2 6465.5 6488.7 6530.8 6329.8 6337.6 6354.2 6373.7 6398.4 6437.7 6454.5 6459.4 6461.6 6479.8 6173.6 6232.2 6275.1 6354.3 6374.3 6308.1 6335.4 6352.4 6352.9 6356.4 5144.8 5149.4 5162.5 5175.8 5203.1 4500.1 4563.2 4644.0 4663.8 4668.4 5995.7 6054.4 6088.8 6102.7 6119.0 6394.9 6466.1 6466.9 6477.0 6485.3 5990.7 6014.4 6120.2 6136.4 6140.5 5527.9 5578.4 5581.4 5626.0 5637.3 6494.3 6575.8 6576.9 6582.3 6590.2 6403.3 6412.6 6414.0 6428.8 6433.2 6309.1 6353.6 6518.6 6572.9 6594.3 6268.5 6274.9 6305.0 6346.7 6382.6 6366.3 6402.8 6405.6 6412.8 6419.2 6180.8 6245.3 6265.2 6321.1 6349.8 6228.5 6269.2 6289.6 6301.6 6360.8 6179.3 6240.8 6314.6 6319.3 6324.4 5253.9 6193.8 6224.7 6235.8 6240.2 6074.1 6278.6 6292.2 6295.0 6307.9 10:32:32 INFO - PROCESS | 1638 | 10:32:32 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:50337.28 Median:169002.35 stddev:102025.34 (60.4%) stddev-sans-first:102243.58 10:32:32 INFO - PROCESS | 1638 | Values: 735.3 758.6 796.8 924.2 925.0 36138.6 36906.3 38414.4 38417.4 38460.4 37093.6 37288.8 37313.4 37333.4 37401.1 7533.9 7702.5 10115.9 10427.9 10490.1 10038.2 10114.2 10120.7 10150.0 10151.6 10107.8 10132.7 10166.3 10177.1 10183.3 10104.8 10124.4 10133.3 10133.7 10138.1 10055.8 10119.1 10173.8 10174.8 10183.8 32337.2 32403.7 32427.2 32596.0 32697.7 3089.0 3108.7 3116.8 3135.5 3230.4 24932.6 25492.7 25505.5 25506.6 25652.2 2974.3 2981.6 3055.2 3099.6 3118.5 307216.5 308016.0 308617.0 309797.0 310303.4 32495.5 33887.7 42001.4 42007.0 42007.9 43369.0 43417.3 43521.0 43555.0 43580.3 12645.6 12736.8 12741.6 12775.1 12785.9 10761.7 10782.1 10784.4 10796.6 10800.0 9191.0 10855.5 11508.6 11571.6 11657.9 5538.4 5600.2 5621.5 5680.9 5691.5 945.3 1121.4 1140.5 1165.7 1206.8 23119.8 25099.4 25350.6 25547.9 25558.4 1090.7 1236.3 1259.9 1269.2 1317.9 12818.2 13017.5 13038.4 13051.8 13095.4 409600.0 412118.0 412576.0 412901.9 413924.7 51476.7 51955.1 52039.5 52098.5 52195.2 1351.9 1354.0 1389.9 1390.5 1398.0 18062.7 24709.0 25091.1 25850.6 25900.4 36990.6 37168.8 37202.1 37301.6 37477.0 420789.0 421150.0 422755.0 422788.0 423145.0 21103.5 21191.4 21196.6 21203.6 21206.9 35673.5 35872.0 37697.1 37739.8 37946.8 29577.7 30788.2 30942.4 31999.5 33311.8 31050.7 31258.8 31508.4 31976.5 33354.0 31565.0 32030.4 32151.8 32215.5 32311.4 26835.6 27155.6 28807.8 28902.8 28981.3 17772.8 20047.3 22143.9 22324.3 22622.3 10:32:32 INFO - PROCESS | 1638 | 10:32:32 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:40338.64 Median:29761.76 stddev:115309.17 (387.4%) stddev-sans-first:115593.61 10:32:32 INFO - PROCESS | 1638 | Values: 381.5 386.6 398.4 409.8 414.5 12800.8 14292.1 19852.9 21192.1 21205.0 20470.0 20717.6 21003.7 21049.8 21333.7 5881.3 6380.1 6402.5 6406.2 6590.1 6433.3 6576.4 6591.0 6592.3 6887.6 7238.9 7318.2 7326.5 7328.7 7341.0 6068.8 6992.6 7134.6 7251.9 7299.1 6082.3 6938.6 6971.0 6994.9 7040.2 24364.6 24421.3 24435.1 24735.9 24748.5 2465.9 2691.8 2818.6 2861.1 2862.1 11983.7 15136.6 15303.9 15818.5 15885.5 1914.0 1932.2 1974.9 1980.8 1989.5 140183.0 146539.5 150944.2 157515.6 163798.0 16681.0 18947.6 19064.9 19177.1 19287.8 29532.3 29991.3 29999.6 30003.0 30158.9 9457.5 9486.8 9703.5 9768.3 9791.7 7999.0 8026.2 8026.3 8167.5 8186.2 8943.6 9023.5 9083.8 9114.0 9130.6 3817.8 3867.3 3868.7 3891.4 3895.3 851.9 961.9 977.3 1016.2 1032.3 16068.4 17256.7 19876.7 20090.3 20518.9 828.6 848.2 877.8 913.7 919.8 5597.7 6524.2 6534.2 6697.2 6768.7 675786.0 678089.0 688138.0 693369.0 694347.0 154702.5 159508.2 160440.9 161735.0 162248.0 990.9 1009.5 1040.3 1043.6 1046.9 10076.3 10156.2 11535.2 11827.9 11961.9 60596.4 61171.4 61186.1 62059.1 63738.0 81752.0 81922.0 82006.6 84596.6 84982.2 8144.8 9845.9 10356.7 10414.3 10982.1 11423.7 12081.2 12255.9 12583.9 12615.7 5942.6 10590.0 10660.0 10704.5 10742.7 8927.2 9357.7 9557.9 10573.3 10760.1 10093.9 10729.2 10741.2 10888.4 11042.2 10764.8 10969.6 10987.2 11023.9 11076.6 10740.5 10820.0 10849.8 11054.5 11054.9 10:32:32 INFO - PROCESS | 1638 | 10:32:32 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:6503.21 Median:2822.34 stddev:4050.56 (143.5%) stddev-sans-first:4043.37 10:32:32 INFO - PROCESS | 1638 | Values: 1344.2 1359.8 1374.7 1565.3 1605.0 9429.8 10189.1 10691.5 11007.1 11169.8 10965.5 11052.7 11164.8 11166.9 11249.8 2318.3 2345.4 2350.6 2354.8 2362.1 1970.5 2306.8 2345.5 2350.9 2360.7 2289.9 2300.1 2308.4 2318.6 2324.7 1919.3 2251.8 2320.6 2322.0 2327.8 2260.5 2327.0 2329.1 2334.7 2343.7 10848.8 10866.2 10934.6 10945.6 10965.1 5243.2 5358.9 5409.9 5418.1 5422.2 3282.6 3381.3 3561.7 3583.2 3591.2 1133.5 1176.9 1179.5 1210.3 1226.5 13632.2 14090.9 14716.8 14753.3 14819.6 4537.4 4673.1 4687.6 4716.0 4720.9 11227.0 11472.4 11497.5 11499.0 11503.1 5372.8 5587.3 5625.5 5627.9 5646.0 5242.8 5243.2 5246.6 5249.3 5255.4 3657.9 3859.6 3875.7 3883.6 3903.6 1031.2 1036.3 1037.5 1044.9 1047.9 769.2 805.5 904.9 906.7 936.4 6248.5 6282.7 6426.3 6557.7 6635.1 930.2 989.8 1002.0 1015.6 1035.8 3395.0 3555.7 3877.5 4081.2 4111.6 9805.8 11942.0 12183.8 13055.6 13275.9 12840.7 12939.4 12983.5 13001.5 13014.8 8459.0 9798.9 9874.6 10106.3 10117.0 5593.4 6033.9 6061.2 6149.8 6231.0 9644.7 11719.4 12107.0 12133.1 12153.4 12071.8 12086.4 12288.9 12331.6 12333.6 8773.7 9093.3 9157.0 9228.1 9236.4 9957.1 10077.4 10104.6 10173.2 10224.0 8272.3 8914.4 8918.2 8928.3 9034.4 8699.6 8925.5 9008.5 9023.1 9043.8 7385.5 7600.2 7699.2 7742.0 7788.4 4710.0 5501.2 5658.2 5688.5 5793.9 5609.2 5729.4 5764.3 5861.4 6007.7 10:32:32 INFO - PROCESS | 1638 | 10:32:32 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4783.62 Median:5117.35 stddev:1360.62 (26.6%) stddev-sans-first:1323.04 10:32:32 INFO - PROCESS | 1638 | Values: 345.8 370.2 370.5 371.7 381.8 5076.6 5156.9 5299.5 5415.3 5566.6 4313.8 5350.8 5445.8 5446.7 5466.2 4380.7 4538.8 4562.7 4606.2 4617.6 4588.2 4598.2 4604.8 4607.5 4639.7 3786.7 4580.1 4603.7 4610.5 4620.8 3806.3 3832.3 4296.6 4430.4 4500.6 3254.3 3953.7 4180.9 4182.5 4208.6 4461.8 5342.1 5358.8 5364.4 5367.7 4434.6 4973.7 5217.2 5289.4 5294.5 4871.9 5042.5 5571.4 5870.9 5948.8 4317.2 4697.9 4705.2 4711.8 4740.2 5450.5 5791.8 5888.0 6153.2 6208.5 4046.3 4768.8 4796.5 4809.9 4812.0 4364.3 4886.2 4893.9 4902.2 4959.7 4386.7 5034.3 5197.9 5247.0 5303.2 4757.3 5161.8 5374.4 5824.5 5920.9 1342.0 1426.8 1591.9 1603.9 1604.5 1109.7 1190.5 1195.8 1200.7 1211.6 4807.4 4875.7 5058.5 5178.5 5194.8 5346.8 5796.5 5801.9 5847.7 5851.5 4508.8 4540.9 4939.1 5172.1 5172.9 2491.2 2631.7 2673.8 2868.9 3022.3 5477.5 5799.6 5877.6 6023.6 6054.4 4685.7 4803.6 5252.2 5801.0 5959.9 5087.9 5562.9 5676.3 6068.5 6270.6 5146.8 6012.2 6028.6 6034.5 6051.0 5423.9 5581.7 6007.0 6011.5 6039.9 5252.6 6204.0 6217.9 6219.0 6306.9 3971.4 4250.1 4250.9 4579.8 4668.0 4790.7 5959.8 5972.8 6113.3 6181.7 5401.8 5462.3 5831.2 5855.2 5871.3 4960.0 4961.4 5022.7 5831.6 5894.7 5064.6 5505.3 5768.3 5779.2 5783.3 5739.2 5821.4 5864.2 5941.4 5966.0 4693.0 4811.7 5373.6 5684.6 5736.5 10:32:32 INFO - PROCESS | 1638 | 10:32:32 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:18586.20 Median:20030.62 stddev:25820.26 (128.9%) stddev-sans-first:25857.87 10:32:32 INFO - PROCESS | 1638 | Values: 727.2 771.9 808.0 818.7 821.4 14856.8 15661.8 15735.7 15744.6 15762.9 13388.4 14653.9 14784.6 14809.9 14813.9 893.3 927.1 942.5 948.5 953.4 818.8 834.2 947.8 948.1 983.4 937.3 1003.5 1012.1 1012.3 1012.3 1001.2 1007.4 1007.6 1009.3 1010.0 744.9 746.4 746.8 748.8 748.9 13606.8 14067.5 15679.9 15807.8 16173.1 13562.1 13633.5 13800.5 13985.2 14055.9 9946.8 10727.4 11400.8 11551.5 12158.3 3580.4 3606.4 3698.6 3726.5 3736.8 92983.6 95751.0 96576.6 97001.0 98523.5 10153.1 10390.5 10473.5 10520.1 10676.1 21527.2 21596.4 21786.5 21859.8 21911.1 7316.7 7316.8 7371.7 7534.0 7539.5 4039.2 4088.7 4134.7 4145.6 4152.3 3371.8 3451.7 3461.8 3523.4 3707.6 657.2 658.1 662.0 675.2 677.7 600.5 622.7 627.9 665.2 688.1 9566.8 9957.7 10004.3 10077.7 10324.3 620.7 667.4 692.6 695.1 701.6 4471.6 4630.1 4908.1 4939.7 5018.8 96791.0 98088.5 99519.0 99569.0 100979.5 55643.0 58972.4 65174.7 78486.2 83065.0 59207.1 59610.9 67735.0 68199.0 69558.3 10383.0 10488.2 10515.6 10523.3 10606.6 36454.8 45414.2 45847.5 47152.5 47552.0 37779.6 60307.3 60647.0 61031.0 61864.0 12000.6 12018.0 12019.6 12188.7 12521.0 13876.5 13979.4 14021.0 14240.6 14414.6 11495.7 12243.7 12744.1 13060.0 13549.2 12445.8 13156.8 13214.5 13406.7 13585.5 12470.6 12639.4 13019.0 13070.5 13505.2 10563.5 10895.9 10924.2 11154.1 11324.4 8995.7 9352.3 11170.8 11317.2 11457.5 10:32:32 INFO - PROCESS | 1638 | -------- Summary: end -------- 10:32:32 INFO - PROCESS | 1638 | 10:32:33 INFO - TEST-INFO | 1638: exit 0 10:32:33 INFO - TEST-OK | dromaeo_css | took 1118375ms 10:32:33 INFO - TEST-START | kraken 10:32:33 INFO - operating with platform_type : mac_ 10:32:33 INFO - Initialising browser for kraken test... 10:32:33 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpm5HOJo/profile http://localhost:49236/getInfo.html) 10:32:35 INFO - PROCESS | 1653 | 2017-03-02 10:32:35.985 plugin-container[1654:10065] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3b, name = 'com.apple.tsm.portname' 10:32:35 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:35 INFO - PROCESS | 1653 | 2017-03-02 10:32:35.988 plugin-container[1654:10065] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 10:32:35 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:35 INFO - PROCESS | 1653 | 2017-03-02 10:32:35.988 plugin-container[1654:10065] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:32:36 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 10:32:36 INFO - PROCESS | 1653 | colorDepth:24 10:32:36 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 10:32:36 INFO - PROCESS | 1653 | __metrics 10:32:36 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3354: TypeError: this.tabs is undefined 10:32:37 INFO - TEST-INFO | 1653: exit 0 10:32:37 INFO - Browser initialized. 10:32:37 INFO - Running cycle 1/1 for kraken test... 10:32:37 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpm5HOJo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:39 INFO - PROCESS | 1655 | 2017-03-02 10:32:39.424 plugin-container[1656:10198] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473b, name = 'com.apple.tsm.portname' 10:32:39 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:39 INFO - PROCESS | 1655 | 2017-03-02 10:32:39.425 plugin-container[1656:10198] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 10:32:39 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:39 INFO - PROCESS | 1655 | 2017-03-02 10:32:39.425 plugin-container[1656:10198] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:32:49 INFO - PROCESS | 1655 | RSS: Main: 226775040 10:32:49 INFO - PROCESS | 1655 | 10:32:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 10:32:53 INFO - PROCESS | 1655 | RSS: Main: 241340416 10:32:53 INFO - PROCESS | 1655 | 10:32:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 10:32:56 INFO - PROCESS | 1655 | RSS: Main: 249413632 10:32:56 INFO - PROCESS | 1655 | 10:33:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 10:33:00 INFO - PROCESS | 1655 | RSS: Main: 252108800 10:33:00 INFO - PROCESS | 1655 | 10:33:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 10:33:03 INFO - PROCESS | 1655 | RSS: Main: 253517824 10:33:03 INFO - PROCESS | 1655 | 10:33:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:06 INFO - PROCESS | 1655 | RSS: Main: 254926848 10:33:06 INFO - PROCESS | 1655 | 10:33:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:10 INFO - PROCESS | 1655 | RSS: Main: 260907008 10:33:10 INFO - PROCESS | 1655 | 10:33:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:13 INFO - PROCESS | 1655 | RSS: Main: 260075520 10:33:13 INFO - PROCESS | 1655 | 10:33:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 10:33:18 INFO - PROCESS | 1655 | RSS: Main: 257159168 10:33:18 INFO - PROCESS | 1655 | 10:33:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:33:20 INFO - PROCESS | 1655 | RSS: Main: 258428928 10:33:20 INFO - PROCESS | 1655 | 10:33:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:33:23 INFO - PROCESS | 1655 | RSS: Main: 258809856 10:33:23 INFO - PROCESS | 1655 | 10:33:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:33:26 INFO - PROCESS | 1655 | RSS: Main: 258887680 10:33:26 INFO - PROCESS | 1655 | 10:33:29 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:33:30 INFO - PROCESS | 1655 | RSS: Main: 259227648 10:33:30 INFO - PROCESS | 1655 | 10:33:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:33 INFO - PROCESS | 1655 | RSS: Main: 259022848 10:33:33 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 10:33:35 INFO - PROCESS | 1655 | RSS: Main: 262377472 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | __start_tp_report 10:33:35 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 10:33:35 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 10:33:35 INFO - PROCESS | 1655 | |i|pagename|runs| 10:33:35 INFO - PROCESS | 1655 | |0;ai-astar;106;122;120;108;161;105;168;182;161;119 10:33:35 INFO - PROCESS | 1655 | |1;audio-beat-detection;147;121;145;164;121;97;126;98;157;143 10:33:35 INFO - PROCESS | 1655 | |2;audio-dft;220;205;216;203;202;199;196;195;196;199 10:33:35 INFO - PROCESS | 1655 | |3;audio-fft;82;59;61;90;63;61;68;52;96;85 10:33:35 INFO - PROCESS | 1655 | |4;audio-oscillator;90;89;117;104;104;101;86;73;71;86 10:33:35 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;83;109;104;107;93;91;92;91;99;93 10:33:35 INFO - PROCESS | 1655 | |6;imaging-darkroom;99;99;98;98;98;99;107;154;99;99 10:33:35 INFO - PROCESS | 1655 | |7;imaging-desaturate;116;131;96;84;116;143;129;89;89;118 10:33:35 INFO - PROCESS | 1655 | |8;json-parse-financial;68;65;67;69;66;74;67;60;66;78 10:33:35 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;60;65;62;90;59;102;87;89;84;60 10:33:35 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;88;87;96;87;90;91;95;89;94;93 10:33:35 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;144;144;147;146;142;144;164;186;195;165 10:33:35 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;175;179;176;177;178;199;177;174;176;172 10:33:35 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;69;70;69;67;71;88;87;85;71;71 10:33:35 INFO - PROCESS | 1655 | __end_tp_report 10:33:35 INFO - PROCESS | 1655 | __start_cc_report 10:33:35 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1015 10:33:35 INFO - PROCESS | 1655 | __end_cc_report 10:33:35 INFO - PROCESS | 1655 | __startTimestamp1488479615669__endTimestamp 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | ------- Summary: start ------- 10:33:35 INFO - PROCESS | 1655 | Number of tests: 14 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:135.20 Median:141.50 stddev:29.38 (20.8%) stddev-sans-first:29.20 10:33:35 INFO - PROCESS | 1655 | Values: 106.0 122.0 120.0 108.0 161.0 105.0 168.0 182.0 161.0 119.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:152.00 stddev:23.15 (15.2%) stddev-sans-first:23.90 10:33:35 INFO - PROCESS | 1655 | Values: 147.0 121.0 145.0 164.0 121.0 97.0 126.0 98.0 157.0 143.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:203.10 Median:202.50 stddev:8.54 (4.2%) stddev-sans-first:6.51 10:33:35 INFO - PROCESS | 1655 | Values: 220.0 205.0 216.0 203.0 202.0 199.0 196.0 195.0 196.0 199.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:71.70 Median:75.00 stddev:15.19 (20.3%) stddev-sans-first:15.65 10:33:35 INFO - PROCESS | 1655 | Values: 82.0 59.0 61.0 90.0 63.0 61.0 68.0 52.0 96.0 85.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:79.50 stddev:14.46 (18.2%) stddev-sans-first:15.31 10:33:35 INFO - PROCESS | 1655 | Values: 90.0 89.0 117.0 104.0 104.0 101.0 86.0 73.0 71.0 86.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:91.50 stddev:8.27 (9.0%) stddev-sans-first:7.26 10:33:35 INFO - PROCESS | 1655 | Values: 83.0 109.0 104.0 107.0 93.0 91.0 92.0 91.0 99.0 93.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:105.00 Median:99.00 stddev:17.42 (17.6%) stddev-sans-first:18.34 10:33:35 INFO - PROCESS | 1655 | Values: 99.0 99.0 98.0 98.0 98.0 99.0 107.0 154.0 99.0 99.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:111.10 Median:113.50 stddev:20.46 (18.0%) stddev-sans-first:21.63 10:33:35 INFO - PROCESS | 1655 | Values: 116.0 131.0 96.0 84.0 116.0 143.0 129.0 89.0 89.0 118.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:67.50 stddev:4.94 (7.3%) stddev-sans-first:5.24 10:33:35 INFO - PROCESS | 1655 | Values: 68.0 65.0 67.0 69.0 66.0 74.0 67.0 60.0 66.0 78.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:75.80 Median:74.50 stddev:16.14 (21.7%) stddev-sans-first:16.07 10:33:35 INFO - PROCESS | 1655 | Values: 60.0 65.0 62.0 90.0 59.0 102.0 87.0 89.0 84.0 60.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:92.00 stddev:3.33 (3.6%) stddev-sans-first:3.35 10:33:35 INFO - PROCESS | 1655 | Values: 88.0 87.0 96.0 87.0 90.0 91.0 95.0 89.0 94.0 93.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:157.70 Median:155.50 stddev:19.28 (12.4%) stddev-sans-first:19.80 10:33:35 INFO - PROCESS | 1655 | Values: 144.0 144.0 147.0 146.0 142.0 144.0 164.0 186.0 195.0 165.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:177.00 stddev:7.54 (4.3%) stddev-sans-first:7.91 10:33:35 INFO - PROCESS | 1655 | Values: 175.0 179.0 176.0 177.0 178.0 199.0 177.0 174.0 176.0 172.0 10:33:35 INFO - PROCESS | 1655 | 10:33:35 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:71.00 stddev:8.31 (11.7%) stddev-sans-first:8.55 10:33:35 INFO - PROCESS | 1655 | Values: 69.0 70.0 69.0 67.0 71.0 88.0 87.0 85.0 71.0 71.0 10:33:35 INFO - PROCESS | 1655 | -------- Summary: end -------- 10:33:35 INFO - PROCESS | 1655 | 10:33:36 INFO - TEST-INFO | 1655: exit 0 10:33:36 INFO - TEST-OK | kraken | took 63555ms 10:33:36 INFO - SUITE-END | took 1181s 10:33:36 INFO - Completed test suite (00:19:42) 10:33:36 INFO - javascript benchmark 10:33:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7460.452223446781, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3442.0190245779972, 3458.9135271618206, 3491.807950562719, 3494.8951531454063, 3495.947560786587, 5398.055340315449, 5402.837914862561, 5956.4341387568165, 5977.163197152397, 6000.489958353534, 5806.361300256968, 5999.700014999244, 6072.423119803622, 6082.178905847709, 6129.205975626773, 4562.311944580493, 5174.3790745110455, 5356.0894647909945, 5453.318335208099, 5499.3675727291275, 5381.0852155133525, 5459.3994660587305, 5525.0, 5536.390996990328, 5538.556915446755, 5463.071277882769, 5463.699496527689, 5503.20203570482, 5508.394076651565, 5533.584981126432, 5327.200919862013, 5338.279332290169, 5352.357717073976, 5398.811041613525, 5430.755615997289, 5355.410904800468, 5370.677759334452, 5389.380221274564, 5442.755076021549, 5476.151196564539, 5791.305043394777, 5912.526997840162, 6063.9090413643835, 6080.179175811298, 6085.208922840046, 6282.96858515709, 6291.591046581958, 6341.651209183493, 6346.397092276226, 6388.616682999035, 6358.0, 6450.516211284125, 6459.773907913201, 6461.0, 6469.708863101125, 6164.044573091178, 6168.414000669929, 6172.382761723837, 6188.752449901954, 6210.254769427697, 6271.43557079865, 6338.176037115238, 6465.515086368541, 6488.708008139645, 6530.8040758777315, 6329.841753956096, 6337.588056776295, 6354.205724284465, 6373.71318290678, 6398.392152745481, 6437.742490300336, 6454.548181627335, 6459.418652321314, 6461.64460954652, 6479.8056058318325, 6173.629582225081, 6232.18981532407, 6275.090111933744, 6354.26925903527, 6374.330695277022, 6308.116863639094, 6335.429811317003, 6352.428281454599, 6352.872942541216, 6356.364363563606, 5144.768485418165, 5149.382074151051, 5162.535371816554, 5175.818846340435, 5203.063448579292, 4500.054988452462, 4563.201439748031, 4643.953560464352, 4663.836765713184, 4668.393108895822, 5995.670238136944, 6054.39456054391, 6088.786892458743, 6102.671035646872, 6118.95422233728, 6394.936050639527, 6466.062420948936, 6466.870662586722, 6476.996065609838, 6485.319041500669, 5990.73041713124, 6014.428629280212, 6120.234970628671, 6136.447719705248, 6140.508759299245, 5527.917081243784, 5578.358488773762, 5581.413951535112, 5625.971870140705, 5637.26715526987, 6494.318096599884, 6575.80272591823, 6576.901346479903, 6582.275949645439, 6590.209174899042, 6403.327650596807, 6412.551121421642, 6414.0, 6428.839279018062, 6433.163688720437, 6309.1167236586, 6353.5870168438905, 6518.608883467007, 6572.868542629025, 6594.307597702364, 6268.4671802897265, 6274.937250627435, 6304.968475157778, 6346.650934198663, 6382.6170429774365, 6366.299707032315, 6402.839929001812, 6405.551611387345, 6412.775552855627, 6419.2296924369375, 6180.783672571439, 6245.250569931637, 6265.185525881606, 6321.11504389395, 6349.777757778455, 6228.532860035425, 6269.216347956505, 6289.591176573508, 6301.590396624205, 6360.809175724736, 6179.28938172116, 6240.812775616739, 6314.589551679126, 6319.3364696706185, 6324.430801227912, 5253.868653283698, 6193.81418557444, 6224.688765561795, 6235.844103897439, 6240.188775459162, 6074.119252708421, 6278.591891527219, 6292.244930608356, 6294.968525157345, 6307.905381419374], "value": 5905.882805234505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.283098978496, 758.5562445969109, 796.7928338631956, 924.2005665099691, 924.9722508324744, 36138.63861361385, 36906.261874762524, 38414.423783643266, 38417.423738643905, 38460.42309365362, 37093.629063709355, 37288.81355593225, 37313.440298395544, 37333.439998399976, 37401.064973375614, 7533.886991695129, 7702.46082774206, 10115.949420252888, 10427.895721042807, 10490.108340791043, 10038.196944244442, 10114.241431892637, 10120.696379108602, 10150.03574660406, 10151.644692435766, 10107.797844043114, 10132.696019119438, 10166.339187952797, 10177.08406243438, 10183.28716989811, 10104.797904041914, 10124.443155626437, 10133.341332813343, 10133.746656333577, 10138.087572118508, 10055.849162262572, 10119.139873110795, 10173.796524069478, 10174.847377289347, 10183.847242291371, 32337.191570210696, 32403.6759632403, 32427.189320266945, 32596.0, 32697.673023269937, 3089.0, 3108.6580476147833, 3116.781825272232, 3135.451296023187, 3230.353929214167, 24932.626010609856, 25492.745072549224, 25505.489890202276, 25506.617400739004, 25652.23043308685, 2974.301039255773, 2981.6272965879266, 3055.2139938915484, 3099.5970523831984, 3118.485449900764, 307216.4639176812, 308016.0, 308617.0, 309797.0, 310303.4484827584, 32495.51256731151, 33887.66112338894, 42001.36997945033, 42007.0, 42007.949801255214, 43369.0, 43417.34873976893, 43521.0, 43555.0, 43580.346294805604, 12645.557405490763, 12736.80894786579, 12741.55404560836, 12775.105742598114, 12785.936070319589, 10761.730956726144, 10782.083522900484, 10784.406857622906, 10796.56813727442, 10799.974002469753, 9191.0, 10855.511501982272, 11508.59719909799, 11571.594994175332, 11657.883421165849, 5538.446155384429, 5600.215969764236, 5621.4659607337235, 5680.914786278209, 5691.487766100988, 945.3146468810057, 1121.4448847820217, 1140.5152810055692, 1165.6794381544973, 1206.849143857018, 23119.768802311763, 25099.37251568689, 25350.619740703904, 25547.87226063895, 25558.361040974123, 1090.7000574841982, 1236.3262022197923, 1259.8929091027364, 1269.1940617707637, 1317.8879795217322, 12818.166819156724, 13017.544385946447, 13038.41327140262, 13051.804222936664, 13095.410706518229, 409600.0, 412118.0, 412576.0, 412901.87098128634, 413924.7215055682, 51476.742616286676, 51955.103367246855, 52039.47960520422, 52098.47901521012, 52195.21707174395, 1351.8783309502192, 1353.9593812185453, 1389.9374528146257, 1390.4577214886, 1397.9510717124851, 18062.729059063862, 24709.0, 25091.121810736535, 25850.61224081678, 25900.35249118787, 36990.63009369872, 37168.814155929045, 37202.06994825151, 37301.6269837309, 37477.0, 420789.0, 421150.0, 422755.0, 422788.0, 423145.0, 21103.472413189178, 21191.364259072252, 21196.57606847885, 21203.575928481034, 21206.893965530075, 35673.46489802707, 35872.0, 37697.05757355978, 37739.81130094332, 37946.8102659496, 29577.704222957494, 30788.230294241926, 30942.38115237728, 31999.520007200375, 33311.83344083264, 31050.68949310478, 31258.843705781324, 31508.376536697655, 31976.520352195203, 33354.0, 31565.0, 32030.35939281248, 32151.839240803645, 32215.51676724898, 32311.35377292488, 26835.597466038416, 27155.59266611042, 28807.847686092322, 28902.843886245155, 28981.275468113465, 17772.822271777117, 20047.298344557872, 22143.889280553492, 22324.330270091923, 22622.321330360115], "value": 17178.348140284026, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.4945197613163, 386.59986913544486, 398.42427691985085, 409.75005246799464, 414.5398607545625, 12800.80798788019, 14292.071015383994, 19852.90073549632, 21192.13906122673, 21205.045772940215, 20470.0, 20717.585648287026, 21003.684944725843, 21049.789502104974, 21333.719976801403, 5881.323647780518, 6380.138681278037, 6402.487800975934, 6406.199225096863, 6590.143281373439, 6433.292337842833, 6576.408123268905, 6591.0, 6592.307807680197, 6887.621180835052, 7238.927610723878, 7318.231585683507, 7326.523775954573, 7328.706851725925, 7341.045664063691, 6068.848278793022, 6992.580445173306, 7134.643267836587, 7251.927480725178, 7299.087614048244, 6082.327359975998, 6938.618375989318, 6970.965145174292, 6994.930050699479, 7040.225575186725, 24364.634530482057, 24421.267361979168, 24435.144769933144, 24735.87632061828, 24748.5050298993, 2465.8767061646845, 2691.8250313729545, 2818.591304260871, 2861.1130549529503, 2862.141357592714, 11983.700407489883, 15136.621584460367, 15303.928724989255, 15818.525444236691, 15885.523434296989, 1913.9617207655908, 1932.2271091563346, 1974.9111289991986, 1980.8019198080076, 1989.4926793667667, 140183.0, 146539.53460465366, 150944.245278774, 157515.63726544226, 163798.0, 16681.0, 18947.621047579247, 19064.904675476533, 19177.137028833735, 19287.807121928883, 29532.261693457836, 29991.250218744706, 29999.550006749916, 30003.0, 30158.944436944603, 9457.479838608804, 9486.810263794685, 9703.514824258758, 9768.267379946532, 9791.657291994889, 7999.040115186099, 8026.237507436784, 8026.317762990211, 8167.509949403055, 8186.222308880647, 8943.642254309885, 9023.548822558978, 9083.772905677411, 9113.954430227806, 9130.634774609074, 3817.828197731109, 3867.3425517662067, 3868.7485313454536, 3891.377379619247, 3895.2988462076532, 851.9148085191555, 961.9038096190465, 977.2719324103447, 1016.2378216337746, 1032.2877214721818, 16068.43760468378, 17256.65486690284, 19876.70184947227, 20090.296839610837, 20518.89740551288, 828.5981299069946, 848.2281124176969, 877.8156587116777, 913.6710784117712, 919.8298314811781, 5597.74810133545, 6524.184476940382, 6534.248561415403, 6697.196336439659, 6768.661566921634, 675786.0, 678089.0, 688138.0, 693369.0, 694347.0, 154702.4529754688, 159508.20245898695, 160440.9319880382, 161735.0, 162248.0, 990.8810942686923, 1009.4649835587151, 1040.3393844908387, 1043.5773511727762, 1046.9110125639406, 10076.345037572535, 10156.238282128723, 11535.192536522698, 11827.881721183023, 11961.940190298992, 60596.39403606084, 61171.38828611657, 61186.08220876601, 62059.1382258533, 63738.0, 81751.95620109545, 81922.0, 82006.58996704979, 84596.57701711453, 84982.15017849742, 8144.75565733029, 9845.89854195926, 10356.689299321033, 10414.323069000491, 10982.06652434552, 11423.657290281304, 12081.154319197924, 12255.938720306342, 12583.93708031454, 12615.747685046432, 5942.58401911862, 10590.0, 10660.0, 10704.518296676513, 10742.677719668422, 8927.24118449939, 9357.689923410591, 9557.904420955701, 10573.2598718089, 10760.139188865029, 10093.899061009295, 10729.248952573245, 10741.248112632353, 10888.40113793749, 11042.227044106836, 10764.784704306026, 10969.57395538575, 10987.230893837355, 11023.944880275547, 11076.556937722724, 10740.516676749408, 10820.0, 10849.837252441377, 11054.502547385548, 11054.949779770908], "value": 10646.182167922703, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.159900062461, 1359.7688392973193, 1374.6975665353623, 1565.3425561264262, 1604.9759253611194, 9429.81140377192, 10189.08298253157, 10691.518881650325, 11007.119430445566, 11169.776604467916, 10965.50655220515, 11052.723681907957, 11164.832527512093, 11166.944165279163, 11249.775004499925, 2318.3045086474076, 2345.3901985483726, 2350.5533948549805, 2354.82338824588, 2362.11420717231, 1970.4975231316066, 2306.7808558186944, 2345.495718420539, 2350.9059637614473, 2360.7403185649564, 2289.9313020609407, 2300.148944890393, 2308.3882771065682, 2318.6174281243575, 2324.651302304651, 1919.3282351177115, 2251.79733823955, 2320.5590937721777, 2321.9883900580558, 2327.7788610082016, 2260.457490202356, 2326.9767302326927, 2329.114936324186, 2334.7315058768118, 2343.730470995823, 10848.78302433947, 10866.239363244576, 10934.617288394948, 10945.56217751289, 10965.122790176847, 5243.161094224905, 5358.91961620576, 5409.9459005409835, 5418.0789265824515, 5422.15956526739, 3282.556854824616, 3381.2561236527927, 3561.71506279497, 3583.229605634775, 3591.1560783215923, 1133.5465813674514, 1176.923499972499, 1179.5222934711455, 1210.334316126127, 1226.533917111492, 13632.182069075887, 14090.872730181562, 14716.779248311284, 14753.33609987553, 14819.555413337617, 4537.410136682211, 4673.135469938073, 4687.648426368036, 4715.976420117878, 4720.858374248778, 11227.045701115334, 11472.426378681033, 11497.482613282255, 11499.0, 11503.07975361969, 5372.764721289601, 5587.273654424899, 5625.54995600351, 5627.887442251132, 5646.0, 5242.790288388498, 5243.213517972258, 5246.580273578104, 5249.317588713443, 5255.369355677267, 3657.8719744808805, 3859.5947425520476, 3875.6705680017512, 3883.5533913600298, 3903.6291552302487, 1031.1544533482472, 1036.2797855490512, 1037.4708898461688, 1044.8798388185303, 1047.9318844275099, 769.2499812682589, 805.5247404031533, 904.9185573298435, 906.723449347942, 936.4334577580465, 6248.4688801452385, 6282.748690052438, 6426.260979987268, 6557.737690492327, 6635.10426092481, 930.2325581395295, 989.811935732223, 1002.0, 1015.5984741057441, 1035.8342665173536, 3394.9660503395144, 3555.6977656898935, 3877.495925529663, 4081.2041651878194, 4111.60939710727, 9805.80388392228, 11942.0, 12183.817242741366, 13055.608331749872, 13275.867241327656, 12840.678983025498, 12939.353032348345, 12983.480660773652, 13001.479940802263, 13014.804777928339, 8459.0, 9798.902010979942, 9874.555644995993, 10106.29255952091, 10117.038881306264, 5593.412691667317, 6033.939660603513, 6061.242344706911, 6149.84625384369, 6231.0, 9644.662436814679, 11719.355435451133, 12107.031437485157, 12133.09001824849, 12153.392330383622, 12071.795940027761, 12086.395680215777, 12288.877111228774, 12331.630051098482, 12333.568325108577, 8773.692920747742, 9093.272538196796, 9157.0, 9228.077192280987, 9236.445813251226, 9957.103860652576, 10077.395356278354, 10104.595816167564, 10173.186145108226, 10224.0, 8272.33821294283, 8914.37599368038, 8918.152775486318, 8928.330375221754, 9034.3675942686, 8699.564571845574, 8925.464472131693, 9008.549572521479, 9023.142801433853, 9043.773905652411, 7385.519941204019, 7600.201978792368, 7699.191584883507, 7741.961290193513, 7788.415868809749, 4710.0, 5501.229827824188, 5658.179563963285, 5688.544916406595, 5793.94206057934, 5609.242752228397, 5729.427057294404, 5764.337101233412, 5861.3845546217035, 6007.669578173242], "value": 4961.95889099218, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.844370033485, 370.22437992405906, 370.4517314374727, 371.69335298378843, 381.77475289579144, 5076.5684916782075, 5156.948430515694, 5299.489645451047, 5415.296011518497, 5566.582506312027, 4313.7843107844565, 5350.785968561263, 5445.809396671118, 5446.700431476267, 5466.180072989054, 4380.71525350852, 4538.7503687297185, 4562.703424277412, 4606.239970404879, 4617.5613316735025, 4588.22000259955, 4598.241290187115, 4604.769761511911, 4607.539246075383, 4639.747268237574, 3786.6522755891388, 4580.129775342674, 4603.700759450642, 4610.469795973456, 4620.768961551926, 3806.2768074066116, 3832.2910261601555, 4296.63478604319, 4430.430350396762, 4500.559820857327, 3254.30032543002, 3953.7348048624453, 4180.895477613054, 4182.498100227992, 4208.642265407444, 4461.776911154429, 5342.0651386007685, 5358.758855851496, 5364.436734142937, 5367.725687330725, 4434.556544345572, 4973.701577905337, 5217.165253559412, 5289.41317604717, 5294.52349288562, 4871.902561948777, 5042.470540593222, 5571.415001424833, 5870.941290587082, 5948.821535353946, 4317.179735850178, 4697.906041879143, 4705.247160454311, 4711.835085772016, 4740.217864052427, 5450.454954504517, 5791.768329266824, 5888.0, 6153.2000839890525, 6208.534359922979, 4046.291898917678, 4768.809247630125, 4796.544328288807, 4809.927851082237, 4812.037592481448, 4364.3017117261725, 4886.214857531244, 4893.853184404474, 4902.240152776254, 4959.652824302337, 4386.7367957922625, 5034.320366750442, 5197.896042079137, 5246.976839516334, 5303.178007408857, 4757.26262429324, 5161.793528258902, 5374.355077390738, 5824.51474873913, 5920.851978700567, 1342.0203251626367, 1426.785982102693, 1591.880608954333, 1603.8957467764558, 1604.5078077387907, 1109.6560066379448, 1190.4761904761876, 1195.838561794164, 1200.6758175292623, 1211.582448535216, 4807.375041244686, 4875.6840500761855, 5058.494150584912, 5178.508041736029, 5194.831152996669, 5346.7861285548925, 5796.536277097822, 5801.882312955825, 5847.736851841677, 5851.473367396955, 4508.752018638941, 4540.932880773015, 4939.110960027229, 5172.120739474299, 5172.870678232999, 2491.2152671908293, 2631.6973098316457, 2673.812833101664, 2868.913932582026, 3022.2897619059504, 5477.534409575231, 5799.623024503394, 5877.617954832922, 6023.578349515492, 6054.3966094579755, 4685.742284174335, 4803.613452515968, 5252.185911183773, 5801.042827933344, 5959.897418977503, 5087.923681144785, 5562.860928476821, 5676.290463692038, 6068.453839154409, 6270.592411493239, 5146.76839542214, 6012.158297838394, 6028.608140470856, 6034.517238620812, 6050.969745151246, 5423.945760542502, 5581.720913954205, 6007.038873780349, 6011.489023433057, 6039.879202415839, 5252.579793616425, 6204.0, 6217.854840080166, 6219.0, 6306.873862522815, 3971.4042893566198, 4250.086231460251, 4250.851220207278, 4579.780270107438, 4667.996380778149, 4790.688380457616, 5959.798342168674, 5972.820815375546, 6113.266408031065, 6181.690915454299, 5401.810936617357, 5462.317210348707, 5831.241938547962, 5855.214159681338, 5871.324797648325, 4959.975200123977, 4961.3798275215595, 5022.673526220784, 5831.620944638755, 5894.734736936763, 5064.5819170632285, 5505.311836020497, 5768.2501274834, 5779.248697669276, 5783.277090363705, 5739.20340456134, 5821.417858214145, 5864.237649105589, 5941.435563621449, 5965.970170149121, 4692.967547139624, 4811.663183577116, 5373.5609210104785, 5684.635687435069, 5736.483716465538], "value": 4378.02622578249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.2218725963219, 771.8687823070078, 807.9515229086259, 818.7257268814947, 821.4373154389242, 14856.777148342784, 15661.765073523906, 15735.685286294267, 15744.60638484037, 15762.92118539407, 13388.397522111503, 14653.853461465382, 14784.556463306119, 14809.92595037026, 14813.888958328114, 893.3255392178896, 927.0775578299601, 942.5334459442586, 948.4546385828141, 953.3898305084751, 818.7625588579334, 834.2200042959821, 947.8199142162968, 948.127722495306, 983.4394395194706, 937.2876613773514, 1003.5183112106193, 1012.084063922148, 1012.2559918459926, 1012.266107072374, 1001.2240513601944, 1007.3653598233067, 1007.5516395204137, 1009.2531526670284, 1009.9546968887166, 744.8659241336558, 746.3544034410196, 746.8431629357841, 748.805310619243, 748.9063867016623, 13606.843418309456, 14067.507637232648, 15679.921600391925, 15807.762883556756, 16173.110478923654, 13562.118462299919, 13633.454661813515, 13800.516981905585, 13985.230812305319, 14055.929720351332, 9946.806383233987, 10727.40413651081, 11400.771984560346, 11551.480183391683, 12158.270503769714, 3580.445031020196, 3606.4229723244157, 3698.556173259226, 3726.5341832270965, 3736.831842567091, 92983.56040818946, 95751.0, 96576.64643572626, 97001.0, 98523.50738246334, 10153.13698335635, 10390.48047597617, 10473.528691208914, 10520.10579100785, 10676.092532134855, 21527.246546370803, 21596.352109436742, 21786.455338616346, 21859.781402186094, 21911.12355505762, 7316.707331706672, 7316.817079573053, 7371.6682749276415, 7534.0, 7539.472236943471, 4039.171969746195, 4088.6933479988525, 4134.669226461876, 4145.585441455831, 4152.294110001307, 3371.831408429569, 3451.6720911513366, 3461.7749846259912, 3523.365794157025, 3707.5550933887566, 657.1850904877917, 658.1312667279145, 661.9602823830586, 675.2302375292171, 677.6747161362573, 600.495583709686, 622.700816055372, 627.9497640188774, 665.2316574356626, 688.1432616392623, 9566.786101574658, 9957.651482198089, 10004.349717268355, 10077.748056298651, 10324.277300589038, 620.7423919073534, 667.4293479075418, 692.5706062241443, 695.0623875343489, 701.6073094906607, 4471.5995028228335, 4630.120277147331, 4908.092002979461, 4939.6542242042715, 5018.774155163026, 96791.0, 98088.50955745176, 99519.0, 99569.0, 100979.49510252548, 55643.0, 58972.41027589669, 65174.67412662906, 78486.21513784904, 83065.0, 59207.111893321635, 59610.91361802316, 67734.9839752414, 68199.0, 69558.26104347431, 10383.0, 10488.213383996383, 10515.57937682484, 10523.315984460985, 10606.628767993083, 36454.8177259112, 45414.18343266232, 45847.541524584325, 47152.52847471481, 47552.0, 37779.62220377871, 60307.26646354841, 60647.02559205571, 61031.0, 61864.0, 12000.57997970067, 12018.0, 12019.579314723942, 12188.695282618006, 12521.0, 13876.514321998682, 13979.370928308048, 14021.0, 14240.643983900485, 14414.639634009234, 11495.711972492412, 12243.653198148375, 12744.10791244641, 13060.0, 13549.187048777105, 12445.75108497843, 13156.80264796048, 13214.537491187762, 13406.664833379244, 13585.45658173662, 12470.625881223577, 12639.431225594686, 13019.0, 13070.54253101137, 13505.189688618715, 10563.471826408802, 10895.891041089488, 10924.235303528676, 11154.107671386431, 11324.37715925632, 8995.730128096167, 9352.29857760657, 11170.776584468103, 11317.20779545457, 11457.484413201259], "value": 7347.898194463784, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 122.0, 120.0, 108.0, 161.0, 105.0, 168.0, 182.0, 161.0, 119.0], "value": 135.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 145.0, 164.0, 121.0, 97.0, 126.0, 98.0, 157.0, 143.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 205.0, 216.0, 203.0, 202.0, 199.0, 196.0, 195.0, 196.0, 199.0], "value": 203.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 61.0, 90.0, 63.0, 61.0, 68.0, 52.0, 96.0, 85.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 117.0, 104.0, 104.0, 101.0, 86.0, 73.0, 71.0, 86.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 109.0, 104.0, 107.0, 93.0, 91.0, 92.0, 91.0, 99.0, 93.0], "value": 96.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 98.0, 98.0, 98.0, 99.0, 107.0, 154.0, 99.0, 99.0], "value": 105.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 131.0, 96.0, 84.0, 116.0, 143.0, 129.0, 89.0, 89.0, 118.0], "value": 111.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 67.0, 69.0, 66.0, 74.0, 67.0, 60.0, 66.0, 78.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 62.0, 90.0, 59.0, 102.0, 87.0, 89.0, 84.0, 60.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 96.0, 87.0, 90.0, 91.0, 95.0, 89.0, 94.0, 93.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 147.0, 146.0, 142.0, 144.0, 164.0, 186.0, 195.0, 165.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 176.0, 177.0, 178.0, 199.0, 177.0, 174.0, 176.0, 172.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 67.0, 71.0, 88.0, 87.0, 85.0, 71.0, 71.0], "value": 74.8, "unit": "score"}]}]} 10:33:36 INFO - Return code: 0 10:33:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:33:36 ERROR - # TBPL SUCCESS # 10:33:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:33:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:33:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:33:37 INFO - 2017-03-02 10:33:36.998 screenresolution[1660:10586] starting screenresolution argv=screenresolution get 10:33:37 INFO - 2017-03-02 10:33:37.001 screenresolution[1660:10586] Display 0: 1600x1200x32@60 10:33:37 INFO - 2017-03-02 10:33:37.007 screenresolution[1661:10590] starting screenresolution argv=screenresolution list 10:33:37 INFO - Available Modes on Display 0 10:33:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:33:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:33:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:33:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:33:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:33:37 INFO - Intel Iris: 10:33:37 INFO - Chipset Model: Intel Iris 10:33:37 INFO - Type: GPU 10:33:37 INFO - Bus: Built-In 10:33:37 INFO - VRAM (Dynamic, Max): 1536 MB 10:33:37 INFO - Vendor: Intel (0x8086) 10:33:37 INFO - Device ID: 0x0a2e 10:33:37 INFO - Revision ID: 0x0009 10:33:37 INFO - Displays: 10:33:37 INFO - Display: 10:33:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:33:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:33:37 INFO - Display Serial Number: 1600x1200 60 10:33:37 INFO - Main Display: Yes 10:33:37 INFO - Mirror: Off 10:33:37 INFO - Online: Yes 10:33:37 INFO - Rotation: Supported 10:33:37 INFO - Return code: 0 10:33:37 INFO - Running post-action listener: _resource_record_post_action 10:33:37 INFO - [mozharness: 2017-03-02 18:33:37.241879Z] Finished run-tests step (success) 10:33:37 INFO - Running post-run listener: _resource_record_post_run 10:33:37 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 39004672; Write bytes: 515630592; Read time: 249; Write time: 1637 10:33:37 INFO - TinderboxPrint: CPU usage
54.5% 10:33:37 INFO - TinderboxPrint: I/O read bytes / time
39,004,672 / 249 10:33:37 INFO - TinderboxPrint: I/O write bytes / time
515,630,592 / 1,637 10:33:37 INFO - TinderboxPrint: CPU idle
2,191.5 (45.5%) 10:33:37 INFO - TinderboxPrint: CPU system
964.3 (20.0%) 10:33:37 INFO - TinderboxPrint: CPU user
1,658.0 (34.4%) 10:33:37 INFO - TinderboxPrint: Swap in / out
249,712,640 / 0 10:33:37 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202656256; Write bytes: 202671616; Read time: 15620; Write time: 454 10:33:37 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 38033920; Write bytes: 303153152; Read time: 235; Write time: 1150 10:33:37 INFO - Running post-run listener: _upload_blobber_files 10:33:37 INFO - Blob upload gear active. 10:33:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:37 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 10:33:37 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:33:37 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:33:38 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:33:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:39 INFO - (blobuploader) - INFO - Done attempting. 10:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:40 INFO - (blobuploader) - INFO - Done attempting. 10:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:33:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:41 INFO - (blobuploader) - INFO - Done attempting. 10:33:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:33:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:33:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:43 INFO - (blobuploader) - INFO - Done attempting. 10:33:43 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:43 INFO - Return code: 0 10:33:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80d90fe8a046b46b306d1a1c3194c65b40d8fa129cd3259df6edebfeddc1d981f36842bbe7865cdabb1e4932b71943419c3afe998368b4ddd205c39883ca7536", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9d6148cd92ef7334a03eb6def288b60fa146d6edd94970b7e9324b64768826c3dd617964b294767d8e2a083c6d99c44eb9eb9c71a8e7dfde51862f8a197c98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deb520969cbb33801cbd8430083c8226fb5cfe22b80895b79b34c034c1b4ad4434c790e90a3ca0355e11dd37f7ef886d28f3a72f56df09520eed69866a54830d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51c43db344188e8c87a2dbe2a855a95dca022e2aebf5af21e3fc308ef2bd70c2edc67d2a39d25c92006bc6c1ec46373b18f34ed6f754091b05961e5f3f6fcafa"} 10:33:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:43 INFO - Contents: 10:33:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80d90fe8a046b46b306d1a1c3194c65b40d8fa129cd3259df6edebfeddc1d981f36842bbe7865cdabb1e4932b71943419c3afe998368b4ddd205c39883ca7536", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9d6148cd92ef7334a03eb6def288b60fa146d6edd94970b7e9324b64768826c3dd617964b294767d8e2a083c6d99c44eb9eb9c71a8e7dfde51862f8a197c98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deb520969cbb33801cbd8430083c8226fb5cfe22b80895b79b34c034c1b4ad4434c790e90a3ca0355e11dd37f7ef886d28f3a72f56df09520eed69866a54830d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51c43db344188e8c87a2dbe2a855a95dca022e2aebf5af21e3fc308ef2bd70c2edc67d2a39d25c92006bc6c1ec46373b18f34ed6f754091b05961e5f3f6fcafa"} 10:33:43 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:43 INFO - Copying logs to upload dir... 10:33:43 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.005511 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-02 10:33:43.285298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 10:33:43.288531) ========= 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.8hCdrcV6do/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.j2KKVf3UNu/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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/Firefox/sha512/80d90fe8a046b46b306d1a1c3194c65b40d8fa129cd3259df6edebfeddc1d981f36842bbe7865cdabb1e4932b71943419c3afe998368b4ddd205c39883ca7536", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9d6148cd92ef7334a03eb6def288b60fa146d6edd94970b7e9324b64768826c3dd617964b294767d8e2a083c6d99c44eb9eb9c71a8e7dfde51862f8a197c98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deb520969cbb33801cbd8430083c8226fb5cfe22b80895b79b34c034c1b4ad4434c790e90a3ca0355e11dd37f7ef886d28f3a72f56df09520eed69866a54830d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51c43db344188e8c87a2dbe2a855a95dca022e2aebf5af21e3fc308ef2bd70c2edc67d2a39d25c92006bc6c1ec46373b18f34ed6f754091b05961e5f3f6fcafa"} build_url:https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010877 build_url: 'https://queue.taskcluster.net/v1/task/K8MjZRWFQYe06Zf0OmnDYw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80d90fe8a046b46b306d1a1c3194c65b40d8fa129cd3259df6edebfeddc1d981f36842bbe7865cdabb1e4932b71943419c3afe998368b4ddd205c39883ca7536", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9d6148cd92ef7334a03eb6def288b60fa146d6edd94970b7e9324b64768826c3dd617964b294767d8e2a083c6d99c44eb9eb9c71a8e7dfde51862f8a197c98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deb520969cbb33801cbd8430083c8226fb5cfe22b80895b79b34c034c1b4ad4434c790e90a3ca0355e11dd37f7ef886d28f3a72f56df09520eed69866a54830d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51c43db344188e8c87a2dbe2a855a95dca022e2aebf5af21e3fc308ef2bd70c2edc67d2a39d25c92006bc6c1ec46373b18f34ed6f754091b05961e5f3f6fcafa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 10:33:43.322670) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 10:33:43.323008) ========= 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.8hCdrcV6do/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.j2KKVf3UNu/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.005117 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 10:33:43.372032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 10:33:43.372367) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 10:33:43.372698) ========= ========= Total master_lag: 0.18 =========