builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0256 starttime: 1486981628.88 results: success (0) buildid: 20170213002940 builduid: 2bf733bc4a094d679c044cb86ffaf070 revision: dde4995469df1c12a38015558652d1c2d4774f1a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:08.875965) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:08.876477) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:08.876777) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:08.901450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:08.901787) ========= 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.vTClp4tVEK/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.uuryahH7TS/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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-02-13 02:27:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.1M=0.001s 2017-02-13 02:27:08 (13.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082311 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:09.007286) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:09.007615) ========= 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.vTClp4tVEK/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.uuryahH7TS/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.021653 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:09.056213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 02:27:09.056586) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dde4995469df1c12a38015558652d1c2d4774f1a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dde4995469df1c12a38015558652d1c2d4774f1a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vTClp4tVEK/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.uuryahH7TS/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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-02-13 02:27:09,138 truncating revision to first 12 chars 2017-02-13 02:27:09,138 Setting DEBUG logging. 2017-02-13 02:27:09,139 attempt 1/10 2017-02-13 02:27:09,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/dde4995469df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 02:27:10,704 unpacking tar archive at: mozilla-aurora-dde4995469df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.845206 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 02:27:10.925409) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:10.925733) ========= script_repo_revision: dde4995469df1c12a38015558652d1c2d4774f1a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:10.926118) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:10.926416) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 02:27:10.946392) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-13 02:27:10.946788) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vTClp4tVEK/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.uuryahH7TS/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 02:27:11 INFO - MultiFileLogger online at 20170213 02:27:11 in /builds/slave/test 02:27:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:27:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:27:11 INFO - {'append_to_log': False, 02:27:11 INFO - 'base_work_dir': '/builds/slave/test', 02:27:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:27:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:27:11 INFO - 'branch': 'Mozilla-Aurora', 02:27:11 INFO - 'buildbot_json_path': 'buildprops.json', 02:27:11 INFO - 'config_files': ('talos/mac_config.py',), 02:27:11 INFO - 'default_actions': ('clobber', 02:27:11 INFO - 'read-buildbot-config', 02:27:11 INFO - 'download-and-extract', 02:27:11 INFO - 'populate-webroot', 02:27:11 INFO - 'create-virtualenv', 02:27:11 INFO - 'install', 02:27:11 INFO - 'run-tests'), 02:27:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:27:11 INFO - 'download_minidump_stackwalk': True, 02:27:11 INFO - 'download_symbols': 'ondemand', 02:27:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:27:11 INFO - 'tooltool.py': '/tools/tooltool.py', 02:27:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:27:11 INFO - '/tools/misc-python/virtualenv.py')}, 02:27:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:27:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:27:11 INFO - 'installer_path': 'installer.exe', 02:27:11 INFO - 'log_level': 'info', 02:27:11 INFO - 'log_name': 'talos', 02:27:11 INFO - 'log_to_console': True, 02:27:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:27:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:27:11 INFO - 'opt_config_files': (), 02:27:11 INFO - 'pip_index': False, 02:27:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:27:11 INFO - 'cmd': ('bash', 02:27:11 INFO - '-c', 02:27:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:27:11 INFO - 'enabled': True, 02:27:11 INFO - 'halt_on_failure': False, 02:27:11 INFO - 'name': 'check_screen_resolution'},), 02:27:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:27:11 INFO - 'cmd': ('bash', 02:27:11 INFO - '-c', 02:27:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:27:11 INFO - 'enabled': True, 02:27:11 INFO - 'halt_on_failure': False, 02:27:11 INFO - 'name': 'check_screen_resolution'},), 02:27:11 INFO - 'run_cmd_checks_enabled': True, 02:27:11 INFO - 'sps_profile': False, 02:27:11 INFO - 'sps_profile_interval': 0, 02:27:11 INFO - 'suite': 'dromaeojs-e10s', 02:27:11 INFO - 'system_bits': '32', 02:27:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:27:11 INFO - 'title': 't-yosemite-r7-0256', 02:27:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:27:11 INFO - 'use_talos_json': True, 02:27:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:27:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:27:11 INFO - 'work_dir': 'build'} 02:27:11 INFO - [mozharness: 2017-02-13 10:27:11.150455Z] Running clobber step. 02:27:11 INFO - Running pre-action listener: _resource_record_pre_action 02:27:11 INFO - Running main action method: clobber 02:27:11 INFO - rmtree: /builds/slave/test/build 02:27:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:27:14 INFO - Running post-action listener: _resource_record_post_action 02:27:14 INFO - [mozharness: 2017-02-13 10:27:14.338686Z] Finished clobber step (success) 02:27:14 INFO - [mozharness: 2017-02-13 10:27:14.338818Z] Running read-buildbot-config step. 02:27:14 INFO - Running pre-action listener: _resource_record_pre_action 02:27:14 INFO - Running main action method: read_buildbot_config 02:27:14 INFO - Using buildbot properties: 02:27:14 INFO - { 02:27:14 INFO - "project": "", 02:27:14 INFO - "product": "firefox", 02:27:14 INFO - "script_repo_revision": "production", 02:27:14 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:27:14 INFO - "repository": "", 02:27:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:27:14 INFO - "buildid": "20170213002940", 02:27:14 INFO - "pgo_build": "False", 02:27:14 INFO - "basedir": "/builds/slave/test", 02:27:14 INFO - "buildnumber": 54, 02:27:14 INFO - "slavename": "t-yosemite-r7-0256", 02:27:14 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:27:14 INFO - "platform": "yosemite_r7", 02:27:14 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:27:14 INFO - "branch": "mozilla-aurora", 02:27:14 INFO - "repo_path": "releases/mozilla-aurora", 02:27:14 INFO - "revision": "dde4995469df1c12a38015558652d1c2d4774f1a", 02:27:14 INFO - "stage_platform": "macosx64", 02:27:14 INFO - "builduid": "2bf733bc4a094d679c044cb86ffaf070", 02:27:14 INFO - "slavebuilddir": "test" 02:27:14 INFO - } 02:27:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:27:14 INFO - Running post-action listener: _resource_record_post_action 02:27:14 INFO - [mozharness: 2017-02-13 10:27:14.341895Z] Finished read-buildbot-config step (success) 02:27:14 INFO - [mozharness: 2017-02-13 10:27:14.342002Z] Running download-and-extract step. 02:27:14 INFO - Running pre-action listener: _resource_record_pre_action 02:27:14 INFO - Running main action method: download_and_extract 02:27:14 INFO - mkdir: /builds/slave/test/build/tests 02:27:14 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')]} 02:27:14 INFO - trying https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:27:14 INFO - Downloading https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:27:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:27:15 INFO - Downloaded 1199 bytes. 02:27:15 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:27:15 INFO - Using the following test package requirements: 02:27:15 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:27:15 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:27:15 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:27:15 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:27:15 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:27:15 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:27:15 INFO - u'jsshell-mac.zip'], 02:27:15 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:27:15 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:27:15 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:27:15 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:27:15 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:27:15 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:27:15 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:27:15 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:27:15 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:27:15 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:27:15 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:27:15 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:27:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:27:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:27:15 INFO - Fetch https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:27:16 INFO - Expected file size: 16358332 02:27:16 INFO - Obtained file size: 16358332 02:27:23 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:27:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:27:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:27:23 INFO - Fetch https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:27:24 INFO - Expected file size: 16358332 02:27:24 INFO - Obtained file size: 16358332 02:27:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:27:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:27:30 INFO - Fetch https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:27:31 INFO - Expected file size: 14403485 02:27:31 INFO - Obtained file size: 14403485 02:27: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')]} 02:27:32 INFO - trying https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:27:32 INFO - Downloading https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:27:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:27:34 INFO - Downloaded 73960653 bytes. 02:27:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:27:34 INFO - mkdir: /builds/slave/test/properties 02:27:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:27:34 INFO - Writing to file /builds/slave/test/properties/build_url 02:27:34 INFO - Contents: 02:27:34 INFO - build_url:https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:27:34 INFO - Running post-action listener: _resource_record_post_action 02:27:34 INFO - Running post-action listener: set_extra_try_arguments 02:27:34 INFO - [mozharness: 2017-02-13 10:27:34.900273Z] Finished download-and-extract step (success) 02:27:34 INFO - [mozharness: 2017-02-13 10:27:34.900415Z] Running populate-webroot step. 02:27:34 INFO - Running pre-action listener: _resource_record_pre_action 02:27:34 INFO - Running main action method: populate_webroot 02:27:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:27:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:27:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:27:34 INFO - '--tppagecycles', 02:27:34 INFO - '7'], 02:27:34 INFO - 'tests': ['tsvgm']}}, 02:27:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:27:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:27:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:27:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:27:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:27:34 INFO - 'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:27:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:27:34 INFO - 'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['damp', 'tps']}, 02:27:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:27:34 INFO - 'tests': ['damp', 'tps']}, 02:27:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['dromaeo_dom']}, 02:27:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:27:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['basic_compositor_video']}, 02:27:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:27:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'other-e10s': {'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['tsvgx', 02:27:34 INFO - 'tsvgr_opacity', 02:27:34 INFO - 'tart', 02:27:34 INFO - 'tscrollx', 02:27:34 INFO - 'cart', 02:27:34 INFO - 'tsvg_static']}, 02:27:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:27:34 INFO - 'tsvgr_opacity', 02:27:34 INFO - 'tart', 02:27:34 INFO - 'tscrollx', 02:27:34 INFO - 'cart', 02:27:34 INFO - 'tsvg_static']}, 02:27:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:27:34 INFO - 'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['tp5o']}, 02:27:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:27:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:27:34 INFO - 'talos_options': ['--disable-e10s', 02:27:34 INFO - '--xperf_path', 02:27:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:34 INFO - 'tests': ['tp5n']}, 02:27:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:27:34 INFO - 'talos_options': ['--xperf_path', 02:27:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:34 INFO - 'tests': ['tp5n']}}, 02:27:34 INFO - 'talos.zip': {'path': '', 02:27:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:27:34 INFO - Running post-action listener: _resource_record_post_action 02:27:34 INFO - [mozharness: 2017-02-13 10:27:34.919648Z] Finished populate-webroot step (success) 02:27:34 INFO - [mozharness: 2017-02-13 10:27:34.919757Z] Running create-virtualenv step. 02:27:34 INFO - Running pre-action listener: _resource_record_pre_action 02:27:34 INFO - Running main action method: create_virtualenv 02:27:34 INFO - Creating virtualenv /builds/slave/test/build/venv 02:27:34 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 02:27:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:27:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:27:35 INFO - Using real prefix '/tools/python27' 02:27:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:27:35 INFO - Installing distribute.............................................................................................................................................................................................done. 02:27:38 INFO - Installing pip.................done. 02:27:38 INFO - Return code: 0 02:27:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:27:38 INFO - Reading from file tmpfile_stdout 02:27:38 INFO - Output received: 02:27:38 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) 02:27:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104917b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10491a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc582470030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f5d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046eabe8>, '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.vTClp4tVEK/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.uuryahH7TS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 02:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vTClp4tVEK/Render', 02:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:38 INFO - 'HOME': '/Users/cltbld', 02:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:38 INFO - 'LOGNAME': 'cltbld', 02:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:38 INFO - 'MOZ_NO_REMOTE': '1', 02:27:38 INFO - 'NO_EM_RESTART': '1', 02:27:38 INFO - 'PAGER': '/bin/cat', 02:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:38 INFO - 'PWD': '/builds/slave/test', 02:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:38 INFO - 'SHELL': '/bin/bash', 02:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uuryahH7TS/Listeners', 02:27:38 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 02:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:38 INFO - 'USER': 'cltbld', 02:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:38 INFO - 'XPC_FLAGS': '0x0', 02:27:38 INFO - 'XPC_SERVICE_NAME': '0', 02:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:39 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 02:27:39 INFO - Cleaning up... 02:27:39 INFO - Return code: 0 02:27:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104917b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10491a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc582470030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f5d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046eabe8>, '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.vTClp4tVEK/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.uuryahH7TS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 02:27:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:27:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vTClp4tVEK/Render', 02:27:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:39 INFO - 'HOME': '/Users/cltbld', 02:27:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:39 INFO - 'LOGNAME': 'cltbld', 02:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:39 INFO - 'MOZ_NO_REMOTE': '1', 02:27:39 INFO - 'NO_EM_RESTART': '1', 02:27:39 INFO - 'PAGER': '/bin/cat', 02:27:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:39 INFO - 'PWD': '/builds/slave/test', 02:27:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:39 INFO - 'SHELL': '/bin/bash', 02:27:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uuryahH7TS/Listeners', 02:27:39 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 02:27:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:39 INFO - 'USER': 'cltbld', 02:27:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:39 INFO - 'XPC_FLAGS': '0x0', 02:27:39 INFO - 'XPC_SERVICE_NAME': '0', 02:27:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:39 INFO - Downloading/unpacking psutil>=3.1.1 02:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:27:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:42 INFO - Installing collected packages: psutil 02:27:42 INFO - Running setup.py install for psutil 02:27:43 INFO - building 'psutil._psutil_osx' extension 02:27:43 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 02:27:43 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 02:27:43 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 02:27:43 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 02:27:43 INFO - building 'psutil._psutil_posix' extension 02:27:43 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 02:27:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:27:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:27:43 INFO - ^ 02:27:43 INFO - 1 warning generated. 02:27:43 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 02:27:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:43 INFO - Successfully installed psutil 02:27:43 INFO - Cleaning up... 02:27:43 INFO - Return code: 0 02:27:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:43 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 0x104917b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10491a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc582470030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f5d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046eabe8>, '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.vTClp4tVEK/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.uuryahH7TS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 02:27:43 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 02:27:43 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 02:27:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vTClp4tVEK/Render', 02:27:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:43 INFO - 'HOME': '/Users/cltbld', 02:27:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:43 INFO - 'LOGNAME': 'cltbld', 02:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:43 INFO - 'MOZ_NO_REMOTE': '1', 02:27:43 INFO - 'NO_EM_RESTART': '1', 02:27:43 INFO - 'PAGER': '/bin/cat', 02:27:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:43 INFO - 'PWD': '/builds/slave/test', 02:27:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:43 INFO - 'SHELL': '/bin/bash', 02:27:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uuryahH7TS/Listeners', 02:27:43 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 02:27:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:43 INFO - 'USER': 'cltbld', 02:27:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:43 INFO - 'XPC_FLAGS': '0x0', 02:27:43 INFO - 'XPC_SERVICE_NAME': '0', 02:27:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:27:44 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 02:27:44 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 02:27:44 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 02:27:44 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 02:27:44 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 02:27:44 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 02:27:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:27:46 INFO - Installing collected packages: mozsystemmonitor 02:27:46 INFO - Running setup.py install for mozsystemmonitor 02:27:46 INFO - Successfully installed mozsystemmonitor 02:27:46 INFO - Cleaning up... 02:27:46 INFO - Return code: 0 02:27:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104917b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10491a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc582470030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f5d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046eabe8>, '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.vTClp4tVEK/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.uuryahH7TS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 02:27:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:27:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vTClp4tVEK/Render', 02:27:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:46 INFO - 'HOME': '/Users/cltbld', 02:27:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:46 INFO - 'LOGNAME': 'cltbld', 02:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:46 INFO - 'MOZ_NO_REMOTE': '1', 02:27:46 INFO - 'NO_EM_RESTART': '1', 02:27:46 INFO - 'PAGER': '/bin/cat', 02:27:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:46 INFO - 'PWD': '/builds/slave/test', 02:27:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:46 INFO - 'SHELL': '/bin/bash', 02:27:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uuryahH7TS/Listeners', 02:27:46 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 02:27:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:46 INFO - 'USER': 'cltbld', 02:27:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:46 INFO - 'XPC_FLAGS': '0x0', 02:27:46 INFO - 'XPC_SERVICE_NAME': '0', 02:27:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:47 INFO - Downloading/unpacking jsonschema==2.5.1 02:27:47 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 02:27:47 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 02:27:47 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 02:27:47 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 02:27:47 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 02:27:47 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 02:27:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:27:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:50 INFO - Downloading functools32-3.2.3-2.tar.gz 02:27:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:27:50 INFO - warning: no files found matching '*.txt' 02:27:50 INFO - no previously-included directories found matching 'build' 02:27:50 INFO - no previously-included directories found matching 'dist' 02:27:50 INFO - no previously-included directories found matching '.git*' 02:27:50 INFO - Installing collected packages: jsonschema, functools32 02:27:50 INFO - Running setup.py install for functools32 02:27:50 INFO - warning: no files found matching '*.txt' 02:27:50 INFO - no previously-included directories found matching 'build' 02:27:50 INFO - no previously-included directories found matching 'dist' 02:27:50 INFO - no previously-included directories found matching '.git*' 02:27:50 INFO - Successfully installed jsonschema functools32 02:27:50 INFO - Cleaning up... 02:27:50 INFO - Return code: 0 02:27:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:50 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 0x104917b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10491a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc582470030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f5d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046eabe8>, '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.vTClp4tVEK/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.uuryahH7TS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 02:27:50 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 02:27:50 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 02:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vTClp4tVEK/Render', 02:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:50 INFO - 'HOME': '/Users/cltbld', 02:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:50 INFO - 'LOGNAME': 'cltbld', 02:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:50 INFO - 'MOZ_NO_REMOTE': '1', 02:27:50 INFO - 'NO_EM_RESTART': '1', 02:27:50 INFO - 'PAGER': '/bin/cat', 02:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:50 INFO - 'PWD': '/builds/slave/test', 02:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:50 INFO - 'SHELL': '/bin/bash', 02:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uuryahH7TS/Listeners', 02:27:50 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 02:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:50 INFO - 'USER': 'cltbld', 02:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:50 INFO - 'XPC_FLAGS': '0x0', 02:27:50 INFO - 'XPC_SERVICE_NAME': '0', 02:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:27:50 INFO - Cleaning up... 02:27:50 INFO - Return code: 0 02:27:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:50 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 0x104917b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10491a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc582470030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f5d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046eabe8>, '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.vTClp4tVEK/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.uuryahH7TS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 02:27:50 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 02:27:50 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 02:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vTClp4tVEK/Render', 02:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:50 INFO - 'HOME': '/Users/cltbld', 02:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:50 INFO - 'LOGNAME': 'cltbld', 02:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:50 INFO - 'MOZ_NO_REMOTE': '1', 02:27:50 INFO - 'NO_EM_RESTART': '1', 02:27:50 INFO - 'PAGER': '/bin/cat', 02:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:50 INFO - 'PWD': '/builds/slave/test', 02:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:50 INFO - 'SHELL': '/bin/bash', 02:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uuryahH7TS/Listeners', 02:27:50 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 02:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:50 INFO - 'USER': 'cltbld', 02:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:50 INFO - 'XPC_FLAGS': '0x0', 02:27:50 INFO - 'XPC_SERVICE_NAME': '0', 02:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:51 INFO - Downloading/unpacking blobuploader==1.2.4 02:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:53 INFO - Downloading blobuploader-1.2.4.tar.gz 02:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:27:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:27:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:55 INFO - Downloading docopt-0.6.1.tar.gz 02:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:27:55 INFO - Installing collected packages: blobuploader, requests, docopt 02:27:55 INFO - Running setup.py install for blobuploader 02:27:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:27:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:27:55 INFO - Running setup.py install for requests 02:27:55 INFO - Running setup.py install for docopt 02:27:55 INFO - Successfully installed blobuploader requests docopt 02:27:55 INFO - Cleaning up... 02:27:56 INFO - Return code: 0 02:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:56 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 0x104917b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10491a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc582470030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f5d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046eabe8>, '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.vTClp4tVEK/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.uuryahH7TS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 02:27:56 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 02:27:56 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 02:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vTClp4tVEK/Render', 02:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:56 INFO - 'HOME': '/Users/cltbld', 02:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:56 INFO - 'LOGNAME': 'cltbld', 02:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:56 INFO - 'MOZ_NO_REMOTE': '1', 02:27:56 INFO - 'NO_EM_RESTART': '1', 02:27:56 INFO - 'PAGER': '/bin/cat', 02:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:56 INFO - 'PWD': '/builds/slave/test', 02:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:56 INFO - 'SHELL': '/bin/bash', 02:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uuryahH7TS/Listeners', 02:27:56 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 02:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:56 INFO - 'USER': 'cltbld', 02:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:56 INFO - 'XPC_FLAGS': '0x0', 02:27:56 INFO - 'XPC_SERVICE_NAME': '0', 02:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:56 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-fcjRPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:56 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-EaJWhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:56 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-yoI24K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:56 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-DsbsvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:56 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-SgNp5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:56 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-t5HVdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:56 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-8j3eyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:57 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-dYEKrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:57 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-KLbfjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:57 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-5vPQvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:57 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-niCD5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:57 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-T213ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:57 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-w3qRU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:57 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-6YMBms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:57 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-jVhgqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:57 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-FWy1pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:58 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Ka7jgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:27:58 INFO - Running setup.py install for manifestparser 02:27:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:27:58 INFO - Running setup.py install for mozcrash 02:27:58 INFO - Running setup.py install for mozdebug 02:27:58 INFO - Running setup.py install for mozdevice 02:27:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:27:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:27:58 INFO - Running setup.py install for mozfile 02:27:58 INFO - Running setup.py install for mozhttpd 02:27:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:27:58 INFO - Running setup.py install for mozinfo 02:27:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Running setup.py install for mozInstall 02:27:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Running setup.py install for mozleak 02:27:59 INFO - Running setup.py install for mozlog 02:27:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Running setup.py install for moznetwork 02:27:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Running setup.py install for mozprocess 02:27:59 INFO - Running setup.py install for mozprofile 02:28:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:28:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:28:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:28:00 INFO - Running setup.py install for mozrunner 02:28:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:28:00 INFO - Running setup.py install for mozscreenshot 02:28:00 INFO - Running setup.py install for moztest 02:28:00 INFO - Running setup.py install for mozversion 02:28:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:28:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:28:00 INFO - Cleaning up... 02:28:00 INFO - Return code: 0 02:28:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:00 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 0x104917b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10491a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc582470030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f5d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046eabe8>, '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.vTClp4tVEK/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.uuryahH7TS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 02:28:00 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 02:28:00 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 02:28:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vTClp4tVEK/Render', 02:28:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:00 INFO - 'HOME': '/Users/cltbld', 02:28:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:00 INFO - 'LOGNAME': 'cltbld', 02:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:00 INFO - 'MOZ_NO_REMOTE': '1', 02:28:00 INFO - 'NO_EM_RESTART': '1', 02:28:00 INFO - 'PAGER': '/bin/cat', 02:28:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:00 INFO - 'PWD': '/builds/slave/test', 02:28:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:00 INFO - 'SHELL': '/bin/bash', 02:28:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uuryahH7TS/Listeners', 02:28:00 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 02:28:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:00 INFO - 'USER': 'cltbld', 02:28:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:00 INFO - 'XPC_FLAGS': '0x0', 02:28:00 INFO - 'XPC_SERVICE_NAME': '0', 02:28:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:00 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-tzivIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:01 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-J7SU2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:01 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:01 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-H_xnZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:01 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-k669_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:01 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:01 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-ZTjuN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:01 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-G_4luG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:01 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-vrjB6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:01 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-IIeW7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:01 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-XmEEZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:01 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:01 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-5AZ1Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:02 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)) 02:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:02 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-bV0TNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:02 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-RuX8UA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 02:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:02 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-mFQWG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:02 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-n4mcgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:02 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)) 02:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:02 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-xszJKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:02 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-GOimxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:02 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)) 02:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:02 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-itHRG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:28:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:05 INFO - Downloading blessings-1.6.tar.gz 02:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:28:05 INFO - Installing collected packages: blessings 02:28:05 INFO - Running setup.py install for blessings 02:28:05 INFO - Successfully installed blessings 02:28:05 INFO - Cleaning up... 02:28:05 INFO - Return code: 0 02:28:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:28:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:05 INFO - Reading from file tmpfile_stdout 02:28:05 INFO - Current package versions: 02:28:05 INFO - blessings == 1.6 02:28:05 INFO - blobuploader == 1.2.4 02:28:05 INFO - docopt == 0.6.1 02:28:05 INFO - functools32 == 3.2.3-2 02:28:05 INFO - jsonschema == 2.5.1 02:28:05 INFO - manifestparser == 1.1 02:28:05 INFO - mozInstall == 1.12 02:28:05 INFO - mozcrash == 1.0 02:28:05 INFO - mozdebug == 0.1 02:28:05 INFO - mozdevice == 0.49 02:28:05 INFO - mozfile == 1.2 02:28:05 INFO - mozhttpd == 0.7 02:28:05 INFO - mozinfo == 0.9 02:28:05 INFO - mozleak == 0.1 02:28:05 INFO - mozlog == 3.4 02:28:05 INFO - moznetwork == 0.27 02:28:05 INFO - mozprocess == 0.24 02:28:05 INFO - mozprofile == 0.28 02:28:05 INFO - mozrunner == 6.13 02:28:05 INFO - mozscreenshot == 0.1 02:28:05 INFO - mozsystemmonitor == 0.3 02:28:05 INFO - moztest == 0.8 02:28:05 INFO - mozversion == 1.4 02:28:05 INFO - psutil == 3.1.1 02:28:05 INFO - requests == 1.2.3 02:28:05 INFO - wsgiref == 0.1.2 02:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:06 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')]} 02:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:06 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 0x104917b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10491a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc582470030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f5d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046eabe8>, '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.vTClp4tVEK/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.uuryahH7TS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 02:28:06 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 02:28:06 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 02:28:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vTClp4tVEK/Render', 02:28:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:06 INFO - 'HOME': '/Users/cltbld', 02:28:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:06 INFO - 'LOGNAME': 'cltbld', 02:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:06 INFO - 'MOZ_NO_REMOTE': '1', 02:28:06 INFO - 'NO_EM_RESTART': '1', 02:28:06 INFO - 'PAGER': '/bin/cat', 02:28:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:06 INFO - 'PWD': '/builds/slave/test', 02:28:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:06 INFO - 'SHELL': '/bin/bash', 02:28:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uuryahH7TS/Listeners', 02:28:06 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 02:28:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:06 INFO - 'USER': 'cltbld', 02:28:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:06 INFO - 'XPC_FLAGS': '0x0', 02:28:06 INFO - 'XPC_SERVICE_NAME': '0', 02:28:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 INFO - Cleaning up... 02:28:06 INFO - Return code: 0 02:28:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:28:06 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')]} 02:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:06 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')]} 02:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:07 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 0x104917b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10491a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc582470030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f5d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046eabe8>, '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.vTClp4tVEK/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.uuryahH7TS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 02:28:07 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 02:28:07 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 02:28:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vTClp4tVEK/Render', 02:28:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:07 INFO - 'HOME': '/Users/cltbld', 02:28:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:07 INFO - 'LOGNAME': 'cltbld', 02:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:07 INFO - 'MOZ_NO_REMOTE': '1', 02:28:07 INFO - 'NO_EM_RESTART': '1', 02:28:07 INFO - 'PAGER': '/bin/cat', 02:28:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:07 INFO - 'PWD': '/builds/slave/test', 02:28:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:07 INFO - 'SHELL': '/bin/bash', 02:28:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uuryahH7TS/Listeners', 02:28:07 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 02:28:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:07 INFO - 'USER': 'cltbld', 02:28:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:07 INFO - 'XPC_FLAGS': '0x0', 02:28:07 INFO - 'XPC_SERVICE_NAME': '0', 02:28:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:28:07 INFO - Cleaning up... 02:28:07 INFO - Return code: 0 02:28:07 INFO - Running post-action listener: _resource_record_post_action 02:28:07 INFO - Running post-action listener: _start_resource_monitoring 02:28:07 INFO - Starting resource monitoring. 02:28:07 INFO - [mozharness: 2017-02-13 10:28:07.639806Z] Finished create-virtualenv step (success) 02:28:07 INFO - [mozharness: 2017-02-13 10:28:07.640758Z] Running install step. 02:28:07 INFO - Running pre-action listener: _resource_record_pre_action 02:28:07 INFO - Running main action method: install 02:28:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:07 INFO - Reading from file tmpfile_stdout 02:28:07 INFO - Detecting whether we're running mozinstall >=1.0... 02:28:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:28:08 INFO - Reading from file tmpfile_stdout 02:28:08 INFO - Output received: 02:28:08 INFO - Usage: mozinstall [options] installer 02:28:08 INFO - Options: 02:28:08 INFO - -h, --help show this help message and exit 02:28:08 INFO - -d DEST, --destination=DEST 02:28:08 INFO - Directory to install application into. [default: 02:28:08 INFO - "/builds/slave/test"] 02:28:08 INFO - --app=APP Application being installed. [default: firefox] 02:28:08 INFO - mkdir: /builds/slave/test/build/application 02:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:28:27 INFO - Reading from file tmpfile_stdout 02:28:27 INFO - Output received: 02:28:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:28:27 INFO - Running post-action listener: _resource_record_post_action 02:28:27 INFO - [mozharness: 2017-02-13 10:28:27.860473Z] Finished install step (success) 02:28:27 INFO - [mozharness: 2017-02-13 10:28:27.860615Z] Running run-tests step. 02:28:27 INFO - Running pre-action listener: _resource_record_pre_action 02:28:27 INFO - Running main action method: run_tests 02:28:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:28:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:28:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:28:27 INFO - 2017-02-13 02:28:27.875 screenresolution[1917:20084] starting screenresolution argv=screenresolution get 02:28:27 INFO - 2017-02-13 02:28:27.877 screenresolution[1917:20084] Display 0: 1600x1200x32@60 02:28:27 INFO - 2017-02-13 02:28:27.883 screenresolution[1918:20086] starting screenresolution argv=screenresolution list 02:28:27 INFO - Available Modes on Display 0 02:28:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:28:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:28:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:28:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:28:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:28:28 INFO - Intel Iris: 02:28:28 INFO - Chipset Model: Intel Iris 02:28:28 INFO - Type: GPU 02:28:28 INFO - Bus: Built-In 02:28:28 INFO - VRAM (Dynamic, Max): 1536 MB 02:28:28 INFO - Vendor: Intel (0x8086) 02:28:28 INFO - Device ID: 0x0a2e 02:28:28 INFO - Revision ID: 0x0009 02:28:28 INFO - Displays: 02:28:28 INFO - Display: 02:28:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:28:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:28:28 INFO - Display Serial Number: 1600x1200 60 02:28:28 INFO - Main Display: Yes 02:28:28 INFO - Mirror: Off 02:28:28 INFO - Online: Yes 02:28:28 INFO - Rotation: Supported 02:28:28 INFO - Return code: 0 02:28:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:28:28 INFO - Python 2.7.3 02:28:28 INFO - Return code: 0 02:28:28 INFO - grabbing minidump binary from tooltool 02:28:28 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')]} 02:28:28 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 0x1046f5d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046eabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:28:28 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 02:28:28 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 02:28:28 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 02:28:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:28:28 INFO - Return code: 0 02:28:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:28:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:28:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:28:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:28:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:28:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--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 02:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0256 --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 02:28:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vTClp4tVEK/Render', 02:28:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:28 INFO - 'HOME': '/Users/cltbld', 02:28:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:28 INFO - 'LOGNAME': 'cltbld', 02:28:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:28:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:28 INFO - 'MOZ_NO_REMOTE': '1', 02:28:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:28:28 INFO - 'NO_EM_RESTART': '1', 02:28:28 INFO - 'PAGER': '/bin/cat', 02:28:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:28 INFO - 'PWD': '/builds/slave/test', 02:28:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:28:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:28 INFO - 'SHELL': '/bin/bash', 02:28:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uuryahH7TS/Listeners', 02:28:28 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 02:28:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:28 INFO - 'USER': 'cltbld', 02:28:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:28 INFO - 'XPC_FLAGS': '0x0', 02:28:28 INFO - 'XPC_SERVICE_NAME': '0', 02:28:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--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 02:28:28 INFO - mozversion application_buildid: 20170213002940 02:28:28 INFO - mozversion application_changeset: dde4995469df1c12a38015558652d1c2d4774f1a 02:28:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:28:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:28:28 INFO - mozversion application_name: Firefox 02:28:28 INFO - mozversion application_remotingname: firefox-dev 02:28:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:28 INFO - mozversion application_vendor: Mozilla 02:28:28 INFO - mozversion application_version: 53.0a2 02:28:28 INFO - mozversion platform_buildid: 20170213002940 02:28:28 INFO - mozversion platform_changeset: dde4995469df1c12a38015558652d1c2d4774f1a 02:28:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:28 INFO - mozversion platform_version: 53.0a2 02:28:28 INFO - using testdate: 1486981708 02:28:28 INFO - actual date: 1486981708 02:28:28 INFO - starting webserver on 'localhost:56584' 02:28:28 INFO - SUITE-START | Running 2 tests 02:28:28 INFO - TEST-START | dromaeo_css 02:28:28 INFO - operating with platform_type : mac_ 02:28:28 INFO - Initialising browser for dromaeo_css test... 02:28:28 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmp0m7VJB/profile http://localhost:56584/getInfo.html) 02:28:31 INFO - PROCESS | 1928 | 2017-02-13 02:28:31.339 plugin-container[1930:20252] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3b, name = 'com.apple.tsm.portname' 02:28:31 INFO - PROCESS | 1928 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:28:31 INFO - PROCESS | 1928 | 2017-02-13 02:28:31.342 plugin-container[1930:20252] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 02:28:31 INFO - PROCESS | 1928 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:28:31 INFO - PROCESS | 1928 | 2017-02-13 02:28:31.342 plugin-container[1930:20252] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:28:31 INFO - PROCESS | 1928 | __metrics Screen width/height:1600/1200 02:28:31 INFO - PROCESS | 1928 | colorDepth:24 02:28:31 INFO - PROCESS | 1928 | Browser inner width/height: 1024/689 02:28:31 INFO - PROCESS | 1928 | __metrics 02:28:31 ERROR - PROCESS | 1928 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 02:28:32 INFO - TEST-INFO | 1928: exit 0 02:28:32 INFO - Browser initialized. 02:28:32 INFO - Running cycle 1/1 for dromaeo_css test... 02:28:32 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmp0m7VJB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:34 INFO - PROCESS | 1931 | 2017-02-13 02:28:34.502 plugin-container[1932:20385] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 02:28:34 INFO - PROCESS | 1931 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:28:34 INFO - PROCESS | 1931 | 2017-02-13 02:28:34.503 plugin-container[1932:20385] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 02:28:34 INFO - PROCESS | 1931 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:28:34 INFO - PROCESS | 1931 | 2017-02-13 02:28:34.503 plugin-container[1932:20385] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:28:44 INFO - PROCESS | 1931 | RSS: Main: 218722304 02:28:44 INFO - PROCESS | 1931 | 02:31:46 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:56584/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56584/tests/dromaeo/cssquery-ext.html) 02:31:47 INFO - PROCESS | 1931 | RSS: Main: 239050752 02:31:47 INFO - PROCESS | 1931 | 02:33:32 INFO - PROCESS | 1931 | ************************* 02:33:32 INFO - PROCESS | 1931 | A coding exception was thrown and uncaught in a Task. 02:33:32 INFO - PROCESS | 1931 | 02:33:32 ERROR - PROCESS | 1931 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:33:32 INFO - PROCESS | 1931 | Full stack: 02:33:32 INFO - PROCESS | 1931 | ************************* 02:34:50 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:56584/tests/dromaeo/cssquery-ext.html (next: http://localhost:56584/tests/dromaeo/cssquery-jquery.html) 02:34:50 INFO - PROCESS | 1931 | RSS: Main: 247595008 02:34:50 INFO - PROCESS | 1931 | 02:37:52 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:56584/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56584/tests/dromaeo/cssquery-mootools.html) 02:37:53 INFO - PROCESS | 1931 | RSS: Main: 253792256 02:37:53 INFO - PROCESS | 1931 | 02:40:55 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:56584/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56584/tests/dromaeo/cssquery-prototype.html) 02:40:55 INFO - PROCESS | 1931 | RSS: Main: 250634240 02:40:55 INFO - PROCESS | 1931 | 02:43:58 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:56584/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56584/tests/dromaeo/cssquery-yui.html) 02:43:59 INFO - PROCESS | 1931 | RSS: Main: 254267392 02:43:59 INFO - PROCESS | 1931 | 02:47:01 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:56584/tests/dromaeo/cssquery-yui.html (next: http://localhost:56584/tests/dromaeo/cssquery-dojo.html) 02:47:02 INFO - PROCESS | 1931 | RSS: Main: 256339968 02:47:02 INFO - PROCESS | 1931 | 02:47:02 INFO - PROCESS | 1931 | __start_tp_report 02:47:02 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 02:47:02 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 02:47:02 INFO - PROCESS | 1931 | |i|pagename|runs| 02:47:02 INFO - PROCESS | 1931 | |0;dojo.html;3074.600301960745;3382.8815991440306;3392.6607339266075;3403.3023230237804;3433.896983090508;5729.512991395731;5782.392848750884;5802.622829516084;5819;5837.941620583793;4669.696469729465;5786.884262314762;5816.185733997244;5832.6792026438525;5900.793472228473;5251.2385704072885;5289.576833853283;5295.973520132394;5309.309789727349;5355.410904800468;5248.396434410053;5270.92093618596;5359.919601205985;5370.409254981949;5372.7045012524295;5144.61415393847;5232.9738351308;5261.316028916216;5288.338957630296;5294.549963253147;5137.357830271216;5203.427622961472;5223.895522089575;5251.474852514756;5276.050310944029;5170.379554453452;5170.844874653766;5182.844514664566;5185.377754669464;5194.4026436959475;5594.049011668027;5631.127175287796;5635.042042852725;5671.8582035449035;5700.315962084576;6147.262328520562;6202.503799696014;6216.751329946796;6223.751049957997;6262.342454042306;6248.31268560458;6249.625022498664;6255.530835187334;6263.498920086382;6274.717637706269;5625.774969001276;5947.6431414115295;5951.434613711691;5956.225690660186;5968.657052163228;6150.969245153746;6329.398707122816;6390.201224846895;6429.517786165963;6432.935670643327;5222.660527065728;6015.368386319461;6085.604435711664;6164.537659675542;6185.969070154621;6249.50003999688;6265.0602409638;6272.278687950853;6280.120783090371;6293.3391993840905;6120.020512922583;6138.75626760427;6144.003198960356;6150.630962142286;6182.227221597301;6226.377362263737;6238.906416403757;6241.656708880964;6251.6561589113035;6253.78111766086;5038.294638750578;5053.938672878737;5061.746912654353;5064.721440320818;5155.664881782672;4344.391785150082;4399;4446.777661116931;4483.282674772021;4546.818127274872;5993.580449368589;6050.092486127116;6054.666993315322;6068.120122582201;6095.116208149882;6145.709401025745;6255.905216587079;6271.811845644638;6291.591046581958;6299.590526615755;5825;5919.378465261086;5982;6010.338862725184;6108.816735497942;5517.337919449611;5519.31008623922;5535.6955367454375;5537.58468114893;5555.611107222537;6484.967575162094;6496.935030649633;6511.8697626047215;6534.281229064704;6535;6109.860177052684;6134.803982731443;6135.386461353829;6148.47737942262;6219.502439804895;5699.743511542073;6410.4871610272;6497.415232629086;6503.512236582181;6526.641034743135;5039.086890282092;5928.525717942641;6231.376862313914;6249.218847644044;6251.9062214067735;5068.847934561969;6142.385761423822;6174.475169610454;6196.225471816023;6256.06159076124;5143.4085080216255;6204.627722336674;6206.565540412308;6213.471854892385;6234.376562343729;6157.599756015845;6165.075238714228;6178.845528861814;6186.072089186658;6207.348228435949;4166.395872598517;4505.504394516535;5877.647341159544;5950.672713000827;6117.755289788537;6011.398860113954;6085.66528840918;6096.603720758137;6097.634141951497;6118.296395914527;5924.407559244041;5927.940720592911;5936.1095835625;6007.219061522149;6013.308469525886 02:47:02 INFO - PROCESS | 1931 | |1;ext.html;416.7437026228869;456.9360289559462;461.50388332542514;546.7457632201028;567.6395488864575;37679.81160094199;40362.19275614486;40425.19149617006;40460.39309410361;40510.18979620406;41941;42788;42816.35775463363;42865.78567107168;42925.57074429255;8377;8601.655933762642;9121.133492318235;9495.335326527145;11298.604548840793;9547.331686781929;11259.4370281486;11532.192746507748;11544.018758405504;11582.942085289562;11540.480678369451;11559;11560.132990025739;11573.421328933562;11602.941985290061;11514.366709830956;11558.017568506688;11569.826452603218;11573.594924177698;11589.768204635944;11535.596254131066;11584.18910676253;11594;11613.18707690462;11637.487126673479;39546.80226598877;39668.40497392541;39762;39874.20251594981;39958.60041399578;3752.2683076800035;3917.2557214129224;4015.578364271768;4018.2164477926817;4047.170330082326;29525.8470570676;30397.848010760026;30881.536776948364;31255.06234812959;32095.679043209737;2978.1363404612634;2981.478241307784;3033.362993771311;3042.1481985044225;3052.0538633023834;452679;469892;506155;509127;510154.9999999963;62482;62775;62811;62871.37128628747;62933.68533157305;65710;66498.00252996209;66693.666531668;66696.66606667936;67194.66402667956;16397.83602163987;17064.402745903833;17079.914600426917;17095.974241545548;17099.316027359015;11902.345371004678;12173;12821.102522823312;13034.413451394521;13060.34698265083;14921.626959326104;15046.022008569407;17040.829591704172;17048.82951170497;17061.829381706026;6239.438450539383;7446.627668616547;7496.287852653989;7507.549547027196;7616.885746713804;808.2281421242699;827.8079565425768;892.8214357128601;893.4058850864233;896.4845214001975;23412.64881026786;24941.750582493944;25549.48901021969;28467.71895264718;30504.54243186354;874.7725591346295;937.6296362936602;1025.2874252394515;1045.2839804733783;1068.1881769854965;13904.652383690489;16176.595585110466;16242.862999590152;16569.83430165707;16888.915555422143;317298;395060;395846.02076990006;396672;397957;58969.705151473965;58987.41012589905;59586;59798.402015979285;59856.10215846766;1422.4736847366541;1436.2459708653041;1444.415011920174;1448.8696017358488;1454.919979401122;29204.853975730835;29912;30003.69996300009;30079.69920300769;30435.934742283913;41204.58795412127;46391;47982.76008620074;48530.27204591863;48691.756541218485;385139;385151;386279;387378;389047;40206.79379618616;41247.793761031004;41319.58680413158;41367.793161034;43094;43826.342604860314;43844.68465946027;44099.11801763882;44993;45139.54860451353;36527.63472365242;36780.26439471249;36873.81563092167;37517;38154.42768358532;36394;36445;36896.89309320725;37070.07324816793;37571.06072348213;35588.93233203008;35659;36022.81988590145;36444.635553644126;36596;31012.0696379109;31334.529982050743;32532.349353012334;33013.00960971175;33070;20997.160113595895;24289.27132186037;24304.878475607507;24713.382165446008;24821.751782481944 02:47:02 INFO - PROCESS | 1931 | |2;jquery.html;369.28911844698956;395.63601486632297;398.7826634484206;399.15578551363853;419.42119874573086;16419.83580164198;19845.900770496144;20855.165793368284;21153.36539903805;21218.939053047343;21236.68144977823;21545.78454215461;21726.456838579044;22001.779982200173;22201.555968880653;5536.667799931997;5901.350851406363;5947.88104237915;5960.5529585281065;5964.582479226456;4413.713108647944;5049.2678561608545;5741.741621627037;5794.275715535558;5798.971005144968;4859.441164266102;5790.826275211751;5795.82612521625;5798.739056742456;5812.970935145339;5752.453516915907;5789.565782566303;7294.708211671526;7616.162222155558;7705.6917723291;6342.492600591988;7363.742269020612;7638.083429988437;7648.464607477423;7653.885191722128;23990;29652.40695186084;29759.40481190364;29830.105096847128;29997.550036749468;2880.4527139843362;2886.942261154786;2904.695007024274;2924.912252632403;2990.7158819912074;17407.825921740747;17493;17550.297988080463;17709.822901770945;17737.731774517782;1975.2395327798756;1983.8313743331835;1997.5405656698895;2001.5696625225646;2023.3221870673342;165919;167688;170187.14906425512;170715;174081;25033.874830626093;25281.241562753148;25379.98480060777;25522.489550209262;25549.616755748677;12229.205101668364;12903.612891613078;43315.35026974598;43604.127917441474;43664;8357.289630381485;8399.034111077182;8529.82940341202;8603.91396086031;8607.913920860836;8782.121787821166;8788.033316335199;8820.073892241351;8937.821243575092;8946.731598052069;4061.045654271244;4139.441175441277;4140.627343539036;4179.811908464127;4207.200631879933;1544.5675210940954;1933.1011079847938;2047.129969762845;2061.1446249806463;2070.8032736889973;978.9853152202722;999.8250306196531;1031.7523794289316;1043.5356266461504;1068.0761141612604;22640.547189056128;23057.53884922292;23120.7687923122;23206.65190022151;23230.83845807703;1037.7716902281486;1054.082947835388;1057.4818339013827;1069.427856097;1073.6403304892792;11485.483153258123;12436.942859856832;12474.563390281297;12741.426635801412;12853.485860565472;764477;794776;805041;814293;819878;125511;163331;164488;166292.16853915653;168173;923.3628796130514;1048.7483004078965;1058.957641694339;1087.8205096159045;1093.5680406239492;19354.225830966603;20418.795812042285;20984.790152098285;21335.573288533833;21540.892295538422;59383.70308148432;61613.383866162556;62360;62498.99999999818;62689;84281;85066.14933850583;85551;86765;88533;6621.304763000008;8234.711785087493;8314.043884953307;8773.42972706772;8938.10618938101;9280.675176368795;12995.805062924253;13200;13607.455701771818;13676.93161534186;11316.807865286071;11559.133065019989;11800.881991180322;11831;11837.408129593658;11269.887301126884;11285.153613479186;11449.198556100993;11772.999295059673;11788.764224715285;8971.237444817263;11296.378699171624;11408;11809.527618895148;11844.585439509576;6388.776392826228;7108.324709152622;7665.961670191613;8274.875876861732;8912.28701703875;11107.888921110685;11263.26788758728;11266.211365204357;11286;11386.487608057823 02:47:02 INFO - PROCESS | 1931 | |3;mootools.html;1213.599512160987;1420.8010878477014;1424.145512692384;1431.7208144411838;1442.7763696627019;6328.968355158224;7655.043119610049;7916.96041519793;8666.523341216238;8668.609912553935;7263.636818159097;8025.719099831507;8448.873266901;8567.143285671445;8593.742187734362;2339.099446713019;2379.988100059506;2385.1413491143176;2385.3917251100943;2402.3994001499627;1974.190581861437;2084.405944305873;2157.8489505734606;2353.9646905296436;2391.8564886106888;2260.5930932432157;2358.174638876388;2361.8582885026867;2362.444825466023;2371.964420533685;2351.600227961242;2359.2568340972625;2371.5968285391436;2373.6320870265135;2379.0840526397287;2341.2039906431723;2358.8348815582917;2362.267697013914;2371.6916800815957;2398.2085911649287;8577.828443431159;8638.481691098554;8658.393912426132;8665.523396213206;8668.00317963436;5199.324087868591;5332.173513105436;5367.570594352443;5376.489233522809;5390.137577987503;2846.501862174132;3377.3414184234084;3455.2398472336045;3611.368010598161;3613.6205698401814;1154.94899641326;1186.6440067979659;1187.590281352932;1257.9496820127276;1270.8856202941688;11093.778124437466;11116.999470047655;11129.833052504218;11153.72115697106;11162.776744465065;4652.441706995182;4761;4812.903741925212;4828.37231159954;4843.370361852936;9688.031196880256;9775.853362199572;9779.41323520591;9787.070228328297;9796.657117001014;5269.710165940834;5383.78464861409;5386.13821788512;5397.59518036141;5400.91898621521;4357.891052723644;4812.25410061441;4866.245731911559;4907.852764417074;4910.533499317559;3750.1937083527173;3803.0872590578615;3817.0457385653585;3848.153406250676;3880.7477513961503;998.7515605493134;1102.2945314998408;1117.1118960426481;1181.6632259805915;1186.3356520348632;875.5053394831899;891.8305521950808;898.0660113482036;898.6719847255705;908.1917093786535;4680.9297860532115;5535.335759708861;5575.884823035409;5706.9429305707245;5784.855378615484;951.4576691286039;987.4766373821742;1001.3891526169031;1016.832222683249;1029.6396261308632;3798.734088613826;3893.9415908761393;3908.882733517999;3919.4904662393706;3920.666743326792;10022.148117409955;10268.794624107475;10333.483325833678;10337.431441270652;10340.27618066728;10212.131968782589;10269.178465722724;10306.690799276033;10337.328073675188;10366.326188797704;7884.448088633855;7998;8113.350931925432;8137.5117492951795;8138.633761480747;5490;5526.253955716088;5583.385827558884;5675.772969081356;5803.303603567599;9108.499032553009;9366;9400.388974716621;9407.200387966826;9449.007854175488;8218.712345067894;9359.485228312236;9527.190188833749;9590.328676992543;9636.180924621485;6085.786997455068;6701.798946031627;6940.652967351713;7402.518836275625;7427.368673662799;6685.465162786868;7783.766487005399;7815.648295826815;8047.678092876219;8214.424990250625;6468.773592924225;7263.854722905407;7292.708291668274;7402.592857392679;7415.258474152757;5812.912806307824;5916.668749531493;7129.750458734127;7186.532875363294;7238.167610724834;5359.249705041375;6403.167588213502;6422.068800023877;6478.2550006749825;6494.837629059311;4905.975470122627;4921.188003979303;5055.443901170942;5088.084144853962;5197.298364720715;4941.332920055746;5068.695878247169;5070.847874563769;5143.794248230179;5255.658382205144 02:47:02 INFO - PROCESS | 1931 | |4;prototype.html;345.7320576553171;362.9239305459313;366.5729425219619;367.44699227662363;371.2056199732573;5414.593905457092;5431.782728690848;5476.577139287945;5482.342118945722;5489.533389661883;5309.469053094688;5348.304720386354;5364.693181931768;5395.762542474513;5429.56563474922;3559.5728512578526;3824.216035712679;3855.8264878080554;3885.5612782687385;4075.735077219986;4087.7138600297844;4090;4096.6927480438935;4100.651444627195;4122.917541649165;3117.688231176887;3847.461355410245;4078.653314468259;4090.406891000803;4092.774897380643;3958.782266975315;3998.3850950252004;4038.7172897896867;4059.147579008397;4103.753774773523;3506.0708912138302;3509.859605615772;3510.140015696171;3510.9824450877836;3519.278547897675;4625.7455839929125;5144.768485418165;5225.033368826779;5267.657602255841;5299.443558426348;4470.26240670289;4640.559146881041;4677.415323084614;4708.8463326485235;4715.278923193044;5687.772489100431;5711.05767548354;5726.942730572682;5732.885342293131;5736.541076713853;3118.3763247350394;3446.8621255149765;3880.1269714314335;3882.9223415531533;3885.26180025797;5034.798608055673;5155.871103222412;5682.488576028178;6024.759009639609;6045.576809623328;3621.6559426854406;3727.440883867387;3805.980970095132;3905.5508616509464;3909.7654140751647;3140.921896541402;3219.036387803438;3967.8809635710977;3986.0901541874596;3991.9201615967518;3742.700583953277;4414.792603698151;4640.814367425265;4668.229742092517;4668.85993420198;5081.568066714371;5238.7904483820985;5373.489518495737;5710.600257981901;5777.682227477445;1296.883280504759;1299.3503248375812;1300.3810256231052;1314.9539766108333;1328.7276108397755;786.6381464526268;810.8297257575975;838.6393850644281;884.6859364925488;885.5793498088357;4133.731307465006;4412.713173643703;4450.641160185107;5037.773300201499;5062.7468626568525;5003.849884503471;5507.03626865297;5616.410276920865;5618.522425593788;5628.523449682127;3901.297766402075;4483.910321793546;4587.3807036050375;4605.953940460552;4697.412823397075;2326.9418264543183;2439.7682220189054;2676.812623116402;2884.178009267349;2884.639420072491;4851.58761505276;5233.1365324721755;5330.440303768126;5655.971720141373;5760.6255593386295;5141.262886726092;5149.995750828552;5180.507851754077;5528.75120619565;5823.155642431823;4914.950850491521;5225.921611175835;5270.3661864822025;5672.432756724294;5865.706714664335;5635.211070450222;5649.6327738696855;5693.373728889736;5696.772129114955;5721.914171287351;4581.74800385982;5262.578993680573;5449.809256675997;5601.663900166003;5892;5130.97434512825;6123.469132716821;6129.670725124424;6132.233470816148;6166.242620853035;3360.6639336066196;3910.4916360872903;3951.6048395160255;3954.3475326570792;4029.2545879012478;4751.244278318636;5405.972970135124;5848.040906296438;5914.704264786829;5942.989691752326;4552.590266875997;5040.344755181803;5248.448912864094;5437.619366644297;5709.4307561596615;4220.38804373358;4310.986918074313;4753.334533165429;5718.742656580381;5755.856103597276;4657.86026419208;4899.31409602663;5205.791768329224;5597.944020559742;5604.2154098425435;5002.899942001212;5353.384360798403;5733.254676891977;5735.483806457439;5773.913391299218;4978.103941290457;5387.299651045339;5556.9444305558045;5591.6365436246515;5608.8878222434505 02:47:02 INFO - PROCESS | 1931 | |5;yui.html;668.324991758324;705.756514002669;715.7280233511261;758.268271118371;813.4712436916004;11580.768384632302;15349.923250383732;15683.764743528842;15687.980281281709;15839.683206335867;14170.574882753508;14386.352614132364;14467.05964112332;14581.416743330254;14656;681.492288245258;852.7271273192581;854.700854700856;855.285836326668;857.7855536115972;683.1324218242829;702.6205848841645;832.3757182113415;861.9482831030127;864.2610567964394;838.6393850644221;889.902110767815;908.4503875155502;910.1171863292628;910.1853840812469;898.0480690468092;903.6701603914589;905.08134243742;905.7690288976335;906.0893801729253;668.8729141463107;674.3054653706641;674.382939610256;674.6019848289533;676.1311714446912;14843.703125937529;15079.54761357161;15115.31981060855;15176.468823591122;15355.232238388036;13758.587242382744;13871;14008.22954737489;14066.901495918657;14172.929135354258;11563;11635.069194464422;11676;11749.706257343549;11759.294442333487;3585.94621080684;3617.8001344722124;3653.799041052741;3712.2204337088974;3735.7571757835653;101709.491452543;101927.96144077151;102047;102131;102213.46679799809;10597.735056623646;10674.73313167177;10706.304090234109;10727.946360268148;10739.301945373525;22070;22255.888720556617;22286.3314100574;22380;22400.663990040164;7729.6521656524465;7784.9610751945875;7789.766307010798;7835.412344074217;7980.720674776355;3748.756330838487;4307.18163548931;4339.830084957522;4363.345498175299;4391.802368893407;3131.185891668137;3590.533230679995;3634.982204982609;3705.7220708446976;3732.4774531565604;660.389140045456;666.8966310221923;674.7739507265023;685.1230425055936;687.08274453604;658.9769358072444;677.9830504237434;693.1889689063706;708.3058602569408;719.9532030418111;10162.4918754062;10433.217508686726;10452.216083793746;10604.628837990633;10608.257421980541;664.9368310010541;683.5420268420171;708.6775517139793;710.5345998371075;723.3273056057816;4936.969039431014;4940.110780059552;4975.573913734235;4978.153713868651;4999.0251900878975;96414.51792740992;104779.476102619;105320.47339763252;105455;111154.44422777997;92152;93721.53139234397;95015;98098.01901981032;98109;86263;87272.5636371814;88387;88738.55630721805;90282;9637.614495420105;9715.951420243136;9756.951215243878;9771.560279787285;9777.804443911224;53521.46478535321;54049.72975135099;55175;55559;56848.14727779169;71608.49370272015;73851.63074184595;74675.01299948158;75196;76444.61777691076;9790.902090979;10277.897221027994;11383.089352851917;11791.705207369885;11999.940000300292;10582.947085264525;12205.145639805129;12547.49810007626;13080.215187088805;13096.083274170716;11563.6530904073;11749.88250117488;11813.704657383634;12146.210496317712;12156.574519891761;11904.226225295328;11920.463579139134;12166.817497737718;12253.387330633612;12522.060845436446;11257.887421125684;11712.70718232017;11743.88256117428;11751.118666100248;12124.818127728267;8690.435121717068;9552.570134343832;9957.402555846673;10368.118709909742;10374.533146008296;9650.662226822027;9843.114119729258;9857.753556161153;9872.753181170528;9875 02:47:02 INFO - PROCESS | 1931 | __end_tp_report 02:47:02 INFO - PROCESS | 1931 | __start_cc_report 02:47:02 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,376 02:47:02 INFO - PROCESS | 1931 | __end_cc_report 02:47:02 INFO - PROCESS | 1931 | __startTimestamp1486982822086__endTimestamp 02:47:02 INFO - PROCESS | 1931 | 02:47:02 INFO - PROCESS | 1931 | ------- Summary: start ------- 02:47:02 INFO - PROCESS | 1931 | Number of tests: 6 02:47:02 INFO - PROCESS | 1931 | 02:47:02 INFO - PROCESS | 1931 | [#0] dojo.html Cycles:165 Average:5749.10 Median:6007.22 stddev:671.80 (11.2%) stddev-sans-first:640.26 02:47:02 INFO - PROCESS | 1931 | Values: 3074.6 3382.9 3392.7 3403.3 3433.9 5729.5 5782.4 5802.6 5819.0 5837.9 4669.7 5786.9 5816.2 5832.7 5900.8 5251.2 5289.6 5296.0 5309.3 5355.4 5248.4 5270.9 5359.9 5370.4 5372.7 5144.6 5233.0 5261.3 5288.3 5294.5 5137.4 5203.4 5223.9 5251.5 5276.1 5170.4 5170.8 5182.8 5185.4 5194.4 5594.0 5631.1 5635.0 5671.9 5700.3 6147.3 6202.5 6216.8 6223.8 6262.3 6248.3 6249.6 6255.5 6263.5 6274.7 5625.8 5947.6 5951.4 5956.2 5968.7 6151.0 6329.4 6390.2 6429.5 6432.9 5222.7 6015.4 6085.6 6164.5 6186.0 6249.5 6265.1 6272.3 6280.1 6293.3 6120.0 6138.8 6144.0 6150.6 6182.2 6226.4 6238.9 6241.7 6251.7 6253.8 5038.3 5053.9 5061.7 5064.7 5155.7 4344.4 4399.0 4446.8 4483.3 4546.8 5993.6 6050.1 6054.7 6068.1 6095.1 6145.7 6255.9 6271.8 6291.6 6299.6 5825.0 5919.4 5982.0 6010.3 6108.8 5517.3 5519.3 5535.7 5537.6 5555.6 6485.0 6496.9 6511.9 6534.3 6535.0 6109.9 6134.8 6135.4 6148.5 6219.5 5699.7 6410.5 6497.4 6503.5 6526.6 5039.1 5928.5 6231.4 6249.2 6251.9 5068.8 6142.4 6174.5 6196.2 6256.1 5143.4 6204.6 6206.6 6213.5 6234.4 6157.6 6165.1 6178.8 6186.1 6207.3 4166.4 4505.5 5877.6 5950.7 6117.8 6011.4 6085.7 6096.6 6097.6 6118.3 5924.4 5927.9 5936.1 6007.2 6013.3 02:47:02 INFO - PROCESS | 1931 | 02:47:02 INFO - PROCESS | 1931 | [#1] ext.html Cycles:180 Average:58017.71 Median:37293.54 stddev:111744.09 (299.6%) stddev-sans-first:111973.87 02:47:02 INFO - PROCESS | 1931 | Values: 416.7 456.9 461.5 546.7 567.6 37679.8 40362.2 40425.2 40460.4 40510.2 41941.0 42788.0 42816.4 42865.8 42925.6 8377.0 8601.7 9121.1 9495.3 11298.6 9547.3 11259.4 11532.2 11544.0 11582.9 11540.5 11559.0 11560.1 11573.4 11602.9 11514.4 11558.0 11569.8 11573.6 11589.8 11535.6 11584.2 11594.0 11613.2 11637.5 39546.8 39668.4 39762.0 39874.2 39958.6 3752.3 3917.3 4015.6 4018.2 4047.2 29525.8 30397.8 30881.5 31255.1 32095.7 2978.1 2981.5 3033.4 3042.1 3052.1 452679.0 469892.0 506155.0 509127.0 510155.0 62482.0 62775.0 62811.0 62871.4 62933.7 65710.0 66498.0 66693.7 66696.7 67194.7 16397.8 17064.4 17079.9 17096.0 17099.3 11902.3 12173.0 12821.1 13034.4 13060.3 14921.6 15046.0 17040.8 17048.8 17061.8 6239.4 7446.6 7496.3 7507.5 7616.9 808.2 827.8 892.8 893.4 896.5 23412.6 24941.8 25549.5 28467.7 30504.5 874.8 937.6 1025.3 1045.3 1068.2 13904.7 16176.6 16242.9 16569.8 16888.9 317298.0 395060.0 395846.0 396672.0 397957.0 58969.7 58987.4 59586.0 59798.4 59856.1 1422.5 1436.2 1444.4 1448.9 1454.9 29204.9 29912.0 30003.7 30079.7 30435.9 41204.6 46391.0 47982.8 48530.3 48691.8 385139.0 385151.0 386279.0 387378.0 389047.0 40206.8 41247.8 41319.6 41367.8 43094.0 43826.3 43844.7 44099.1 44993.0 45139.5 36527.6 36780.3 36873.8 37517.0 38154.4 36394.0 36445.0 36896.9 37070.1 37571.1 35588.9 35659.0 36022.8 36444.6 36596.0 31012.1 31334.5 32532.3 33013.0 33070.0 20997.2 24289.3 24304.9 24713.4 24821.8 02:47:02 INFO - PROCESS | 1931 | 02:47:02 INFO - PROCESS | 1931 | [#2] jquery.html Cycles:180 Average:44778.57 Median:25451.24 stddev:133598.07 (524.9%) stddev-sans-first:133931.23 02:47:02 INFO - PROCESS | 1931 | Values: 369.3 395.6 398.8 399.2 419.4 16419.8 19845.9 20855.2 21153.4 21218.9 21236.7 21545.8 21726.5 22001.8 22201.6 5536.7 5901.4 5947.9 5960.6 5964.6 4413.7 5049.3 5741.7 5794.3 5799.0 4859.4 5790.8 5795.8 5798.7 5813.0 5752.5 5789.6 7294.7 7616.2 7705.7 6342.5 7363.7 7638.1 7648.5 7653.9 23990.0 29652.4 29759.4 29830.1 29997.6 2880.5 2886.9 2904.7 2924.9 2990.7 17407.8 17493.0 17550.3 17709.8 17737.7 1975.2 1983.8 1997.5 2001.6 2023.3 165919.0 167688.0 170187.1 170715.0 174081.0 25033.9 25281.2 25380.0 25522.5 25549.6 12229.2 12903.6 43315.4 43604.1 43664.0 8357.3 8399.0 8529.8 8603.9 8607.9 8782.1 8788.0 8820.1 8937.8 8946.7 4061.0 4139.4 4140.6 4179.8 4207.2 1544.6 1933.1 2047.1 2061.1 2070.8 979.0 999.8 1031.8 1043.5 1068.1 22640.5 23057.5 23120.8 23206.7 23230.8 1037.8 1054.1 1057.5 1069.4 1073.6 11485.5 12436.9 12474.6 12741.4 12853.5 764477.0 794776.0 805041.0 814293.0 819878.0 125511.0 163331.0 164488.0 166292.2 168173.0 923.4 1048.7 1059.0 1087.8 1093.6 19354.2 20418.8 20984.8 21335.6 21540.9 59383.7 61613.4 62360.0 62499.0 62689.0 84281.0 85066.1 85551.0 86765.0 88533.0 6621.3 8234.7 8314.0 8773.4 8938.1 9280.7 12995.8 13200.0 13607.5 13676.9 11316.8 11559.1 11800.9 11831.0 11837.4 11269.9 11285.2 11449.2 11773.0 11788.8 8971.2 11296.4 11408.0 11809.5 11844.6 6388.8 7108.3 7666.0 8274.9 8912.3 11107.9 11263.3 11266.2 11286.0 11386.5 02:47:02 INFO - PROCESS | 1931 | 02:47:02 INFO - PROCESS | 1931 | [#3] mootools.html Cycles:180 Average:5479.62 Median:5170.55 stddev:3016.87 (58.3%) stddev-sans-first:3008.29 02:47:02 INFO - PROCESS | 1931 | Values: 1213.6 1420.8 1424.1 1431.7 1442.8 6329.0 7655.0 7917.0 8666.5 8668.6 7263.6 8025.7 8448.9 8567.1 8593.7 2339.1 2380.0 2385.1 2385.4 2402.4 1974.2 2084.4 2157.8 2354.0 2391.9 2260.6 2358.2 2361.9 2362.4 2372.0 2351.6 2359.3 2371.6 2373.6 2379.1 2341.2 2358.8 2362.3 2371.7 2398.2 8577.8 8638.5 8658.4 8665.5 8668.0 5199.3 5332.2 5367.6 5376.5 5390.1 2846.5 3377.3 3455.2 3611.4 3613.6 1154.9 1186.6 1187.6 1257.9 1270.9 11093.8 11117.0 11129.8 11153.7 11162.8 4652.4 4761.0 4812.9 4828.4 4843.4 9688.0 9775.9 9779.4 9787.1 9796.7 5269.7 5383.8 5386.1 5397.6 5400.9 4357.9 4812.3 4866.2 4907.9 4910.5 3750.2 3803.1 3817.0 3848.2 3880.7 998.8 1102.3 1117.1 1181.7 1186.3 875.5 891.8 898.1 898.7 908.2 4680.9 5535.3 5575.9 5706.9 5784.9 951.5 987.5 1001.4 1016.8 1029.6 3798.7 3893.9 3908.9 3919.5 3920.7 10022.1 10268.8 10333.5 10337.4 10340.3 10212.1 10269.2 10306.7 10337.3 10366.3 7884.4 7998.0 8113.4 8137.5 8138.6 5490.0 5526.3 5583.4 5675.8 5803.3 9108.5 9366.0 9400.4 9407.2 9449.0 8218.7 9359.5 9527.2 9590.3 9636.2 6085.8 6701.8 6940.7 7402.5 7427.4 6685.5 7783.8 7815.6 8047.7 8214.4 6468.8 7263.9 7292.7 7402.6 7415.3 5812.9 5916.7 7129.8 7186.5 7238.2 5359.2 6403.2 6422.1 6478.3 6494.8 4906.0 4921.2 5055.4 5088.1 5197.3 4941.3 5068.7 5070.8 5143.8 5255.7 02:47:02 INFO - PROCESS | 1931 | 02:47:02 INFO - PROCESS | 1931 | [#4] prototype.html Cycles:180 Average:4463.34 Median:5003.37 stddev:1388.17 (27.7%) stddev-sans-first:1357.22 02:47:02 INFO - PROCESS | 1931 | Values: 345.7 362.9 366.6 367.4 371.2 5414.6 5431.8 5476.6 5482.3 5489.5 5309.5 5348.3 5364.7 5395.8 5429.6 3559.6 3824.2 3855.8 3885.6 4075.7 4087.7 4090.0 4096.7 4100.7 4122.9 3117.7 3847.5 4078.7 4090.4 4092.8 3958.8 3998.4 4038.7 4059.1 4103.8 3506.1 3509.9 3510.1 3511.0 3519.3 4625.7 5144.8 5225.0 5267.7 5299.4 4470.3 4640.6 4677.4 4708.8 4715.3 5687.8 5711.1 5726.9 5732.9 5736.5 3118.4 3446.9 3880.1 3882.9 3885.3 5034.8 5155.9 5682.5 6024.8 6045.6 3621.7 3727.4 3806.0 3905.6 3909.8 3140.9 3219.0 3967.9 3986.1 3991.9 3742.7 4414.8 4640.8 4668.2 4668.9 5081.6 5238.8 5373.5 5710.6 5777.7 1296.9 1299.4 1300.4 1315.0 1328.7 786.6 810.8 838.6 884.7 885.6 4133.7 4412.7 4450.6 5037.8 5062.7 5003.8 5507.0 5616.4 5618.5 5628.5 3901.3 4483.9 4587.4 4606.0 4697.4 2326.9 2439.8 2676.8 2884.2 2884.6 4851.6 5233.1 5330.4 5656.0 5760.6 5141.3 5150.0 5180.5 5528.8 5823.2 4915.0 5225.9 5270.4 5672.4 5865.7 5635.2 5649.6 5693.4 5696.8 5721.9 4581.7 5262.6 5449.8 5601.7 5892.0 5131.0 6123.5 6129.7 6132.2 6166.2 3360.7 3910.5 3951.6 3954.3 4029.3 4751.2 5406.0 5848.0 5914.7 5943.0 4552.6 5040.3 5248.4 5437.6 5709.4 4220.4 4311.0 4753.3 5718.7 5755.9 4657.9 4899.3 5205.8 5597.9 5604.2 5002.9 5353.4 5733.3 5735.5 5773.9 4978.1 5387.3 5556.9 5591.6 5608.9 02:47:02 INFO - PROCESS | 1931 | 02:47:02 INFO - PROCESS | 1931 | [#5] yui.html Cycles:180 Average:20907.10 Median:4938.54 stddev:30783.14 (623.3%) stddev-sans-first:30831.98 02:47:02 INFO - PROCESS | 1931 | Values: 668.3 705.8 715.7 758.3 813.5 11580.8 15349.9 15683.8 15688.0 15839.7 14170.6 14386.4 14467.1 14581.4 14656.0 681.5 852.7 854.7 855.3 857.8 683.1 702.6 832.4 861.9 864.3 838.6 889.9 908.5 910.1 910.2 898.0 903.7 905.1 905.8 906.1 668.9 674.3 674.4 674.6 676.1 14843.7 15079.5 15115.3 15176.5 15355.2 13758.6 13871.0 14008.2 14066.9 14172.9 11563.0 11635.1 11676.0 11749.7 11759.3 3585.9 3617.8 3653.8 3712.2 3735.8 101709.5 101928.0 102047.0 102131.0 102213.5 10597.7 10674.7 10706.3 10727.9 10739.3 22070.0 22255.9 22286.3 22380.0 22400.7 7729.7 7785.0 7789.8 7835.4 7980.7 3748.8 4307.2 4339.8 4363.3 4391.8 3131.2 3590.5 3635.0 3705.7 3732.5 660.4 666.9 674.8 685.1 687.1 659.0 678.0 693.2 708.3 720.0 10162.5 10433.2 10452.2 10604.6 10608.3 664.9 683.5 708.7 710.5 723.3 4937.0 4940.1 4975.6 4978.2 4999.0 96414.5 104779.5 105320.5 105455.0 111154.4 92152.0 93721.5 95015.0 98098.0 98109.0 86263.0 87272.6 88387.0 88738.6 90282.0 9637.6 9716.0 9757.0 9771.6 9777.8 53521.5 54049.7 55175.0 55559.0 56848.1 71608.5 73851.6 74675.0 75196.0 76444.6 9790.9 10277.9 11383.1 11791.7 11999.9 10582.9 12205.1 12547.5 13080.2 13096.1 11563.7 11749.9 11813.7 12146.2 12156.6 11904.2 11920.5 12166.8 12253.4 12522.1 11257.9 11712.7 11743.9 11751.1 12124.8 8690.4 9552.6 9957.4 10368.1 10374.5 9650.7 9843.1 9857.8 9872.8 9875.0 02:47:02 INFO - PROCESS | 1931 | -------- Summary: end -------- 02:47:02 INFO - PROCESS | 1931 | 02:47:02 INFO - TEST-INFO | 1931: exit 0 02:47:02 INFO - TEST-OK | dromaeo_css | took 1114360ms 02:47:02 INFO - TEST-START | kraken 02:47:02 INFO - operating with platform_type : mac_ 02:47:02 INFO - Initialising browser for kraken test... 02:47:02 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpEkJBJF/profile http://localhost:56584/getInfo.html) 02:47:05 INFO - PROCESS | 1937 | 2017-02-13 02:47:05.830 plugin-container[1938:22303] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 02:47:05 INFO - PROCESS | 1937 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:05 INFO - PROCESS | 1937 | 2017-02-13 02:47:05.833 plugin-container[1938:22303] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 02:47:05 INFO - PROCESS | 1937 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:05 INFO - PROCESS | 1937 | 2017-02-13 02:47:05.833 plugin-container[1938:22303] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:47:05 INFO - PROCESS | 1937 | __metrics Screen width/height:1600/1200 02:47:05 INFO - PROCESS | 1937 | colorDepth:24 02:47:05 INFO - PROCESS | 1937 | Browser inner width/height: 1024/689 02:47:05 INFO - PROCESS | 1937 | __metrics 02:47:06 ERROR - PROCESS | 1937 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 02:47:06 INFO - TEST-INFO | 1937: exit 0 02:47:06 INFO - Browser initialized. 02:47:06 INFO - Running cycle 1/1 for kraken test... 02:47:06 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpEkJBJF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:09 INFO - PROCESS | 1939 | 2017-02-13 02:47:09.192 plugin-container[1940:22430] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8743, name = 'com.apple.tsm.portname' 02:47:09 INFO - PROCESS | 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:09 INFO - PROCESS | 1939 | 2017-02-13 02:47:09.192 plugin-container[1940:22430] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8823, name = 'com.apple.CFPasteboardClient' 02:47:09 INFO - PROCESS | 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:09 INFO - PROCESS | 1939 | 2017-02-13 02:47:09.192 plugin-container[1940:22430] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:47:18 INFO - PROCESS | 1939 | RSS: Main: 218902528 02:47:18 INFO - PROCESS | 1939 | 02:47:21 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56584/tests/kraken/driver.html?testName=audio-beat-detection) 02:47:22 INFO - PROCESS | 1939 | RSS: Main: 233037824 02:47:22 INFO - PROCESS | 1939 | 02:47:25 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56584/tests/kraken/driver.html?testName=audio-dft) 02:47:25 INFO - PROCESS | 1939 | RSS: Main: 242024448 02:47:25 INFO - PROCESS | 1939 | 02:47:29 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56584/tests/kraken/driver.html?testName=audio-fft) 02:47:29 INFO - PROCESS | 1939 | RSS: Main: 244944896 02:47:29 INFO - PROCESS | 1939 | 02:47:31 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56584/tests/kraken/driver.html?testName=audio-oscillator) 02:47:32 INFO - PROCESS | 1939 | RSS: Main: 244985856 02:47:32 INFO - PROCESS | 1939 | 02:47:34 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56584/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:47:35 INFO - PROCESS | 1939 | RSS: Main: 245026816 02:47:35 INFO - PROCESS | 1939 | 02:47:38 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56584/tests/kraken/driver.html?testName=imaging-darkroom) 02:47:38 INFO - PROCESS | 1939 | RSS: Main: 249085952 02:47:38 INFO - PROCESS | 1939 | 02:47:41 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56584/tests/kraken/driver.html?testName=imaging-desaturate) 02:47:42 INFO - PROCESS | 1939 | RSS: Main: 248610816 02:47:42 INFO - PROCESS | 1939 | 02:47:45 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56584/tests/kraken/driver.html?testName=json-parse-financial) 02:47:46 INFO - PROCESS | 1939 | RSS: Main: 249671680 02:47:46 INFO - PROCESS | 1939 | 02:47:48 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56584/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:47:48 INFO - PROCESS | 1939 | RSS: Main: 249286656 02:47:48 INFO - PROCESS | 1939 | 02:47:50 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56584/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:47:51 INFO - PROCESS | 1939 | RSS: Main: 249319424 02:47:51 INFO - PROCESS | 1939 | 02:47:53 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56584/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:47:54 INFO - PROCESS | 1939 | RSS: Main: 249389056 02:47:54 INFO - PROCESS | 1939 | 02:47:57 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:47:58 INFO - PROCESS | 1939 | RSS: Main: 249651200 02:47:58 INFO - PROCESS | 1939 | 02:48:00 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:48:01 INFO - PROCESS | 1939 | RSS: Main: 249507840 02:48:01 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56584/tests/kraken/driver.html?testName=ai-astar) 02:48:03 INFO - PROCESS | 1939 | RSS: Main: 251396096 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | __start_tp_report 02:48:03 INFO - PROCESS | 1939 | _x_x_mozilla_page_load 02:48:03 INFO - PROCESS | 1939 | _x_x_mozilla_page_load_details 02:48:03 INFO - PROCESS | 1939 | |i|pagename|runs| 02:48:03 INFO - PROCESS | 1939 | |0;ai-astar;105;117;120;119;120;115;120;119;118;119 02:48:03 INFO - PROCESS | 1939 | |1;audio-beat-detection;150;119;116;151;145;116;116;114;132;117 02:48:03 INFO - PROCESS | 1939 | |2;audio-dft;191;205;200;202;197;197;194;241;277;199 02:48:03 INFO - PROCESS | 1939 | |3;audio-fft;85;76;84;96;60;58;60;61;69;60 02:48:03 INFO - PROCESS | 1939 | |4;audio-oscillator;90;72;85;74;70;72;80;69;71;82 02:48:03 INFO - PROCESS | 1939 | |5;imaging-gaussian-blur;83;132;136;89;90;87;91;87;90;90 02:48:03 INFO - PROCESS | 1939 | |6;imaging-darkroom;152;154;97;97;96;95;94;151;154;134 02:48:03 INFO - PROCESS | 1939 | |7;imaging-desaturate;105;128;76;139;88;107;146;149;101;145 02:48:03 INFO - PROCESS | 1939 | |8;json-parse-financial;56;58;55;56;66;60;59;59;61;60 02:48:03 INFO - PROCESS | 1939 | |9;json-stringify-tinderbox;70;69;73;73;80;72;70;71;70;109 02:48:03 INFO - PROCESS | 1939 | |10;stanford-crypto-aes;104;105;112;77;106;106;106;108;89;91 02:48:03 INFO - PROCESS | 1939 | |11;stanford-crypto-ccm;149;167;144;136;140;186;158;137;193;144 02:48:03 INFO - PROCESS | 1939 | |12;stanford-crypto-pbkdf2;168;169;179;163;172;173;172;160;187;170 02:48:03 INFO - PROCESS | 1939 | |13;stanford-crypto-sha256-iterative;68;71;67;67;68;66;70;69;67;65 02:48:03 INFO - PROCESS | 1939 | __end_tp_report 02:48:03 INFO - PROCESS | 1939 | __start_cc_report 02:48:03 INFO - PROCESS | 1939 | _x_x_mozilla_cycle_collect,934 02:48:03 INFO - PROCESS | 1939 | __end_cc_report 02:48:03 INFO - PROCESS | 1939 | __startTimestamp1486982883580__endTimestamp 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | ------- Summary: start ------- 02:48:03 INFO - PROCESS | 1939 | Number of tests: 14 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#0] ai-astar Cycles:10 Average:117.20 Median:119.00 stddev:4.57 (3.8%) stddev-sans-first:1.67 02:48:03 INFO - PROCESS | 1939 | Values: 105.0 117.0 120.0 119.0 120.0 115.0 120.0 119.0 118.0 119.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:125.50 stddev:15.44 (12.3%) stddev-sans-first:14.09 02:48:03 INFO - PROCESS | 1939 | Values: 150.0 119.0 116.0 151.0 145.0 116.0 116.0 114.0 132.0 117.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#2] audio-dft Cycles:10 Average:210.30 Median:201.00 stddev:27.31 (13.6%) stddev-sans-first:28.06 02:48:03 INFO - PROCESS | 1939 | Values: 191.0 205.0 200.0 202.0 197.0 197.0 194.0 241.0 277.0 199.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#3] audio-fft Cycles:10 Average:70.90 Median:72.50 stddev:13.54 (18.7%) stddev-sans-first:13.37 02:48:03 INFO - PROCESS | 1939 | Values: 85.0 76.0 84.0 96.0 60.0 58.0 60.0 61.0 69.0 60.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:77.00 stddev:7.25 (9.4%) stddev-sans-first:5.81 02:48:03 INFO - PROCESS | 1939 | Values: 90.0 72.0 85.0 74.0 70.0 72.0 80.0 69.0 71.0 82.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#5] imaging-gaussian-blur Cycles:10 Average:97.50 Median:89.50 stddev:19.40 (21.7%) stddev-sans-first:19.85 02:48:03 INFO - PROCESS | 1939 | Values: 83.0 132.0 136.0 89.0 90.0 87.0 91.0 87.0 90.0 90.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#6] imaging-darkroom Cycles:10 Average:122.40 Median:94.50 stddev:28.62 (30.3%) stddev-sans-first:28.28 02:48:03 INFO - PROCESS | 1939 | Values: 152.0 154.0 97.0 97.0 96.0 95.0 94.0 151.0 154.0 134.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#7] imaging-desaturate Cycles:10 Average:118.40 Median:145.50 stddev:26.37 (18.1%) stddev-sans-first:27.52 02:48:03 INFO - PROCESS | 1939 | Values: 105.0 128.0 76.0 139.0 88.0 107.0 146.0 149.0 101.0 145.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.50 stddev:3.16 (5.3%) stddev-sans-first:3.16 02:48:03 INFO - PROCESS | 1939 | Values: 56.0 58.0 55.0 56.0 66.0 60.0 59.0 59.0 61.0 60.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:71.50 stddev:12.11 (16.9%) stddev-sans-first:12.67 02:48:03 INFO - PROCESS | 1939 | Values: 70.0 69.0 73.0 73.0 80.0 72.0 70.0 71.0 70.0 109.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#10] stanford-crypto-aes Cycles:10 Average:100.40 Median:110.00 stddev:10.99 (10.0%) stddev-sans-first:11.58 02:48:03 INFO - PROCESS | 1939 | Values: 104.0 105.0 112.0 77.0 106.0 106.0 106.0 108.0 89.0 91.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#11] stanford-crypto-ccm Cycles:10 Average:155.40 Median:153.50 stddev:20.40 (13.3%) stddev-sans-first:21.50 02:48:03 INFO - PROCESS | 1939 | Values: 149.0 167.0 144.0 136.0 140.0 186.0 158.0 137.0 193.0 144.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:172.00 stddev:7.63 (4.4%) stddev-sans-first:8.00 02:48:03 INFO - PROCESS | 1939 | Values: 168.0 169.0 179.0 163.0 172.0 173.0 172.0 160.0 187.0 170.0 02:48:03 INFO - PROCESS | 1939 | 02:48:03 INFO - PROCESS | 1939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.81 (2.7%) stddev-sans-first:1.92 02:48:03 INFO - PROCESS | 1939 | Values: 68.0 71.0 67.0 67.0 68.0 66.0 70.0 69.0 67.0 65.0 02:48:03 INFO - PROCESS | 1939 | -------- Summary: end -------- 02:48:03 INFO - PROCESS | 1939 | 02:48:04 INFO - TEST-INFO | 1939: exit 0 02:48:04 INFO - TEST-OK | kraken | took 61626ms 02:48:04 INFO - SUITE-END | took 1175s 02:48:04 INFO - Completed test suite (00:19:36) 02:48:04 INFO - javascript benchmark 02:48:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7390.641675888243, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.600301960745, 3382.8815991440306, 3392.6607339266075, 3403.3023230237804, 3433.896983090508, 5729.512991395731, 5782.392848750884, 5802.622829516084, 5819.0, 5837.941620583793, 4669.696469729465, 5786.884262314762, 5816.185733997244, 5832.6792026438525, 5900.793472228473, 5251.2385704072885, 5289.576833853283, 5295.973520132394, 5309.309789727349, 5355.410904800468, 5248.396434410053, 5270.92093618596, 5359.919601205985, 5370.409254981949, 5372.7045012524295, 5144.61415393847, 5232.9738351308, 5261.316028916216, 5288.338957630296, 5294.549963253147, 5137.357830271216, 5203.427622961472, 5223.895522089575, 5251.474852514756, 5276.050310944029, 5170.379554453452, 5170.844874653766, 5182.844514664566, 5185.377754669464, 5194.4026436959475, 5594.049011668027, 5631.127175287796, 5635.042042852725, 5671.8582035449035, 5700.315962084576, 6147.262328520562, 6202.503799696014, 6216.751329946796, 6223.751049957997, 6262.342454042306, 6248.31268560458, 6249.625022498664, 6255.530835187334, 6263.498920086382, 6274.717637706269, 5625.774969001276, 5947.6431414115295, 5951.434613711691, 5956.225690660186, 5968.657052163228, 6150.969245153746, 6329.398707122816, 6390.201224846895, 6429.517786165963, 6432.935670643327, 5222.660527065728, 6015.368386319461, 6085.604435711664, 6164.537659675542, 6185.969070154621, 6249.50003999688, 6265.0602409638, 6272.278687950853, 6280.120783090371, 6293.3391993840905, 6120.020512922583, 6138.75626760427, 6144.003198960356, 6150.630962142286, 6182.227221597301, 6226.377362263737, 6238.906416403757, 6241.656708880964, 6251.6561589113035, 6253.78111766086, 5038.294638750578, 5053.938672878737, 5061.746912654353, 5064.721440320818, 5155.664881782672, 4344.391785150082, 4399.0, 4446.777661116931, 4483.282674772021, 4546.818127274872, 5993.580449368589, 6050.092486127116, 6054.666993315322, 6068.120122582201, 6095.116208149882, 6145.709401025745, 6255.905216587079, 6271.811845644638, 6291.591046581958, 6299.590526615755, 5825.0, 5919.378465261086, 5982.0, 6010.338862725184, 6108.816735497942, 5517.337919449611, 5519.31008623922, 5535.6955367454375, 5537.58468114893, 5555.611107222537, 6484.967575162094, 6496.935030649633, 6511.8697626047215, 6534.281229064704, 6535.0, 6109.860177052684, 6134.803982731443, 6135.386461353829, 6148.47737942262, 6219.502439804895, 5699.743511542073, 6410.4871610272, 6497.415232629086, 6503.512236582181, 6526.641034743135, 5039.086890282092, 5928.525717942641, 6231.376862313914, 6249.218847644044, 6251.9062214067735, 5068.847934561969, 6142.385761423822, 6174.475169610454, 6196.225471816023, 6256.06159076124, 5143.4085080216255, 6204.627722336674, 6206.565540412308, 6213.471854892385, 6234.376562343729, 6157.599756015845, 6165.075238714228, 6178.845528861814, 6186.072089186658, 6207.348228435949, 4166.395872598517, 4505.504394516535, 5877.647341159544, 5950.672713000827, 6117.755289788537, 6011.398860113954, 6085.66528840918, 6096.603720758137, 6097.634141951497, 6118.296395914527, 5924.407559244041, 5927.940720592911, 5936.1095835625, 6007.219061522149, 6013.308469525886], "value": 5708.025642715912, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.7437026228869, 456.9360289559462, 461.50388332542514, 546.7457632201028, 567.6395488864575, 37679.81160094199, 40362.19275614486, 40425.19149617006, 40460.39309410361, 40510.18979620406, 41941.0, 42788.0, 42816.35775463363, 42865.78567107168, 42925.57074429255, 8377.0, 8601.655933762642, 9121.133492318235, 9495.335326527145, 11298.604548840793, 9547.331686781929, 11259.4370281486, 11532.192746507748, 11544.018758405504, 11582.942085289562, 11540.480678369451, 11559.0, 11560.132990025739, 11573.421328933562, 11602.941985290061, 11514.366709830956, 11558.017568506688, 11569.826452603218, 11573.594924177698, 11589.768204635944, 11535.596254131066, 11584.18910676253, 11594.0, 11613.18707690462, 11637.487126673479, 39546.80226598877, 39668.40497392541, 39762.0, 39874.20251594981, 39958.60041399578, 3752.2683076800035, 3917.2557214129224, 4015.578364271768, 4018.2164477926817, 4047.170330082326, 29525.8470570676, 30397.848010760026, 30881.536776948364, 31255.06234812959, 32095.679043209737, 2978.1363404612634, 2981.478241307784, 3033.362993771311, 3042.1481985044225, 3052.0538633023834, 452679.0, 469892.0, 506155.0, 509127.0, 510154.9999999963, 62482.0, 62775.0, 62811.0, 62871.37128628747, 62933.68533157305, 65710.0, 66498.00252996209, 66693.666531668, 66696.66606667936, 67194.66402667956, 16397.83602163987, 17064.402745903833, 17079.914600426917, 17095.974241545548, 17099.316027359015, 11902.345371004678, 12173.0, 12821.102522823312, 13034.413451394521, 13060.34698265083, 14921.626959326104, 15046.022008569407, 17040.829591704172, 17048.82951170497, 17061.829381706026, 6239.438450539383, 7446.627668616547, 7496.287852653989, 7507.549547027196, 7616.885746713804, 808.2281421242699, 827.8079565425768, 892.8214357128601, 893.4058850864233, 896.4845214001975, 23412.64881026786, 24941.750582493944, 25549.48901021969, 28467.71895264718, 30504.54243186354, 874.7725591346295, 937.6296362936602, 1025.2874252394515, 1045.2839804733783, 1068.1881769854965, 13904.652383690489, 16176.595585110466, 16242.862999590152, 16569.83430165707, 16888.915555422143, 317298.0, 395060.0, 395846.02076990006, 396672.0, 397957.0, 58969.705151473965, 58987.41012589905, 59586.0, 59798.402015979285, 59856.10215846766, 1422.4736847366541, 1436.2459708653041, 1444.415011920174, 1448.8696017358488, 1454.919979401122, 29204.853975730835, 29912.0, 30003.69996300009, 30079.69920300769, 30435.934742283913, 41204.58795412127, 46391.0, 47982.76008620074, 48530.27204591863, 48691.756541218485, 385139.0, 385151.0, 386279.0, 387378.0, 389047.0, 40206.79379618616, 41247.793761031004, 41319.58680413158, 41367.793161034, 43094.0, 43826.342604860314, 43844.68465946027, 44099.11801763882, 44993.0, 45139.54860451353, 36527.63472365242, 36780.26439471249, 36873.81563092167, 37517.0, 38154.42768358532, 36394.0, 36445.0, 36896.89309320725, 37070.07324816793, 37571.06072348213, 35588.93233203008, 35659.0, 36022.81988590145, 36444.635553644126, 36596.0, 31012.0696379109, 31334.529982050743, 32532.349353012334, 33013.00960971175, 33070.0, 20997.160113595895, 24289.27132186037, 24304.878475607507, 24713.382165446008, 24821.751782481944], "value": 19767.916982806408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.28911844698956, 395.63601486632297, 398.7826634484206, 399.15578551363853, 419.42119874573086, 16419.83580164198, 19845.900770496144, 20855.165793368284, 21153.36539903805, 21218.939053047343, 21236.68144977823, 21545.78454215461, 21726.456838579044, 22001.779982200173, 22201.555968880653, 5536.667799931997, 5901.350851406363, 5947.88104237915, 5960.5529585281065, 5964.582479226456, 4413.713108647944, 5049.2678561608545, 5741.741621627037, 5794.275715535558, 5798.971005144968, 4859.441164266102, 5790.826275211751, 5795.82612521625, 5798.739056742456, 5812.970935145339, 5752.453516915907, 5789.565782566303, 7294.708211671526, 7616.162222155558, 7705.6917723291, 6342.492600591988, 7363.742269020612, 7638.083429988437, 7648.464607477423, 7653.885191722128, 23990.0, 29652.40695186084, 29759.40481190364, 29830.105096847128, 29997.550036749468, 2880.4527139843362, 2886.942261154786, 2904.695007024274, 2924.912252632403, 2990.7158819912074, 17407.825921740747, 17493.0, 17550.297988080463, 17709.822901770945, 17737.731774517782, 1975.2395327798756, 1983.8313743331835, 1997.5405656698895, 2001.5696625225646, 2023.3221870673342, 165919.0, 167688.0, 170187.14906425512, 170715.0, 174081.0, 25033.874830626093, 25281.241562753148, 25379.98480060777, 25522.489550209262, 25549.616755748677, 12229.205101668364, 12903.612891613078, 43315.35026974598, 43604.127917441474, 43664.0, 8357.289630381485, 8399.034111077182, 8529.82940341202, 8603.91396086031, 8607.913920860836, 8782.121787821166, 8788.033316335199, 8820.073892241351, 8937.821243575092, 8946.731598052069, 4061.045654271244, 4139.441175441277, 4140.627343539036, 4179.811908464127, 4207.200631879933, 1544.5675210940954, 1933.1011079847938, 2047.129969762845, 2061.1446249806463, 2070.8032736889973, 978.9853152202722, 999.8250306196531, 1031.7523794289316, 1043.5356266461504, 1068.0761141612604, 22640.547189056128, 23057.53884922292, 23120.7687923122, 23206.65190022151, 23230.83845807703, 1037.7716902281486, 1054.082947835388, 1057.4818339013827, 1069.427856097, 1073.6403304892792, 11485.483153258123, 12436.942859856832, 12474.563390281297, 12741.426635801412, 12853.485860565472, 764477.0, 794776.0, 805041.0, 814293.0, 819878.0, 125511.0, 163331.0, 164488.0, 166292.16853915653, 168173.0, 923.3628796130514, 1048.7483004078965, 1058.957641694339, 1087.8205096159045, 1093.5680406239492, 19354.225830966603, 20418.795812042285, 20984.790152098285, 21335.573288533833, 21540.892295538422, 59383.70308148432, 61613.383866162556, 62360.0, 62498.99999999818, 62689.0, 84281.0, 85066.14933850583, 85551.0, 86765.0, 88533.0, 6621.304763000008, 8234.711785087493, 8314.043884953307, 8773.42972706772, 8938.10618938101, 9280.675176368795, 12995.805062924253, 13200.0, 13607.455701771818, 13676.93161534186, 11316.807865286071, 11559.133065019989, 11800.881991180322, 11831.0, 11837.408129593658, 11269.887301126884, 11285.153613479186, 11449.198556100993, 11772.999295059673, 11788.764224715285, 8971.237444817263, 11296.378699171624, 11408.0, 11809.527618895148, 11844.585439509576, 6388.776392826228, 7108.324709152622, 7665.961670191613, 8274.875876861732, 8912.28701703875, 11107.888921110685, 11263.26788758728, 11266.211365204357, 11286.0, 11386.487608057823], "value": 10886.79224255862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1213.599512160987, 1420.8010878477014, 1424.145512692384, 1431.7208144411838, 1442.7763696627019, 6328.968355158224, 7655.043119610049, 7916.96041519793, 8666.523341216238, 8668.609912553935, 7263.636818159097, 8025.719099831507, 8448.873266901, 8567.143285671445, 8593.742187734362, 2339.099446713019, 2379.988100059506, 2385.1413491143176, 2385.3917251100943, 2402.3994001499627, 1974.190581861437, 2084.405944305873, 2157.8489505734606, 2353.9646905296436, 2391.8564886106888, 2260.5930932432157, 2358.174638876388, 2361.8582885026867, 2362.444825466023, 2371.964420533685, 2351.600227961242, 2359.2568340972625, 2371.5968285391436, 2373.6320870265135, 2379.0840526397287, 2341.2039906431723, 2358.8348815582917, 2362.267697013914, 2371.6916800815957, 2398.2085911649287, 8577.828443431159, 8638.481691098554, 8658.393912426132, 8665.523396213206, 8668.00317963436, 5199.324087868591, 5332.173513105436, 5367.570594352443, 5376.489233522809, 5390.137577987503, 2846.501862174132, 3377.3414184234084, 3455.2398472336045, 3611.368010598161, 3613.6205698401814, 1154.94899641326, 1186.6440067979659, 1187.590281352932, 1257.9496820127276, 1270.8856202941688, 11093.778124437466, 11116.999470047655, 11129.833052504218, 11153.72115697106, 11162.776744465065, 4652.441706995182, 4761.0, 4812.903741925212, 4828.37231159954, 4843.370361852936, 9688.031196880256, 9775.853362199572, 9779.41323520591, 9787.070228328297, 9796.657117001014, 5269.710165940834, 5383.78464861409, 5386.13821788512, 5397.59518036141, 5400.91898621521, 4357.891052723644, 4812.25410061441, 4866.245731911559, 4907.852764417074, 4910.533499317559, 3750.1937083527173, 3803.0872590578615, 3817.0457385653585, 3848.153406250676, 3880.7477513961503, 998.7515605493134, 1102.2945314998408, 1117.1118960426481, 1181.6632259805915, 1186.3356520348632, 875.5053394831899, 891.8305521950808, 898.0660113482036, 898.6719847255705, 908.1917093786535, 4680.9297860532115, 5535.335759708861, 5575.884823035409, 5706.9429305707245, 5784.855378615484, 951.4576691286039, 987.4766373821742, 1001.3891526169031, 1016.832222683249, 1029.6396261308632, 3798.734088613826, 3893.9415908761393, 3908.882733517999, 3919.4904662393706, 3920.666743326792, 10022.148117409955, 10268.794624107475, 10333.483325833678, 10337.431441270652, 10340.27618066728, 10212.131968782589, 10269.178465722724, 10306.690799276033, 10337.328073675188, 10366.326188797704, 7884.448088633855, 7998.0, 8113.350931925432, 8137.5117492951795, 8138.633761480747, 5490.0, 5526.253955716088, 5583.385827558884, 5675.772969081356, 5803.303603567599, 9108.499032553009, 9366.0, 9400.388974716621, 9407.200387966826, 9449.007854175488, 8218.712345067894, 9359.485228312236, 9527.190188833749, 9590.328676992543, 9636.180924621485, 6085.786997455068, 6701.798946031627, 6940.652967351713, 7402.518836275625, 7427.368673662799, 6685.465162786868, 7783.766487005399, 7815.648295826815, 8047.678092876219, 8214.424990250625, 6468.773592924225, 7263.854722905407, 7292.708291668274, 7402.592857392679, 7415.258474152757, 5812.912806307824, 5916.668749531493, 7129.750458734127, 7186.532875363294, 7238.167610724834, 5359.249705041375, 6403.167588213502, 6422.068800023877, 6478.2550006749825, 6494.837629059311, 4905.975470122627, 4921.188003979303, 5055.443901170942, 5088.084144853962, 5197.298364720715, 4941.332920055746, 5068.695878247169, 5070.847874563769, 5143.794248230179, 5255.658382205144], "value": 4443.7895757262, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.7320576553171, 362.9239305459313, 366.5729425219619, 367.44699227662363, 371.2056199732573, 5414.593905457092, 5431.782728690848, 5476.577139287945, 5482.342118945722, 5489.533389661883, 5309.469053094688, 5348.304720386354, 5364.693181931768, 5395.762542474513, 5429.56563474922, 3559.5728512578526, 3824.216035712679, 3855.8264878080554, 3885.5612782687385, 4075.735077219986, 4087.7138600297844, 4090.0, 4096.6927480438935, 4100.651444627195, 4122.917541649165, 3117.688231176887, 3847.461355410245, 4078.653314468259, 4090.406891000803, 4092.774897380643, 3958.782266975315, 3998.3850950252004, 4038.7172897896867, 4059.147579008397, 4103.753774773523, 3506.0708912138302, 3509.859605615772, 3510.140015696171, 3510.9824450877836, 3519.278547897675, 4625.7455839929125, 5144.768485418165, 5225.033368826779, 5267.657602255841, 5299.443558426348, 4470.26240670289, 4640.559146881041, 4677.415323084614, 4708.8463326485235, 4715.278923193044, 5687.772489100431, 5711.05767548354, 5726.942730572682, 5732.885342293131, 5736.541076713853, 3118.3763247350394, 3446.8621255149765, 3880.1269714314335, 3882.9223415531533, 3885.26180025797, 5034.798608055673, 5155.871103222412, 5682.488576028178, 6024.759009639609, 6045.576809623328, 3621.6559426854406, 3727.440883867387, 3805.980970095132, 3905.5508616509464, 3909.7654140751647, 3140.921896541402, 3219.036387803438, 3967.8809635710977, 3986.0901541874596, 3991.9201615967518, 3742.700583953277, 4414.792603698151, 4640.814367425265, 4668.229742092517, 4668.85993420198, 5081.568066714371, 5238.7904483820985, 5373.489518495737, 5710.600257981901, 5777.682227477445, 1296.883280504759, 1299.3503248375812, 1300.3810256231052, 1314.9539766108333, 1328.7276108397755, 786.6381464526268, 810.8297257575975, 838.6393850644281, 884.6859364925488, 885.5793498088357, 4133.731307465006, 4412.713173643703, 4450.641160185107, 5037.773300201499, 5062.7468626568525, 5003.849884503471, 5507.03626865297, 5616.410276920865, 5618.522425593788, 5628.523449682127, 3901.297766402075, 4483.910321793546, 4587.3807036050375, 4605.953940460552, 4697.412823397075, 2326.9418264543183, 2439.7682220189054, 2676.812623116402, 2884.178009267349, 2884.639420072491, 4851.58761505276, 5233.1365324721755, 5330.440303768126, 5655.971720141373, 5760.6255593386295, 5141.262886726092, 5149.995750828552, 5180.507851754077, 5528.75120619565, 5823.155642431823, 4914.950850491521, 5225.921611175835, 5270.3661864822025, 5672.432756724294, 5865.706714664335, 5635.211070450222, 5649.6327738696855, 5693.373728889736, 5696.772129114955, 5721.914171287351, 4581.74800385982, 5262.578993680573, 5449.809256675997, 5601.663900166003, 5892.0, 5130.97434512825, 6123.469132716821, 6129.670725124424, 6132.233470816148, 6166.242620853035, 3360.6639336066196, 3910.4916360872903, 3951.6048395160255, 3954.3475326570792, 4029.2545879012478, 4751.244278318636, 5405.972970135124, 5848.040906296438, 5914.704264786829, 5942.989691752326, 4552.590266875997, 5040.344755181803, 5248.448912864094, 5437.619366644297, 5709.4307561596615, 4220.38804373358, 4310.986918074313, 4753.334533165429, 5718.742656580381, 5755.856103597276, 4657.86026419208, 4899.31409602663, 5205.791768329224, 5597.944020559742, 5604.2154098425435, 5002.899942001212, 5353.384360798403, 5733.254676891977, 5735.483806457439, 5773.913391299218, 4978.103941290457, 5387.299651045339, 5556.9444305558045, 5591.6365436246515, 5608.8878222434505], "value": 4038.1036653108386, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.324991758324, 705.756514002669, 715.7280233511261, 758.268271118371, 813.4712436916004, 11580.768384632302, 15349.923250383732, 15683.764743528842, 15687.980281281709, 15839.683206335867, 14170.574882753508, 14386.352614132364, 14467.05964112332, 14581.416743330254, 14656.0, 681.492288245258, 852.7271273192581, 854.700854700856, 855.285836326668, 857.7855536115972, 683.1324218242829, 702.6205848841645, 832.3757182113415, 861.9482831030127, 864.2610567964394, 838.6393850644221, 889.902110767815, 908.4503875155502, 910.1171863292628, 910.1853840812469, 898.0480690468092, 903.6701603914589, 905.08134243742, 905.7690288976335, 906.0893801729253, 668.8729141463107, 674.3054653706641, 674.382939610256, 674.6019848289533, 676.1311714446912, 14843.703125937529, 15079.54761357161, 15115.31981060855, 15176.468823591122, 15355.232238388036, 13758.587242382744, 13871.0, 14008.22954737489, 14066.901495918657, 14172.929135354258, 11563.0, 11635.069194464422, 11676.0, 11749.706257343549, 11759.294442333487, 3585.94621080684, 3617.8001344722124, 3653.799041052741, 3712.2204337088974, 3735.7571757835653, 101709.491452543, 101927.96144077151, 102047.0, 102131.0, 102213.46679799809, 10597.735056623646, 10674.73313167177, 10706.304090234109, 10727.946360268148, 10739.301945373525, 22070.0, 22255.888720556617, 22286.3314100574, 22380.0, 22400.663990040164, 7729.6521656524465, 7784.9610751945875, 7789.766307010798, 7835.412344074217, 7980.720674776355, 3748.756330838487, 4307.18163548931, 4339.830084957522, 4363.345498175299, 4391.802368893407, 3131.185891668137, 3590.533230679995, 3634.982204982609, 3705.7220708446976, 3732.4774531565604, 660.389140045456, 666.8966310221923, 674.7739507265023, 685.1230425055936, 687.08274453604, 658.9769358072444, 677.9830504237434, 693.1889689063706, 708.3058602569408, 719.9532030418111, 10162.4918754062, 10433.217508686726, 10452.216083793746, 10604.628837990633, 10608.257421980541, 664.9368310010541, 683.5420268420171, 708.6775517139793, 710.5345998371075, 723.3273056057816, 4936.969039431014, 4940.110780059552, 4975.573913734235, 4978.153713868651, 4999.0251900878975, 96414.51792740992, 104779.476102619, 105320.47339763252, 105455.0, 111154.44422777997, 92152.0, 93721.53139234397, 95015.0, 98098.01901981032, 98109.0, 86263.0, 87272.5636371814, 88387.0, 88738.55630721805, 90282.0, 9637.614495420105, 9715.951420243136, 9756.951215243878, 9771.560279787285, 9777.804443911224, 53521.46478535321, 54049.72975135099, 55175.0, 55559.0, 56848.14727779169, 71608.49370272015, 73851.63074184595, 74675.01299948158, 75196.0, 76444.61777691076, 9790.902090979, 10277.897221027994, 11383.089352851917, 11791.705207369885, 11999.940000300292, 10582.947085264525, 12205.145639805129, 12547.49810007626, 13080.215187088805, 13096.083274170716, 11563.6530904073, 11749.88250117488, 11813.704657383634, 12146.210496317712, 12156.574519891761, 11904.226225295328, 11920.463579139134, 12166.817497737718, 12253.387330633612, 12522.060845436446, 11257.887421125684, 11712.70718232017, 11743.88256117428, 11751.118666100248, 12124.818127728267, 8690.435121717068, 9552.570134343832, 9957.402555846673, 10368.118709909742, 10374.533146008296, 9650.662226822027, 9843.114119729258, 9857.753556161153, 9872.753181170528, 9875.0], "value": 7392.06511038457, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 120.0, 119.0, 120.0, 115.0, 120.0, 119.0, 118.0, 119.0], "value": 117.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 116.0, 151.0, 145.0, 116.0, 116.0, 114.0, 132.0, 117.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 205.0, 200.0, 202.0, 197.0, 197.0, 194.0, 241.0, 277.0, 199.0], "value": 210.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 76.0, 84.0, 96.0, 60.0, 58.0, 60.0, 61.0, 69.0, 60.0], "value": 70.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 85.0, 74.0, 70.0, 72.0, 80.0, 69.0, 71.0, 82.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 132.0, 136.0, 89.0, 90.0, 87.0, 91.0, 87.0, 90.0, 90.0], "value": 97.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 154.0, 97.0, 97.0, 96.0, 95.0, 94.0, 151.0, 154.0, 134.0], "value": 122.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 128.0, 76.0, 139.0, 88.0, 107.0, 146.0, 149.0, 101.0, 145.0], "value": 118.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 55.0, 56.0, 66.0, 60.0, 59.0, 59.0, 61.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 73.0, 73.0, 80.0, 72.0, 70.0, 71.0, 70.0, 109.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 112.0, 77.0, 106.0, 106.0, 106.0, 108.0, 89.0, 91.0], "value": 100.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 167.0, 144.0, 136.0, 140.0, 186.0, 158.0, 137.0, 193.0, 144.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 179.0, 163.0, 172.0, 173.0, 172.0, 160.0, 187.0, 170.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 67.0, 68.0, 66.0, 70.0, 69.0, 67.0, 65.0], "value": 67.8, "unit": "score"}]}]} 02:48:04 INFO - Return code: 0 02:48:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:48:04 ERROR - # TBPL SUCCESS # 02:48:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:48:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:48:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:48:04 INFO - 2017-02-13 02:48:04.907 screenresolution[1944:22814] starting screenresolution argv=screenresolution get 02:48:04 INFO - 2017-02-13 02:48:04.910 screenresolution[1944:22814] Display 0: 1600x1200x32@60 02:48:04 INFO - 2017-02-13 02:48:04.915 screenresolution[1945:22817] starting screenresolution argv=screenresolution list 02:48:04 INFO - Available Modes on Display 0 02:48:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:48:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:48:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:48:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:48:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:48:05 INFO - Intel Iris: 02:48:05 INFO - Chipset Model: Intel Iris 02:48:05 INFO - Type: GPU 02:48:05 INFO - Bus: Built-In 02:48:05 INFO - VRAM (Dynamic, Max): 1536 MB 02:48:05 INFO - Vendor: Intel (0x8086) 02:48:05 INFO - Device ID: 0x0a2e 02:48:05 INFO - Revision ID: 0x0009 02:48:05 INFO - Displays: 02:48:05 INFO - Display: 02:48:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:48:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:48:05 INFO - Display Serial Number: 1600x1200 60 02:48:05 INFO - Main Display: Yes 02:48:05 INFO - Mirror: Off 02:48:05 INFO - Online: Yes 02:48:05 INFO - Rotation: Supported 02:48:05 INFO - Return code: 0 02:48:05 INFO - Running post-action listener: _resource_record_post_action 02:48:05 INFO - [mozharness: 2017-02-13 10:48:05.154477Z] Finished run-tests step (success) 02:48:05 INFO - Running post-run listener: _resource_record_post_run 02:48:05 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 135168; Write bytes: 511012352; Read time: 4; Write time: 1623 02:48:05 INFO - TinderboxPrint: CPU usage
54.2% 02:48:05 INFO - TinderboxPrint: I/O read bytes / time
135,168 / 4 02:48:05 INFO - TinderboxPrint: I/O write bytes / time
511,012,352 / 1,623 02:48:05 INFO - TinderboxPrint: CPU idle
2,195.8 (45.8%) 02:48:05 INFO - TinderboxPrint: CPU system
962.8 (20.1%) 02:48:05 INFO - TinderboxPrint: CPU user
1,631.2 (34.1%) 02:48:05 INFO - TinderboxPrint: Swap in / out
207,323,136 / 0 02:48:05 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207426048; Write bytes: 202835456; Read time: 15912; Write time: 455 02:48:05 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 8192; Write bytes: 298174464; Read time: 1; Write time: 1133 02:48:05 INFO - Running post-run listener: _upload_blobber_files 02:48:05 INFO - Blob upload gear active. 02:48:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:48:05 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 02:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:48:06 INFO - (blobuploader) - INFO - Open directory for files ... 02:48:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:48:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:48:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:07 INFO - (blobuploader) - INFO - Done attempting. 02:48:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:48:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:48:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:08 INFO - (blobuploader) - INFO - Done attempting. 02:48:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:48:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:48:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:09 INFO - (blobuploader) - INFO - Done attempting. 02:48:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:48:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:48:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:12 INFO - (blobuploader) - INFO - Done attempting. 02:48:12 INFO - (blobuploader) - INFO - Iteration through files over. 02:48:12 INFO - Return code: 0 02:48:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:48:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:48:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b73a20b12ed6ab24b494af77c40234ff67d4d7619843b4f556030364f10bd84134b820a185ddcbd30772582c80fc564902f47e3a171e83e754beec36c92323b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2f58fba0e54da38fa54a3f82f72b78a2e42fcfc1b5813341abf2839389c31084688ebf6304340002252b1923b063609b31e892d833d0624c96805b0c59b4769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e65f9438a154cb38df014af70b4ae17a8e80f66e9fdb4fe4e9a40465be60d3fc9fbe457d510d16fb332e5f26204bb006c29b3f025bf17fd6dfda06df976d8239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41ece5e75fb3c7b0d52e0f246e480493514722ef7878104162fe002933f2f5662e2ee5e8c8593d2664c0c67033bacd7f60d0f8d71086abdbcf3afff77d4ea86e"} 02:48:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:48:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:48:12 INFO - Contents: 02:48:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b73a20b12ed6ab24b494af77c40234ff67d4d7619843b4f556030364f10bd84134b820a185ddcbd30772582c80fc564902f47e3a171e83e754beec36c92323b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2f58fba0e54da38fa54a3f82f72b78a2e42fcfc1b5813341abf2839389c31084688ebf6304340002252b1923b063609b31e892d833d0624c96805b0c59b4769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e65f9438a154cb38df014af70b4ae17a8e80f66e9fdb4fe4e9a40465be60d3fc9fbe457d510d16fb332e5f26204bb006c29b3f025bf17fd6dfda06df976d8239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41ece5e75fb3c7b0d52e0f246e480493514722ef7878104162fe002933f2f5662e2ee5e8c8593d2664c0c67033bacd7f60d0f8d71086abdbcf3afff77d4ea86e"} 02:48:12 INFO - Running post-run listener: copy_logs_to_upload_dir 02:48:12 INFO - Copying logs to upload dir... 02:48:12 INFO - mkdir: /builds/slave/test/build/upload/logs 02:48:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.145607 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-13 02:48:12.141425) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 02:48:12.145011) ========= 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.vTClp4tVEK/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.uuryahH7TS/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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/Mozilla-Aurora/sha512/b73a20b12ed6ab24b494af77c40234ff67d4d7619843b4f556030364f10bd84134b820a185ddcbd30772582c80fc564902f47e3a171e83e754beec36c92323b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2f58fba0e54da38fa54a3f82f72b78a2e42fcfc1b5813341abf2839389c31084688ebf6304340002252b1923b063609b31e892d833d0624c96805b0c59b4769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e65f9438a154cb38df014af70b4ae17a8e80f66e9fdb4fe4e9a40465be60d3fc9fbe457d510d16fb332e5f26204bb006c29b3f025bf17fd6dfda06df976d8239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41ece5e75fb3c7b0d52e0f246e480493514722ef7878104162fe002933f2f5662e2ee5e8c8593d2664c0c67033bacd7f60d0f8d71086abdbcf3afff77d4ea86e"} build_url:https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010697 build_url: 'https://queue.taskcluster.net/v1/task/EK8D-EE4RN2a5LuOPcskbA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b73a20b12ed6ab24b494af77c40234ff67d4d7619843b4f556030364f10bd84134b820a185ddcbd30772582c80fc564902f47e3a171e83e754beec36c92323b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2f58fba0e54da38fa54a3f82f72b78a2e42fcfc1b5813341abf2839389c31084688ebf6304340002252b1923b063609b31e892d833d0624c96805b0c59b4769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e65f9438a154cb38df014af70b4ae17a8e80f66e9fdb4fe4e9a40465be60d3fc9fbe457d510d16fb332e5f26204bb006c29b3f025bf17fd6dfda06df976d8239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41ece5e75fb3c7b0d52e0f246e480493514722ef7878104162fe002933f2f5662e2ee5e8c8593d2664c0c67033bacd7f60d0f8d71086abdbcf3afff77d4ea86e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 02:48:12.179658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:48:12.180032) ========= 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.vTClp4tVEK/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.uuryahH7TS/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.005424 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:48:12.229579) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 02:48:12.229955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 02:48:12.230344) ========= ========= Total master_lag: 0.19 =========