builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0272 starttime: 1487021211.42 results: success (0) buildid: 20170213102439 builduid: 7c3f002e147b483baec552ad471d2add revision: 4ad8573642c78523c549e9ee3b90c24f9a464834 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:51.422461) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:51.422949) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:51.423224) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:51.448813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:51.449219) ========= 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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:26:51-- 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% 7.99M=0.001s 2017-02-13 13:26:51 (7.99 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:51.622230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:51.622547) ========= 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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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.020380 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:51.670933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-02-13 13:26:51.671281) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ad8573642c78523c549e9ee3b90c24f9a464834 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ad8573642c78523c549e9ee3b90c24f9a464834 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nWPgc3lgLx/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.IL6WTCUyQx/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:26:51,709 truncating revision to first 12 chars 2017-02-13 13:26:51,709 Setting DEBUG logging. 2017-02-13 13:26:51,709 attempt 1/10 2017-02-13 13:26:51,709 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4ad8573642c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 13:26:53,443 unpacking tar archive at: mozilla-beta-4ad8573642c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.988770 ========= master_lag: 1.40 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-02-13 13:26:55.063639) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:55.063958) ========= script_repo_revision: 4ad8573642c78523c549e9ee3b90c24f9a464834 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:55.064313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:55.064591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 13:26:55.087361) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-13 13:26:55.087726) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nWPgc3lgLx/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.IL6WTCUyQx/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:26:55 INFO - MultiFileLogger online at 20170213 13:26:55 in /builds/slave/test 13:26:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:26:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:26:55 INFO - {'append_to_log': False, 13:26:55 INFO - 'base_work_dir': '/builds/slave/test', 13:26:55 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:26:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:26:55 INFO - 'branch': 'Mozilla-Beta', 13:26:55 INFO - 'buildbot_json_path': 'buildprops.json', 13:26:55 INFO - 'config_files': ('talos/mac_config.py',), 13:26:55 INFO - 'default_actions': ('clobber', 13:26:55 INFO - 'read-buildbot-config', 13:26:55 INFO - 'download-and-extract', 13:26:55 INFO - 'populate-webroot', 13:26:55 INFO - 'create-virtualenv', 13:26:55 INFO - 'install', 13:26:55 INFO - 'run-tests'), 13:26:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:26:55 INFO - 'download_minidump_stackwalk': True, 13:26:55 INFO - 'download_symbols': 'ondemand', 13:26:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:26:55 INFO - 'tooltool.py': '/tools/tooltool.py', 13:26:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:26:55 INFO - '/tools/misc-python/virtualenv.py')}, 13:26:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:26:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:26:55 INFO - 'installer_path': 'installer.exe', 13:26:55 INFO - 'log_level': 'info', 13:26:55 INFO - 'log_name': 'talos', 13:26:55 INFO - 'log_to_console': True, 13:26:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:26:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:26:55 INFO - 'opt_config_files': (), 13:26:55 INFO - 'pip_index': False, 13:26:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:26:55 INFO - 'cmd': ('bash', 13:26:55 INFO - '-c', 13:26:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:26:55 INFO - 'enabled': True, 13:26:55 INFO - 'halt_on_failure': False, 13:26:55 INFO - 'name': 'check_screen_resolution'},), 13:26:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:26:55 INFO - 'cmd': ('bash', 13:26:55 INFO - '-c', 13:26:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:26:55 INFO - 'enabled': True, 13:26:55 INFO - 'halt_on_failure': False, 13:26:55 INFO - 'name': 'check_screen_resolution'},), 13:26:55 INFO - 'run_cmd_checks_enabled': True, 13:26:55 INFO - 'sps_profile': False, 13:26:55 INFO - 'sps_profile_interval': 0, 13:26:55 INFO - 'suite': 'dromaeojs-e10s', 13:26:55 INFO - 'system_bits': '32', 13:26:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:26:55 INFO - 'title': 't-yosemite-r7-0272', 13:26:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:26:55 INFO - 'use_talos_json': True, 13:26:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:26:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:26:55 INFO - 'work_dir': 'build'} 13:26:55 INFO - [mozharness: 2017-02-13 21:26:55.246705Z] Running clobber step. 13:26:55 INFO - Running pre-action listener: _resource_record_pre_action 13:26:55 INFO - Running main action method: clobber 13:26:55 INFO - rmtree: /builds/slave/test/build 13:26:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:26:57 INFO - Running post-action listener: _resource_record_post_action 13:26:57 INFO - [mozharness: 2017-02-13 21:26:57.182517Z] Finished clobber step (success) 13:26:57 INFO - [mozharness: 2017-02-13 21:26:57.182676Z] Running read-buildbot-config step. 13:26:57 INFO - Running pre-action listener: _resource_record_pre_action 13:26:57 INFO - Running main action method: read_buildbot_config 13:26:57 INFO - Using buildbot properties: 13:26:57 INFO - { 13:26:57 INFO - "project": "", 13:26:57 INFO - "product": "firefox", 13:26:57 INFO - "script_repo_revision": "production", 13:26:57 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:26:57 INFO - "repository": "", 13:26:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:26:57 INFO - "buildid": "20170213102439", 13:26:57 INFO - "pgo_build": "False", 13:26:57 INFO - "basedir": "/builds/slave/test", 13:26:57 INFO - "buildnumber": 7, 13:26:57 INFO - "slavename": "t-yosemite-r7-0272", 13:26:57 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:26:57 INFO - "platform": "yosemite_r7", 13:26:57 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:26:57 INFO - "branch": "mozilla-beta", 13:26:57 INFO - "repo_path": "releases/mozilla-beta", 13:26:57 INFO - "revision": "4ad8573642c78523c549e9ee3b90c24f9a464834", 13:26:57 INFO - "stage_platform": "macosx64", 13:26:57 INFO - "builduid": "7c3f002e147b483baec552ad471d2add", 13:26:57 INFO - "slavebuilddir": "test" 13:26:57 INFO - } 13:26:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 13:26:57 INFO - Running post-action listener: _resource_record_post_action 13:26:57 INFO - [mozharness: 2017-02-13 21:26:57.186186Z] Finished read-buildbot-config step (success) 13:26:57 INFO - [mozharness: 2017-02-13 21:26:57.186306Z] Running download-and-extract step. 13:26:57 INFO - Running pre-action listener: _resource_record_pre_action 13:26:57 INFO - Running main action method: download_and_extract 13:26:57 INFO - mkdir: /builds/slave/test/build/tests 13:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:57 INFO - trying https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 13:26:57 INFO - Downloading https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:26:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 13:26:58 INFO - Downloaded 1165 bytes. 13:26:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:26:58 INFO - Using the following test package requirements: 13:26:58 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:26:58 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:26:58 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 13:26:58 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:26:58 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 13:26:58 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:26:58 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:26:58 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 13:26:58 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:26:58 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:26:58 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 13:26:58 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:26:58 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 13:26:58 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:26:58 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 13:26:58 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:26:58 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 13:26:58 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 13:26:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:26:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:26:58 INFO - Fetch https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:26:59 INFO - Http code: 200 13:26:59 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 13:26:59 INFO - x-amz-cf-id: AfWKSEOSLkUTYT6LcNypzNKiPU0pJ16VHzUAR3yDRROV9LMawBnytQ== 13:26:59 INFO - x-amz-version-id: CJM.8f1PkUr2THFx4jKImVB3DNWzyfWM 13:26:59 INFO - Expected file size: 16094122 13:26:59 INFO - Obtained file size: 16094122 13:27:06 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:27:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:27:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:27:06 INFO - Fetch https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:27:06 INFO - Http code: 200 13:27:06 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 13:27:06 INFO - x-amz-cf-id: fMjRfutuL01EtwE9UW46NFqp1XbkLllzc8QvN6heV-zzSDiYwl2G8A== 13:27:06 INFO - x-amz-version-id: CJM.8f1PkUr2THFx4jKImVB3DNWzyfWM 13:27:07 INFO - Expected file size: 16094122 13:27:07 INFO - Obtained file size: 16094122 13:27:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 13:27:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 13:27:13 INFO - Fetch https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 13:27:15 INFO - Http code: 200 13:27:15 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 13:27:15 INFO - x-amz-cf-id: 7Sln9S00ascmruvICi18M0J2Vh3AapGJlSlfI2mkjoC3srvw5LXBBQ== 13:27:15 INFO - x-amz-version-id: 4xIqLraYdYcLae0uMeh2PuZDt7Yr9SxX 13:27:15 INFO - Expected file size: 14403005 13:27:15 INFO - Obtained file size: 14403005 13:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:15 INFO - trying https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:27:15 INFO - Downloading https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 13:27:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 13:27:17 INFO - Downloaded 82106139 bytes. 13:27:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:27:17 INFO - mkdir: /builds/slave/test/properties 13:27:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:27:17 INFO - Writing to file /builds/slave/test/properties/build_url 13:27:17 INFO - Contents: 13:27:17 INFO - build_url:https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:27:18 INFO - Running post-action listener: _resource_record_post_action 13:27:18 INFO - Running post-action listener: set_extra_try_arguments 13:27:18 INFO - [mozharness: 2017-02-13 21:27:18.665626Z] Finished download-and-extract step (success) 13:27:18 INFO - [mozharness: 2017-02-13 21:27:18.665760Z] Running populate-webroot step. 13:27:18 INFO - Running pre-action listener: _resource_record_pre_action 13:27:18 INFO - Running main action method: populate_webroot 13:27:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:27:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:27:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:27:18 INFO - '--tppagecycles', 13:27:18 INFO - '7'], 13:27:18 INFO - 'tests': ['tsvgm']}}, 13:27:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:27:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:27:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:27:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:27:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:27:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:27:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:18 INFO - 'talos_options': ['--disable-e10s'], 13:27:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:27:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:27:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:18 INFO - 'talos_options': ['--disable-e10s'], 13:27:18 INFO - 'tests': ['damp', 'tps']}, 13:27:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:18 INFO - 'tests': ['damp', 'tps']}, 13:27:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:27:18 INFO - 'tests': ['dromaeo_dom']}, 13:27:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:27:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:27:18 INFO - 'tests': ['basic_compositor_video']}, 13:27:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:27:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:27:18 INFO - 'tests': ['a11yr', 13:27:18 INFO - 'ts_paint', 13:27:18 INFO - 'tpaint', 13:27:18 INFO - 'sessionrestore', 13:27:18 INFO - 'sessionrestore_no_auto_restore', 13:27:18 INFO - 'tabpaint']}, 13:27:18 INFO - 'other-e10s': {'tests': ['a11yr', 13:27:18 INFO - 'ts_paint', 13:27:18 INFO - 'tpaint', 13:27:18 INFO - 'sessionrestore', 13:27:18 INFO - 'sessionrestore_no_auto_restore', 13:27:18 INFO - 'tabpaint']}, 13:27:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:27:18 INFO - 'ts_paint', 13:27:18 INFO - 'tpaint', 13:27:18 INFO - 'sessionrestore', 13:27:18 INFO - 'sessionrestore_no_auto_restore', 13:27:18 INFO - 'tabpaint']}, 13:27:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:27:18 INFO - 'ts_paint', 13:27:18 INFO - 'tpaint', 13:27:18 INFO - 'sessionrestore', 13:27:18 INFO - 'sessionrestore_no_auto_restore', 13:27:18 INFO - 'tabpaint']}, 13:27:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:27:18 INFO - 'tests': ['a11yr', 13:27:18 INFO - 'ts_paint', 13:27:18 INFO - 'tpaint', 13:27:18 INFO - 'sessionrestore', 13:27:18 INFO - 'sessionrestore_no_auto_restore', 13:27:18 INFO - 'tabpaint']}, 13:27:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:27:18 INFO - 'tests': ['a11yr', 13:27:18 INFO - 'ts_paint', 13:27:18 INFO - 'tpaint', 13:27:18 INFO - 'sessionrestore', 13:27:18 INFO - 'sessionrestore_no_auto_restore', 13:27:18 INFO - 'tabpaint']}, 13:27:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:27:18 INFO - 'tests': ['tsvgx', 13:27:18 INFO - 'tsvgr_opacity', 13:27:18 INFO - 'tart', 13:27:18 INFO - 'tscrollx', 13:27:18 INFO - 'cart']}, 13:27:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:27:18 INFO - 'tsvgr_opacity', 13:27:18 INFO - 'tart', 13:27:18 INFO - 'tscrollx', 13:27:18 INFO - 'cart']}, 13:27:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:18 INFO - 'talos_options': ['--disable-e10s'], 13:27:18 INFO - 'tests': ['tp5o']}, 13:27:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:18 INFO - 'tests': ['tp5o']}, 13:27:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:18 INFO - 'talos_options': ['--disable-e10s', 13:27:18 INFO - '--xperf_path', 13:27:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:27:18 INFO - 'tests': ['tp5n']}, 13:27:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:18 INFO - 'talos_options': ['--xperf_path', 13:27:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:27:18 INFO - 'tests': ['tp5n']}}, 13:27:18 INFO - 'talos.zip': {'path': '', 13:27:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:27:18 INFO - Running post-action listener: _resource_record_post_action 13:27:18 INFO - [mozharness: 2017-02-13 21:27:18.684884Z] Finished populate-webroot step (success) 13:27:18 INFO - [mozharness: 2017-02-13 21:27:18.685010Z] Running create-virtualenv step. 13:27:18 INFO - Running pre-action listener: _resource_record_pre_action 13:27:18 INFO - Running main action method: create_virtualenv 13:27:18 INFO - Creating virtualenv /builds/slave/test/build/venv 13:27:18 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 13:27:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:27:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:27:18 INFO - Using real prefix '/tools/python27' 13:27:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:27:19 INFO - Installing distribute.............................................................................................................................................................................................done. 13:27:22 INFO - Installing pip.................done. 13:27:22 INFO - Return code: 0 13:27:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:27:22 INFO - Reading from file tmpfile_stdout 13:27:22 INFO - Output received: 13:27:22 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) 13:27:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:22 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 0x10e386490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d0598e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ad30>, '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 0x10e000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e192b20>, '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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:27:22 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 13:27:22 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 13:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWPgc3lgLx/Render', 13:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:22 INFO - 'HOME': '/Users/cltbld', 13:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:22 INFO - 'LOGNAME': 'cltbld', 13:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:22 INFO - 'MOZ_NO_REMOTE': '1', 13:27:22 INFO - 'NO_EM_RESTART': '1', 13:27:22 INFO - 'PAGER': '/bin/cat', 13:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:22 INFO - 'PWD': '/builds/slave/test', 13:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:22 INFO - 'SHELL': '/bin/bash', 13:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IL6WTCUyQx/Listeners', 13:27:22 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 13:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:22 INFO - 'USER': 'cltbld', 13:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:22 INFO - 'XPC_FLAGS': '0x0', 13:27:22 INFO - 'XPC_SERVICE_NAME': '0', 13:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:22 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 13:27:22 INFO - Cleaning up... 13:27:22 INFO - Return code: 0 13:27:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:22 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 0x10e386490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d0598e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ad30>, '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 0x10e000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e192b20>, '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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:27:22 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 13:27:22 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 13:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWPgc3lgLx/Render', 13:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:22 INFO - 'HOME': '/Users/cltbld', 13:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:22 INFO - 'LOGNAME': 'cltbld', 13:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:22 INFO - 'MOZ_NO_REMOTE': '1', 13:27:22 INFO - 'NO_EM_RESTART': '1', 13:27:22 INFO - 'PAGER': '/bin/cat', 13:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:22 INFO - 'PWD': '/builds/slave/test', 13:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:22 INFO - 'SHELL': '/bin/bash', 13:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IL6WTCUyQx/Listeners', 13:27:22 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 13:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:22 INFO - 'USER': 'cltbld', 13:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:22 INFO - 'XPC_FLAGS': '0x0', 13:27:22 INFO - 'XPC_SERVICE_NAME': '0', 13:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:23 INFO - Downloading/unpacking psutil>=3.1.1 13:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:27:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:26 INFO - Installing collected packages: psutil 13:27:26 INFO - Running setup.py install for psutil 13:27:26 INFO - building 'psutil._psutil_osx' extension 13:27:26 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 13:27:27 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 13:27:27 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 13:27:27 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 13:27:27 INFO - building 'psutil._psutil_posix' extension 13:27:27 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 13:27:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:27:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:27:27 INFO - ^ 13:27:27 INFO - 1 warning generated. 13:27:27 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 13:27:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:27 INFO - Successfully installed psutil 13:27:27 INFO - Cleaning up... 13:27:27 INFO - Return code: 0 13:27:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e386490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d0598e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ad30>, '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 0x10e000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e192b20>, '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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWPgc3lgLx/Render', 13:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:27 INFO - 'HOME': '/Users/cltbld', 13:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:27 INFO - 'LOGNAME': 'cltbld', 13:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:27 INFO - 'MOZ_NO_REMOTE': '1', 13:27:27 INFO - 'NO_EM_RESTART': '1', 13:27:27 INFO - 'PAGER': '/bin/cat', 13:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:27 INFO - 'PWD': '/builds/slave/test', 13:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:27 INFO - 'SHELL': '/bin/bash', 13:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IL6WTCUyQx/Listeners', 13:27:27 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 13:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:27 INFO - 'USER': 'cltbld', 13:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:27 INFO - 'XPC_FLAGS': '0x0', 13:27:27 INFO - 'XPC_SERVICE_NAME': '0', 13:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:27:30 INFO - Installing collected packages: mozsystemmonitor 13:27:30 INFO - Running setup.py install for mozsystemmonitor 13:27:30 INFO - Successfully installed mozsystemmonitor 13:27:30 INFO - Cleaning up... 13:27:30 INFO - Return code: 0 13:27:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e386490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d0598e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ad30>, '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 0x10e000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e192b20>, '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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:27:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWPgc3lgLx/Render', 13:27:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:30 INFO - 'HOME': '/Users/cltbld', 13:27:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:30 INFO - 'LOGNAME': 'cltbld', 13:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:30 INFO - 'MOZ_NO_REMOTE': '1', 13:27:30 INFO - 'NO_EM_RESTART': '1', 13:27:30 INFO - 'PAGER': '/bin/cat', 13:27:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:30 INFO - 'PWD': '/builds/slave/test', 13:27:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:30 INFO - 'SHELL': '/bin/bash', 13:27:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IL6WTCUyQx/Listeners', 13:27:30 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 13:27:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:30 INFO - 'USER': 'cltbld', 13:27:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:30 INFO - 'XPC_FLAGS': '0x0', 13:27:30 INFO - 'XPC_SERVICE_NAME': '0', 13:27:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:31 INFO - Downloading/unpacking jsonschema==2.5.1 13:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:27:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:27:33 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 13:27:33 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 13:27:33 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 13:27:33 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 13:27:33 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 13:27:33 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 13:27:34 INFO - Downloading functools32-3.2.3-2.tar.gz 13:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:27:34 INFO - warning: no files found matching '*.txt' 13:27:34 INFO - no previously-included directories found matching 'build' 13:27:34 INFO - no previously-included directories found matching 'dist' 13:27:34 INFO - no previously-included directories found matching '.git*' 13:27:34 INFO - Installing collected packages: jsonschema, functools32 13:27:34 INFO - Running setup.py install for functools32 13:27:34 INFO - warning: no files found matching '*.txt' 13:27:34 INFO - no previously-included directories found matching 'build' 13:27:34 INFO - no previously-included directories found matching 'dist' 13:27:34 INFO - no previously-included directories found matching '.git*' 13:27:34 INFO - Successfully installed jsonschema functools32 13:27:34 INFO - Cleaning up... 13:27:34 INFO - Return code: 0 13:27:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e386490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d0598e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ad30>, '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 0x10e000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e192b20>, '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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWPgc3lgLx/Render', 13:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:34 INFO - 'HOME': '/Users/cltbld', 13:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:34 INFO - 'LOGNAME': 'cltbld', 13:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:34 INFO - 'MOZ_NO_REMOTE': '1', 13:27:34 INFO - 'NO_EM_RESTART': '1', 13:27:34 INFO - 'PAGER': '/bin/cat', 13:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:34 INFO - 'PWD': '/builds/slave/test', 13:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:34 INFO - 'SHELL': '/bin/bash', 13:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IL6WTCUyQx/Listeners', 13:27:34 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 13:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:34 INFO - 'USER': 'cltbld', 13:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:34 INFO - 'XPC_FLAGS': '0x0', 13:27:34 INFO - 'XPC_SERVICE_NAME': '0', 13:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:27:34 INFO - Cleaning up... 13:27:34 INFO - Return code: 0 13:27:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e386490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d0598e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ad30>, '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 0x10e000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e192b20>, '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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWPgc3lgLx/Render', 13:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:34 INFO - 'HOME': '/Users/cltbld', 13:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:34 INFO - 'LOGNAME': 'cltbld', 13:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:34 INFO - 'MOZ_NO_REMOTE': '1', 13:27:34 INFO - 'NO_EM_RESTART': '1', 13:27:34 INFO - 'PAGER': '/bin/cat', 13:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:34 INFO - 'PWD': '/builds/slave/test', 13:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:34 INFO - 'SHELL': '/bin/bash', 13:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IL6WTCUyQx/Listeners', 13:27:34 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 13:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:34 INFO - 'USER': 'cltbld', 13:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:34 INFO - 'XPC_FLAGS': '0x0', 13:27:34 INFO - 'XPC_SERVICE_NAME': '0', 13:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:34 INFO - Downloading/unpacking blobuploader==1.2.4 13:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:37 INFO - Downloading blobuploader-1.2.4.tar.gz 13:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:27:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:27:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:38 INFO - Downloading docopt-0.6.1.tar.gz 13:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:27:38 INFO - Installing collected packages: blobuploader, requests, docopt 13:27:38 INFO - Running setup.py install for blobuploader 13:27:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:27:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:27:39 INFO - Running setup.py install for requests 13:27:39 INFO - Running setup.py install for docopt 13:27:39 INFO - Successfully installed blobuploader requests docopt 13:27:39 INFO - Cleaning up... 13:27:39 INFO - Return code: 0 13:27:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13: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')]} 13:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13: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')]} 13:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:39 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 0x10e386490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d0598e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ad30>, '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 0x10e000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e192b20>, '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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:27:39 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 13:27:39 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 13:27:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWPgc3lgLx/Render', 13:27:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:39 INFO - 'HOME': '/Users/cltbld', 13:27:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:39 INFO - 'LOGNAME': 'cltbld', 13:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:39 INFO - 'MOZ_NO_REMOTE': '1', 13:27:39 INFO - 'NO_EM_RESTART': '1', 13:27:39 INFO - 'PAGER': '/bin/cat', 13:27:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:39 INFO - 'PWD': '/builds/slave/test', 13:27:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:39 INFO - 'SHELL': '/bin/bash', 13:27:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IL6WTCUyQx/Listeners', 13:27:39 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 13:27:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:39 INFO - 'USER': 'cltbld', 13:27:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:39 INFO - 'XPC_FLAGS': '0x0', 13:27:39 INFO - 'XPC_SERVICE_NAME': '0', 13:27:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-QOgalZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-jUD5wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-QgbCzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-gd8h2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-U4qbp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-6e5oyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-IWL4oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-TuRcGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-Ud1P71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-vSdlBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-JFihH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-gHsjil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-7oWyOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-7mQjn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-IaCQ6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-woawlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-OK4kR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:27:41 INFO - Running setup.py install for manifestparser 13:27:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:27:41 INFO - Running setup.py install for mozcrash 13:27:42 INFO - Running setup.py install for mozdebug 13:27:42 INFO - Running setup.py install for mozdevice 13:27:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:27:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:27:42 INFO - Running setup.py install for mozfile 13:27:42 INFO - Running setup.py install for mozhttpd 13:27:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:27:42 INFO - Running setup.py install for mozinfo 13:27:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:27:42 INFO - Running setup.py install for mozInstall 13:27:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:27:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:27:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:27:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:27:42 INFO - Running setup.py install for mozleak 13:27:43 INFO - Running setup.py install for mozlog 13:27:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:27:43 INFO - Running setup.py install for moznetwork 13:27:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:27:43 INFO - Running setup.py install for mozprocess 13:27:43 INFO - Running setup.py install for mozprofile 13:27:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:27:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:27:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:27:43 INFO - Running setup.py install for mozrunner 13:27:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:27:43 INFO - Running setup.py install for mozscreenshot 13:27:44 INFO - Running setup.py install for moztest 13:27:44 INFO - Running setup.py install for mozversion 13:27:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:27:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:27:44 INFO - Cleaning up... 13:27:44 INFO - Return code: 0 13:27:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:44 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')]} 13:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:44 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')]} 13:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:44 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 0x10e386490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d0598e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ad30>, '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 0x10e000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e192b20>, '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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:27:44 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 13:27:44 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 13:27:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWPgc3lgLx/Render', 13:27:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:44 INFO - 'HOME': '/Users/cltbld', 13:27:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:44 INFO - 'LOGNAME': 'cltbld', 13:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:44 INFO - 'MOZ_NO_REMOTE': '1', 13:27:44 INFO - 'NO_EM_RESTART': '1', 13:27:44 INFO - 'PAGER': '/bin/cat', 13:27:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:44 INFO - 'PWD': '/builds/slave/test', 13:27:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:44 INFO - 'SHELL': '/bin/bash', 13:27:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IL6WTCUyQx/Listeners', 13:27:44 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 13:27:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:44 INFO - 'USER': 'cltbld', 13:27:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:44 INFO - 'XPC_FLAGS': '0x0', 13:27:44 INFO - 'XPC_SERVICE_NAME': '0', 13:27:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-fpgXlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:44 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)) 13:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-BamyF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:44 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)) 13:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-lZO83X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:44 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)) 13:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-OzNa4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-73tk13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:45 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)) 13:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-JclhEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:45 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)) 13:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-jdx1jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:45 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)) 13:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-Fu2L7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:45 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)) 13:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-7RQWLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:45 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)) 13:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-mEeyNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:45 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)) 13:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-OB6Rs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:45 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)) 13:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-qLhFoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-fZYmJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:46 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)) 13:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-l3vNHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:46 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)) 13:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-XtEfEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:46 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)) 13:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-1PljG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:46 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)) 13:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-5Nx1Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:46 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)) 13:27:46 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)) 13:27:46 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)) 13:27:46 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)) 13:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:27:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:49 INFO - Downloading blessings-1.6.tar.gz 13:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:27:49 INFO - Installing collected packages: blessings 13:27:49 INFO - Running setup.py install for blessings 13:27:49 INFO - Successfully installed blessings 13:27:49 INFO - Cleaning up... 13:27:49 INFO - Return code: 0 13:27:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:27:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:49 INFO - Reading from file tmpfile_stdout 13:27:49 INFO - Current package versions: 13:27:49 INFO - blessings == 1.6 13:27:49 INFO - blobuploader == 1.2.4 13:27:49 INFO - docopt == 0.6.1 13:27:49 INFO - functools32 == 3.2.3-2 13:27:49 INFO - jsonschema == 2.5.1 13:27:49 INFO - manifestparser == 1.1 13:27:49 INFO - mozInstall == 1.12 13:27:49 INFO - mozcrash == 1.0 13:27:49 INFO - mozdebug == 0.1 13:27:49 INFO - mozdevice == 0.48 13:27:49 INFO - mozfile == 1.2 13:27:49 INFO - mozhttpd == 0.7 13:27:49 INFO - mozinfo == 0.9 13:27:49 INFO - mozleak == 0.1 13:27:49 INFO - mozlog == 3.4 13:27:49 INFO - moznetwork == 0.27 13:27:49 INFO - mozprocess == 0.23 13:27:49 INFO - mozprofile == 0.28 13:27:49 INFO - mozrunner == 6.13 13:27:49 INFO - mozscreenshot == 0.1 13:27:49 INFO - mozsystemmonitor == 0.3 13:27:49 INFO - moztest == 0.8 13:27:49 INFO - mozversion == 1.4 13:27:49 INFO - psutil == 3.1.1 13:27:49 INFO - requests == 1.2.3 13:27:49 INFO - wsgiref == 0.1.2 13:27:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:49 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')]} 13:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13: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')]} 13:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:50 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 0x10e386490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d0598e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ad30>, '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 0x10e000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e192b20>, '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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:27:50 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 13:27:50 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 13:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWPgc3lgLx/Render', 13:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:50 INFO - 'HOME': '/Users/cltbld', 13:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:50 INFO - 'LOGNAME': 'cltbld', 13:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:50 INFO - 'MOZ_NO_REMOTE': '1', 13:27:50 INFO - 'NO_EM_RESTART': '1', 13:27:50 INFO - 'PAGER': '/bin/cat', 13:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:50 INFO - 'PWD': '/builds/slave/test', 13:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:50 INFO - 'SHELL': '/bin/bash', 13:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IL6WTCUyQx/Listeners', 13:27:50 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 13:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:50 INFO - 'USER': 'cltbld', 13:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:50 INFO - 'XPC_FLAGS': '0x0', 13:27:50 INFO - 'XPC_SERVICE_NAME': '0', 13:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:50 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)) 13:27:50 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)) 13:27:50 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)) 13:27:50 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)) 13:27:50 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)) 13:27:50 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)) 13:27:50 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)) 13:27:50 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)) 13:27:50 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)) 13:27:50 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)) 13:27:50 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)) 13:27:50 INFO - Cleaning up... 13:27:50 INFO - Return code: 0 13:27:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13: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')]} 13:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13: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')]} 13:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:51 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 0x10e386490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d0598e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ad30>, '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 0x10e000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e192b20>, '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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 13:27:51 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 13:27:51 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 13:27:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWPgc3lgLx/Render', 13:27:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:51 INFO - 'HOME': '/Users/cltbld', 13:27:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:51 INFO - 'LOGNAME': 'cltbld', 13:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:51 INFO - 'MOZ_NO_REMOTE': '1', 13:27:51 INFO - 'NO_EM_RESTART': '1', 13:27:51 INFO - 'PAGER': '/bin/cat', 13:27:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:51 INFO - 'PWD': '/builds/slave/test', 13:27:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:51 INFO - 'SHELL': '/bin/bash', 13:27:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IL6WTCUyQx/Listeners', 13:27:51 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 13:27:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:51 INFO - 'USER': 'cltbld', 13:27:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:51 INFO - 'XPC_FLAGS': '0x0', 13:27:51 INFO - 'XPC_SERVICE_NAME': '0', 13:27:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:27:51 INFO - Cleaning up... 13:27:51 INFO - Return code: 0 13:27:51 INFO - Running post-action listener: _resource_record_post_action 13:27:51 INFO - Running post-action listener: _start_resource_monitoring 13:27:51 INFO - Starting resource monitoring. 13:27:51 INFO - [mozharness: 2017-02-13 21:27:51.582514Z] Finished create-virtualenv step (success) 13:27:51 INFO - [mozharness: 2017-02-13 21:27:51.583459Z] Running install step. 13:27:51 INFO - Running pre-action listener: _resource_record_pre_action 13:27:51 INFO - Running main action method: install 13:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:51 INFO - Reading from file tmpfile_stdout 13:27:51 INFO - Detecting whether we're running mozinstall >=1.0... 13:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:27:51 INFO - Reading from file tmpfile_stdout 13:27:51 INFO - Output received: 13:27:51 INFO - Usage: mozinstall [options] installer 13:27:51 INFO - Options: 13:27:51 INFO - -h, --help show this help message and exit 13:27:51 INFO - -d DEST, --destination=DEST 13:27:51 INFO - Directory to install application into. [default: 13:27:51 INFO - "/builds/slave/test"] 13:27:51 INFO - --app=APP Application being installed. [default: firefox] 13:27:51 INFO - mkdir: /builds/slave/test/build/application 13:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:28:14 INFO - Reading from file tmpfile_stdout 13:28:14 INFO - Output received: 13:28:14 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:28:14 INFO - Running post-action listener: _resource_record_post_action 13:28:14 INFO - [mozharness: 2017-02-13 21:28:14.154357Z] Finished install step (success) 13:28:14 INFO - [mozharness: 2017-02-13 21:28:14.154518Z] Running run-tests step. 13:28:14 INFO - Running pre-action listener: _resource_record_pre_action 13:28:14 INFO - Running main action method: run_tests 13:28:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:28:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:28:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:28:14 INFO - 2017-02-13 13:28:14.169 screenresolution[1899:10890] starting screenresolution argv=screenresolution get 13:28:14 INFO - 2017-02-13 13:28:14.171 screenresolution[1899:10890] Display 0: 1600x1200x32@60 13:28:14 INFO - 2017-02-13 13:28:14.177 screenresolution[1900:10893] starting screenresolution argv=screenresolution list 13:28:14 INFO - Available Modes on Display 0 13:28:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:28:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:28:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:28:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:28:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:28:14 INFO - Intel Iris: 13:28:14 INFO - Chipset Model: Intel Iris 13:28:14 INFO - Type: GPU 13:28:14 INFO - Bus: Built-In 13:28:14 INFO - VRAM (Dynamic, Max): 1536 MB 13:28:14 INFO - Vendor: Intel (0x8086) 13:28:14 INFO - Device ID: 0x0a2e 13:28:14 INFO - Revision ID: 0x0009 13:28:14 INFO - Displays: 13:28:14 INFO - Display: 13:28:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:28:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:28:14 INFO - Display Serial Number: 1600x1200 60 13:28:14 INFO - Main Display: Yes 13:28:14 INFO - Mirror: Off 13:28:14 INFO - Online: Yes 13:28:14 INFO - Rotation: Supported 13:28:14 INFO - Return code: 0 13:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:28:14 INFO - Python 2.7.3 13:28:14 INFO - Return code: 0 13:28:14 INFO - grabbing minidump binary from tooltool 13:28: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')]} 13:28:14 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 0x10e19ad30>, '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 0x10e000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e192b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:28:14 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 13:28:14 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 13:28:14 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 13:28:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:28:14 INFO - Return code: 0 13:28:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:28:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:28:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:28:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:28:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0272', '--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 13:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0272 --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 13:28:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWPgc3lgLx/Render', 13:28:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:28:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:28:14 INFO - 'HOME': '/Users/cltbld', 13:28:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:28:14 INFO - 'LOGNAME': 'cltbld', 13:28:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:28:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:14 INFO - 'MOZ_NO_REMOTE': '1', 13:28:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:28:14 INFO - 'NO_EM_RESTART': '1', 13:28:14 INFO - 'PAGER': '/bin/cat', 13:28:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:14 INFO - 'PWD': '/builds/slave/test', 13:28:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:28:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:28:14 INFO - 'SHELL': '/bin/bash', 13:28:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IL6WTCUyQx/Listeners', 13:28:14 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 13:28:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:28:14 INFO - 'USER': 'cltbld', 13:28:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:28:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:14 INFO - 'XPC_FLAGS': '0x0', 13:28:14 INFO - 'XPC_SERVICE_NAME': '0', 13:28:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:28:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0272', '--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 13:28:14 INFO - mozversion application_buildid: 20170213102439 13:28:14 INFO - mozversion application_changeset: 4ad8573642c78523c549e9ee3b90c24f9a464834 13:28:14 INFO - mozversion application_display_name: Firefox 13:28:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:28:14 INFO - mozversion application_name: Firefox 13:28:14 INFO - mozversion application_remotingname: firefox 13:28:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:28:14 INFO - mozversion application_vendor: Mozilla 13:28:14 INFO - mozversion application_version: 52.0 13:28:14 INFO - mozversion platform_buildid: 20170213102439 13:28:14 INFO - mozversion platform_changeset: 4ad8573642c78523c549e9ee3b90c24f9a464834 13:28:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:28:14 INFO - mozversion platform_version: 52.0 13:28:14 INFO - using testdate: 1487021294 13:28:14 INFO - actual date: 1487021294 13:28:14 INFO - starting webserver on 'localhost:49704' 13:28:14 INFO - SUITE-START | Running 2 tests 13:28:14 INFO - TEST-START | dromaeo_css 13:28:14 INFO - operating with platform_type : mac_ 13:28:14 INFO - Initialising browser for dromaeo_css test... 13:28:14 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmp7a9v4V/profile http://localhost:49704/getInfo.html) 13:28:17 INFO - PROCESS | 1910 | 2017-02-13 13:28:17.711 plugin-container[1913:11053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 13:28:17 INFO - PROCESS | 1910 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:28:17 INFO - PROCESS | 1910 | 2017-02-13 13:28:17.712 plugin-container[1913:11053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c23, name = 'com.apple.CFPasteboardClient' 13:28:17 INFO - PROCESS | 1910 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:28:17 INFO - PROCESS | 1910 | 2017-02-13 13:28:17.712 plugin-container[1913:11053] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:28:17 INFO - PROCESS | 1910 | __metrics Screen width/height:1600/1200 13:28:17 INFO - PROCESS | 1910 | colorDepth:24 13:28:17 INFO - PROCESS | 1910 | Browser inner width/height: 1024/689 13:28:17 INFO - PROCESS | 1910 | __metrics 13:28:17 ERROR - PROCESS | 1910 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 13:28:18 INFO - TEST-INFO | 1910: exit 0 13:28:18 INFO - Browser initialized. 13:28:18 INFO - Running cycle 1/1 for dromaeo_css test... 13:28:18 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmp7a9v4V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:21 INFO - PROCESS | 1914 | 2017-02-13 13:28:21.118 plugin-container[1915:11188] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8643, name = 'com.apple.tsm.portname' 13:28:21 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:28:21 INFO - PROCESS | 1914 | 2017-02-13 13:28:21.119 plugin-container[1915:11188] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 13:28:21 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:28:21 INFO - PROCESS | 1914 | 2017-02-13 13:28:21.119 plugin-container[1915:11188] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:28:30 INFO - PROCESS | 1914 | RSS: Main: 177422336 13:28:30 INFO - PROCESS | 1914 | 13:31:33 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49704/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49704/tests/dromaeo/cssquery-ext.html) 13:31:35 INFO - PROCESS | 1914 | RSS: Main: 181661696 13:31:35 INFO - PROCESS | 1914 | 13:34:37 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49704/tests/dromaeo/cssquery-ext.html (next: http://localhost:49704/tests/dromaeo/cssquery-jquery.html) 13:34:37 INFO - PROCESS | 1914 | RSS: Main: 194461696 13:34:37 INFO - PROCESS | 1914 | 13:37:39 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49704/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49704/tests/dromaeo/cssquery-mootools.html) 13:37:40 INFO - PROCESS | 1914 | RSS: Main: 196116480 13:37:40 INFO - PROCESS | 1914 | 13:40:42 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49704/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49704/tests/dromaeo/cssquery-prototype.html) 13:40:42 INFO - PROCESS | 1914 | RSS: Main: 199159808 13:40:42 INFO - PROCESS | 1914 | 13:43:45 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49704/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49704/tests/dromaeo/cssquery-yui.html) 13:43:46 INFO - PROCESS | 1914 | RSS: Main: 200671232 13:43:46 INFO - PROCESS | 1914 | 13:46:48 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49704/tests/dromaeo/cssquery-yui.html (next: http://localhost:49704/tests/dromaeo/cssquery-dojo.html) 13:46:48 INFO - PROCESS | 1914 | RSS: Main: 201134080 13:46:48 INFO - PROCESS | 1914 | 13:46:48 INFO - PROCESS | 1914 | __start_tp_report 13:46:48 INFO - PROCESS | 1914 | _x_x_mozilla_page_load 13:46:48 INFO - PROCESS | 1914 | _x_x_mozilla_page_load_details 13:46:48 INFO - PROCESS | 1914 | |i|pagename|runs| 13:46:48 INFO - PROCESS | 1914 | |0;dojo.html;3529.488224207488;3530.3645343838107;3554.62676418976;3565.92868142637;3585.8027808470524;5833.883322333556;5861.3552509223955;5876.618019828708;5921.911171332434;5922.851928701784;5911.881762364761;5969.224000879891;5990.490808281302;6014.849628759283;6024.75900963962;5237.685738855662;5382.407935127133;5397.757100930448;5451.04606693829;5520.199571062193;4759.286107083931;5471.7264136793;5477.835664930039;5487.945120548783;5487.972560137194;5243.632945693803;5336;5347.411784703699;5474.72626368682;5521.972390138044;5343.305370301836;5372.301600791891;5408.080626293539;5409.594280428983;5426.21319908615;5337.653052551572;5353.518183363477;5373.274607927919;5441.727913604304;5453.291072160594;5719.02776527987;5949.0481522956115;5962.165296858443;6029.216201893726;6035.577509574332;6157.96921015392;6217.098520714471;6267.561270711052;6282.277538083134;6284.811455656338;6266.749330026793;6268.216472940882;6272.498200143978;6272.843178920518;6293.9370606293805;5857.26784151981;5929.14027466015;5941.524678025834;6045.093236014589;6047.576669633084;6303.338149494237;6357.968210159012;6362.1093046973465;6370.140031095742;6381.23425188971;6243.843903902439;6262.655553944577;6277.435030847246;6279.497640188774;6297.937020629826;6138.235132557318;6247.3440288769025;6296.811095667137;6308.369163083747;6316.084167795736;6194.938050619527;6204.100405441186;6240.31356550779;6255.655938923312;6293.653849038347;6244.781432649836;6282.623042617458;6287.2140982377205;6292.087647291117;6295.874082518324;4251.213525497731;4885.731284779371;5060.038592667382;5076.670016448993;5113.744312784346;4454.510003899569;4464.665150113755;4501.7974191161475;4521.095780843844;4567.611753001032;5182.378114626194;5626.677730733274;6019.367966363557;6025.0661147522205;6041;6204;6261.467775239064;6272.40412160844;6288.748450061947;6295.685215739195;5962.165296858443;5996.880062398727;6025.578209525291;6066.939330606726;6098.969505152535;5559.8888022239325;5571.0807716727095;5588.608797384225;5600.831975040755;5601.915971260434;5142.922856157086;6262.749490020348;6419.903701444482;6458.289588145206;6460.483161347081;6211;6212.347703491249;6257.405546473078;6269;6310.2743184534365;6363.681815909279;6382.0745991831855;6391.456726178327;6395.20059992501;6589.0775291460195;5141.511556402136;6171.9691401544505;6289.528285378524;6292.465140463112;6307.24313082433;6188.504919606511;6199.225096862892;6206.658633775186;6243.906341404973;6266.811995640138;6251.156093927261;6258.12386265914;6259.092431597302;6269.279032911091;6269.279032911274;6020.555066784028;6110.480609148272;6244.594101383395;6256.499480041677;6282.811515654537;5805.448482394166;6037.879242415215;6069.180660610761;6124.319907527303;6131.785387511416;6204.937950620436;6258.405451482102;6262.74949002053;6275.748970041147;6292.590981586182;6154.415330543591;6178.042403427476;6178.783742568989;6182.041783523561;6209.627422354492 13:46:48 INFO - PROCESS | 1914 | |1;ext.html;462.99992017242744;496.3621746056318;505.46420793958396;514.6011840823364;527.7071225469865;38439.039024024416;40353.59646403535;40383.596164038354;40403;42471.36292955608;43036.354454683125;43065.56934430655;43316.91707707301;43368.566314336844;43371.56628433715;9541.141297283242;9551.904480955205;9563.234941204722;9717.805643887117;9740.561674724619;9632.951835240849;9636.084571965652;9647.565859536338;9681.177099946513;9808.068233517804;9773.853392199122;9793;9812.509374531244;9817.018298170162;9841.065098815601;9624.663136790214;9637.18083962864;9679;9694.272929530314;9759.560819763128;9534.713958581253;9560.760980975461;9621.470819104947;9666.323357364987;9677.90322096777;39796.60203397958;40189.79905100485;40491.39262911059;40515;40564.797176014225;3207.759418043656;3316.2704205074847;3351.9664803351898;3414.3171365726707;3776.7356285060055;30445.934392296163;30588.69411305903;30606.54090188649;30975;30999.690003099906;3174.698403651649;3304.438245498271;3305.058058453329;3318.3197444524058;3324.6509116542898;381381;491131;494304;495500;501838;56755.43244567502;57507.712461437426;57535.712321438965;57771.71114144402;57802.13296800551;59641;59642.70178649079;59751;59929.70035149884;60156;16421.83578164227;16671.16644167811;16671.833281667026;16675.332986680638;16691.666166676598;12965.416556254992;12994.545190918272;13018.02364822642;13024.739505209844;13046.478140874258;14771;15178.241087945558;15370.615734606725;15410.306536205897;15574;3344.1472424532076;6080.69596520181;6995.726388923518;7141.143062832493;7507.549547027196;744.817519707675;972.7227740094181;1055.2613170780485;1058.1904842795268;1069.4225118436113;29923.551146732818;30179;30185.396292074034;30198.245043873638;30524.54213186804;939.8543225800012;1033.8035773203067;1054.478033373485;1085.9565617375374;1100.658795773313;15544.611384715246;15631.296591653403;15707.900446968602;15800.288986995383;15934;659727;666094;666464;666909;668815;58321.41678583244;58495.41504584985;58726;58742.82514349689;58868.7056564723;1395.2186775405603;1401.9299035048207;1404.8876089912783;1413.4982081361175;1417.6597616572155;25625.974961002095;29131.126066218047;29300;30057.549136763402;32114.51828222532;54255;55149.72425137849;55183.44816551783;55263.723681381336;55519.722401387735;606450;608962;610937;615940;616043;41864.697441639786;42305.15389692251;42753;42806.78596606997;43002.78498607487;45475.77262113668;46445.76777116093;46504;46948.530514694416;47161;36464.63535364719;37797.24405511929;38443.80778096092;38718.032049199;39905;38213.42679859749;38302.42546361751;39185.628503002255;39441.802790985865;39587;37656.43515347217;37930.500541950496;38272.808635956644;38348.42477362786;38817.805910970266;33795;34445.62217511372;35000.29999400049;35137.824310878284;35157.94526164219;25532.61701074448;25560.8721956389;25563.36091597725;25945.870270648527;26120.60819087753 13:46:48 INFO - PROCESS | 1914 | |2;jquery.html;381.1804620066856;385.4356205122184;386.58442174662235;393.8365578285012;412.09133859839056;19548.120334584943;20120.597588048266;20733.68899466509;20795.480112997164;20827.166913323468;17863.73204401935;17866.92798432092;19405.514862128453;20018.799812001875;20469.18123275071;5751.7699292028265;5889.7644094236175;5942.940570594304;5997.130416089664;6029.216201893748;5888.381719919411;5894.970525147368;5925.200097986782;6014.458698717114;6022.247219097613;5355.437679043703;5743.712814359286;5837.941620583782;5922.911156332659;5950.970245148768;4969.925451118236;5662.631928924607;5830.387809280007;5890.5582081343855;6038.245219347582;5722;5744.253247077895;5857.502112320458;5864.912026319608;5871.9412805871825;13158.473661053642;15327;23830.52338953211;24295.54226746401;24325.391865203335;2195.9780402195934;2330.5222429401933;2361;2562.282560882937;2654.283343497245;9857.950710246474;9917.950410247975;9968.202543796551;10260.076593106656;10400.687979360555;1855.7958624551288;1904.7904730479636;1942.14545599937;1953.8925359105244;1959.657060014506;115986;118748;124636;126642;130506.34746826206;11534.884651153548;11753.236039657395;11783.705407364885;11802.232854864405;11803.834486587166;12132.272063676208;14494.130352178903;14497.057691250035;14620.488282910048;14626.85373146255;8258.463199891989;8389.07720150783;8439.873401898976;8598.699045533376;8671.826563468696;8355.916440835636;8388.32893368529;8404.285635721033;8493.915060849313;8528.786780330542;3797.8290976906105;4489.483709373399;4590.908181836345;4601.148787474328;4623.144718227139;1964.3223088034606;1983.072065916197;1983.603279344137;1991.4708320433258;2029.5129168999629;849.7748096754365;851.3699862102;881.352206128495;952.2049089010753;994.0953732103895;15185.848141518665;20193.192272308945;20955;20974.89512552458;22666.320010399715;740.899978502906;779.5050143159135;883.7936217063661;891.1445012787667;925.3707478914268;8464.619092140869;8663.696770612998;10895.945520272347;11102.833457498144;11153.665390038312;586695;588427.1157288458;599690;604406;605575;121201;134778;136401;137623.31188343995;147623.52376476311;365.6909911125095;457.48304416009694;460.27047130298854;460.3003434779184;462.9837506672821;10489.947550262199;10867.456627168767;11055.281406708538;11237.494312755782;11311.604093856675;39048.80475597717;46134.538654613025;46755.53244467648;47075;55164.17253741277;79795.20204797878;83881;83976.58011709902;84149.57925210334;84751.57624211839;7827.412944029106;8005.879911801211;8198.959005204935;8214.26071653554;8302.709405171032;11374.772504549697;11652.83471652828;11927.582534611247;12580.930620897327;12929.870701292866;10257;10535.63125290611;10634.255602107778;10748.140148788234;10862.94568527184;10681.931806819255;10831.661780589491;10907;11000.944995274973;11203.887961120285;10959.01368876773;10982.286151400453;10985.121190304597;11020.567326247536;11186.272892261977;8046.476978996347;8167.714130005421;8337.95831020841;8376.413651044368;8441.873371899304;8290.917090829256;10542.947285263524;10707.19696022817;10888.727781805519;10913.672589822318 13:46:48 INFO - PROCESS | 1914 | |3;mootools.html;1486.6357742353123;1532.991780767195;1706.5648259693776;1797.793253775816;1842.9262829486822;7653.272939070779;7888.9211107888905;8044.356451483882;8488.193621605953;8499.51258529758;6898.965505172467;8392.412531122824;8424.747257582267;8495.872561911561;8558.657653693845;2372.09860253104;2408.205292253552;2415.5651982643117;2415.6618073469726;2418.7218469875925;2394.4851856850773;2424.4544977380037;2427.890744916474;2453.938651533717;2464.383904023994;2300.4823914619246;2315.8031567316716;2324.8023917966993;2331.8834058297102;2333.2766842278947;2360.44529535559;2365.254944692425;2380.071772008918;2395.149721848736;2409.0604664180983;2035.521652411682;2396.388920825196;2410.9397265068337;2412.276317104879;2425.9514809703883;8121.066077401116;8203.05664848544;8249.628766705513;8289.917100828974;8502.702405415843;5162.535371816554;5213.035588416155;5281.52466278033;5316.255724198615;5316.9734151329385;3492.7380446466364;3519.753617246794;3547.308274886398;3587.6053634100226;3607.134287770942;1069.2362882653017;1072.1476426241156;1105.9115270778318;1110.2062025651617;1118.9552417903274;11086.501107450184;11090.334579925231;11143.721406964809;11145.442727863656;11156.609518666888;4519.909601807945;4680.672352935262;4774.904501909942;4776.331313616097;4798.688085274446;8011.519308841488;9569.856452153223;9601.32790704658;9635.181009614262;9659.082387173208;4397.890052748707;5275.287836142148;5287.048331300402;5302.70835104073;5316.175992721134;4327.394164816928;4338.023944612437;4788.664793464493;4854.368932038812;4859.028194361142;3896;3903;4005.919881602352;4008.9198216035516;4012.538558065801;1270.6505710929569;1301.6615679923289;1317.4730107956702;1320.6368248731676;1327.0511584217331;792.4096548071724;881.9250363719156;903.9819203615891;912.7398691372927;914.2183433164681;5746.856328591819;5760.53915686744;5782.797602083907;5865.090910908816;5882;864.2351518905688;899.6131663384807;914.1544071733753;921.4149015375151;988.3229987458614;3679.300932822755;3713.628637136265;3795.4686343911876;3807.124361396839;3886.8250928708276;10045.648402305884;10437.739056523647;10440;10460.63387781424;10465.68602941913;10067.295289329822;10263.384196948207;10271.897281027093;10415.531301091469;10428.800687920835;7498.700051997859;7898.368130549542;7908.4464087513325;7944.483608565425;7975.760727178078;5517.337919449692;5666.603337766317;5809.331926828469;5811.4479124483105;5820.708964551671;9251.167394934488;9382.10869967352;9408.905910940803;9412.105849944244;9537.284703647116;9610.279229057709;9619.90380096218;9655.324127311022;9683.564239609093;9818.263630227904;6660;6837.658117094026;7005.299470052954;7151.7854464366155;7313.341799238094;7102.715891364288;7806.531608103532;7998.800029999296;8018.118007019107;8023.6389362479995;6988.510804243654;7203.603801790951;7230.313120253568;7247.057882475245;7389.482736208413;7030.980507826439;7039.964800175966;7077.6461176941975;7189.604571748395;7224.674889629874;5588.888222235614;6784.966075169593;6860.5540639858245;6865.210500792473;6883.965580172067;4106.794660266915;4200.957990420179;4834.516548345137;4867.123917694849;4921.876953076202;4374.956250437455;4586.65600080002;4824.252240902666;4876.390451193601;4955.82654607087 13:46:48 INFO - PROCESS | 1914 | |4;prototype.html;268.4979089103376;299.4265980647061;312.756050280781;317.7775557110022;324.7596778383995;4241.554636763138;4467.7542735149555;4619.607333376663;5437.791702895296;5518.889622207554;4411.735295882249;4642.558956899089;5119.897602047957;5356.598255130871;5397.541208997231;3390.4744764561533;3770.849166033369;4014.0165659413337;4104.4664193654935;4164.541900390955;3230.9176425897354;3997.100652353212;4116;4121.001314362532;4160.292750232453;3905.8242379092867;4126.855560055399;4127.814248358816;4148.780402484671;4163.895902602429;3430.2624935638833;3969.4244334571326;4095.5494895561465;4117.300058989949;4185.853495127656;3580.15866271426;3600.513930619359;3607.134287770942;3616.150204701893;3621.3662609043577;4722.952770472286;4799.920067942256;5204.505571970694;5219.660722053054;5267.499587539178;3836.6163383661687;4274.679399045084;4346.6522678185665;4776.09254241693;4777.710018295041;4766.499517550642;5586.944130558683;5610.971945140289;5634.774609015634;5679.346875109374;3884.533855937306;3887.5334959805004;3923.293807114718;3934.3672375963943;3934.921301573981;5164.431912489623;5179.870503237412;5502.9174562381595;5783.797567085174;5969.224000879858;3807.676347510437;3896.844126234919;3905.4922860028014;3911.393733971239;3920.137569734654;3138.9529157062207;3312.9834350828573;3843.2121415109837;3971.046948732341;3981.2634662587516;4618.56123668251;4621.491635920046;4641.466231383367;4686.7656617169005;4688.859334219979;5392.379876314274;5596.2165296858475;5687.289088863892;5688.573356998241;5778.324285957109;1204.6626944455566;1291.7803973324558;1295.747329270802;1299.8050292456207;1300.135409952371;797.0554892452462;818.6848063495478;823.5347028928755;878.547548012774;898.4384759525296;4911.287863259808;5208.359366799446;5380.166074258496;5393.6763794172475;5423.83728488146;4662.580367766849;5887.381824908323;5909.852253693606;5911.349751527328;5940.138679891392;4166.416701661769;4639.793653650007;4967.430759285949;5036.294918711384;5388.272583201296;2457.4225057111566;2630.7369263073538;2650.880710368038;2724.3733941193636;2987.985060074729;5017.498250174954;5399.78400863961;5527.751251193706;5810.331811841692;5850.882982340329;5221.869453263623;5318.957592229933;5675.624695966359;5796;5809.448102430347;5474.7810087596845;5565.666060036411;5770.354864334167;5780.1907732917425;5803.071508558611;5183.81856635016;5652.5020869470445;5693;5709.829484955657;5760.395158508464;4876.561109500162;5735;5775.509081727932;5790.728238545208;5824.388439213822;6062.696520248168;6088.082254089947;6098.817035488943;6107.373829253464;6112.755489780537;3835.520559930009;3963.4847469828737;3967.3850553164307;3980.601939805996;3993.600639935983;4805.807767689393;5003.399592048831;5059.684482034624;5144.536991670768;5471.206675032177;5599.888002239851;5736.340320863154;5737.9139312911175;5761.683107428964;5804.332501762351;4951.554360107463;5454.645448045864;5667.603267771216;5686.459786320293;5692.743826527733;5602.439756024365;5623.493885550157;5637.351704554028;5658.405867383865;5663;4618.607418369476;5538.280023597068;5605.971970140124;5617.017022021211;5708.771649133988;5616.775328986958;5623.272712734402;5643.915341269966;5652.717364131695;5683.687397193194 13:46:48 INFO - PROCESS | 1914 | |5;yui.html;653.7154491424353;703.651692412256;719.1154879498217;726.9993719121072;758.6244808819634;14322.355494002768;15183.772243416357;15186;15194.544163675093;15231.54305370838;13605.115667481607;13616.45534178634;13696.863031369683;13733;13779.242141682204;675.0684056002709;708.8688592610383;842.5955541340176;857.3569822633025;859.2481578618708;835.2232423845821;851.9818816514268;865.2861389353777;866.2766589897443;868.2402897464718;892.2727976699002;900.6352427266935;912.8083102548472;917.8210249001447;918.2653876898488;811.6753298680545;913.474752017586;914.7987442762582;915.281504019345;917.2936838634248;648.2674577727186;653.6241661044918;661.1603263854926;677.14003215916;678.6437120511722;11828.70428239301;14097.5065872695;14269.643258918506;14304.642383940381;14726.705465890622;13909.930450347785;14187.43250269988;14198.290085495684;14258.572242832628;14259.928700356535;9846.113849753485;11516.193866429354;11584.536618535249;11749.29504229749;11769.470373833197;3692.390755525335;3733.7386382953205;3825.598312177209;3828.8659896903473;3836.6163383661687;82249.17750822475;89517;90396.54801726015;94608.05391946061;95203.52398237964;7581.772546823604;9997.80004399908;10310.845337319946;10430.956904309509;10570.947145264225;19601.1179496923;19692.015399229982;19917.302894398916;20037.098330575158;20053.899730501253;7514.887276690854;7552.584607846511;7740.7677769667;7759.146493885781;7852.528848269122;4321.891952701145;4454.1537107950035;4458.375827384169;4463.04044630406;4486.147631949919;3162.2094476380903;3193.4251834669517;3207.4547326954007;3236.093893709765;3259.2177877309273;604.1632339210138;604.9697515124315;613.7974468425409;616.5499185594541;623.7754408412968;506.46288514358747;555.7971340460703;599.6462087368474;615.2954866677629;650.72344253692;7150.463715221275;8512.233898949124;8775.613282758666;8876;9049.230815380766;552.5607142321863;557.7462254674114;588.2352941176454;603.1405247522263;617.4720613875072;4189.210693825579;4214.3678448232395;4455.443069616298;4466.151431228056;4478.776061196927;90930;102302.48848755709;120796;121441.39279303547;128396.35801820931;61351;68763.3123668767;88997;90804;93050.60424093645;60250.09624855631;67595.66202168958;74207;76629;81148.78276825852;9457.43255404678;9899.95050024774;9915.752106197115;10035.197184225099;10102.09081182697;42026;42316.36525452182;46378.76810615925;55083;55446.891062177725;71734.64132679303;73872;74684;77023.61488192747;77516;12503.187292825936;12526.561570344995;12593;12606.684832879251;12985.220886746825;14002.719945601235;14263.64340891486;14450.349734262194;14466.20435876037;14496.275186240857;12950.870491294967;13174;13469;13601.319934003062;13663.931680341535;12978.870211298145;13206.603801885958;13501.864981350061;13556.322183890568;14179.929100354844;12963.635549496794;13135.605931822061;13255.270960096901;13357.732845343233;13854.099483533539;10817.567297308335;10822.296550724177;11484.655460336204;11557.47991340375;11613.477393517143;9525.809483810424;11432.539226607892;11510.654680359603;11663.24188927717;11715.589954351557 13:46:48 INFO - PROCESS | 1914 | __end_tp_report 13:46:48 INFO - PROCESS | 1914 | __start_cc_report 13:46:48 INFO - PROCESS | 1914 | _x_x_mozilla_cycle_collect,355 13:46:48 INFO - PROCESS | 1914 | __end_cc_report 13:46:48 INFO - PROCESS | 1914 | __startTimestamp1487022408834__endTimestamp 13:46:48 INFO - PROCESS | 1914 | 13:46:48 INFO - PROCESS | 1914 | ------- Summary: start ------- 13:46:48 INFO - PROCESS | 1914 | Number of tests: 6 13:46:48 INFO - PROCESS | 1914 | 13:46:48 INFO - PROCESS | 1914 | [#0] dojo.html Cycles:165 Average:5854.26 Median:6124.32 stddev:627.99 (10.3%) stddev-sans-first:602.85 13:46:48 INFO - PROCESS | 1914 | Values: 3529.5 3530.4 3554.6 3565.9 3585.8 5833.9 5861.4 5876.6 5921.9 5922.9 5911.9 5969.2 5990.5 6014.8 6024.8 5237.7 5382.4 5397.8 5451.0 5520.2 4759.3 5471.7 5477.8 5487.9 5488.0 5243.6 5336.0 5347.4 5474.7 5522.0 5343.3 5372.3 5408.1 5409.6 5426.2 5337.7 5353.5 5373.3 5441.7 5453.3 5719.0 5949.0 5962.2 6029.2 6035.6 6158.0 6217.1 6267.6 6282.3 6284.8 6266.7 6268.2 6272.5 6272.8 6293.9 5857.3 5929.1 5941.5 6045.1 6047.6 6303.3 6358.0 6362.1 6370.1 6381.2 6243.8 6262.7 6277.4 6279.5 6297.9 6138.2 6247.3 6296.8 6308.4 6316.1 6194.9 6204.1 6240.3 6255.7 6293.7 6244.8 6282.6 6287.2 6292.1 6295.9 4251.2 4885.7 5060.0 5076.7 5113.7 4454.5 4464.7 4501.8 4521.1 4567.6 5182.4 5626.7 6019.4 6025.1 6041.0 6204.0 6261.5 6272.4 6288.7 6295.7 5962.2 5996.9 6025.6 6066.9 6099.0 5559.9 5571.1 5588.6 5600.8 5601.9 5142.9 6262.7 6419.9 6458.3 6460.5 6211.0 6212.3 6257.4 6269.0 6310.3 6363.7 6382.1 6391.5 6395.2 6589.1 5141.5 6172.0 6289.5 6292.5 6307.2 6188.5 6199.2 6206.7 6243.9 6266.8 6251.2 6258.1 6259.1 6269.3 6269.3 6020.6 6110.5 6244.6 6256.5 6282.8 5805.4 6037.9 6069.2 6124.3 6131.8 6204.9 6258.4 6262.7 6275.7 6292.6 6154.4 6178.0 6178.8 6182.0 6209.6 13:46:48 INFO - PROCESS | 1914 | 13:46:48 INFO - PROCESS | 1914 | [#1] ext.html Cycles:180 Average:71833.81 Median:40503.20 stddev:157674.97 (389.3%) stddev-sans-first:158026.23 13:46:48 INFO - PROCESS | 1914 | Values: 463.0 496.4 505.5 514.6 527.7 38439.0 40353.6 40383.6 40403.0 42471.4 43036.4 43065.6 43316.9 43368.6 43371.6 9541.1 9551.9 9563.2 9717.8 9740.6 9633.0 9636.1 9647.6 9681.2 9808.1 9773.9 9793.0 9812.5 9817.0 9841.1 9624.7 9637.2 9679.0 9694.3 9759.6 9534.7 9560.8 9621.5 9666.3 9677.9 39796.6 40189.8 40491.4 40515.0 40564.8 3207.8 3316.3 3352.0 3414.3 3776.7 30445.9 30588.7 30606.5 30975.0 30999.7 3174.7 3304.4 3305.1 3318.3 3324.7 381381.0 491131.0 494304.0 495500.0 501838.0 56755.4 57507.7 57535.7 57771.7 57802.1 59641.0 59642.7 59751.0 59929.7 60156.0 16421.8 16671.2 16671.8 16675.3 16691.7 12965.4 12994.5 13018.0 13024.7 13046.5 14771.0 15178.2 15370.6 15410.3 15574.0 3344.1 6080.7 6995.7 7141.1 7507.5 744.8 972.7 1055.3 1058.2 1069.4 29923.6 30179.0 30185.4 30198.2 30524.5 939.9 1033.8 1054.5 1086.0 1100.7 15544.6 15631.3 15707.9 15800.3 15934.0 659727.0 666094.0 666464.0 666909.0 668815.0 58321.4 58495.4 58726.0 58742.8 58868.7 1395.2 1401.9 1404.9 1413.5 1417.7 25626.0 29131.1 29300.0 30057.5 32114.5 54255.0 55149.7 55183.4 55263.7 55519.7 606450.0 608962.0 610937.0 615940.0 616043.0 41864.7 42305.2 42753.0 42806.8 43002.8 45475.8 46445.8 46504.0 46948.5 47161.0 36464.6 37797.2 38443.8 38718.0 39905.0 38213.4 38302.4 39185.6 39441.8 39587.0 37656.4 37930.5 38272.8 38348.4 38817.8 33795.0 34445.6 35000.3 35137.8 35157.9 25532.6 25560.9 25563.4 25945.9 26120.6 13:46:48 INFO - PROCESS | 1914 | 13:46:48 INFO - PROCESS | 1914 | [#2] jquery.html Cycles:180 Average:34812.74 Median:2089.50 stddev:100139.45 (4792.5%) stddev-sans-first:100386.99 13:46:48 INFO - PROCESS | 1914 | Values: 381.2 385.4 386.6 393.8 412.1 19548.1 20120.6 20733.7 20795.5 20827.2 17863.7 17866.9 19405.5 20018.8 20469.2 5751.8 5889.8 5942.9 5997.1 6029.2 5888.4 5895.0 5925.2 6014.5 6022.2 5355.4 5743.7 5837.9 5922.9 5951.0 4969.9 5662.6 5830.4 5890.6 6038.2 5722.0 5744.3 5857.5 5864.9 5871.9 13158.5 15327.0 23830.5 24295.5 24325.4 2196.0 2330.5 2361.0 2562.3 2654.3 9858.0 9918.0 9968.2 10260.1 10400.7 1855.8 1904.8 1942.1 1953.9 1959.7 115986.0 118748.0 124636.0 126642.0 130506.3 11534.9 11753.2 11783.7 11802.2 11803.8 12132.3 14494.1 14497.1 14620.5 14626.9 8258.5 8389.1 8439.9 8598.7 8671.8 8355.9 8388.3 8404.3 8493.9 8528.8 3797.8 4489.5 4590.9 4601.1 4623.1 1964.3 1983.1 1983.6 1991.5 2029.5 849.8 851.4 881.4 952.2 994.1 15185.8 20193.2 20955.0 20974.9 22666.3 740.9 779.5 883.8 891.1 925.4 8464.6 8663.7 10895.9 11102.8 11153.7 586695.0 588427.1 599690.0 604406.0 605575.0 121201.0 134778.0 136401.0 137623.3 147623.5 365.7 457.5 460.3 460.3 463.0 10489.9 10867.5 11055.3 11237.5 11311.6 39048.8 46134.5 46755.5 47075.0 55164.2 79795.2 83881.0 83976.6 84149.6 84751.6 7827.4 8005.9 8199.0 8214.3 8302.7 11374.8 11652.8 11927.6 12580.9 12929.9 10257.0 10535.6 10634.3 10748.1 10862.9 10681.9 10831.7 10907.0 11000.9 11203.9 10959.0 10982.3 10985.1 11020.6 11186.3 8046.5 8167.7 8338.0 8376.4 8441.9 8290.9 10542.9 10707.2 10888.7 10913.7 13:46:48 INFO - PROCESS | 1914 | 13:46:48 INFO - PROCESS | 1914 | [#3] mootools.html Cycles:180 Average:5495.92 Median:5059.18 stddev:3006.58 (59.4%) stddev-sans-first:2999.92 13:46:48 INFO - PROCESS | 1914 | Values: 1486.6 1533.0 1706.6 1797.8 1842.9 7653.3 7888.9 8044.4 8488.2 8499.5 6899.0 8392.4 8424.7 8495.9 8558.7 2372.1 2408.2 2415.6 2415.7 2418.7 2394.5 2424.5 2427.9 2453.9 2464.4 2300.5 2315.8 2324.8 2331.9 2333.3 2360.4 2365.3 2380.1 2395.1 2409.1 2035.5 2396.4 2410.9 2412.3 2426.0 8121.1 8203.1 8249.6 8289.9 8502.7 5162.5 5213.0 5281.5 5316.3 5317.0 3492.7 3519.8 3547.3 3587.6 3607.1 1069.2 1072.1 1105.9 1110.2 1119.0 11086.5 11090.3 11143.7 11145.4 11156.6 4519.9 4680.7 4774.9 4776.3 4798.7 8011.5 9569.9 9601.3 9635.2 9659.1 4397.9 5275.3 5287.0 5302.7 5316.2 4327.4 4338.0 4788.7 4854.4 4859.0 3896.0 3903.0 4005.9 4008.9 4012.5 1270.7 1301.7 1317.5 1320.6 1327.1 792.4 881.9 904.0 912.7 914.2 5746.9 5760.5 5782.8 5865.1 5882.0 864.2 899.6 914.2 921.4 988.3 3679.3 3713.6 3795.5 3807.1 3886.8 10045.6 10437.7 10440.0 10460.6 10465.7 10067.3 10263.4 10271.9 10415.5 10428.8 7498.7 7898.4 7908.4 7944.5 7975.8 5517.3 5666.6 5809.3 5811.4 5820.7 9251.2 9382.1 9408.9 9412.1 9537.3 9610.3 9619.9 9655.3 9683.6 9818.3 6660.0 6837.7 7005.3 7151.8 7313.3 7102.7 7806.5 7998.8 8018.1 8023.6 6988.5 7203.6 7230.3 7247.1 7389.5 7031.0 7040.0 7077.6 7189.6 7224.7 5588.9 6785.0 6860.6 6865.2 6884.0 4106.8 4201.0 4834.5 4867.1 4921.9 4375.0 4586.7 4824.3 4876.4 4955.8 13:46:48 INFO - PROCESS | 1914 | 13:46:48 INFO - PROCESS | 1914 | [#4] prototype.html Cycles:180 Average:4538.08 Median:5089.79 stddev:1412.86 (27.8%) stddev-sans-first:1380.00 13:46:48 INFO - PROCESS | 1914 | Values: 268.5 299.4 312.8 317.8 324.8 4241.6 4467.8 4619.6 5437.8 5518.9 4411.7 4642.6 5119.9 5356.6 5397.5 3390.5 3770.8 4014.0 4104.5 4164.5 3230.9 3997.1 4116.0 4121.0 4160.3 3905.8 4126.9 4127.8 4148.8 4163.9 3430.3 3969.4 4095.5 4117.3 4185.9 3580.2 3600.5 3607.1 3616.2 3621.4 4723.0 4799.9 5204.5 5219.7 5267.5 3836.6 4274.7 4346.7 4776.1 4777.7 4766.5 5586.9 5611.0 5634.8 5679.3 3884.5 3887.5 3923.3 3934.4 3934.9 5164.4 5179.9 5502.9 5783.8 5969.2 3807.7 3896.8 3905.5 3911.4 3920.1 3139.0 3313.0 3843.2 3971.0 3981.3 4618.6 4621.5 4641.5 4686.8 4688.9 5392.4 5596.2 5687.3 5688.6 5778.3 1204.7 1291.8 1295.7 1299.8 1300.1 797.1 818.7 823.5 878.5 898.4 4911.3 5208.4 5380.2 5393.7 5423.8 4662.6 5887.4 5909.9 5911.3 5940.1 4166.4 4639.8 4967.4 5036.3 5388.3 2457.4 2630.7 2650.9 2724.4 2988.0 5017.5 5399.8 5527.8 5810.3 5850.9 5221.9 5319.0 5675.6 5796.0 5809.4 5474.8 5565.7 5770.4 5780.2 5803.1 5183.8 5652.5 5693.0 5709.8 5760.4 4876.6 5735.0 5775.5 5790.7 5824.4 6062.7 6088.1 6098.8 6107.4 6112.8 3835.5 3963.5 3967.4 3980.6 3993.6 4805.8 5003.4 5059.7 5144.5 5471.2 5599.9 5736.3 5737.9 5761.7 5804.3 4951.6 5454.6 5667.6 5686.5 5692.7 5602.4 5623.5 5637.4 5658.4 5663.0 4618.6 5538.3 5606.0 5617.0 5708.8 5616.8 5623.3 5643.9 5652.7 5683.7 13:46:48 INFO - PROCESS | 1914 | 13:46:48 INFO - PROCESS | 1914 | [#5] yui.html Cycles:180 Average:19850.26 Median:4464.60 stddev:28794.39 (644.9%) stddev-sans-first:28839.09 13:46:48 INFO - PROCESS | 1914 | Values: 653.7 703.7 719.1 727.0 758.6 14322.4 15183.8 15186.0 15194.5 15231.5 13605.1 13616.5 13696.9 13733.0 13779.2 675.1 708.9 842.6 857.4 859.2 835.2 852.0 865.3 866.3 868.2 892.3 900.6 912.8 917.8 918.3 811.7 913.5 914.8 915.3 917.3 648.3 653.6 661.2 677.1 678.6 11828.7 14097.5 14269.6 14304.6 14726.7 13909.9 14187.4 14198.3 14258.6 14259.9 9846.1 11516.2 11584.5 11749.3 11769.5 3692.4 3733.7 3825.6 3828.9 3836.6 82249.2 89517.0 90396.5 94608.1 95203.5 7581.8 9997.8 10310.8 10431.0 10570.9 19601.1 19692.0 19917.3 20037.1 20053.9 7514.9 7552.6 7740.8 7759.1 7852.5 4321.9 4454.2 4458.4 4463.0 4486.1 3162.2 3193.4 3207.5 3236.1 3259.2 604.2 605.0 613.8 616.5 623.8 506.5 555.8 599.6 615.3 650.7 7150.5 8512.2 8775.6 8876.0 9049.2 552.6 557.7 588.2 603.1 617.5 4189.2 4214.4 4455.4 4466.2 4478.8 90930.0 102302.5 120796.0 121441.4 128396.4 61351.0 68763.3 88997.0 90804.0 93050.6 60250.1 67595.7 74207.0 76629.0 81148.8 9457.4 9900.0 9915.8 10035.2 10102.1 42026.0 42316.4 46378.8 55083.0 55446.9 71734.6 73872.0 74684.0 77023.6 77516.0 12503.2 12526.6 12593.0 12606.7 12985.2 14002.7 14263.6 14450.3 14466.2 14496.3 12950.9 13174.0 13469.0 13601.3 13663.9 12978.9 13206.6 13501.9 13556.3 14179.9 12963.6 13135.6 13255.3 13357.7 13854.1 10817.6 10822.3 11484.7 11557.5 11613.5 9525.8 11432.5 11510.7 11663.2 11715.6 13:46:48 INFO - PROCESS | 1914 | -------- Summary: end -------- 13:46:48 INFO - PROCESS | 1914 | 13:46:49 INFO - TEST-INFO | 1914: exit 0 13:46:49 INFO - TEST-OK | dromaeo_css | took 1114676ms 13:46:49 INFO - TEST-START | kraken 13:46:49 INFO - operating with platform_type : mac_ 13:46:49 INFO - Initialising browser for kraken test... 13:46:49 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmp2RVdOd/profile http://localhost:49704/getInfo.html) 13:46:52 INFO - PROCESS | 1920 | 2017-02-13 13:46:52.158 plugin-container[1922:13162] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 13:46:52 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:46:52 INFO - PROCESS | 1920 | 2017-02-13 13:46:52.159 plugin-container[1922:13162] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 13:46:52 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:46:52 INFO - PROCESS | 1920 | 2017-02-13 13:46:52.159 plugin-container[1922:13162] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:46:52 INFO - PROCESS | 1920 | __metrics Screen width/height:1600/1200 13:46:52 INFO - PROCESS | 1920 | colorDepth:24 13:46:52 INFO - PROCESS | 1920 | Browser inner width/height: 1024/689 13:46:52 INFO - PROCESS | 1920 | __metrics 13:46:52 ERROR - PROCESS | 1920 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 13:46:53 INFO - TEST-INFO | 1920: exit 0 13:46:53 INFO - Browser initialized. 13:46:53 INFO - Running cycle 1/1 for kraken test... 13:46:53 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmp2RVdOd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:55 INFO - PROCESS | 1923 | 2017-02-13 13:46:55.398 plugin-container[1924:13289] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 13:46:55 INFO - PROCESS | 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:46:55 INFO - PROCESS | 1923 | 2017-02-13 13:46:55.398 plugin-container[1924:13289] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 13:46:55 INFO - PROCESS | 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:46:55 INFO - PROCESS | 1923 | 2017-02-13 13:46:55.398 plugin-container[1924:13289] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:47:05 INFO - PROCESS | 1923 | RSS: Main: 177254400 13:47:05 INFO - PROCESS | 1923 | 13:47:08 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49704/tests/kraken/driver.html?testName=audio-beat-detection) 13:47:08 INFO - PROCESS | 1923 | RSS: Main: 190275584 13:47:08 INFO - PROCESS | 1923 | 13:47:11 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49704/tests/kraken/driver.html?testName=audio-dft) 13:47:12 INFO - PROCESS | 1923 | RSS: Main: 198258688 13:47:12 INFO - PROCESS | 1923 | 13:47:15 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49704/tests/kraken/driver.html?testName=audio-fft) 13:47:15 INFO - PROCESS | 1923 | RSS: Main: 201977856 13:47:15 INFO - PROCESS | 1923 | 13:47:17 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49704/tests/kraken/driver.html?testName=audio-oscillator) 13:47:18 INFO - PROCESS | 1923 | RSS: Main: 203313152 13:47:18 INFO - PROCESS | 1923 | 13:47:20 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49704/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:47:21 INFO - PROCESS | 1923 | RSS: Main: 203714560 13:47:21 INFO - PROCESS | 1923 | 13:47:23 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49704/tests/kraken/driver.html?testName=imaging-darkroom) 13:47:24 INFO - PROCESS | 1923 | RSS: Main: 207515648 13:47:24 INFO - PROCESS | 1923 | 13:47:27 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49704/tests/kraken/driver.html?testName=imaging-desaturate) 13:47:28 INFO - PROCESS | 1923 | RSS: Main: 207724544 13:47:28 INFO - PROCESS | 1923 | 13:47:30 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49704/tests/kraken/driver.html?testName=json-parse-financial) 13:47:31 INFO - PROCESS | 1923 | RSS: Main: 207237120 13:47:31 INFO - PROCESS | 1923 | 13:47:33 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49704/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:47:33 INFO - PROCESS | 1923 | RSS: Main: 206163968 13:47:33 INFO - PROCESS | 1923 | 13:47:35 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49704/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:47:36 INFO - PROCESS | 1923 | RSS: Main: 206282752 13:47:36 INFO - PROCESS | 1923 | 13:47:38 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49704/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:47:39 INFO - PROCESS | 1923 | RSS: Main: 206340096 13:47:39 INFO - PROCESS | 1923 | 13:47:42 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:47:42 INFO - PROCESS | 1923 | RSS: Main: 206352384 13:47:42 INFO - PROCESS | 1923 | 13:47:45 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:47:46 INFO - PROCESS | 1923 | RSS: Main: 206741504 13:47:46 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49704/tests/kraken/driver.html?testName=ai-astar) 13:47:48 INFO - PROCESS | 1923 | RSS: Main: 208670720 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | __start_tp_report 13:47:48 INFO - PROCESS | 1923 | _x_x_mozilla_page_load 13:47:48 INFO - PROCESS | 1923 | _x_x_mozilla_page_load_details 13:47:48 INFO - PROCESS | 1923 | |i|pagename|runs| 13:47:48 INFO - PROCESS | 1923 | |0;ai-astar;106;120;114;111;168;166;118;117;116;117 13:47:48 INFO - PROCESS | 1923 | |1;audio-beat-detection;134;103;153;133;145;139;113;109;141;110 13:47:48 INFO - PROCESS | 1923 | |2;audio-dft;191;198;193;199;194;194;197;194;198;221 13:47:48 INFO - PROCESS | 1923 | |3;audio-fft;82;60;60;85;60;78;77;56;84;82 13:47:48 INFO - PROCESS | 1923 | |4;audio-oscillator;87;69;86;74;72;72;84;69;77;118 13:47:48 INFO - PROCESS | 1923 | |5;imaging-gaussian-blur;93;90;93;91;93;89;92;92;96;90 13:47:48 INFO - PROCESS | 1923 | |6;imaging-darkroom;103;107;103;103;103;103;102;104;129;171 13:47:48 INFO - PROCESS | 1923 | |7;imaging-desaturate;115;113;82;88;91;90;92;98;89;87 13:47:48 INFO - PROCESS | 1923 | |8;json-parse-financial;56;64;66;87;89;89;87;61;59;57 13:47:48 INFO - PROCESS | 1923 | |9;json-stringify-tinderbox;67;74;72;83;75;74;67;69;68;69 13:47:48 INFO - PROCESS | 1923 | |10;stanford-crypto-aes;103;101;85;81;83;82;86;83;86;81 13:47:48 INFO - PROCESS | 1923 | |11;stanford-crypto-ccm;132;157;160;176;138;128;160;133;187;192 13:47:48 INFO - PROCESS | 1923 | |12;stanford-crypto-pbkdf2;165;161;163;154;162;160;176;168;239;191 13:47:48 INFO - PROCESS | 1923 | |13;stanford-crypto-sha256-iterative;68;65;68;66;68;78;76;65;66;68 13:47:48 INFO - PROCESS | 1923 | __end_tp_report 13:47:48 INFO - PROCESS | 1923 | __start_cc_report 13:47:48 INFO - PROCESS | 1923 | _x_x_mozilla_cycle_collect,899 13:47:48 INFO - PROCESS | 1923 | __end_cc_report 13:47:48 INFO - PROCESS | 1923 | __startTimestamp1487022468390__endTimestamp 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | ------- Summary: start ------- 13:47:48 INFO - PROCESS | 1923 | Number of tests: 14 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#0] ai-astar Cycles:10 Average:125.30 Median:117.50 stddev:22.34 (19.0%) stddev-sans-first:22.57 13:47:48 INFO - PROCESS | 1923 | Values: 106.0 120.0 114.0 111.0 168.0 166.0 118.0 117.0 116.0 117.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:136.50 stddev:17.64 (12.9%) stddev-sans-first:18.57 13:47:48 INFO - PROCESS | 1923 | Values: 134.0 103.0 153.0 133.0 145.0 139.0 113.0 109.0 141.0 110.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#2] audio-dft Cycles:10 Average:197.90 Median:197.50 stddev:8.52 (4.3%) stddev-sans-first:8.66 13:47:48 INFO - PROCESS | 1923 | Values: 191.0 198.0 193.0 199.0 194.0 194.0 197.0 194.0 198.0 221.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#3] audio-fft Cycles:10 Average:72.40 Median:80.00 stddev:11.83 (14.8%) stddev-sans-first:12.03 13:47:48 INFO - PROCESS | 1923 | Values: 82.0 60.0 60.0 85.0 60.0 78.0 77.0 56.0 84.0 82.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#4] audio-oscillator Cycles:10 Average:80.80 Median:75.50 stddev:14.73 (19.5%) stddev-sans-first:15.46 13:47:48 INFO - PROCESS | 1923 | Values: 87.0 69.0 86.0 74.0 72.0 72.0 84.0 69.0 77.0 118.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:92.50 stddev:2.02 (2.2%) stddev-sans-first:2.11 13:47:48 INFO - PROCESS | 1923 | Values: 93.0 90.0 93.0 91.0 93.0 89.0 92.0 92.0 96.0 90.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#6] imaging-darkroom Cycles:10 Average:112.80 Median:103.50 stddev:22.00 (21.3%) stddev-sans-first:23.05 13:47:48 INFO - PROCESS | 1923 | Values: 103.0 107.0 103.0 103.0 103.0 103.0 102.0 104.0 129.0 171.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:89.50 stddev:11.05 (12.3%) stddev-sans-first:8.89 13:47:48 INFO - PROCESS | 1923 | Values: 115.0 113.0 82.0 88.0 91.0 90.0 92.0 98.0 89.0 87.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#8] json-parse-financial Cycles:10 Average:71.50 Median:76.50 stddev:14.52 (19.0%) stddev-sans-first:14.27 13:47:48 INFO - PROCESS | 1923 | Values: 56.0 64.0 66.0 87.0 89.0 89.0 87.0 61.0 59.0 57.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:73.00 stddev:4.96 (6.8%) stddev-sans-first:4.95 13:47:48 INFO - PROCESS | 1923 | Values: 67.0 74.0 72.0 83.0 75.0 74.0 67.0 69.0 68.0 69.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:83.00 stddev:8.08 (9.7%) stddev-sans-first:6.18 13:47:48 INFO - PROCESS | 1923 | Values: 103.0 101.0 85.0 81.0 83.0 82.0 86.0 83.0 86.0 81.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#11] stanford-crypto-ccm Cycles:10 Average:156.30 Median:160.00 stddev:23.34 (14.6%) stddev-sans-first:23.04 13:47:48 INFO - PROCESS | 1923 | Values: 132.0 157.0 160.0 176.0 138.0 128.0 160.0 133.0 187.0 192.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:166.50 stddev:25.09 (15.1%) stddev-sans-first:26.40 13:47:48 INFO - PROCESS | 1923 | Values: 165.0 161.0 163.0 154.0 162.0 160.0 176.0 168.0 239.0 191.0 13:47:48 INFO - PROCESS | 1923 | 13:47:48 INFO - PROCESS | 1923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.00 stddev:4.52 (6.6%) stddev-sans-first:4.78 13:47:48 INFO - PROCESS | 1923 | Values: 68.0 65.0 68.0 66.0 68.0 78.0 76.0 65.0 66.0 68.0 13:47:48 INFO - PROCESS | 1923 | -------- Summary: end -------- 13:47:48 INFO - PROCESS | 1923 | 13:47:49 INFO - TEST-INFO | 1923: exit 0 13:47:49 INFO - TEST-OK | kraken | took 59911ms 13:47:49 INFO - SUITE-END | took 1174s 13:47:49 INFO - Completed test suite (00:19:34) 13:47:49 INFO - javascript benchmark 13:47:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7211.437625326785, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3529.488224207488, 3530.3645343838107, 3554.62676418976, 3565.92868142637, 3585.8027808470524, 5833.883322333556, 5861.3552509223955, 5876.618019828708, 5921.911171332434, 5922.851928701784, 5911.881762364761, 5969.224000879891, 5990.490808281302, 6014.849628759283, 6024.75900963962, 5237.685738855662, 5382.407935127133, 5397.757100930448, 5451.04606693829, 5520.199571062193, 4759.286107083931, 5471.7264136793, 5477.835664930039, 5487.945120548783, 5487.972560137194, 5243.632945693803, 5336.0, 5347.411784703699, 5474.72626368682, 5521.972390138044, 5343.305370301836, 5372.301600791891, 5408.080626293539, 5409.594280428983, 5426.21319908615, 5337.653052551572, 5353.518183363477, 5373.274607927919, 5441.727913604304, 5453.291072160594, 5719.02776527987, 5949.0481522956115, 5962.165296858443, 6029.216201893726, 6035.577509574332, 6157.96921015392, 6217.098520714471, 6267.561270711052, 6282.277538083134, 6284.811455656338, 6266.749330026793, 6268.216472940882, 6272.498200143978, 6272.843178920518, 6293.9370606293805, 5857.26784151981, 5929.14027466015, 5941.524678025834, 6045.093236014589, 6047.576669633084, 6303.338149494237, 6357.968210159012, 6362.1093046973465, 6370.140031095742, 6381.23425188971, 6243.843903902439, 6262.655553944577, 6277.435030847246, 6279.497640188774, 6297.937020629826, 6138.235132557318, 6247.3440288769025, 6296.811095667137, 6308.369163083747, 6316.084167795736, 6194.938050619527, 6204.100405441186, 6240.31356550779, 6255.655938923312, 6293.653849038347, 6244.781432649836, 6282.623042617458, 6287.2140982377205, 6292.087647291117, 6295.874082518324, 4251.213525497731, 4885.731284779371, 5060.038592667382, 5076.670016448993, 5113.744312784346, 4454.510003899569, 4464.665150113755, 4501.7974191161475, 4521.095780843844, 4567.611753001032, 5182.378114626194, 5626.677730733274, 6019.367966363557, 6025.0661147522205, 6041.0, 6204.0, 6261.467775239064, 6272.40412160844, 6288.748450061947, 6295.685215739195, 5962.165296858443, 5996.880062398727, 6025.578209525291, 6066.939330606726, 6098.969505152535, 5559.8888022239325, 5571.0807716727095, 5588.608797384225, 5600.831975040755, 5601.915971260434, 5142.922856157086, 6262.749490020348, 6419.903701444482, 6458.289588145206, 6460.483161347081, 6211.0, 6212.347703491249, 6257.405546473078, 6269.0, 6310.2743184534365, 6363.681815909279, 6382.0745991831855, 6391.456726178327, 6395.20059992501, 6589.0775291460195, 5141.511556402136, 6171.9691401544505, 6289.528285378524, 6292.465140463112, 6307.24313082433, 6188.504919606511, 6199.225096862892, 6206.658633775186, 6243.906341404973, 6266.811995640138, 6251.156093927261, 6258.12386265914, 6259.092431597302, 6269.279032911091, 6269.279032911274, 6020.555066784028, 6110.480609148272, 6244.594101383395, 6256.499480041677, 6282.811515654537, 5805.448482394166, 6037.879242415215, 6069.180660610761, 6124.319907527303, 6131.785387511416, 6204.937950620436, 6258.405451482102, 6262.74949002053, 6275.748970041147, 6292.590981586182, 6154.415330543591, 6178.042403427476, 6178.783742568989, 6182.041783523561, 6209.627422354492], "value": 5816.928195659922, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.99992017242744, 496.3621746056318, 505.46420793958396, 514.6011840823364, 527.7071225469865, 38439.039024024416, 40353.59646403535, 40383.596164038354, 40403.0, 42471.36292955608, 43036.354454683125, 43065.56934430655, 43316.91707707301, 43368.566314336844, 43371.56628433715, 9541.141297283242, 9551.904480955205, 9563.234941204722, 9717.805643887117, 9740.561674724619, 9632.951835240849, 9636.084571965652, 9647.565859536338, 9681.177099946513, 9808.068233517804, 9773.853392199122, 9793.0, 9812.509374531244, 9817.018298170162, 9841.065098815601, 9624.663136790214, 9637.18083962864, 9679.0, 9694.272929530314, 9759.560819763128, 9534.713958581253, 9560.760980975461, 9621.470819104947, 9666.323357364987, 9677.90322096777, 39796.60203397958, 40189.79905100485, 40491.39262911059, 40515.0, 40564.797176014225, 3207.759418043656, 3316.2704205074847, 3351.9664803351898, 3414.3171365726707, 3776.7356285060055, 30445.934392296163, 30588.69411305903, 30606.54090188649, 30975.0, 30999.690003099906, 3174.698403651649, 3304.438245498271, 3305.058058453329, 3318.3197444524058, 3324.6509116542898, 381381.0, 491131.0, 494304.0, 495500.0, 501838.0, 56755.43244567502, 57507.712461437426, 57535.712321438965, 57771.71114144402, 57802.13296800551, 59641.0, 59642.70178649079, 59751.0, 59929.70035149884, 60156.0, 16421.83578164227, 16671.16644167811, 16671.833281667026, 16675.332986680638, 16691.666166676598, 12965.416556254992, 12994.545190918272, 13018.02364822642, 13024.739505209844, 13046.478140874258, 14771.0, 15178.241087945558, 15370.615734606725, 15410.306536205897, 15574.0, 3344.1472424532076, 6080.69596520181, 6995.726388923518, 7141.143062832493, 7507.549547027196, 744.817519707675, 972.7227740094181, 1055.2613170780485, 1058.1904842795268, 1069.4225118436113, 29923.551146732818, 30179.0, 30185.396292074034, 30198.245043873638, 30524.54213186804, 939.8543225800012, 1033.8035773203067, 1054.478033373485, 1085.9565617375374, 1100.658795773313, 15544.611384715246, 15631.296591653403, 15707.900446968602, 15800.288986995383, 15934.0, 659727.0, 666094.0, 666464.0, 666909.0, 668815.0, 58321.41678583244, 58495.41504584985, 58726.0, 58742.82514349689, 58868.7056564723, 1395.2186775405603, 1401.9299035048207, 1404.8876089912783, 1413.4982081361175, 1417.6597616572155, 25625.974961002095, 29131.126066218047, 29300.0, 30057.549136763402, 32114.51828222532, 54255.0, 55149.72425137849, 55183.44816551783, 55263.723681381336, 55519.722401387735, 606450.0, 608962.0, 610937.0, 615940.0, 616043.0, 41864.697441639786, 42305.15389692251, 42753.0, 42806.78596606997, 43002.78498607487, 45475.77262113668, 46445.76777116093, 46504.0, 46948.530514694416, 47161.0, 36464.63535364719, 37797.24405511929, 38443.80778096092, 38718.032049199, 39905.0, 38213.42679859749, 38302.42546361751, 39185.628503002255, 39441.802790985865, 39587.0, 37656.43515347217, 37930.500541950496, 38272.808635956644, 38348.42477362786, 38817.805910970266, 33795.0, 34445.62217511372, 35000.29999400049, 35137.824310878284, 35157.94526164219, 25532.61701074448, 25560.8721956389, 25563.36091597725, 25945.870270648527, 26120.60819087753], "value": 20160.25865079403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.1804620066856, 385.4356205122184, 386.58442174662235, 393.8365578285012, 412.09133859839056, 19548.120334584943, 20120.597588048266, 20733.68899466509, 20795.480112997164, 20827.166913323468, 17863.73204401935, 17866.92798432092, 19405.514862128453, 20018.799812001875, 20469.18123275071, 5751.7699292028265, 5889.7644094236175, 5942.940570594304, 5997.130416089664, 6029.216201893748, 5888.381719919411, 5894.970525147368, 5925.200097986782, 6014.458698717114, 6022.247219097613, 5355.437679043703, 5743.712814359286, 5837.941620583782, 5922.911156332659, 5950.970245148768, 4969.925451118236, 5662.631928924607, 5830.387809280007, 5890.5582081343855, 6038.245219347582, 5722.0, 5744.253247077895, 5857.502112320458, 5864.912026319608, 5871.9412805871825, 13158.473661053642, 15327.0, 23830.52338953211, 24295.54226746401, 24325.391865203335, 2195.9780402195934, 2330.5222429401933, 2361.0, 2562.282560882937, 2654.283343497245, 9857.950710246474, 9917.950410247975, 9968.202543796551, 10260.076593106656, 10400.687979360555, 1855.7958624551288, 1904.7904730479636, 1942.14545599937, 1953.8925359105244, 1959.657060014506, 115986.0, 118748.0, 124636.0, 126642.0, 130506.34746826206, 11534.884651153548, 11753.236039657395, 11783.705407364885, 11802.232854864405, 11803.834486587166, 12132.272063676208, 14494.130352178903, 14497.057691250035, 14620.488282910048, 14626.85373146255, 8258.463199891989, 8389.07720150783, 8439.873401898976, 8598.699045533376, 8671.826563468696, 8355.916440835636, 8388.32893368529, 8404.285635721033, 8493.915060849313, 8528.786780330542, 3797.8290976906105, 4489.483709373399, 4590.908181836345, 4601.148787474328, 4623.144718227139, 1964.3223088034606, 1983.072065916197, 1983.603279344137, 1991.4708320433258, 2029.5129168999629, 849.7748096754365, 851.3699862102, 881.352206128495, 952.2049089010753, 994.0953732103895, 15185.848141518665, 20193.192272308945, 20955.0, 20974.89512552458, 22666.320010399715, 740.899978502906, 779.5050143159135, 883.7936217063661, 891.1445012787667, 925.3707478914268, 8464.619092140869, 8663.696770612998, 10895.945520272347, 11102.833457498144, 11153.665390038312, 586695.0, 588427.1157288458, 599690.0, 604406.0, 605575.0, 121201.0, 134778.0, 136401.0, 137623.31188343995, 147623.52376476311, 365.6909911125095, 457.48304416009694, 460.27047130298854, 460.3003434779184, 462.9837506672821, 10489.947550262199, 10867.456627168767, 11055.281406708538, 11237.494312755782, 11311.604093856675, 39048.80475597717, 46134.538654613025, 46755.53244467648, 47075.0, 55164.17253741277, 79795.20204797878, 83881.0, 83976.58011709902, 84149.57925210334, 84751.57624211839, 7827.412944029106, 8005.879911801211, 8198.959005204935, 8214.26071653554, 8302.709405171032, 11374.772504549697, 11652.83471652828, 11927.582534611247, 12580.930620897327, 12929.870701292866, 10257.0, 10535.63125290611, 10634.255602107778, 10748.140148788234, 10862.94568527184, 10681.931806819255, 10831.661780589491, 10907.0, 11000.944995274973, 11203.887961120285, 10959.01368876773, 10982.286151400453, 10985.121190304597, 11020.567326247536, 11186.272892261977, 8046.476978996347, 8167.714130005421, 8337.95831020841, 8376.413651044368, 8441.873371899304, 8290.917090829256, 10542.947285263524, 10707.19696022817, 10888.727781805519, 10913.672589822318], "value": 9083.283027220506, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.6357742353123, 1532.991780767195, 1706.5648259693776, 1797.793253775816, 1842.9262829486822, 7653.272939070779, 7888.9211107888905, 8044.356451483882, 8488.193621605953, 8499.51258529758, 6898.965505172467, 8392.412531122824, 8424.747257582267, 8495.872561911561, 8558.657653693845, 2372.09860253104, 2408.205292253552, 2415.5651982643117, 2415.6618073469726, 2418.7218469875925, 2394.4851856850773, 2424.4544977380037, 2427.890744916474, 2453.938651533717, 2464.383904023994, 2300.4823914619246, 2315.8031567316716, 2324.8023917966993, 2331.8834058297102, 2333.2766842278947, 2360.44529535559, 2365.254944692425, 2380.071772008918, 2395.149721848736, 2409.0604664180983, 2035.521652411682, 2396.388920825196, 2410.9397265068337, 2412.276317104879, 2425.9514809703883, 8121.066077401116, 8203.05664848544, 8249.628766705513, 8289.917100828974, 8502.702405415843, 5162.535371816554, 5213.035588416155, 5281.52466278033, 5316.255724198615, 5316.9734151329385, 3492.7380446466364, 3519.753617246794, 3547.308274886398, 3587.6053634100226, 3607.134287770942, 1069.2362882653017, 1072.1476426241156, 1105.9115270778318, 1110.2062025651617, 1118.9552417903274, 11086.501107450184, 11090.334579925231, 11143.721406964809, 11145.442727863656, 11156.609518666888, 4519.909601807945, 4680.672352935262, 4774.904501909942, 4776.331313616097, 4798.688085274446, 8011.519308841488, 9569.856452153223, 9601.32790704658, 9635.181009614262, 9659.082387173208, 4397.890052748707, 5275.287836142148, 5287.048331300402, 5302.70835104073, 5316.175992721134, 4327.394164816928, 4338.023944612437, 4788.664793464493, 4854.368932038812, 4859.028194361142, 3896.0, 3903.0, 4005.919881602352, 4008.9198216035516, 4012.538558065801, 1270.6505710929569, 1301.6615679923289, 1317.4730107956702, 1320.6368248731676, 1327.0511584217331, 792.4096548071724, 881.9250363719156, 903.9819203615891, 912.7398691372927, 914.2183433164681, 5746.856328591819, 5760.53915686744, 5782.797602083907, 5865.090910908816, 5882.0, 864.2351518905688, 899.6131663384807, 914.1544071733753, 921.4149015375151, 988.3229987458614, 3679.300932822755, 3713.628637136265, 3795.4686343911876, 3807.124361396839, 3886.8250928708276, 10045.648402305884, 10437.739056523647, 10440.0, 10460.63387781424, 10465.68602941913, 10067.295289329822, 10263.384196948207, 10271.897281027093, 10415.531301091469, 10428.800687920835, 7498.700051997859, 7898.368130549542, 7908.4464087513325, 7944.483608565425, 7975.760727178078, 5517.337919449692, 5666.603337766317, 5809.331926828469, 5811.4479124483105, 5820.708964551671, 9251.167394934488, 9382.10869967352, 9408.905910940803, 9412.105849944244, 9537.284703647116, 9610.279229057709, 9619.90380096218, 9655.324127311022, 9683.564239609093, 9818.263630227904, 6660.0, 6837.658117094026, 7005.299470052954, 7151.7854464366155, 7313.341799238094, 7102.715891364288, 7806.531608103532, 7998.800029999296, 8018.118007019107, 8023.6389362479995, 6988.510804243654, 7203.603801790951, 7230.313120253568, 7247.057882475245, 7389.482736208413, 7030.980507826439, 7039.964800175966, 7077.6461176941975, 7189.604571748395, 7224.674889629874, 5588.888222235614, 6784.966075169593, 6860.5540639858245, 6865.210500792473, 6883.965580172067, 4106.794660266915, 4200.957990420179, 4834.516548345137, 4867.123917694849, 4921.876953076202, 4374.956250437455, 4586.65600080002, 4824.252240902666, 4876.390451193601, 4955.82654607087], "value": 4472.265626517985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.4979089103376, 299.4265980647061, 312.756050280781, 317.7775557110022, 324.7596778383995, 4241.554636763138, 4467.7542735149555, 4619.607333376663, 5437.791702895296, 5518.889622207554, 4411.735295882249, 4642.558956899089, 5119.897602047957, 5356.598255130871, 5397.541208997231, 3390.4744764561533, 3770.849166033369, 4014.0165659413337, 4104.4664193654935, 4164.541900390955, 3230.9176425897354, 3997.100652353212, 4116.0, 4121.001314362532, 4160.292750232453, 3905.8242379092867, 4126.855560055399, 4127.814248358816, 4148.780402484671, 4163.895902602429, 3430.2624935638833, 3969.4244334571326, 4095.5494895561465, 4117.300058989949, 4185.853495127656, 3580.15866271426, 3600.513930619359, 3607.134287770942, 3616.150204701893, 3621.3662609043577, 4722.952770472286, 4799.920067942256, 5204.505571970694, 5219.660722053054, 5267.499587539178, 3836.6163383661687, 4274.679399045084, 4346.6522678185665, 4776.09254241693, 4777.710018295041, 4766.499517550642, 5586.944130558683, 5610.971945140289, 5634.774609015634, 5679.346875109374, 3884.533855937306, 3887.5334959805004, 3923.293807114718, 3934.3672375963943, 3934.921301573981, 5164.431912489623, 5179.870503237412, 5502.9174562381595, 5783.797567085174, 5969.224000879858, 3807.676347510437, 3896.844126234919, 3905.4922860028014, 3911.393733971239, 3920.137569734654, 3138.9529157062207, 3312.9834350828573, 3843.2121415109837, 3971.046948732341, 3981.2634662587516, 4618.56123668251, 4621.491635920046, 4641.466231383367, 4686.7656617169005, 4688.859334219979, 5392.379876314274, 5596.2165296858475, 5687.289088863892, 5688.573356998241, 5778.324285957109, 1204.6626944455566, 1291.7803973324558, 1295.747329270802, 1299.8050292456207, 1300.135409952371, 797.0554892452462, 818.6848063495478, 823.5347028928755, 878.547548012774, 898.4384759525296, 4911.287863259808, 5208.359366799446, 5380.166074258496, 5393.6763794172475, 5423.83728488146, 4662.580367766849, 5887.381824908323, 5909.852253693606, 5911.349751527328, 5940.138679891392, 4166.416701661769, 4639.793653650007, 4967.430759285949, 5036.294918711384, 5388.272583201296, 2457.4225057111566, 2630.7369263073538, 2650.880710368038, 2724.3733941193636, 2987.985060074729, 5017.498250174954, 5399.78400863961, 5527.751251193706, 5810.331811841692, 5850.882982340329, 5221.869453263623, 5318.957592229933, 5675.624695966359, 5796.0, 5809.448102430347, 5474.7810087596845, 5565.666060036411, 5770.354864334167, 5780.1907732917425, 5803.071508558611, 5183.81856635016, 5652.5020869470445, 5693.0, 5709.829484955657, 5760.395158508464, 4876.561109500162, 5735.0, 5775.509081727932, 5790.728238545208, 5824.388439213822, 6062.696520248168, 6088.082254089947, 6098.817035488943, 6107.373829253464, 6112.755489780537, 3835.520559930009, 3963.4847469828737, 3967.3850553164307, 3980.601939805996, 3993.600639935983, 4805.807767689393, 5003.399592048831, 5059.684482034624, 5144.536991670768, 5471.206675032177, 5599.888002239851, 5736.340320863154, 5737.9139312911175, 5761.683107428964, 5804.332501762351, 4951.554360107463, 5454.645448045864, 5667.603267771216, 5686.459786320293, 5692.743826527733, 5602.439756024365, 5623.493885550157, 5637.351704554028, 5658.405867383865, 5663.0, 4618.607418369476, 5538.280023597068, 5605.971970140124, 5617.017022021211, 5708.771649133988, 5616.775328986958, 5623.272712734402, 5643.915341269966, 5652.717364131695, 5683.687397193194], "value": 4081.5691231061473, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.7154491424353, 703.651692412256, 719.1154879498217, 726.9993719121072, 758.6244808819634, 14322.355494002768, 15183.772243416357, 15186.0, 15194.544163675093, 15231.54305370838, 13605.115667481607, 13616.45534178634, 13696.863031369683, 13733.0, 13779.242141682204, 675.0684056002709, 708.8688592610383, 842.5955541340176, 857.3569822633025, 859.2481578618708, 835.2232423845821, 851.9818816514268, 865.2861389353777, 866.2766589897443, 868.2402897464718, 892.2727976699002, 900.6352427266935, 912.8083102548472, 917.8210249001447, 918.2653876898488, 811.6753298680545, 913.474752017586, 914.7987442762582, 915.281504019345, 917.2936838634248, 648.2674577727186, 653.6241661044918, 661.1603263854926, 677.14003215916, 678.6437120511722, 11828.70428239301, 14097.5065872695, 14269.643258918506, 14304.642383940381, 14726.705465890622, 13909.930450347785, 14187.43250269988, 14198.290085495684, 14258.572242832628, 14259.928700356535, 9846.113849753485, 11516.193866429354, 11584.536618535249, 11749.29504229749, 11769.470373833197, 3692.390755525335, 3733.7386382953205, 3825.598312177209, 3828.8659896903473, 3836.6163383661687, 82249.17750822475, 89517.0, 90396.54801726015, 94608.05391946061, 95203.52398237964, 7581.772546823604, 9997.80004399908, 10310.845337319946, 10430.956904309509, 10570.947145264225, 19601.1179496923, 19692.015399229982, 19917.302894398916, 20037.098330575158, 20053.899730501253, 7514.887276690854, 7552.584607846511, 7740.7677769667, 7759.146493885781, 7852.528848269122, 4321.891952701145, 4454.1537107950035, 4458.375827384169, 4463.04044630406, 4486.147631949919, 3162.2094476380903, 3193.4251834669517, 3207.4547326954007, 3236.093893709765, 3259.2177877309273, 604.1632339210138, 604.9697515124315, 613.7974468425409, 616.5499185594541, 623.7754408412968, 506.46288514358747, 555.7971340460703, 599.6462087368474, 615.2954866677629, 650.72344253692, 7150.463715221275, 8512.233898949124, 8775.613282758666, 8876.0, 9049.230815380766, 552.5607142321863, 557.7462254674114, 588.2352941176454, 603.1405247522263, 617.4720613875072, 4189.210693825579, 4214.3678448232395, 4455.443069616298, 4466.151431228056, 4478.776061196927, 90930.0, 102302.48848755709, 120796.0, 121441.39279303547, 128396.35801820931, 61351.0, 68763.3123668767, 88997.0, 90804.0, 93050.60424093645, 60250.09624855631, 67595.66202168958, 74207.0, 76629.0, 81148.78276825852, 9457.43255404678, 9899.95050024774, 9915.752106197115, 10035.197184225099, 10102.09081182697, 42026.0, 42316.36525452182, 46378.76810615925, 55083.0, 55446.891062177725, 71734.64132679303, 73872.0, 74684.0, 77023.61488192747, 77516.0, 12503.187292825936, 12526.561570344995, 12593.0, 12606.684832879251, 12985.220886746825, 14002.719945601235, 14263.64340891486, 14450.349734262194, 14466.20435876037, 14496.275186240857, 12950.870491294967, 13174.0, 13469.0, 13601.319934003062, 13663.931680341535, 12978.870211298145, 13206.603801885958, 13501.864981350061, 13556.322183890568, 14179.929100354844, 12963.635549496794, 13135.605931822061, 13255.270960096901, 13357.732845343233, 13854.099483533539, 10817.567297308335, 10822.296550724177, 11484.655460336204, 11557.47991340375, 11613.477393517143, 9525.809483810424, 11432.539226607892, 11510.654680359603, 11663.24188927717, 11715.589954351557], "value": 7232.6506861637645, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 120.0, 114.0, 111.0, 168.0, 166.0, 118.0, 117.0, 116.0, 117.0], "value": 125.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 103.0, 153.0, 133.0, 145.0, 139.0, 113.0, 109.0, 141.0, 110.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 198.0, 193.0, 199.0, 194.0, 194.0, 197.0, 194.0, 198.0, 221.0], "value": 197.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 60.0, 85.0, 60.0, 78.0, 77.0, 56.0, 84.0, 82.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 86.0, 74.0, 72.0, 72.0, 84.0, 69.0, 77.0, 118.0], "value": 80.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 93.0, 91.0, 93.0, 89.0, 92.0, 92.0, 96.0, 90.0], "value": 91.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 107.0, 103.0, 103.0, 103.0, 103.0, 102.0, 104.0, 129.0, 171.0], "value": 112.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 82.0, 88.0, 91.0, 90.0, 92.0, 98.0, 89.0, 87.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 64.0, 66.0, 87.0, 89.0, 89.0, 87.0, 61.0, 59.0, 57.0], "value": 71.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 72.0, 83.0, 75.0, 74.0, 67.0, 69.0, 68.0, 69.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 101.0, 85.0, 81.0, 83.0, 82.0, 86.0, 83.0, 86.0, 81.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 157.0, 160.0, 176.0, 138.0, 128.0, 160.0, 133.0, 187.0, 192.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 163.0, 154.0, 162.0, 160.0, 176.0, 168.0, 239.0, 191.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 68.0, 66.0, 68.0, 78.0, 76.0, 65.0, 66.0, 68.0], "value": 68.8, "unit": "score"}]}]} 13:47:49 INFO - Return code: 0 13:47:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:47:49 ERROR - # TBPL SUCCESS # 13:47:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:47:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:47:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:47:49 INFO - 2017-02-13 13:47:49.743 screenresolution[1928:13673] starting screenresolution argv=screenresolution get 13:47:49 INFO - 2017-02-13 13:47:49.746 screenresolution[1928:13673] Display 0: 1600x1200x32@60 13:47:49 INFO - 2017-02-13 13:47:49.752 screenresolution[1929:13676] starting screenresolution argv=screenresolution list 13:47:49 INFO - Available Modes on Display 0 13:47:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:47:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:47:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:47:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:47:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:47:49 INFO - Intel Iris: 13:47:49 INFO - Chipset Model: Intel Iris 13:47:49 INFO - Type: GPU 13:47:49 INFO - Bus: Built-In 13:47:49 INFO - VRAM (Dynamic, Max): 1536 MB 13:47:49 INFO - Vendor: Intel (0x8086) 13:47:49 INFO - Device ID: 0x0a2e 13:47:49 INFO - Revision ID: 0x0009 13:47:49 INFO - Displays: 13:47:49 INFO - Display: 13:47:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:47:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:47:49 INFO - Display Serial Number: 1600x1200 60 13:47:49 INFO - Main Display: Yes 13:47:49 INFO - Mirror: Off 13:47:49 INFO - Online: Yes 13:47:49 INFO - Rotation: Supported 13:47:49 INFO - Return code: 0 13:47:49 INFO - Running post-action listener: _resource_record_post_action 13:47:49 INFO - [mozharness: 2017-02-13 21:47:49.993333Z] Finished run-tests step (success) 13:47:49 INFO - Running post-run listener: _resource_record_post_run 13:47:50 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 1651712; Write bytes: 498679296; Read time: 20; Write time: 1583 13:47:50 INFO - TinderboxPrint: CPU usage
54.0% 13:47:50 INFO - TinderboxPrint: I/O read bytes / time
1,651,712 / 20 13:47:50 INFO - TinderboxPrint: I/O write bytes / time
498,679,296 / 1,583 13:47:50 INFO - TinderboxPrint: CPU idle
2,201.3 (46.0%) 13:47:50 INFO - TinderboxPrint: CPU system
966.6 (20.2%) 13:47:50 INFO - TinderboxPrint: CPU user
1,621.8 (33.9%) 13:47:50 INFO - TinderboxPrint: Swap in / out
193,859,584 / 0 13:47:50 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 187107840; Write bytes: 188913152; Read time: 18244; Write time: 412 13:47:50 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1651712; Write bytes: 302753792; Read time: 20; Write time: 1139 13:47:50 INFO - Running post-run listener: _upload_blobber_files 13:47:50 INFO - Blob upload gear active. 13:47:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:47:50 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 13:47:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:47:50 INFO - (blobuploader) - INFO - Open directory for files ... 13:47:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:47:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:47:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:51 INFO - (blobuploader) - INFO - Done attempting. 13:47:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:47:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:47:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:52 INFO - (blobuploader) - INFO - Done attempting. 13:47:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:47:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:47:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:55 INFO - (blobuploader) - INFO - Done attempting. 13:47:55 INFO - (blobuploader) - INFO - Iteration through files over. 13:47:55 INFO - Return code: 0 13:47:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:47:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:47:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51bbf897884da7f8914b05049b716382f5a3ce492a2bcd172629c6bf5fdb565562f560617f687f61e705160943f14cb76f2b689ddf0abd3e920754eee7e45146", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0beeadc1c3c97f304f2aa38291563d432f4e407abc0ed92151a0d7fdc97ad34b121f3e7d94db7902c185e7cd6ff7b88c8128f76fa8ddf8afaa19f79ce4a9ce28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/690b98dc977e7045099e5d60c4845463ffc3eee37603ae2aa91a1eefb61c0b923a9cb194f70ffe9643014ebfae42a0441809e6f9e9e2503abd9feb76a64bc933"} 13:47:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:47:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:47:55 INFO - Contents: 13:47:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51bbf897884da7f8914b05049b716382f5a3ce492a2bcd172629c6bf5fdb565562f560617f687f61e705160943f14cb76f2b689ddf0abd3e920754eee7e45146", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0beeadc1c3c97f304f2aa38291563d432f4e407abc0ed92151a0d7fdc97ad34b121f3e7d94db7902c185e7cd6ff7b88c8128f76fa8ddf8afaa19f79ce4a9ce28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/690b98dc977e7045099e5d60c4845463ffc3eee37603ae2aa91a1eefb61c0b923a9cb194f70ffe9643014ebfae42a0441809e6f9e9e2503abd9feb76a64bc933"} 13:47:55 INFO - Running post-run listener: copy_logs_to_upload_dir 13:47:55 INFO - Copying logs to upload dir... 13:47:55 INFO - mkdir: /builds/slave/test/build/upload/logs 13:47:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.333725 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-13 13:47:55.492961) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 13:47:55.496793) ========= 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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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-Beta/sha512/51bbf897884da7f8914b05049b716382f5a3ce492a2bcd172629c6bf5fdb565562f560617f687f61e705160943f14cb76f2b689ddf0abd3e920754eee7e45146", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0beeadc1c3c97f304f2aa38291563d432f4e407abc0ed92151a0d7fdc97ad34b121f3e7d94db7902c185e7cd6ff7b88c8128f76fa8ddf8afaa19f79ce4a9ce28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/690b98dc977e7045099e5d60c4845463ffc3eee37603ae2aa91a1eefb61c0b923a9cb194f70ffe9643014ebfae42a0441809e6f9e9e2503abd9feb76a64bc933"} build_url:https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011108 build_url: 'https://queue.taskcluster.net/v1/task/VPL8D-MJQbKdnGnoOGhw8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51bbf897884da7f8914b05049b716382f5a3ce492a2bcd172629c6bf5fdb565562f560617f687f61e705160943f14cb76f2b689ddf0abd3e920754eee7e45146", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0beeadc1c3c97f304f2aa38291563d432f4e407abc0ed92151a0d7fdc97ad34b121f3e7d94db7902c185e7cd6ff7b88c8128f76fa8ddf8afaa19f79ce4a9ce28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/690b98dc977e7045099e5d60c4845463ffc3eee37603ae2aa91a1eefb61c0b923a9cb194f70ffe9643014ebfae42a0441809e6f9e9e2503abd9feb76a64bc933"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 13:47:55.532075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 13:47:55.532440) ========= 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.nWPgc3lgLx/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.IL6WTCUyQx/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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.005226 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 13:47:55.581177) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 13:47:55.581500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 13:47:55.581826) ========= ========= Total master_lag: 1.59 =========