builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0192 starttime: 1486000351.05 results: success (0) buildid: 20170201154808 builduid: 83b39ef880d64fa39bd3e0b4b0d6db11 revision: e293c1aa1c10d38b271b48742650d97a4ee5061e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 17:52:31.049894) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 17:52:31.050451) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 17:52:31.050721) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 17:52:31.078311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-01 17:52:31.078605) ========= 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.RmCFujgd4V/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.DW5FzU2QHz/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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-01 17:52:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2017-02-01 17:52:31 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.237121 ========= master_lag: 2.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-01 17:52:33.757008) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 17:52:33.757345) ========= 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.RmCFujgd4V/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.DW5FzU2QHz/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.026646 ========= master_lag: 0.26 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 17:52:34.044133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-01 17:52:34.044493) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e293c1aa1c10d38b271b48742650d97a4ee5061e --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 e293c1aa1c10d38b271b48742650d97a4ee5061e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RmCFujgd4V/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.DW5FzU2QHz/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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-01 17:52:34,148 truncating revision to first 12 chars 2017-02-01 17:52:34,148 Setting DEBUG logging. 2017-02-01 17:52:34,148 attempt 1/10 2017-02-01 17:52:34,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e293c1aa1c10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 17:52:36,075 unpacking tar archive at: mozilla-beta-e293c1aa1c10/testing/mozharness/ program finished with exit code 0 elapsedTime=2.176376 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-01 17:52:36.506773) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 17:52:36.507137) ========= script_repo_revision: e293c1aa1c10d38b271b48742650d97a4ee5061e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 17:52:36.507553) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 17:52:36.507821) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 17:52:36.528224) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-01 17:52:36.528505) ========= /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.RmCFujgd4V/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.DW5FzU2QHz/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 17:52:36 INFO - MultiFileLogger online at 20170201 17:52:36 in /builds/slave/test 17:52:36 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 17:52:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:52:36 INFO - {'append_to_log': False, 17:52:36 INFO - 'base_work_dir': '/builds/slave/test', 17:52:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:52:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:52:36 INFO - 'branch': 'Mozilla-Beta', 17:52:36 INFO - 'buildbot_json_path': 'buildprops.json', 17:52:36 INFO - 'config_files': ('talos/mac_config.py',), 17:52:36 INFO - 'default_actions': ('clobber', 17:52:36 INFO - 'read-buildbot-config', 17:52:36 INFO - 'download-and-extract', 17:52:36 INFO - 'populate-webroot', 17:52:36 INFO - 'create-virtualenv', 17:52:36 INFO - 'install', 17:52:36 INFO - 'run-tests'), 17:52:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:52:36 INFO - 'download_minidump_stackwalk': True, 17:52:36 INFO - 'download_symbols': 'ondemand', 17:52:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:52:36 INFO - 'tooltool.py': '/tools/tooltool.py', 17:52:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:52:36 INFO - '/tools/misc-python/virtualenv.py')}, 17:52:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:52:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:52:36 INFO - 'installer_path': 'installer.exe', 17:52:36 INFO - 'log_level': 'info', 17:52:36 INFO - 'log_name': 'talos', 17:52:36 INFO - 'log_to_console': True, 17:52:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:52:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:52:36 INFO - 'opt_config_files': (), 17:52:36 INFO - 'pip_index': False, 17:52:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:52:36 INFO - 'cmd': ('bash', 17:52:36 INFO - '-c', 17:52:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:52:36 INFO - 'enabled': True, 17:52:36 INFO - 'halt_on_failure': False, 17:52:36 INFO - 'name': 'check_screen_resolution'},), 17:52:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:52:36 INFO - 'cmd': ('bash', 17:52:36 INFO - '-c', 17:52:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:52:36 INFO - 'enabled': True, 17:52:36 INFO - 'halt_on_failure': False, 17:52:36 INFO - 'name': 'check_screen_resolution'},), 17:52:36 INFO - 'run_cmd_checks_enabled': True, 17:52:36 INFO - 'sps_profile': False, 17:52:36 INFO - 'sps_profile_interval': 0, 17:52:36 INFO - 'suite': 'dromaeojs-e10s', 17:52:36 INFO - 'system_bits': '32', 17:52:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:52:36 INFO - 'title': 't-yosemite-r7-0192', 17:52:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:52:36 INFO - 'use_talos_json': True, 17:52:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:52:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:52:36 INFO - 'work_dir': 'build'} 17:52:36 INFO - [mozharness: 2017-02-02 01:52:36.743795Z] Running clobber step. 17:52:36 INFO - Running pre-action listener: _resource_record_pre_action 17:52:36 INFO - Running main action method: clobber 17:52:36 INFO - rmtree: /builds/slave/test/build 17:52:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:52:39 INFO - Running post-action listener: _resource_record_post_action 17:52:39 INFO - [mozharness: 2017-02-02 01:52:39.120109Z] Finished clobber step (success) 17:52:39 INFO - [mozharness: 2017-02-02 01:52:39.120265Z] Running read-buildbot-config step. 17:52:39 INFO - Running pre-action listener: _resource_record_pre_action 17:52:39 INFO - Running main action method: read_buildbot_config 17:52:39 INFO - Using buildbot properties: 17:52:39 INFO - { 17:52:39 INFO - "project": "", 17:52:39 INFO - "product": "firefox", 17:52:39 INFO - "script_repo_revision": "production", 17:52:39 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 17:52:39 INFO - "repository": "", 17:52:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 17:52:39 INFO - "buildid": "20170201154808", 17:52:39 INFO - "pgo_build": "False", 17:52:39 INFO - "basedir": "/builds/slave/test", 17:52:39 INFO - "buildnumber": 18, 17:52:39 INFO - "slavename": "t-yosemite-r7-0192", 17:52:39 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 17:52:39 INFO - "platform": "yosemite_r7", 17:52:39 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:52:39 INFO - "branch": "mozilla-beta", 17:52:39 INFO - "repo_path": "releases/mozilla-beta", 17:52:39 INFO - "revision": "e293c1aa1c10d38b271b48742650d97a4ee5061e", 17:52:39 INFO - "stage_platform": "macosx64", 17:52:39 INFO - "builduid": "83b39ef880d64fa39bd3e0b4b0d6db11", 17:52:39 INFO - "slavebuilddir": "test" 17:52:39 INFO - } 17:52:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 17:52:39 INFO - Running post-action listener: _resource_record_post_action 17:52:39 INFO - [mozharness: 2017-02-02 01:52:39.123602Z] Finished read-buildbot-config step (success) 17:52:39 INFO - [mozharness: 2017-02-02 01:52:39.123744Z] Running download-and-extract step. 17:52:39 INFO - Running pre-action listener: _resource_record_pre_action 17:52:39 INFO - Running main action method: download_and_extract 17:52:39 INFO - mkdir: /builds/slave/test/build/tests 17:52: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')]} 17:52:39 INFO - trying https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 17:52:39 INFO - Downloading https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/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 17:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/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 17:52:40 INFO - Downloaded 1165 bytes. 17:52:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 17:52:40 INFO - Using the following test package requirements: 17:52:40 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 17:52:40 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:52:40 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 17:52:40 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:52:40 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 17:52:40 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:52:40 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:52:40 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 17:52:40 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 17:52:40 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:52:40 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 17:52:40 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:52:40 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 17:52:40 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:52:40 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 17:52:40 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:52:40 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 17:52:40 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 17:52:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 17:52:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 17:52:40 INFO - Fetch https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 17:52:40 INFO - Http code: 200 17:52:40 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 17:52:40 INFO - x-amz-cf-id: Xhh1kZ9MLxXPAu7SlTOz0sw14_ZD3vvYGDtdgWcLy3mbmuuKfIBcAg== 17:52:40 INFO - x-amz-version-id: mymQydGLF11SjPuVwQ4I8bUhYEc64plu 17:52:41 INFO - Expected file size: 16090516 17:52:41 INFO - Obtained file size: 16090516 17:52:47 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 17:52:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 17:52:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 17:52:47 INFO - Fetch https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 17:52:48 INFO - Http code: 200 17:52:48 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 17:52:48 INFO - x-amz-cf-id: Z6UAOOgXft58VOpQYz040Vg0GVnu7--gcjFlsOzowGTeevkkzGdCMw== 17:52:48 INFO - x-amz-version-id: mymQydGLF11SjPuVwQ4I8bUhYEc64plu 17:52:48 INFO - Expected file size: 16090516 17:52:48 INFO - Obtained file size: 16090516 17:52:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 17:52:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 17:52:55 INFO - Fetch https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 17:52:55 INFO - Http code: 200 17:52:55 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 17:52:55 INFO - x-amz-cf-id: lhLIV-3kV4CAzujvSYqn1XhnJOgn8NScuoeVQdbj_ruL1K1ekQm2Kw== 17:52:55 INFO - x-amz-version-id: jKPrNtgwROmE0QfENeSxY.vAa.plI0JQ 17:52:56 INFO - Expected file size: 14403005 17:52:56 INFO - Obtained file size: 14403005 17:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:56 INFO - trying https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:52:56 INFO - Downloading https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 17:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/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 17:52:58 INFO - Downloaded 82135814 bytes. 17:52:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:52:58 INFO - mkdir: /builds/slave/test/properties 17:52:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:52:58 INFO - Writing to file /builds/slave/test/properties/build_url 17:52:58 INFO - Contents: 17:52:58 INFO - build_url:https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:52:59 INFO - Running post-action listener: _resource_record_post_action 17:52:59 INFO - Running post-action listener: set_extra_try_arguments 17:52:59 INFO - [mozharness: 2017-02-02 01:52:59.356428Z] Finished download-and-extract step (success) 17:52:59 INFO - [mozharness: 2017-02-02 01:52:59.356566Z] Running populate-webroot step. 17:52:59 INFO - Running pre-action listener: _resource_record_pre_action 17:52:59 INFO - Running main action method: populate_webroot 17:52:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:52:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:52:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:52:59 INFO - '--tppagecycles', 17:52:59 INFO - '7'], 17:52:59 INFO - 'tests': ['tsvgm']}}, 17:52:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:52:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:52:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:52:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:52:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:52:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:52:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:52:59 INFO - 'talos_options': ['--disable-e10s'], 17:52:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:52:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:52:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:52:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:52:59 INFO - 'talos_options': ['--disable-e10s'], 17:52:59 INFO - 'tests': ['damp', 'tps']}, 17:52:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:52:59 INFO - 'tests': ['damp', 'tps']}, 17:52:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:52:59 INFO - 'tests': ['dromaeo_dom']}, 17:52:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:52:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:52:59 INFO - 'tests': ['basic_compositor_video']}, 17:52:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:52:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:52:59 INFO - 'tests': ['a11yr', 17:52:59 INFO - 'ts_paint', 17:52:59 INFO - 'tpaint', 17:52:59 INFO - 'sessionrestore', 17:52:59 INFO - 'sessionrestore_no_auto_restore', 17:52:59 INFO - 'tabpaint']}, 17:52:59 INFO - 'other-e10s': {'tests': ['a11yr', 17:52:59 INFO - 'ts_paint', 17:52:59 INFO - 'tpaint', 17:52:59 INFO - 'sessionrestore', 17:52:59 INFO - 'sessionrestore_no_auto_restore', 17:52:59 INFO - 'tabpaint']}, 17:52:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:52:59 INFO - 'ts_paint', 17:52:59 INFO - 'tpaint', 17:52:59 INFO - 'sessionrestore', 17:52:59 INFO - 'sessionrestore_no_auto_restore', 17:52:59 INFO - 'tabpaint']}, 17:52:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:52:59 INFO - 'ts_paint', 17:52:59 INFO - 'tpaint', 17:52:59 INFO - 'sessionrestore', 17:52:59 INFO - 'sessionrestore_no_auto_restore', 17:52:59 INFO - 'tabpaint']}, 17:52:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:52:59 INFO - 'tests': ['a11yr', 17:52:59 INFO - 'ts_paint', 17:52:59 INFO - 'tpaint', 17:52:59 INFO - 'sessionrestore', 17:52:59 INFO - 'sessionrestore_no_auto_restore', 17:52:59 INFO - 'tabpaint']}, 17:52:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:52:59 INFO - 'tests': ['a11yr', 17:52:59 INFO - 'ts_paint', 17:52:59 INFO - 'tpaint', 17:52:59 INFO - 'sessionrestore', 17:52:59 INFO - 'sessionrestore_no_auto_restore', 17:52:59 INFO - 'tabpaint']}, 17:52:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:52:59 INFO - 'tests': ['tsvgx', 17:52:59 INFO - 'tsvgr_opacity', 17:52:59 INFO - 'tart', 17:52:59 INFO - 'tscrollx', 17:52:59 INFO - 'cart']}, 17:52:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:52:59 INFO - 'tsvgr_opacity', 17:52:59 INFO - 'tart', 17:52:59 INFO - 'tscrollx', 17:52:59 INFO - 'cart']}, 17:52:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:52:59 INFO - 'talos_options': ['--disable-e10s'], 17:52:59 INFO - 'tests': ['tp5o']}, 17:52:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:52:59 INFO - 'tests': ['tp5o']}, 17:52:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:52:59 INFO - 'talos_options': ['--disable-e10s', 17:52:59 INFO - '--xperf_path', 17:52:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:52:59 INFO - 'tests': ['tp5n']}, 17:52:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:52:59 INFO - 'talos_options': ['--xperf_path', 17:52:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:52:59 INFO - 'tests': ['tp5n']}}, 17:52:59 INFO - 'talos.zip': {'path': '', 17:52:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:52:59 INFO - Running post-action listener: _resource_record_post_action 17:52:59 INFO - [mozharness: 2017-02-02 01:52:59.375150Z] Finished populate-webroot step (success) 17:52:59 INFO - [mozharness: 2017-02-02 01:52:59.375281Z] Running create-virtualenv step. 17:52:59 INFO - Running pre-action listener: _resource_record_pre_action 17:52:59 INFO - Running main action method: create_virtualenv 17:52:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:52:59 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 17:52:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:52:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:52:59 INFO - Using real prefix '/tools/python27' 17:52:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:53:00 INFO - Installing distribute.............................................................................................................................................................................................done. 17:53:03 INFO - Installing pip.................done. 17:53:03 INFO - Return code: 0 17:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:53:03 INFO - Reading from file tmpfile_stdout 17:53:03 INFO - Output received: 17:53:03 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) 17:53:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:53:03 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')]} 17:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:03 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')]} 17:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:03 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 0x1105f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110567570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe638581480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110405d30>, '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 0x11026bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103fdb20>, '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.RmCFujgd4V/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.DW5FzU2QHz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 17:53:03 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 17:53:03 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 17:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RmCFujgd4V/Render', 17:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:53:03 INFO - 'HOME': '/Users/cltbld', 17:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:53:03 INFO - 'LOGNAME': 'cltbld', 17:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:03 INFO - 'MOZ_NO_REMOTE': '1', 17:53:03 INFO - 'NO_EM_RESTART': '1', 17:53:03 INFO - 'PAGER': '/bin/cat', 17:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:03 INFO - 'PWD': '/builds/slave/test', 17:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:53:03 INFO - 'SHELL': '/bin/bash', 17:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DW5FzU2QHz/Listeners', 17:53:03 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 17:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:53:03 INFO - 'USER': 'cltbld', 17:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:03 INFO - 'XPC_FLAGS': '0x0', 17:53:03 INFO - 'XPC_SERVICE_NAME': '0', 17:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:03 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 17:53:03 INFO - Cleaning up... 17:53:03 INFO - Return code: 0 17:53:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:53:03 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')]} 17:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:03 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')]} 17:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:03 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 0x1105f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110567570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe638581480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110405d30>, '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 0x11026bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103fdb20>, '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.RmCFujgd4V/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.DW5FzU2QHz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 17:53:03 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 17:53:03 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 17:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RmCFujgd4V/Render', 17:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:53:03 INFO - 'HOME': '/Users/cltbld', 17:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:53:03 INFO - 'LOGNAME': 'cltbld', 17:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:03 INFO - 'MOZ_NO_REMOTE': '1', 17:53:03 INFO - 'NO_EM_RESTART': '1', 17:53:03 INFO - 'PAGER': '/bin/cat', 17:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:03 INFO - 'PWD': '/builds/slave/test', 17:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:53:03 INFO - 'SHELL': '/bin/bash', 17:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DW5FzU2QHz/Listeners', 17:53:03 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 17:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:53:03 INFO - 'USER': 'cltbld', 17:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:03 INFO - 'XPC_FLAGS': '0x0', 17:53:03 INFO - 'XPC_SERVICE_NAME': '0', 17:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:03 INFO - Downloading/unpacking psutil>=3.1.1 17:53:03 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 17:53:03 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 17:53:03 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 17:53:03 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 17:53:03 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 17:53:03 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 17:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:53:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:53:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:53:07 INFO - Installing collected packages: psutil 17:53:07 INFO - Running setup.py install for psutil 17:53:07 INFO - building 'psutil._psutil_osx' extension 17:53:07 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 17:53:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:53:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:53:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:53:08 INFO - building 'psutil._psutil_posix' extension 17:53:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:53:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:53:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:53:08 INFO - ^ 17:53:08 INFO - 1 warning generated. 17:53:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:53:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:53:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:53:08 INFO - Successfully installed psutil 17:53:08 INFO - Cleaning up... 17:53:08 INFO - Return code: 0 17:53:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110567570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe638581480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110405d30>, '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 0x11026bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103fdb20>, '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.RmCFujgd4V/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.DW5FzU2QHz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 17:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:53:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RmCFujgd4V/Render', 17:53:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:53:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:53:08 INFO - 'HOME': '/Users/cltbld', 17:53:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:53:08 INFO - 'LOGNAME': 'cltbld', 17:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:08 INFO - 'MOZ_NO_REMOTE': '1', 17:53:08 INFO - 'NO_EM_RESTART': '1', 17:53:08 INFO - 'PAGER': '/bin/cat', 17:53:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:08 INFO - 'PWD': '/builds/slave/test', 17:53:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:53:08 INFO - 'SHELL': '/bin/bash', 17:53:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DW5FzU2QHz/Listeners', 17:53:08 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 17:53:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:53:08 INFO - 'USER': 'cltbld', 17:53:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:53:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:08 INFO - 'XPC_FLAGS': '0x0', 17:53:08 INFO - 'XPC_SERVICE_NAME': '0', 17:53:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:53:08 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 17:53:08 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 17:53:08 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 17:53:08 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 17:53:08 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 17:53:08 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 17:53:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:53:11 INFO - Installing collected packages: mozsystemmonitor 17:53:11 INFO - Running setup.py install for mozsystemmonitor 17:53:11 INFO - Successfully installed mozsystemmonitor 17:53:11 INFO - Cleaning up... 17:53:11 INFO - Return code: 0 17:53:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1105f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110567570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe638581480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110405d30>, '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 0x11026bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103fdb20>, '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.RmCFujgd4V/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.DW5FzU2QHz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 17:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RmCFujgd4V/Render', 17:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:53:11 INFO - 'HOME': '/Users/cltbld', 17:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:53:11 INFO - 'LOGNAME': 'cltbld', 17:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:11 INFO - 'MOZ_NO_REMOTE': '1', 17:53:11 INFO - 'NO_EM_RESTART': '1', 17:53:11 INFO - 'PAGER': '/bin/cat', 17:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:11 INFO - 'PWD': '/builds/slave/test', 17:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:53:11 INFO - 'SHELL': '/bin/bash', 17:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DW5FzU2QHz/Listeners', 17:53:11 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 17:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:53:11 INFO - 'USER': 'cltbld', 17:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:11 INFO - 'XPC_FLAGS': '0x0', 17:53:11 INFO - 'XPC_SERVICE_NAME': '0', 17:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:12 INFO - Downloading/unpacking jsonschema==2.5.1 17:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:53:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:15 INFO - Downloading functools32-3.2.3-2.tar.gz 17:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:53:15 INFO - warning: no files found matching '*.txt' 17:53:15 INFO - no previously-included directories found matching 'build' 17:53:15 INFO - no previously-included directories found matching 'dist' 17:53:15 INFO - no previously-included directories found matching '.git*' 17:53:15 INFO - Installing collected packages: jsonschema, functools32 17:53:15 INFO - Running setup.py install for functools32 17:53:15 INFO - warning: no files found matching '*.txt' 17:53:15 INFO - no previously-included directories found matching 'build' 17:53:15 INFO - no previously-included directories found matching 'dist' 17:53:15 INFO - no previously-included directories found matching '.git*' 17:53:15 INFO - Successfully installed jsonschema functools32 17:53:15 INFO - Cleaning up... 17:53:15 INFO - Return code: 0 17:53:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:53: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')]} 17:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53: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')]} 17:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:15 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 0x1105f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110567570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe638581480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110405d30>, '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 0x11026bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103fdb20>, '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.RmCFujgd4V/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.DW5FzU2QHz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 17:53:15 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 17:53:15 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 17:53:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RmCFujgd4V/Render', 17:53:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:53:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:53:15 INFO - 'HOME': '/Users/cltbld', 17:53:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:53:15 INFO - 'LOGNAME': 'cltbld', 17:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:15 INFO - 'MOZ_NO_REMOTE': '1', 17:53:15 INFO - 'NO_EM_RESTART': '1', 17:53:15 INFO - 'PAGER': '/bin/cat', 17:53:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:15 INFO - 'PWD': '/builds/slave/test', 17:53:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:53:15 INFO - 'SHELL': '/bin/bash', 17:53:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DW5FzU2QHz/Listeners', 17:53:15 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 17:53:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:53:15 INFO - 'USER': 'cltbld', 17:53:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:53:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:15 INFO - 'XPC_FLAGS': '0x0', 17:53:15 INFO - 'XPC_SERVICE_NAME': '0', 17:53:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:53:15 INFO - Cleaning up... 17:53:15 INFO - Return code: 0 17:53:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:53: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')]} 17:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53: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')]} 17:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:15 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 0x1105f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110567570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe638581480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110405d30>, '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 0x11026bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103fdb20>, '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.RmCFujgd4V/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.DW5FzU2QHz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 17:53:15 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 17:53:15 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 17:53:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RmCFujgd4V/Render', 17:53:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:53:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:53:15 INFO - 'HOME': '/Users/cltbld', 17:53:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:53:15 INFO - 'LOGNAME': 'cltbld', 17:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:15 INFO - 'MOZ_NO_REMOTE': '1', 17:53:15 INFO - 'NO_EM_RESTART': '1', 17:53:15 INFO - 'PAGER': '/bin/cat', 17:53:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:15 INFO - 'PWD': '/builds/slave/test', 17:53:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:53:15 INFO - 'SHELL': '/bin/bash', 17:53:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DW5FzU2QHz/Listeners', 17:53:15 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 17:53:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:53:15 INFO - 'USER': 'cltbld', 17:53:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:53:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:15 INFO - 'XPC_FLAGS': '0x0', 17:53:15 INFO - 'XPC_SERVICE_NAME': '0', 17:53:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:16 INFO - Downloading/unpacking blobuploader==1.2.4 17:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:18 INFO - Downloading blobuploader-1.2.4.tar.gz 17:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:53:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:53:18 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 17:53:18 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 17:53:18 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 17:53:18 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 17:53:18 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 17:53:18 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 17:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:53:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:53:19 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 17:53:19 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 17:53:19 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 17:53:19 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 17:53:19 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 17:53:19 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 17:53:19 INFO - Downloading docopt-0.6.1.tar.gz 17:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:53:20 INFO - Installing collected packages: blobuploader, requests, docopt 17:53:20 INFO - Running setup.py install for blobuploader 17:53:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:53:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:53:20 INFO - Running setup.py install for requests 17:53:20 INFO - Running setup.py install for docopt 17:53:20 INFO - Successfully installed blobuploader requests docopt 17:53:20 INFO - Cleaning up... 17:53:20 INFO - Return code: 0 17:53:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:20 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 0x1105f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110567570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe638581480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110405d30>, '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 0x11026bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103fdb20>, '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.RmCFujgd4V/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.DW5FzU2QHz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 17:53:20 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 17:53:20 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 17:53:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RmCFujgd4V/Render', 17:53:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:53:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:53:20 INFO - 'HOME': '/Users/cltbld', 17:53:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:53:20 INFO - 'LOGNAME': 'cltbld', 17:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:20 INFO - 'MOZ_NO_REMOTE': '1', 17:53:20 INFO - 'NO_EM_RESTART': '1', 17:53:20 INFO - 'PAGER': '/bin/cat', 17:53:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:20 INFO - 'PWD': '/builds/slave/test', 17:53:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:53:20 INFO - 'SHELL': '/bin/bash', 17:53:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DW5FzU2QHz/Listeners', 17:53:20 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 17:53:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:53:20 INFO - 'USER': 'cltbld', 17:53:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:53:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:20 INFO - 'XPC_FLAGS': '0x0', 17:53:20 INFO - 'XPC_SERVICE_NAME': '0', 17:53:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:53:21 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-OtedI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:53:21 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-SL4Zn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:53:21 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Bes4JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:53:21 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ZxP0AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:53:21 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Zq3XS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:53:21 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-cQ46Op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:53:21 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Xazgx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:53:21 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-XLEVQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:53:22 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-4MQSti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:53:22 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-cZBifM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:53:22 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-4zsVMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:53:22 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-4th8jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:53:22 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-zht0kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:53:22 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-VYtwUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:53:22 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-e_9zES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:53:22 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-3Jg6tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:53:22 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Hf4ArW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:53:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:53:22 INFO - Running setup.py install for manifestparser 17:53:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:53:23 INFO - Running setup.py install for mozcrash 17:53:23 INFO - Running setup.py install for mozdebug 17:53:23 INFO - Running setup.py install for mozdevice 17:53:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:53:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:53:23 INFO - Running setup.py install for mozfile 17:53:23 INFO - Running setup.py install for mozhttpd 17:53:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:53:23 INFO - Running setup.py install for mozinfo 17:53:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:53:24 INFO - Running setup.py install for mozInstall 17:53:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:53:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:53:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:53:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:53:24 INFO - Running setup.py install for mozleak 17:53:24 INFO - Running setup.py install for mozlog 17:53:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:53:24 INFO - Running setup.py install for moznetwork 17:53:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:53:24 INFO - Running setup.py install for mozprocess 17:53:24 INFO - Running setup.py install for mozprofile 17:53:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:53:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:53:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:53:24 INFO - Running setup.py install for mozrunner 17:53:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:53:25 INFO - Running setup.py install for mozscreenshot 17:53:25 INFO - Running setup.py install for moztest 17:53:25 INFO - Running setup.py install for mozversion 17:53:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:53:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:53:25 INFO - Cleaning up... 17:53:25 INFO - Return code: 0 17:53:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:53:25 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')]} 17:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:25 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')]} 17:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:25 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 0x1105f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110567570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe638581480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110405d30>, '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 0x11026bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103fdb20>, '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.RmCFujgd4V/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.DW5FzU2QHz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 17:53:25 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 17:53:25 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 17:53:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RmCFujgd4V/Render', 17:53:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:53:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:53:25 INFO - 'HOME': '/Users/cltbld', 17:53:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:53:25 INFO - 'LOGNAME': 'cltbld', 17:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:25 INFO - 'MOZ_NO_REMOTE': '1', 17:53:25 INFO - 'NO_EM_RESTART': '1', 17:53:25 INFO - 'PAGER': '/bin/cat', 17:53:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:25 INFO - 'PWD': '/builds/slave/test', 17:53:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:53:25 INFO - 'SHELL': '/bin/bash', 17:53:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DW5FzU2QHz/Listeners', 17:53:25 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 17:53:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:53:25 INFO - 'USER': 'cltbld', 17:53:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:53:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:25 INFO - 'XPC_FLAGS': '0x0', 17:53:25 INFO - 'XPC_SERVICE_NAME': '0', 17:53:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:53:25 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-8DxvSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:53:25 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)) 17:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:53:25 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-kdXVx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:53:26 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)) 17:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:53:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-TSH72t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:53:26 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)) 17:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:53:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-r5rhpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:53:26 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)) 17:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:53:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-dwb7tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:53:26 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)) 17:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:53:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-yvHE3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:53:26 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)) 17:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:53:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-CtRKrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:53:26 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)) 17:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:53:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-fkBDtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:53:26 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)) 17:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:53:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-3eyvel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:53:26 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)) 17:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:53:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-NqMHST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:53:26 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)) 17:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:53:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-VC0PJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:53:27 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)) 17:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:53:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-4MsCm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:53:27 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)) 17:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:53:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-9ashTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:53:27 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)) 17:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:53:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-_GDZoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:53:27 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)) 17:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:53:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-blJiaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:53:27 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)) 17:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:53:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-vkmlln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:53:27 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)) 17:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:53:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-9hhIip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:53:27 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)) 17:53:27 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)) 17:53:27 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)) 17:53:27 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)) 17:53:27 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)) 17:53:27 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)) 17:53:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:53: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 17:53: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 17:53: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 17:53: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 17:53: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 17:53: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 17:53:30 INFO - Downloading blessings-1.6.tar.gz 17:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:53:30 INFO - Installing collected packages: blessings 17:53:30 INFO - Running setup.py install for blessings 17:53:30 INFO - Successfully installed blessings 17:53:30 INFO - Cleaning up... 17:53:31 INFO - Return code: 0 17:53:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:53:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:53:31 INFO - Reading from file tmpfile_stdout 17:53:31 INFO - Current package versions: 17:53:31 INFO - blessings == 1.6 17:53:31 INFO - blobuploader == 1.2.4 17:53:31 INFO - docopt == 0.6.1 17:53:31 INFO - functools32 == 3.2.3-2 17:53:31 INFO - jsonschema == 2.5.1 17:53:31 INFO - manifestparser == 1.1 17:53:31 INFO - mozInstall == 1.12 17:53:31 INFO - mozcrash == 1.0 17:53:31 INFO - mozdebug == 0.1 17:53:31 INFO - mozdevice == 0.48 17:53:31 INFO - mozfile == 1.2 17:53:31 INFO - mozhttpd == 0.7 17:53:31 INFO - mozinfo == 0.9 17:53:31 INFO - mozleak == 0.1 17:53:31 INFO - mozlog == 3.4 17:53:31 INFO - moznetwork == 0.27 17:53:31 INFO - mozprocess == 0.23 17:53:31 INFO - mozprofile == 0.28 17:53:31 INFO - mozrunner == 6.13 17:53:31 INFO - mozscreenshot == 0.1 17:53:31 INFO - mozsystemmonitor == 0.3 17:53:31 INFO - moztest == 0.8 17:53:31 INFO - mozversion == 1.4 17:53:31 INFO - psutil == 3.1.1 17:53:31 INFO - requests == 1.2.3 17:53:31 INFO - wsgiref == 0.1.2 17:53:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:31 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 0x1105f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110567570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe638581480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110405d30>, '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 0x11026bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103fdb20>, '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.RmCFujgd4V/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.DW5FzU2QHz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 17:53:31 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 17:53:31 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 17:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RmCFujgd4V/Render', 17:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:53:31 INFO - 'HOME': '/Users/cltbld', 17:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:53:31 INFO - 'LOGNAME': 'cltbld', 17:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:31 INFO - 'MOZ_NO_REMOTE': '1', 17:53:31 INFO - 'NO_EM_RESTART': '1', 17:53:31 INFO - 'PAGER': '/bin/cat', 17:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:31 INFO - 'PWD': '/builds/slave/test', 17:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:53:31 INFO - 'SHELL': '/bin/bash', 17:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DW5FzU2QHz/Listeners', 17:53:31 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 17:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:53:31 INFO - 'USER': 'cltbld', 17:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:31 INFO - 'XPC_FLAGS': '0x0', 17:53:31 INFO - 'XPC_SERVICE_NAME': '0', 17:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:31 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)) 17:53:31 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)) 17:53:31 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)) 17:53:31 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)) 17:53:31 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)) 17:53:31 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)) 17:53:31 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)) 17:53:31 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)) 17:53:31 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)) 17:53:31 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)) 17:53:31 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)) 17:53:31 INFO - Cleaning up... 17:53:31 INFO - Return code: 0 17:53:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110567570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe638581480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110405d30>, '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 0x11026bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103fdb20>, '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.RmCFujgd4V/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.DW5FzU2QHz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 17:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RmCFujgd4V/Render', 17:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:53:31 INFO - 'HOME': '/Users/cltbld', 17:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:53:31 INFO - 'LOGNAME': 'cltbld', 17:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:31 INFO - 'MOZ_NO_REMOTE': '1', 17:53:31 INFO - 'NO_EM_RESTART': '1', 17:53:31 INFO - 'PAGER': '/bin/cat', 17:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:31 INFO - 'PWD': '/builds/slave/test', 17:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:53:31 INFO - 'SHELL': '/bin/bash', 17:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DW5FzU2QHz/Listeners', 17:53:31 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 17:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:53:31 INFO - 'USER': 'cltbld', 17:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:31 INFO - 'XPC_FLAGS': '0x0', 17:53:31 INFO - 'XPC_SERVICE_NAME': '0', 17:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:53:32 INFO - Cleaning up... 17:53:32 INFO - Return code: 0 17:53:32 INFO - Running post-action listener: _resource_record_post_action 17:53:32 INFO - Running post-action listener: _start_resource_monitoring 17:53:32 INFO - Starting resource monitoring. 17:53:32 INFO - [mozharness: 2017-02-02 01:53:32.173942Z] Finished create-virtualenv step (success) 17:53:32 INFO - [mozharness: 2017-02-02 01:53:32.174922Z] Running install step. 17:53:32 INFO - Running pre-action listener: _resource_record_pre_action 17:53:32 INFO - Running main action method: install 17:53:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:53:32 INFO - Reading from file tmpfile_stdout 17:53:32 INFO - Detecting whether we're running mozinstall >=1.0... 17:53:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:53:32 INFO - Reading from file tmpfile_stdout 17:53:32 INFO - Output received: 17:53:32 INFO - Usage: mozinstall [options] installer 17:53:32 INFO - Options: 17:53:32 INFO - -h, --help show this help message and exit 17:53:32 INFO - -d DEST, --destination=DEST 17:53:32 INFO - Directory to install application into. [default: 17:53:32 INFO - "/builds/slave/test"] 17:53:32 INFO - --app=APP Application being installed. [default: firefox] 17:53:32 INFO - mkdir: /builds/slave/test/build/application 17:53:32 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'] 17:53:32 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 17:53:53 INFO - Reading from file tmpfile_stdout 17:53:53 INFO - Output received: 17:53:53 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:53:53 INFO - Running post-action listener: _resource_record_post_action 17:53:53 INFO - [mozharness: 2017-02-02 01:53:53.639416Z] Finished install step (success) 17:53:53 INFO - [mozharness: 2017-02-02 01:53:53.639549Z] Running run-tests step. 17:53:53 INFO - Running pre-action listener: _resource_record_pre_action 17:53:53 INFO - Running main action method: run_tests 17:53:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:53:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:53:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:53:53 INFO - 2017-02-01 17:53:53.654 screenresolution[1624:7255] starting screenresolution argv=screenresolution get 17:53:53 INFO - 2017-02-01 17:53:53.657 screenresolution[1624:7255] Display 0: 1600x1200x32@60 17:53:53 INFO - 2017-02-01 17:53:53.662 screenresolution[1625:7257] starting screenresolution argv=screenresolution list 17:53:53 INFO - Available Modes on Display 0 17:53:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:53:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:53:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:53:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:53:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:53:53 INFO - Intel Iris: 17:53:53 INFO - Chipset Model: Intel Iris 17:53:53 INFO - Type: GPU 17:53:53 INFO - Bus: Built-In 17:53:53 INFO - VRAM (Dynamic, Max): 1536 MB 17:53:53 INFO - Vendor: Intel (0x8086) 17:53:53 INFO - Device ID: 0x0a2e 17:53:53 INFO - Revision ID: 0x0009 17:53:53 INFO - Displays: 17:53:53 INFO - Display: 17:53:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:53:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:53:53 INFO - Display Serial Number: 1600x1200 60 17:53:53 INFO - Main Display: Yes 17:53:53 INFO - Mirror: Off 17:53:53 INFO - Online: Yes 17:53:53 INFO - Rotation: Supported 17:53:53 INFO - Return code: 0 17:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:53:53 INFO - Python 2.7.3 17:53:53 INFO - Return code: 0 17:53:53 INFO - grabbing minidump binary from tooltool 17:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:53 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 0x110405d30>, '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 0x11026bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103fdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:53:53 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 17:53:53 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 17:53:53 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 17:53:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:53:54 INFO - Return code: 0 17:53:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:53:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:53:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:53:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:53:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:53:54 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/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 17:53:54 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/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0192 --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 17:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RmCFujgd4V/Render', 17:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:53:54 INFO - 'HOME': '/Users/cltbld', 17:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:53:54 INFO - 'LOGNAME': 'cltbld', 17:53:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:53:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:54 INFO - 'MOZ_NO_REMOTE': '1', 17:53:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:53:54 INFO - 'NO_EM_RESTART': '1', 17:53:54 INFO - 'PAGER': '/bin/cat', 17:53:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:54 INFO - 'PWD': '/builds/slave/test', 17:53:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:53:54 INFO - 'SHELL': '/bin/bash', 17:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DW5FzU2QHz/Listeners', 17:53:54 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 17:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:53:54 INFO - 'USER': 'cltbld', 17:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:54 INFO - 'XPC_FLAGS': '0x0', 17:53:54 INFO - 'XPC_SERVICE_NAME': '0', 17:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:53:54 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/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 17:53:54 INFO - mozversion application_buildid: 20170201154808 17:53:54 INFO - mozversion application_changeset: e293c1aa1c10d38b271b48742650d97a4ee5061e 17:53:54 INFO - mozversion application_display_name: Firefox 17:53:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:53:54 INFO - mozversion application_name: Firefox 17:53:54 INFO - mozversion application_remotingname: firefox 17:53:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:53:54 INFO - mozversion application_vendor: Mozilla 17:53:54 INFO - mozversion application_version: 52.0 17:53:54 INFO - mozversion platform_buildid: 20170201154808 17:53:54 INFO - mozversion platform_changeset: e293c1aa1c10d38b271b48742650d97a4ee5061e 17:53:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:53:54 INFO - mozversion platform_version: 52.0 17:53:54 INFO - using testdate: 1486000434 17:53:54 INFO - actual date: 1486000434 17:53:54 INFO - starting webserver on 'localhost:49236' 17:53:54 INFO - SUITE-START | Running 2 tests 17:53:54 INFO - TEST-START | dromaeo_css 17:53:54 INFO - operating with platform_type : mac_ 17:53:54 INFO - Initialising browser for dromaeo_css test... 17:53:54 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmp8uzWNg/profile http://localhost:49236/getInfo.html) 17:53:57 INFO - PROCESS | 1635 | 2017-02-01 17:53:57.128 plugin-container[1637:7417] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 17:53:57 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:53:57 INFO - PROCESS | 1635 | 2017-02-01 17:53:57.128 plugin-container[1637:7417] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 17:53:57 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:53:57 INFO - PROCESS | 1635 | 2017-02-01 17:53:57.128 plugin-container[1637:7417] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:53:57 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 17:53:57 INFO - PROCESS | 1635 | colorDepth:24 17:53:57 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 17:53:57 INFO - PROCESS | 1635 | __metrics 17:53:57 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 17:53:57 INFO - TEST-INFO | 1635: exit 0 17:53:57 INFO - Browser initialized. 17:53:57 INFO - Running cycle 1/1 for dromaeo_css test... 17:53:57 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmp8uzWNg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:00 INFO - PROCESS | 1639 | 2017-02-01 17:54:00.451 plugin-container[1640:7571] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 17:54:00 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:54:00 INFO - PROCESS | 1639 | 2017-02-01 17:54:00.454 plugin-container[1640:7571] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 17:54:00 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:54:00 INFO - PROCESS | 1639 | 2017-02-01 17:54:00.455 plugin-container[1640:7571] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:54:10 INFO - PROCESS | 1639 | RSS: Main: 177430528 17:54:10 INFO - PROCESS | 1639 | 17:57:12 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 17:57:13 INFO - PROCESS | 1639 | RSS: Main: 184729600 17:57:13 INFO - PROCESS | 1639 | 18:00:15 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 18:00:16 INFO - PROCESS | 1639 | RSS: Main: 193662976 18:00:16 INFO - PROCESS | 1639 | 18:03:18 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 18:03:19 INFO - PROCESS | 1639 | RSS: Main: 195854336 18:03:19 INFO - PROCESS | 1639 | 18:06:21 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 18:06:21 INFO - PROCESS | 1639 | RSS: Main: 201289728 18:06:21 INFO - PROCESS | 1639 | 18:09:24 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 18:09:25 INFO - PROCESS | 1639 | RSS: Main: 202657792 18:09:25 INFO - PROCESS | 1639 | 18:12:27 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 18:12:27 INFO - PROCESS | 1639 | RSS: Main: 207093760 18:12:27 INFO - PROCESS | 1639 | 18:12:27 INFO - PROCESS | 1639 | __start_tp_report 18:12:27 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 18:12:27 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 18:12:27 INFO - PROCESS | 1639 | |i|pagename|runs| 18:12:27 INFO - PROCESS | 1639 | |0;dojo.html;3481.112316359328;3537.416326306159;3539.769914955528;3545.4681797730336;3575.9821200893994;5872.324682661495;5913.793017244392;5937.970310148454;6017.608855424394;6030.668313242781;5947.375525569818;6021.09683547467;6027.216461859952;6039.214902062737;6070.605410648316;5301.655392399492;5356.678599284055;5361.356637203541;5391.865203369908;5503.862403439926;4469.396631454761;5354.544863686591;5431.6740995540395;5435.619506634537;5441.564674826024;4526.79629416677;5083.389993200803;5361.651492652965;5415.0523658360025;5422.322209723785;4230.365445183216;5292.100342941709;5335.7865685372535;5338.839834804962;5410.648307860016;5254.7635356409055;5277.759726464278;5284.233786100994;5296.655717378358;5300.310959575269;4731.982623735913;5752.654840709571;6017.308009578867;6023.337432882379;6028.5478589106;6161.691915404212;6172;6232.909240882827;6233.065040243954;6343.524235682342;6393.776217832354;6410.615363078184;6429.03564465334;6433.163688720483;6434.774782882577;6086.421789929949;6134.325224225332;6136.048912418582;6137.447629713347;6154;6257.092721555349;6309.873802523924;6391.872162556723;6403.839904002344;6437.324080971431;6184.103305020837;6238.844028899314;6245.125682404467;6267.122602835607;6267.122602835607;6384.138141350951;6390.488760899117;6398.744050238031;6399.64801935898;6404;6175.197224360804;6185;6211.472024877846;6213.596116252429;6243.406876346739;6282.685865706696;6330.525210609223;6331.05034244867;6332.588381755171;6335.493160547145;5141.5886729061585;5151.25306830515;5151.845444636667;5166.483351664803;5172.612054095883;4455.1980643484485;4546.545345465427;4580.1068791585985;4608.9308660370125;4669.066186762661;5990.5507086968655;6049.697515124226;6085.36103709113;6120.60216085953;6125.17440701618;5657.745401456944;6458.741650333934;6469.126667899867;6482;6530.05314229434;5953.434423729739;6011.9699401503585;6036.547258955508;6039.66781826995;6058.727357268934;5671.546276297886;5676.489115979499;5677.914831277534;5679.602427830095;5717.285339332583;6572.178477690289;6608.107905432801;6631.801045968725;6638.435732962752;6665.966670166618;6130.031268545553;6199.473044791062;6283.560150789401;6332.366763323631;6458.354164583504;6511.576747511396;6628.767993120217;6631.204255489372;6634.767783127568;6662.267150613526;6347.936520634735;6381.904271435839;6385.393387628168;6392.456641185551;6417.454516365974;6216.564840461125;6243.125962365363;6325.683715814099;6372.235331760218;6462.4183823456115;5187.688738675692;6165.691715414301;6184.845378865564;6195.907061394173;6207.937920620917;6212.130301757667;6236.095766113979;6276.905846412399;6284.4344009039405;6291.993281075006;4885.609151267819;6063.757449701962;6231.2522497300615;6239.4696450800375;6265.592736472115;6130.8567837443225;6144.726451212901;6178.351273116258;6216.160818289654;6255.218097737783;6185.628862268279;6224.782132625336;6226.782062627786;6239.625622462667;6251.6874156292915 18:12:27 INFO - PROCESS | 1639 | |1;ext.html;460.68212933076177;484.1962342511429;530.4774796825129;537.3846945247692;547.0017218576098;40622.59377406229;42633;42640.786796066015;42840;44569.55430445694;35580.46629300562;44330.77834610822;44635.88410289744;44744;44771;9681.806363872718;9684.37051591646;9767.609295628166;9823.165030972375;9865;8278.958605206966;9635.518224088803;9646.324757266993;9724.367916085432;9819.754506137368;9799.608015679365;9834.114929656329;9835.852462213072;9839.21286297098;9841.753956151082;9702.417854928726;9748.902510974905;9800.313978021577;9801.705948821547;9808.36245644038;9711.223102151811;9752.512374381324;9791;9792.020797920222;9819.459929703864;42173.789131054145;42274.78862605698;42527.57472425267;42606;42620;3308.5368048473233;3449.448088305859;3503.5095086687884;3687.4468829675493;4169.332906734908;24675.62986555203;31119.06642800697;31180.220494487592;31670.524942125885;31921.042368728977;3141.497360422344;3176.539401786751;3184.2835362043356;3243.464828303327;3246.5779448671756;527852;529460;530299;531783;532833.9999999962;65969.34030659632;66653;66689.6665516679;66773.66613167;66806.33193668099;69203.65398172977;69443;69629;69675.30324696688;69772.95340569895;16692.24884880183;17002.914985424995;17271.4818555441;17496.125193740263;17515.737263940795;13011.869881301254;13264.867351326557;13334.799978000337;13336.399862006234;13367.532136375181;16017.59956001086;17693.469195924143;19961.401157965283;20013.899930500254;20022.69965950512;6652.7006284716335;7822.608869556613;7892.881606775903;7952.125266220711;8032.83934321322;862.3058437957504;872.3631748823394;882.8543290357147;989.8069876374038;991.5389343954952;23971.400714981915;30770.69229307723;31255.531167032514;31516.527252091237;32037.359252814815;1048.8688913885765;1104.4588151805717;1131.7849608574345;1137.5392965848844;1185.3125187391292;13732.588022359345;15802.36790528366;15980.840191598169;16189.757153642704;16358.509244722678;443298;445053;445682;447001;447330;56069.43930560642;56464.43535564674;56824.71587642118;56905.43094569084;57127.14309285364;1227.8894899459092;1384.723055388906;1388.3058470764618;1393.8188035555313;1409.5066726645591;29584.112476625734;29598.704012960457;30258.84870575633;30793.846030769702;31113.222169445944;48581.5141848577;48977.51022489872;49204.507954919995;49279;49281.75359123181;326046;326506;326540;328880.3555982205;330088;26575.33561660974;26898.32754181161;27031.1890643281;27779.722202777713;28273.57589636116;34659.65340346564;47600.80997975078;48539;49488.75255623699;49508.50491495039;39401.80299098486;39927.00182495461;40378.39432408458;40754;41969.580304197785;40045.79977100096;40354;40825.79587102164;41922;42091.94770130771;38832.80583597064;39203;39870;40115.39826902657;40205;31151.84424077865;32498.350032998736;33087;34809.60761569509;35958.64041359658;26744.732552674224;26843.19470415891;26847.060352887554;26981.595276070482;27252.182434526996 18:12:27 INFO - PROCESS | 1639 | |2;jquery.html;343.6786604524769;378.4002356265319;390.8768737847576;399.2952438945262;416.972163616685;15786.763198552031;19419.41741747748;20642.17431302748;20793.960301984916;21008.36974890752;20027.899860500715;20034.398968030982;20550.58898822023;20817;21168.788312116874;5664.490195882369;5929.110633404992;5975.0439929611275;6110.908336374958;6186.319504854462;6040.848978775522;6133.386661333853;6138.47822935051;6146.539009574278;6146.938530614681;5823.475887170154;6046.093086037107;6093.329733729286;6100.572959892787;6103.755849766004;5788.855278618068;5986.820395388146;6005.309389420229;6058.575899687024;6086.878262434749;5267.025600263925;5275.973620131875;5280.339957505312;5317.335333083364;5329.120695085307;21761.782382176134;25185;26013.73986260151;26048.609270860954;26233.475330493475;2579.2649095007832;2629.737026297374;2711.8779654915575;3232.1273256220925;3236.96763032369;10326.432046237454;10438.582456701799;11914.344711040889;13626.909847212299;15712.528624141294;1932.1981377728225;1979.9109040093085;1985.7021446783099;1989.8706584071988;2012.8087831655969;82375.5881220596;115073;116918.41540792327;126177;135225;10238.795224095476;10949.671509854557;11337.546498140147;11812;12162.75674486523;15024.323905424064;15044.247787610575;15123.621909452351;15172.165530895907;15185.468508602145;8573.142685731376;8827.735167944971;8837.646494140163;8946.329025323126;8971.461712297283;8657;8743.169398907094;8744.169303916118;8852.778680533038;8855.247303979233;4215.777424546847;4271.9359209611885;4673.112108699336;4675.836345727883;4702.612729244881;1952.7461430014007;1994.9850650842463;2000.8099230573073;2011.7988201179764;2018.2532462988788;840.7477756672973;850.8808766772656;938.8591711243231;995.0298459002415;1075.9623413180502;16616.25226864794;20759.377218683163;20855.791442085687;20988.580228395345;21089.945502724804;829.3986859526915;946.4983558713893;953.4660590069583;984.414273507262;985.4826216236534;10951.83572246417;11384.37385943781;11399.886001140048;11414.429278536207;11434.771304573862;511469;614721;622360;634843;635506;101245;133200;137468.56328591864;138673;143904;981.7153025622489;1014.7057353367588;1027.0294571629888;1030.644427672452;1035.1046344911597;18247.54381140482;19611.607767844278;19731.210751569775;19771.20915163435;19838.40484785459;40775.79612101921;52527.474725253785;52984.20523692071;54729;56432;76078.61960690162;80616.59691701503;81516.18483815086;82592.58703706443;84058.15941840503;5372.650777699437;5595.440455954372;8018.158093400109;8185.71350002747;8381.49711017341;11739.002184814044;12814.423350949417;12999.285039322927;13121.540746074223;13253.271070091238;11028;11099.223054386115;11123.443827808416;11428.657140285804;11445.027172690414;10879.510422031186;10967.725806854893;10988.670339889815;11068.944655276671;11423.771524569629;11182.099043162845;11532.019778318936;11598;11623.59317423886;11641.59254426091;7936.56348900816;8094.352451803724;8125.918740812516;8426.283765879969;8481.024682161631;8351.540665263468;10234.590616375262;11182.832257515982;11401.885981140415;11477.426128693698 18:12:27 INFO - PROCESS | 1639 | |3;mootools.html;1394.4143459746906;1495.910245385277;1677.4967509747073;1789.740487629293;1861.097367776628;7656.808579785495;7907.565083920382;8224.547649879254;8605.784855378619;8615.353848461367;6478.870422591545;8383.245507904287;8424.199701028392;8466.153384661531;8499.065102838698;2006.4883454719027;2236.1390864517116;2408.0127147869375;2409.4337830609793;2423.151896836111;2403;2422.842515236504;2436.9390765230833;2437.85372877627;2446.4006318452;2048.4162013826062;2363.397333679909;2384.2132096408145;2407.9036838526526;2421.6125419932814;1989.8706584072133;2321.6981792367055;2353.1646265575646;2392.3899405651623;2401.531701318235;2382.332946774906;2396.748341424143;2402.723686776008;2406.4585468269674;2407.807375409963;8368.953880764904;8498.787530311793;8509.914900850974;8552.35857310698;8576.271016963565;4423.51341352451;5015.598752099823;5275.973620131913;5295.31160949078;5295.920561191585;3380.6281309055985;3537.239493508908;3641.8543258269638;3657.3051120287328;3665.486831843544;987.8666380038746;1029.5521448169995;1076.34343050739;1111.5109351885144;1123.3709122891207;10992.890071099268;11073.446327683583;11086.334819910831;11098.112151027979;11104.167187460973;4611.262198048296;4629.888826681572;4721.291806229025;4859.368282123372;4862.197737373364;8670.86993695095;9215.262778977665;9504.239660827117;9531.857022144673;9550.904490955141;5245.501677340647;5274.472552744772;5305.8938821223355;5339.733013349394;5429.945700542944;4422.71252368595;4446.911061778746;4879.95120048795;4907.3620429343955;4916.72957987307;3364.1925937775245;3932.134930315326;3942.8619998299923;3975.403689446606;4022.7328391556566;1296.6110166949877;1302.1666133674455;1305.2560040776666;1315.2305901047994;1316.3155159317294;774.2721841469114;851.8892543969368;869.9695510657223;944.9952750236342;957.4590356448584;5067.189249720101;5526.198701188305;5588.944110558842;5598.048331783607;5809.390014048464;913.5021413329752;967.99032009679;1011.5903059261011;1026.825439675257;1031.0926384781344;3817.2174704185577;3936.193080418507;3943.921121577552;3961.742486738353;3976.522817261889;10004.699859004242;10159.949200253952;10339.276250662382;10364.792704145875;10370.014848589371;10127.848082278771;10131.898681013243;10282.691519254435;10339.121174700083;10339.379637221791;7606.695732170651;7964.1637628049375;8027.7993050173045;8052.5571093590415;8187.38594605407;5880.26496687914;5922.674252916131;5941.91087133702;5984.521238300838;6112.816615501542;9212.124848139416;9513.66702165421;9565.426074435556;9618.663346782829;9634.325597208128;9374.062593740844;9452.338336316392;9558.61765529371;9686.660966866126;9735.853962190715;7282.854342913218;7369.77890663281;7373;7452.813679658052;7476.21499742541;7907.367410607023;7925.524468531907;7978.720744773905;7990.240927111915;7992.5204487730925;7106.5736055836815;7222.458315626454;7280.708771649287;7349.926500735138;7407.962960185165;6401.751658426562;6822.761203357859;7093.432525398059;7150.070490836366;7302.6713797878165;5631.436856314336;6765.357291057342;6853;6853.4859885507785;6856.725730970706;4887.047025829929;4987.9002419950675;5022.547970682656;5024.321716568216;5053.924191137063;4941.6293777966075;4973.35346404965;4980.05378977993;5024.271480635214;5141.691498510101 18:12:27 INFO - PROCESS | 1639 | |4;prototype.html;264.86359524844704;322.6934412308308;322.8821480159742;325.3395606917957;329.0687354785957;4143.544210136883;5325.721826761578;5408.4050754417085;5448.863778405537;5668.6315389499705;4567.817287308504;4654.418197725285;4850.054239423313;5577.135543990677;5641.774329026834;4016.2569924563977;4093.97953010236;4153.02403935075;4208.83245128759;4279.015826359939;4220.894477638069;4225.830966761341;4240.936385954213;4260.957390426102;4275.337322714984;3412.897613071612;4194.182134483777;4241.618254357108;4255.893602659928;4268.530461649231;4157.688173386993;4217.536071032184;4224.429701990253;4239.745615263063;4253.2769429197115;3355.580552430946;3386.593608766964;3473.4369533709933;3670.743047986642;3686.502322186497;4549.2258019372475;4577.633789296849;5423.674579525241;5451.700156491392;5461.061323230276;4329.437173167468;4767.42790865095;4868.902621947576;4913.764237272033;4990.700557966534;5193.610479214074;5529.944700552983;5645.943540564624;5777.075667893159;5908.307307932542;3770.377887648535;4130.876073717794;4139.689523285766;4154.4183814266025;4175.039740859619;4663.253879379283;5491.890162196773;6107.511399088106;6120.234970628671;6234.438900498977;3612.512310838003;4156.605122513356;4182.372644103348;4192.308269135619;4210.2842516772225;3624.4744512045604;3837.8678289904547;3985.70107241958;4268.59448352406;4288.549702281278;4134.813933373005;4611.717199986028;4895;4925.926111108264;4966.478519755446;5455.427180146107;5553.333599968029;5907.63694522186;5925.73334199962;6037.366076561985;1090.6727981605486;1278.9936050319689;1370.8012338211104;1382.8478867324586;1387.4658256571292;718.795143384133;838.2581415447373;891.2379915172564;911.6234485926299;954.7540459700158;5091.556053094535;5377.838664840061;5523.696196709139;5591.608587398924;5603.1984007996;5282.181261904411;5425.755840987165;5991.55063370249;6138.171346868205;6147.508199344042;4452.4211852458975;4941.344649542371;5444.972775136099;5578.163275508625;5582.883423315353;3052.9084127476212;3056.144279601715;3064.4371370600707;3070.45152523405;3083.6894319913945;5387.892242155213;5650.915236271459;6003.388525991208;6022.638641681513;6103.969480152659;4973.47778483254;5090.338256026767;5365.490278423622;5715.914261286084;5889.172038175135;5753.446569426315;5950.5239580834295;6018.8194354169445;6052.818415447544;6082.452579267887;4883.096627123993;5313.814016509404;5371.69017322555;5759.942400576108;5848.654809393778;4798.73606951621;5069.442361340323;5140.511651393262;5608.822147348939;5700.800471983461;5114.411842638145;5552.361478429871;5938.991180952926;5982.46157845796;6000.609960352563;3690.8892733218045;3745.3071181831447;3920.31394505966;4061.7156799024965;4093.874184599259;5990.64056156632;6112.074696470598;6119.388061193845;6140.3245642978345;6147.784827531015;4814.677872268124;5664.26364572603;5672.716364181857;5961.523078153824;6024.819255422344;4919.729414882073;5599.692016939108;5860.208871802422;5919.496842768241;5928.229330187048;4772.785224664968;4979.103761322996;5161.612879034013;5448.591355648263;5842.970785146217;5022.070916880389;5289.550388217045;5348;5720.227769251264;5799.246098007401;4864.635152363516;4895.485973972682;5044.344235249394;5898.705064746659;5902.557308201816 18:12:27 INFO - PROCESS | 1639 | |5;yui.html;711.9145702515696;747.3498056690678;763.7708687393784;784.2275358771609;821.954792486413;15199.16404597748;15746.84253157468;15818.683626327494;15843.366265349387;15848.603784905383;13948.442062317521;14120.71758564828;14259.429622815074;14318.64203394913;14325.713485730279;858.3733874271785;881.497546398553;891.189017993626;893.2942975049702;895.83427065993;867.7483529776357;873.3406278259905;875.7504111328273;878.1876763993281;881.5504092912597;877.8112705768259;907.3376435202306;919.2921450483124;931.417863835103;932.6409332407038;912.6075787411411;914.3416739947294;915.1946287267195;915.7847905742145;917.6100157433098;659.5613916745407;661.137215933207;701.253165378875;703.7290643102391;705.3405066263009;12778.744425111445;12841.87158128416;12894.677633059155;12903;13392.799108013387;11932.940335298355;12820.423080961378;12831.03767217453;12879.484820607164;13167;12293.877061229452;12448.564300249447;12469.501219951191;12897.613071607866;13069.54256601024;4577.9542204577865;4581.748003859786;4626.537346265381;4787.54518320759;4837.637177211724;74693.75918722447;78904.60547697282;86240.13759862384;88188.55905720494;90805.63791543132;10292.897071029343;10522.736931576772;10573.577056917791;10629.46852657364;10842.186835987175;15941.282642281125;19190.61618767645;19287.51781205453;19426.028698565016;19458.70811937822;7441.962790186014;7518.173000969889;7588.089429268523;7658.770236892902;7783.961080194563;4362.280223763107;4430.13612345596;4454.086912182995;4473.150101480708;4568.88577785558;3330.8834190803204;3396.100033491127;3400.9489857652156;3414.2488652496413;3456.948145777815;655.9967200164064;657.3984803904374;675.6419097878132;675.972961081561;726.9273072692794;574.5719439017959;619.4579742725116;627.7551754815626;652.9953044154495;686.5228666077029;8354.58227088643;9362.25101991839;9489.335746497678;9750.853737193947;9953.104220620178;616.6269407008784;620.1906512001881;629.6002038705363;641.3330136657823;655.6099121022984;4604.37840891482;4683.391159149357;4746.28805679144;4753.405824271966;4775.140474714515;93037.60443593352;97170.51414742881;99662.5016874911;102372;120661;66343;81775.5467335981;84710;86097.56951215329;90256.548717256;65002.67498662571;70913.64543177251;78820;81258.59370703109;83963.48109556723;8151.551664658501;9562.95218523903;10101.292909496558;10160.847587286049;10194.643187488402;55088.17367739567;56154.719226403606;56432.07463216467;56755.71622141863;57325.713371432874;80480.59759701398;80935;82386.17613824025;83983.5800820992;85196.57401712952;12606.747865042831;13071;13436.93281533586;13914.304284785923;14053.508127215498;14519.274036298355;14522.273886305431;14634.92682536623;14875.925620371829;14910.701785964437;13700.24648644334;13746.725065498835;13829.930850345683;13937.372818223406;13976.301184940916;13203.801942971055;13834.65413364674;13861.584152475441;14440.350184241945;14452.494162704676;13689.794653080013;13707.314634268047;14069.929650352093;14166.929165354108;14258.144511329354;11527.250728702607;11536;11684.18210725241;11712;12107.152499324962;9836.409815411098;11455.001771289137;11711.824322634997;11735.530578776754;11843.644690659294 18:12:27 INFO - PROCESS | 1639 | __end_tp_report 18:12:27 INFO - PROCESS | 1639 | __start_cc_report 18:12:27 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,366 18:12:27 INFO - PROCESS | 1639 | __end_cc_report 18:12:27 INFO - PROCESS | 1639 | __startTimestamp1486001547948__endTimestamp 18:12:27 INFO - PROCESS | 1639 | 18:12:27 INFO - PROCESS | 1639 | ------- Summary: start ------- 18:12:27 INFO - PROCESS | 1639 | Number of tests: 6 18:12:27 INFO - PROCESS | 1639 | 18:12:27 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5889.43 Median:6161.69 stddev:676.09 (11.0%) stddev-sans-first:651.23 18:12:27 INFO - PROCESS | 1639 | Values: 3481.1 3537.4 3539.8 3545.5 3576.0 5872.3 5913.8 5938.0 6017.6 6030.7 5947.4 6021.1 6027.2 6039.2 6070.6 5301.7 5356.7 5361.4 5391.9 5503.9 4469.4 5354.5 5431.7 5435.6 5441.6 4526.8 5083.4 5361.7 5415.1 5422.3 4230.4 5292.1 5335.8 5338.8 5410.6 5254.8 5277.8 5284.2 5296.7 5300.3 4732.0 5752.7 6017.3 6023.3 6028.5 6161.7 6172.0 6232.9 6233.1 6343.5 6393.8 6410.6 6429.0 6433.2 6434.8 6086.4 6134.3 6136.0 6137.4 6154.0 6257.1 6309.9 6391.9 6403.8 6437.3 6184.1 6238.8 6245.1 6267.1 6267.1 6384.1 6390.5 6398.7 6399.6 6404.0 6175.2 6185.0 6211.5 6213.6 6243.4 6282.7 6330.5 6331.1 6332.6 6335.5 5141.6 5151.3 5151.8 5166.5 5172.6 4455.2 4546.5 4580.1 4608.9 4669.1 5990.6 6049.7 6085.4 6120.6 6125.2 5657.7 6458.7 6469.1 6482.0 6530.1 5953.4 6012.0 6036.5 6039.7 6058.7 5671.5 5676.5 5677.9 5679.6 5717.3 6572.2 6608.1 6631.8 6638.4 6666.0 6130.0 6199.5 6283.6 6332.4 6458.4 6511.6 6628.8 6631.2 6634.8 6662.3 6347.9 6381.9 6385.4 6392.5 6417.5 6216.6 6243.1 6325.7 6372.2 6462.4 5187.7 6165.7 6184.8 6195.9 6207.9 6212.1 6236.1 6276.9 6284.4 6292.0 4885.6 6063.8 6231.3 6239.5 6265.6 6130.9 6144.7 6178.4 6216.2 6255.2 6185.6 6224.8 6226.8 6239.6 6251.7 18:12:27 INFO - PROCESS | 1639 | 18:12:27 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:59735.30 Median:41945.79 stddev:117377.78 (279.8%) stddev-sans-first:117622.69 18:12:27 INFO - PROCESS | 1639 | Values: 460.7 484.2 530.5 537.4 547.0 40622.6 42633.0 42640.8 42840.0 44569.6 35580.5 44330.8 44635.9 44744.0 44771.0 9681.8 9684.4 9767.6 9823.2 9865.0 8279.0 9635.5 9646.3 9724.4 9819.8 9799.6 9834.1 9835.9 9839.2 9841.8 9702.4 9748.9 9800.3 9801.7 9808.4 9711.2 9752.5 9791.0 9792.0 9819.5 42173.8 42274.8 42527.6 42606.0 42620.0 3308.5 3449.4 3503.5 3687.4 4169.3 24675.6 31119.1 31180.2 31670.5 31921.0 3141.5 3176.5 3184.3 3243.5 3246.6 527852.0 529460.0 530299.0 531783.0 532834.0 65969.3 66653.0 66689.7 66773.7 66806.3 69203.7 69443.0 69629.0 69675.3 69773.0 16692.2 17002.9 17271.5 17496.1 17515.7 13011.9 13264.9 13334.8 13336.4 13367.5 16017.6 17693.5 19961.4 20013.9 20022.7 6652.7 7822.6 7892.9 7952.1 8032.8 862.3 872.4 882.9 989.8 991.5 23971.4 30770.7 31255.5 31516.5 32037.4 1048.9 1104.5 1131.8 1137.5 1185.3 13732.6 15802.4 15980.8 16189.8 16358.5 443298.0 445053.0 445682.0 447001.0 447330.0 56069.4 56464.4 56824.7 56905.4 57127.1 1227.9 1384.7 1388.3 1393.8 1409.5 29584.1 29598.7 30258.8 30793.8 31113.2 48581.5 48977.5 49204.5 49279.0 49281.8 326046.0 326506.0 326540.0 328880.4 330088.0 26575.3 26898.3 27031.2 27779.7 28273.6 34659.7 47600.8 48539.0 49488.8 49508.5 39401.8 39927.0 40378.4 40754.0 41969.6 40045.8 40354.0 40825.8 41922.0 42091.9 38832.8 39203.0 39870.0 40115.4 40205.0 31151.8 32498.4 33087.0 34809.6 35958.6 26744.7 26843.2 26847.1 26981.6 27252.2 18:12:27 INFO - PROCESS | 1639 | 18:12:27 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:35309.01 Median:14296.50 stddev:101119.40 (707.3%) stddev-sans-first:101368.98 18:12:27 INFO - PROCESS | 1639 | Values: 343.7 378.4 390.9 399.3 417.0 15786.8 19419.4 20642.2 20794.0 21008.4 20027.9 20034.4 20550.6 20817.0 21168.8 5664.5 5929.1 5975.0 6110.9 6186.3 6040.8 6133.4 6138.5 6146.5 6146.9 5823.5 6046.1 6093.3 6100.6 6103.8 5788.9 5986.8 6005.3 6058.6 6086.9 5267.0 5276.0 5280.3 5317.3 5329.1 21761.8 25185.0 26013.7 26048.6 26233.5 2579.3 2629.7 2711.9 3232.1 3237.0 10326.4 10438.6 11914.3 13626.9 15712.5 1932.2 1979.9 1985.7 1989.9 2012.8 82375.6 115073.0 116918.4 126177.0 135225.0 10238.8 10949.7 11337.5 11812.0 12162.8 15024.3 15044.2 15123.6 15172.2 15185.5 8573.1 8827.7 8837.6 8946.3 8971.5 8657.0 8743.2 8744.2 8852.8 8855.2 4215.8 4271.9 4673.1 4675.8 4702.6 1952.7 1995.0 2000.8 2011.8 2018.3 840.7 850.9 938.9 995.0 1076.0 16616.3 20759.4 20855.8 20988.6 21089.9 829.4 946.5 953.5 984.4 985.5 10951.8 11384.4 11399.9 11414.4 11434.8 511469.0 614721.0 622360.0 634843.0 635506.0 101245.0 133200.0 137468.6 138673.0 143904.0 981.7 1014.7 1027.0 1030.6 1035.1 18247.5 19611.6 19731.2 19771.2 19838.4 40775.8 52527.5 52984.2 54729.0 56432.0 76078.6 80616.6 81516.2 82592.6 84058.2 5372.7 5595.4 8018.2 8185.7 8381.5 11739.0 12814.4 12999.3 13121.5 13253.3 11028.0 11099.2 11123.4 11428.7 11445.0 10879.5 10967.7 10988.7 11068.9 11423.8 11182.1 11532.0 11598.0 11623.6 11641.6 7936.6 8094.4 8125.9 8426.3 8481.0 8351.5 10234.6 11182.8 11401.9 11477.4 18:12:27 INFO - PROCESS | 1639 | 18:12:27 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5531.22 Median:5024.30 stddev:3009.71 (59.9%) stddev-sans-first:3002.10 18:12:27 INFO - PROCESS | 1639 | Values: 1394.4 1495.9 1677.5 1789.7 1861.1 7656.8 7907.6 8224.5 8605.8 8615.4 6478.9 8383.2 8424.2 8466.2 8499.1 2006.5 2236.1 2408.0 2409.4 2423.2 2403.0 2422.8 2436.9 2437.9 2446.4 2048.4 2363.4 2384.2 2407.9 2421.6 1989.9 2321.7 2353.2 2392.4 2401.5 2382.3 2396.7 2402.7 2406.5 2407.8 8369.0 8498.8 8509.9 8552.4 8576.3 4423.5 5015.6 5276.0 5295.3 5295.9 3380.6 3537.2 3641.9 3657.3 3665.5 987.9 1029.6 1076.3 1111.5 1123.4 10992.9 11073.4 11086.3 11098.1 11104.2 4611.3 4629.9 4721.3 4859.4 4862.2 8670.9 9215.3 9504.2 9531.9 9550.9 5245.5 5274.5 5305.9 5339.7 5429.9 4422.7 4446.9 4880.0 4907.4 4916.7 3364.2 3932.1 3942.9 3975.4 4022.7 1296.6 1302.2 1305.3 1315.2 1316.3 774.3 851.9 870.0 945.0 957.5 5067.2 5526.2 5588.9 5598.0 5809.4 913.5 968.0 1011.6 1026.8 1031.1 3817.2 3936.2 3943.9 3961.7 3976.5 10004.7 10159.9 10339.3 10364.8 10370.0 10127.8 10131.9 10282.7 10339.1 10339.4 7606.7 7964.2 8027.8 8052.6 8187.4 5880.3 5922.7 5941.9 5984.5 6112.8 9212.1 9513.7 9565.4 9618.7 9634.3 9374.1 9452.3 9558.6 9686.7 9735.9 7282.9 7369.8 7373.0 7452.8 7476.2 7907.4 7925.5 7978.7 7990.2 7992.5 7106.6 7222.5 7280.7 7349.9 7408.0 6401.8 6822.8 7093.4 7150.1 7302.7 5631.4 6765.4 6853.0 6853.5 6856.7 4887.0 4987.9 5022.5 5024.3 5053.9 4941.6 4973.4 4980.1 5024.3 5141.7 18:12:27 INFO - PROCESS | 1639 | 18:12:27 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4643.68 Median:5079.89 stddev:1414.95 (27.9%) stddev-sans-first:1380.23 18:12:27 INFO - PROCESS | 1639 | Values: 264.9 322.7 322.9 325.3 329.1 4143.5 5325.7 5408.4 5448.9 5668.6 4567.8 4654.4 4850.1 5577.1 5641.8 4016.3 4094.0 4153.0 4208.8 4279.0 4220.9 4225.8 4240.9 4261.0 4275.3 3412.9 4194.2 4241.6 4255.9 4268.5 4157.7 4217.5 4224.4 4239.7 4253.3 3355.6 3386.6 3473.4 3670.7 3686.5 4549.2 4577.6 5423.7 5451.7 5461.1 4329.4 4767.4 4868.9 4913.8 4990.7 5193.6 5529.9 5645.9 5777.1 5908.3 3770.4 4130.9 4139.7 4154.4 4175.0 4663.3 5491.9 6107.5 6120.2 6234.4 3612.5 4156.6 4182.4 4192.3 4210.3 3624.5 3837.9 3985.7 4268.6 4288.5 4134.8 4611.7 4895.0 4925.9 4966.5 5455.4 5553.3 5907.6 5925.7 6037.4 1090.7 1279.0 1370.8 1382.8 1387.5 718.8 838.3 891.2 911.6 954.8 5091.6 5377.8 5523.7 5591.6 5603.2 5282.2 5425.8 5991.6 6138.2 6147.5 4452.4 4941.3 5445.0 5578.2 5582.9 3052.9 3056.1 3064.4 3070.5 3083.7 5387.9 5650.9 6003.4 6022.6 6104.0 4973.5 5090.3 5365.5 5715.9 5889.2 5753.4 5950.5 6018.8 6052.8 6082.5 4883.1 5313.8 5371.7 5759.9 5848.7 4798.7 5069.4 5140.5 5608.8 5700.8 5114.4 5552.4 5939.0 5982.5 6000.6 3690.9 3745.3 3920.3 4061.7 4093.9 5990.6 6112.1 6119.4 6140.3 6147.8 4814.7 5664.3 5672.7 5961.5 6024.8 4919.7 5599.7 5860.2 5919.5 5928.2 4772.8 4979.1 5161.6 5448.6 5843.0 5022.1 5289.6 5348.0 5720.2 5799.2 4864.6 4895.5 5044.3 5898.7 5902.6 18:12:27 INFO - PROCESS | 1639 | 18:12:27 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20120.30 Median:4764.27 stddev:28288.01 (593.8%) stddev-sans-first:28329.83 18:12:27 INFO - PROCESS | 1639 | Values: 711.9 747.3 763.8 784.2 822.0 15199.2 15746.8 15818.7 15843.4 15848.6 13948.4 14120.7 14259.4 14318.6 14325.7 858.4 881.5 891.2 893.3 895.8 867.7 873.3 875.8 878.2 881.6 877.8 907.3 919.3 931.4 932.6 912.6 914.3 915.2 915.8 917.6 659.6 661.1 701.3 703.7 705.3 12778.7 12841.9 12894.7 12903.0 13392.8 11932.9 12820.4 12831.0 12879.5 13167.0 12293.9 12448.6 12469.5 12897.6 13069.5 4578.0 4581.7 4626.5 4787.5 4837.6 74693.8 78904.6 86240.1 88188.6 90805.6 10292.9 10522.7 10573.6 10629.5 10842.2 15941.3 19190.6 19287.5 19426.0 19458.7 7442.0 7518.2 7588.1 7658.8 7784.0 4362.3 4430.1 4454.1 4473.2 4568.9 3330.9 3396.1 3400.9 3414.2 3456.9 656.0 657.4 675.6 676.0 726.9 574.6 619.5 627.8 653.0 686.5 8354.6 9362.3 9489.3 9750.9 9953.1 616.6 620.2 629.6 641.3 655.6 4604.4 4683.4 4746.3 4753.4 4775.1 93037.6 97170.5 99662.5 102372.0 120661.0 66343.0 81775.5 84710.0 86097.6 90256.5 65002.7 70913.6 78820.0 81258.6 83963.5 8151.6 9563.0 10101.3 10160.8 10194.6 55088.2 56154.7 56432.1 56755.7 57325.7 80480.6 80935.0 82386.2 83983.6 85196.6 12606.7 13071.0 13436.9 13914.3 14053.5 14519.3 14522.3 14634.9 14875.9 14910.7 13700.2 13746.7 13829.9 13937.4 13976.3 13203.8 13834.7 13861.6 14440.4 14452.5 13689.8 13707.3 14069.9 14166.9 14258.1 11527.3 11536.0 11684.2 11712.0 12107.2 9836.4 11455.0 11711.8 11735.5 11843.6 18:12:27 INFO - PROCESS | 1639 | -------- Summary: end -------- 18:12:27 INFO - PROCESS | 1639 | 18:12:28 INFO - TEST-INFO | 1639: exit 0 18:12:28 INFO - TEST-OK | dromaeo_css | took 1114321ms 18:12:28 INFO - TEST-START | kraken 18:12:28 INFO - operating with platform_type : mac_ 18:12:28 INFO - Initialising browser for kraken test... 18:12:28 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpi7QMMu/profile http://localhost:49236/getInfo.html) 18:12:31 INFO - PROCESS | 1650 | 2017-02-01 18:12:31.274 plugin-container[1652:9782] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 18:12:31 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:12:31 INFO - PROCESS | 1650 | 2017-02-01 18:12:31.275 plugin-container[1652:9782] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8923, name = 'com.apple.CFPasteboardClient' 18:12:31 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:12:31 INFO - PROCESS | 1650 | 2017-02-01 18:12:31.275 plugin-container[1652:9782] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:12:31 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 18:12:31 INFO - PROCESS | 1650 | colorDepth:24 18:12:31 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 18:12:31 INFO - PROCESS | 1650 | __metrics 18:12:31 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 18:12:32 INFO - TEST-INFO | 1650: exit 0 18:12:32 INFO - Browser initialized. 18:12:32 INFO - Running cycle 1/1 for kraken test... 18:12:32 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpi7QMMu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:12:34 INFO - PROCESS | 1653 | 2017-02-01 18:12:34.878 plugin-container[1654:9918] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x424b, name = 'com.apple.tsm.portname' 18:12:34 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:12:34 INFO - PROCESS | 1653 | 2017-02-01 18:12:34.878 plugin-container[1654:9918] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4517, name = 'com.apple.CFPasteboardClient' 18:12:34 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:12:34 INFO - PROCESS | 1653 | 2017-02-01 18:12:34.878 plugin-container[1654:9918] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:12:44 INFO - PROCESS | 1653 | RSS: Main: 177487872 18:12:44 INFO - PROCESS | 1653 | 18:12:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 18:12:48 INFO - PROCESS | 1653 | RSS: Main: 190521344 18:12:48 INFO - PROCESS | 1653 | 18:12:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 18:12:51 INFO - PROCESS | 1653 | RSS: Main: 198897664 18:12:51 INFO - PROCESS | 1653 | 18:12:55 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 18:12:55 INFO - PROCESS | 1653 | RSS: Main: 201961472 18:12:55 INFO - PROCESS | 1653 | 18:12:57 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 18:12:58 INFO - PROCESS | 1653 | RSS: Main: 202387456 18:12:58 INFO - PROCESS | 1653 | 18:13:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:13:00 INFO - PROCESS | 1653 | RSS: Main: 202424320 18:13:00 INFO - PROCESS | 1653 | 18:13:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 18:13:04 INFO - PROCESS | 1653 | RSS: Main: 206512128 18:13:04 INFO - PROCESS | 1653 | 18:13:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 18:13:08 INFO - PROCESS | 1653 | RSS: Main: 205631488 18:13:08 INFO - PROCESS | 1653 | 18:13:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 18:13:11 INFO - PROCESS | 1653 | RSS: Main: 207106048 18:13:11 INFO - PROCESS | 1653 | 18:13:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:13:13 INFO - PROCESS | 1653 | RSS: Main: 206086144 18:13:13 INFO - PROCESS | 1653 | 18:13:15 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:13:16 INFO - PROCESS | 1653 | RSS: Main: 206094336 18:13:16 INFO - PROCESS | 1653 | 18:13:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:13:19 INFO - PROCESS | 1653 | RSS: Main: 206163968 18:13:19 INFO - PROCESS | 1653 | 18:13:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:13:22 INFO - PROCESS | 1653 | RSS: Main: 206569472 18:13:22 INFO - PROCESS | 1653 | 18:13:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:13:26 INFO - PROCESS | 1653 | RSS: Main: 206602240 18:13:26 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 18:13:28 INFO - PROCESS | 1653 | RSS: Main: 208396288 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | __start_tp_report 18:13:28 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 18:13:28 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 18:13:28 INFO - PROCESS | 1653 | |i|pagename|runs| 18:13:28 INFO - PROCESS | 1653 | |0;ai-astar;108;118;115;118;147;156;176;175;118;120 18:13:28 INFO - PROCESS | 1653 | |1;audio-beat-detection;140;116;138;147;102;147;143;110;141;128 18:13:28 INFO - PROCESS | 1653 | |2;audio-dft;193;199;194;201;250;256;198;196;197;199 18:13:28 INFO - PROCESS | 1653 | |3;audio-fft;84;58;61;87;60;58;58;58;76;60 18:13:28 INFO - PROCESS | 1653 | |4;audio-oscillator;95;71;89;72;69;74;83;69;72;88 18:13:28 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;77;135;137;85;108;125;138;132;92;132 18:13:28 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;123;116;95;94;94;95;95;94;115 18:13:28 INFO - PROCESS | 1653 | |7;imaging-desaturate;89;87;94;78;138;134;91;88;90;97 18:13:28 INFO - PROCESS | 1653 | |8;json-parse-financial;55;55;56;57;60;61;59;60;59;58 18:13:28 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;68;73;67;84;74;74;69;68;71;72 18:13:28 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;106;76;81;105;107;103;107;84;85;86 18:13:28 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;162;150;134;150;154;144;148;164;207;158 18:13:28 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;167;190;167;164;164;162;185;160;238;228 18:13:28 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;66;68;68;66;68;65;67;66;68;65 18:13:28 INFO - PROCESS | 1653 | __end_tp_report 18:13:28 INFO - PROCESS | 1653 | __start_cc_report 18:13:28 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,916 18:13:28 INFO - PROCESS | 1653 | __end_cc_report 18:13:28 INFO - PROCESS | 1653 | __startTimestamp1486001608452__endTimestamp 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | ------- Summary: start ------- 18:13:28 INFO - PROCESS | 1653 | Number of tests: 14 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:135.10 Median:133.50 stddev:26.01 (19.5%) stddev-sans-first:25.67 18:13:28 INFO - PROCESS | 1653 | Values: 108.0 118.0 115.0 118.0 147.0 156.0 176.0 175.0 118.0 120.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:140.50 stddev:16.34 (11.6%) stddev-sans-first:17.01 18:13:28 INFO - PROCESS | 1653 | Values: 140.0 116.0 138.0 147.0 102.0 147.0 143.0 110.0 141.0 128.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:208.30 Median:199.00 stddev:23.72 (11.9%) stddev-sans-first:24.51 18:13:28 INFO - PROCESS | 1653 | Values: 193.0 199.0 194.0 201.0 250.0 256.0 198.0 196.0 197.0 199.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:11.63 (19.2%) stddev-sans-first:10.36 18:13:28 INFO - PROCESS | 1653 | Values: 84.0 58.0 61.0 87.0 60.0 58.0 58.0 58.0 76.0 60.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.50 stddev:9.62 (12.3%) stddev-sans-first:8.06 18:13:28 INFO - PROCESS | 1653 | Values: 95.0 71.0 89.0 72.0 69.0 74.0 83.0 69.0 72.0 88.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:137.50 stddev:23.57 (17.1%) stddev-sans-first:20.32 18:13:28 INFO - PROCESS | 1653 | Values: 77.0 135.0 137.0 85.0 108.0 125.0 138.0 132.0 92.0 132.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:101.50 Median:94.00 stddev:11.58 (12.3%) stddev-sans-first:11.96 18:13:28 INFO - PROCESS | 1653 | Values: 94.0 123.0 116.0 95.0 94.0 94.0 95.0 95.0 94.0 115.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:98.60 Median:89.50 stddev:20.34 (22.7%) stddev-sans-first:21.28 18:13:28 INFO - PROCESS | 1653 | Values: 89.0 87.0 94.0 78.0 138.0 134.0 91.0 88.0 90.0 97.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:59.00 stddev:2.16 (3.7%) stddev-sans-first:2.00 18:13:28 INFO - PROCESS | 1653 | Values: 55.0 55.0 56.0 57.0 60.0 61.0 59.0 60.0 59.0 58.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:72.50 stddev:4.94 (6.8%) stddev-sans-first:5.03 18:13:28 INFO - PROCESS | 1653 | Values: 68.0 73.0 67.0 84.0 74.0 74.0 69.0 68.0 71.0 72.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:78.50 stddev:12.57 (16.0%) stddev-sans-first:12.56 18:13:28 INFO - PROCESS | 1653 | Values: 106.0 76.0 81.0 105.0 107.0 103.0 107.0 84.0 85.0 86.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:157.10 Median:156.00 stddev:19.61 (12.6%) stddev-sans-first:20.72 18:13:28 INFO - PROCESS | 1653 | Values: 162.0 150.0 134.0 150.0 154.0 144.0 148.0 164.0 207.0 158.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.50 Median:176.00 stddev:28.49 (16.2%) stddev-sans-first:29.66 18:13:28 INFO - PROCESS | 1653 | Values: 167.0 190.0 167.0 164.0 164.0 162.0 185.0 160.0 238.0 228.0 18:13:28 INFO - PROCESS | 1653 | 18:13:28 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 18:13:28 INFO - PROCESS | 1653 | Values: 66.0 68.0 68.0 66.0 68.0 65.0 67.0 66.0 68.0 65.0 18:13:28 INFO - PROCESS | 1653 | -------- Summary: end -------- 18:13:28 INFO - PROCESS | 1653 | 18:13:29 INFO - TEST-INFO | 1653: exit 0 18:13:29 INFO - TEST-OK | kraken | took 60869ms 18:13:29 INFO - SUITE-END | took 1175s 18:13:29 INFO - Completed test suite (00:19:35) 18:13:29 INFO - javascript benchmark 18:13:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7373.24944564558, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3481.112316359328, 3537.416326306159, 3539.769914955528, 3545.4681797730336, 3575.9821200893994, 5872.324682661495, 5913.793017244392, 5937.970310148454, 6017.608855424394, 6030.668313242781, 5947.375525569818, 6021.09683547467, 6027.216461859952, 6039.214902062737, 6070.605410648316, 5301.655392399492, 5356.678599284055, 5361.356637203541, 5391.865203369908, 5503.862403439926, 4469.396631454761, 5354.544863686591, 5431.6740995540395, 5435.619506634537, 5441.564674826024, 4526.79629416677, 5083.389993200803, 5361.651492652965, 5415.0523658360025, 5422.322209723785, 4230.365445183216, 5292.100342941709, 5335.7865685372535, 5338.839834804962, 5410.648307860016, 5254.7635356409055, 5277.759726464278, 5284.233786100994, 5296.655717378358, 5300.310959575269, 4731.982623735913, 5752.654840709571, 6017.308009578867, 6023.337432882379, 6028.5478589106, 6161.691915404212, 6172.0, 6232.909240882827, 6233.065040243954, 6343.524235682342, 6393.776217832354, 6410.615363078184, 6429.03564465334, 6433.163688720483, 6434.774782882577, 6086.421789929949, 6134.325224225332, 6136.048912418582, 6137.447629713347, 6154.0, 6257.092721555349, 6309.873802523924, 6391.872162556723, 6403.839904002344, 6437.324080971431, 6184.103305020837, 6238.844028899314, 6245.125682404467, 6267.122602835607, 6267.122602835607, 6384.138141350951, 6390.488760899117, 6398.744050238031, 6399.64801935898, 6404.0, 6175.197224360804, 6185.0, 6211.472024877846, 6213.596116252429, 6243.406876346739, 6282.685865706696, 6330.525210609223, 6331.05034244867, 6332.588381755171, 6335.493160547145, 5141.5886729061585, 5151.25306830515, 5151.845444636667, 5166.483351664803, 5172.612054095883, 4455.1980643484485, 4546.545345465427, 4580.1068791585985, 4608.9308660370125, 4669.066186762661, 5990.5507086968655, 6049.697515124226, 6085.36103709113, 6120.60216085953, 6125.17440701618, 5657.745401456944, 6458.741650333934, 6469.126667899867, 6482.0, 6530.05314229434, 5953.434423729739, 6011.9699401503585, 6036.547258955508, 6039.66781826995, 6058.727357268934, 5671.546276297886, 5676.489115979499, 5677.914831277534, 5679.602427830095, 5717.285339332583, 6572.178477690289, 6608.107905432801, 6631.801045968725, 6638.435732962752, 6665.966670166618, 6130.031268545553, 6199.473044791062, 6283.560150789401, 6332.366763323631, 6458.354164583504, 6511.576747511396, 6628.767993120217, 6631.204255489372, 6634.767783127568, 6662.267150613526, 6347.936520634735, 6381.904271435839, 6385.393387628168, 6392.456641185551, 6417.454516365974, 6216.564840461125, 6243.125962365363, 6325.683715814099, 6372.235331760218, 6462.4183823456115, 5187.688738675692, 6165.691715414301, 6184.845378865564, 6195.907061394173, 6207.937920620917, 6212.130301757667, 6236.095766113979, 6276.905846412399, 6284.4344009039405, 6291.993281075006, 4885.609151267819, 6063.757449701962, 6231.2522497300615, 6239.4696450800375, 6265.592736472115, 6130.8567837443225, 6144.726451212901, 6178.351273116258, 6216.160818289654, 6255.218097737783, 6185.628862268279, 6224.782132625336, 6226.782062627786, 6239.625622462667, 6251.6874156292915], "value": 5848.031454082667, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.68212933076177, 484.1962342511429, 530.4774796825129, 537.3846945247692, 547.0017218576098, 40622.59377406229, 42633.0, 42640.786796066015, 42840.0, 44569.55430445694, 35580.46629300562, 44330.77834610822, 44635.88410289744, 44744.0, 44771.0, 9681.806363872718, 9684.37051591646, 9767.609295628166, 9823.165030972375, 9865.0, 8278.958605206966, 9635.518224088803, 9646.324757266993, 9724.367916085432, 9819.754506137368, 9799.608015679365, 9834.114929656329, 9835.852462213072, 9839.21286297098, 9841.753956151082, 9702.417854928726, 9748.902510974905, 9800.313978021577, 9801.705948821547, 9808.36245644038, 9711.223102151811, 9752.512374381324, 9791.0, 9792.020797920222, 9819.459929703864, 42173.789131054145, 42274.78862605698, 42527.57472425267, 42606.0, 42620.0, 3308.5368048473233, 3449.448088305859, 3503.5095086687884, 3687.4468829675493, 4169.332906734908, 24675.62986555203, 31119.06642800697, 31180.220494487592, 31670.524942125885, 31921.042368728977, 3141.497360422344, 3176.539401786751, 3184.2835362043356, 3243.464828303327, 3246.5779448671756, 527852.0, 529460.0, 530299.0, 531783.0, 532833.9999999962, 65969.34030659632, 66653.0, 66689.6665516679, 66773.66613167, 66806.33193668099, 69203.65398172977, 69443.0, 69629.0, 69675.30324696688, 69772.95340569895, 16692.24884880183, 17002.914985424995, 17271.4818555441, 17496.125193740263, 17515.737263940795, 13011.869881301254, 13264.867351326557, 13334.799978000337, 13336.399862006234, 13367.532136375181, 16017.59956001086, 17693.469195924143, 19961.401157965283, 20013.899930500254, 20022.69965950512, 6652.7006284716335, 7822.608869556613, 7892.881606775903, 7952.125266220711, 8032.83934321322, 862.3058437957504, 872.3631748823394, 882.8543290357147, 989.8069876374038, 991.5389343954952, 23971.400714981915, 30770.69229307723, 31255.531167032514, 31516.527252091237, 32037.359252814815, 1048.8688913885765, 1104.4588151805717, 1131.7849608574345, 1137.5392965848844, 1185.3125187391292, 13732.588022359345, 15802.36790528366, 15980.840191598169, 16189.757153642704, 16358.509244722678, 443298.0, 445053.0, 445682.0, 447001.0, 447330.0, 56069.43930560642, 56464.43535564674, 56824.71587642118, 56905.43094569084, 57127.14309285364, 1227.8894899459092, 1384.723055388906, 1388.3058470764618, 1393.8188035555313, 1409.5066726645591, 29584.112476625734, 29598.704012960457, 30258.84870575633, 30793.846030769702, 31113.222169445944, 48581.5141848577, 48977.51022489872, 49204.507954919995, 49279.0, 49281.75359123181, 326046.0, 326506.0, 326540.0, 328880.3555982205, 330088.0, 26575.33561660974, 26898.32754181161, 27031.1890643281, 27779.722202777713, 28273.57589636116, 34659.65340346564, 47600.80997975078, 48539.0, 49488.75255623699, 49508.50491495039, 39401.80299098486, 39927.00182495461, 40378.39432408458, 40754.0, 41969.580304197785, 40045.79977100096, 40354.0, 40825.79587102164, 41922.0, 42091.94770130771, 38832.80583597064, 39203.0, 39870.0, 40115.39826902657, 40205.0, 31151.84424077865, 32498.350032998736, 33087.0, 34809.60761569509, 35958.64041359658, 26744.732552674224, 26843.19470415891, 26847.060352887554, 26981.595276070482, 27252.182434526996], "value": 19907.858163280605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.6786604524769, 378.4002356265319, 390.8768737847576, 399.2952438945262, 416.972163616685, 15786.763198552031, 19419.41741747748, 20642.17431302748, 20793.960301984916, 21008.36974890752, 20027.899860500715, 20034.398968030982, 20550.58898822023, 20817.0, 21168.788312116874, 5664.490195882369, 5929.110633404992, 5975.0439929611275, 6110.908336374958, 6186.319504854462, 6040.848978775522, 6133.386661333853, 6138.47822935051, 6146.539009574278, 6146.938530614681, 5823.475887170154, 6046.093086037107, 6093.329733729286, 6100.572959892787, 6103.755849766004, 5788.855278618068, 5986.820395388146, 6005.309389420229, 6058.575899687024, 6086.878262434749, 5267.025600263925, 5275.973620131875, 5280.339957505312, 5317.335333083364, 5329.120695085307, 21761.782382176134, 25185.0, 26013.73986260151, 26048.609270860954, 26233.475330493475, 2579.2649095007832, 2629.737026297374, 2711.8779654915575, 3232.1273256220925, 3236.96763032369, 10326.432046237454, 10438.582456701799, 11914.344711040889, 13626.909847212299, 15712.528624141294, 1932.1981377728225, 1979.9109040093085, 1985.7021446783099, 1989.8706584071988, 2012.8087831655969, 82375.5881220596, 115073.0, 116918.41540792327, 126177.0, 135225.0, 10238.795224095476, 10949.671509854557, 11337.546498140147, 11812.0, 12162.75674486523, 15024.323905424064, 15044.247787610575, 15123.621909452351, 15172.165530895907, 15185.468508602145, 8573.142685731376, 8827.735167944971, 8837.646494140163, 8946.329025323126, 8971.461712297283, 8657.0, 8743.169398907094, 8744.169303916118, 8852.778680533038, 8855.247303979233, 4215.777424546847, 4271.9359209611885, 4673.112108699336, 4675.836345727883, 4702.612729244881, 1952.7461430014007, 1994.9850650842463, 2000.8099230573073, 2011.7988201179764, 2018.2532462988788, 840.7477756672973, 850.8808766772656, 938.8591711243231, 995.0298459002415, 1075.9623413180502, 16616.25226864794, 20759.377218683163, 20855.791442085687, 20988.580228395345, 21089.945502724804, 829.3986859526915, 946.4983558713893, 953.4660590069583, 984.414273507262, 985.4826216236534, 10951.83572246417, 11384.37385943781, 11399.886001140048, 11414.429278536207, 11434.771304573862, 511469.0, 614721.0, 622360.0, 634843.0, 635506.0, 101245.0, 133200.0, 137468.56328591864, 138673.0, 143904.0, 981.7153025622489, 1014.7057353367588, 1027.0294571629888, 1030.644427672452, 1035.1046344911597, 18247.54381140482, 19611.607767844278, 19731.210751569775, 19771.20915163435, 19838.40484785459, 40775.79612101921, 52527.474725253785, 52984.20523692071, 54729.0, 56432.0, 76078.61960690162, 80616.59691701503, 81516.18483815086, 82592.58703706443, 84058.15941840503, 5372.650777699437, 5595.440455954372, 8018.158093400109, 8185.71350002747, 8381.49711017341, 11739.002184814044, 12814.423350949417, 12999.285039322927, 13121.540746074223, 13253.271070091238, 11028.0, 11099.223054386115, 11123.443827808416, 11428.657140285804, 11445.027172690414, 10879.510422031186, 10967.725806854893, 10988.670339889815, 11068.944655276671, 11423.771524569629, 11182.099043162845, 11532.019778318936, 11598.0, 11623.59317423886, 11641.59254426091, 7936.56348900816, 8094.352451803724, 8125.918740812516, 8426.283765879969, 8481.024682161631, 8351.540665263468, 10234.590616375262, 11182.832257515982, 11401.885981140415, 11477.426128693698], "value": 9740.464409785, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.4143459746906, 1495.910245385277, 1677.4967509747073, 1789.740487629293, 1861.097367776628, 7656.808579785495, 7907.565083920382, 8224.547649879254, 8605.784855378619, 8615.353848461367, 6478.870422591545, 8383.245507904287, 8424.199701028392, 8466.153384661531, 8499.065102838698, 2006.4883454719027, 2236.1390864517116, 2408.0127147869375, 2409.4337830609793, 2423.151896836111, 2403.0, 2422.842515236504, 2436.9390765230833, 2437.85372877627, 2446.4006318452, 2048.4162013826062, 2363.397333679909, 2384.2132096408145, 2407.9036838526526, 2421.6125419932814, 1989.8706584072133, 2321.6981792367055, 2353.1646265575646, 2392.3899405651623, 2401.531701318235, 2382.332946774906, 2396.748341424143, 2402.723686776008, 2406.4585468269674, 2407.807375409963, 8368.953880764904, 8498.787530311793, 8509.914900850974, 8552.35857310698, 8576.271016963565, 4423.51341352451, 5015.598752099823, 5275.973620131913, 5295.31160949078, 5295.920561191585, 3380.6281309055985, 3537.239493508908, 3641.8543258269638, 3657.3051120287328, 3665.486831843544, 987.8666380038746, 1029.5521448169995, 1076.34343050739, 1111.5109351885144, 1123.3709122891207, 10992.890071099268, 11073.446327683583, 11086.334819910831, 11098.112151027979, 11104.167187460973, 4611.262198048296, 4629.888826681572, 4721.291806229025, 4859.368282123372, 4862.197737373364, 8670.86993695095, 9215.262778977665, 9504.239660827117, 9531.857022144673, 9550.904490955141, 5245.501677340647, 5274.472552744772, 5305.8938821223355, 5339.733013349394, 5429.945700542944, 4422.71252368595, 4446.911061778746, 4879.95120048795, 4907.3620429343955, 4916.72957987307, 3364.1925937775245, 3932.134930315326, 3942.8619998299923, 3975.403689446606, 4022.7328391556566, 1296.6110166949877, 1302.1666133674455, 1305.2560040776666, 1315.2305901047994, 1316.3155159317294, 774.2721841469114, 851.8892543969368, 869.9695510657223, 944.9952750236342, 957.4590356448584, 5067.189249720101, 5526.198701188305, 5588.944110558842, 5598.048331783607, 5809.390014048464, 913.5021413329752, 967.99032009679, 1011.5903059261011, 1026.825439675257, 1031.0926384781344, 3817.2174704185577, 3936.193080418507, 3943.921121577552, 3961.742486738353, 3976.522817261889, 10004.699859004242, 10159.949200253952, 10339.276250662382, 10364.792704145875, 10370.014848589371, 10127.848082278771, 10131.898681013243, 10282.691519254435, 10339.121174700083, 10339.379637221791, 7606.695732170651, 7964.1637628049375, 8027.7993050173045, 8052.5571093590415, 8187.38594605407, 5880.26496687914, 5922.674252916131, 5941.91087133702, 5984.521238300838, 6112.816615501542, 9212.124848139416, 9513.66702165421, 9565.426074435556, 9618.663346782829, 9634.325597208128, 9374.062593740844, 9452.338336316392, 9558.61765529371, 9686.660966866126, 9735.853962190715, 7282.854342913218, 7369.77890663281, 7373.0, 7452.813679658052, 7476.21499742541, 7907.367410607023, 7925.524468531907, 7978.720744773905, 7990.240927111915, 7992.5204487730925, 7106.5736055836815, 7222.458315626454, 7280.708771649287, 7349.926500735138, 7407.962960185165, 6401.751658426562, 6822.761203357859, 7093.432525398059, 7150.070490836366, 7302.6713797878165, 5631.436856314336, 6765.357291057342, 6853.0, 6853.4859885507785, 6856.725730970706, 4887.047025829929, 4987.9002419950675, 5022.547970682656, 5024.321716568216, 5053.924191137063, 4941.6293777966075, 4973.35346404965, 4980.05378977993, 5024.271480635214, 5141.691498510101], "value": 4500.549431124692, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.86359524844704, 322.6934412308308, 322.8821480159742, 325.3395606917957, 329.0687354785957, 4143.544210136883, 5325.721826761578, 5408.4050754417085, 5448.863778405537, 5668.6315389499705, 4567.817287308504, 4654.418197725285, 4850.054239423313, 5577.135543990677, 5641.774329026834, 4016.2569924563977, 4093.97953010236, 4153.02403935075, 4208.83245128759, 4279.015826359939, 4220.894477638069, 4225.830966761341, 4240.936385954213, 4260.957390426102, 4275.337322714984, 3412.897613071612, 4194.182134483777, 4241.618254357108, 4255.893602659928, 4268.530461649231, 4157.688173386993, 4217.536071032184, 4224.429701990253, 4239.745615263063, 4253.2769429197115, 3355.580552430946, 3386.593608766964, 3473.4369533709933, 3670.743047986642, 3686.502322186497, 4549.2258019372475, 4577.633789296849, 5423.674579525241, 5451.700156491392, 5461.061323230276, 4329.437173167468, 4767.42790865095, 4868.902621947576, 4913.764237272033, 4990.700557966534, 5193.610479214074, 5529.944700552983, 5645.943540564624, 5777.075667893159, 5908.307307932542, 3770.377887648535, 4130.876073717794, 4139.689523285766, 4154.4183814266025, 4175.039740859619, 4663.253879379283, 5491.890162196773, 6107.511399088106, 6120.234970628671, 6234.438900498977, 3612.512310838003, 4156.605122513356, 4182.372644103348, 4192.308269135619, 4210.2842516772225, 3624.4744512045604, 3837.8678289904547, 3985.70107241958, 4268.59448352406, 4288.549702281278, 4134.813933373005, 4611.717199986028, 4895.0, 4925.926111108264, 4966.478519755446, 5455.427180146107, 5553.333599968029, 5907.63694522186, 5925.73334199962, 6037.366076561985, 1090.6727981605486, 1278.9936050319689, 1370.8012338211104, 1382.8478867324586, 1387.4658256571292, 718.795143384133, 838.2581415447373, 891.2379915172564, 911.6234485926299, 954.7540459700158, 5091.556053094535, 5377.838664840061, 5523.696196709139, 5591.608587398924, 5603.1984007996, 5282.181261904411, 5425.755840987165, 5991.55063370249, 6138.171346868205, 6147.508199344042, 4452.4211852458975, 4941.344649542371, 5444.972775136099, 5578.163275508625, 5582.883423315353, 3052.9084127476212, 3056.144279601715, 3064.4371370600707, 3070.45152523405, 3083.6894319913945, 5387.892242155213, 5650.915236271459, 6003.388525991208, 6022.638641681513, 6103.969480152659, 4973.47778483254, 5090.338256026767, 5365.490278423622, 5715.914261286084, 5889.172038175135, 5753.446569426315, 5950.5239580834295, 6018.8194354169445, 6052.818415447544, 6082.452579267887, 4883.096627123993, 5313.814016509404, 5371.69017322555, 5759.942400576108, 5848.654809393778, 4798.73606951621, 5069.442361340323, 5140.511651393262, 5608.822147348939, 5700.800471983461, 5114.411842638145, 5552.361478429871, 5938.991180952926, 5982.46157845796, 6000.609960352563, 3690.8892733218045, 3745.3071181831447, 3920.31394505966, 4061.7156799024965, 4093.874184599259, 5990.64056156632, 6112.074696470598, 6119.388061193845, 6140.3245642978345, 6147.784827531015, 4814.677872268124, 5664.26364572603, 5672.716364181857, 5961.523078153824, 6024.819255422344, 4919.729414882073, 5599.692016939108, 5860.208871802422, 5919.496842768241, 5928.229330187048, 4772.785224664968, 4979.103761322996, 5161.612879034013, 5448.591355648263, 5842.970785146217, 5022.070916880389, 5289.550388217045, 5348.0, 5720.227769251264, 5799.246098007401, 4864.635152363516, 4895.485973972682, 5044.344235249394, 5898.705064746659, 5902.557308201816], "value": 4188.119071428145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.9145702515696, 747.3498056690678, 763.7708687393784, 784.2275358771609, 821.954792486413, 15199.16404597748, 15746.84253157468, 15818.683626327494, 15843.366265349387, 15848.603784905383, 13948.442062317521, 14120.71758564828, 14259.429622815074, 14318.64203394913, 14325.713485730279, 858.3733874271785, 881.497546398553, 891.189017993626, 893.2942975049702, 895.83427065993, 867.7483529776357, 873.3406278259905, 875.7504111328273, 878.1876763993281, 881.5504092912597, 877.8112705768259, 907.3376435202306, 919.2921450483124, 931.417863835103, 932.6409332407038, 912.6075787411411, 914.3416739947294, 915.1946287267195, 915.7847905742145, 917.6100157433098, 659.5613916745407, 661.137215933207, 701.253165378875, 703.7290643102391, 705.3405066263009, 12778.744425111445, 12841.87158128416, 12894.677633059155, 12903.0, 13392.799108013387, 11932.940335298355, 12820.423080961378, 12831.03767217453, 12879.484820607164, 13167.0, 12293.877061229452, 12448.564300249447, 12469.501219951191, 12897.613071607866, 13069.54256601024, 4577.9542204577865, 4581.748003859786, 4626.537346265381, 4787.54518320759, 4837.637177211724, 74693.75918722447, 78904.60547697282, 86240.13759862384, 88188.55905720494, 90805.63791543132, 10292.897071029343, 10522.736931576772, 10573.577056917791, 10629.46852657364, 10842.186835987175, 15941.282642281125, 19190.61618767645, 19287.51781205453, 19426.028698565016, 19458.70811937822, 7441.962790186014, 7518.173000969889, 7588.089429268523, 7658.770236892902, 7783.961080194563, 4362.280223763107, 4430.13612345596, 4454.086912182995, 4473.150101480708, 4568.88577785558, 3330.8834190803204, 3396.100033491127, 3400.9489857652156, 3414.2488652496413, 3456.948145777815, 655.9967200164064, 657.3984803904374, 675.6419097878132, 675.972961081561, 726.9273072692794, 574.5719439017959, 619.4579742725116, 627.7551754815626, 652.9953044154495, 686.5228666077029, 8354.58227088643, 9362.25101991839, 9489.335746497678, 9750.853737193947, 9953.104220620178, 616.6269407008784, 620.1906512001881, 629.6002038705363, 641.3330136657823, 655.6099121022984, 4604.37840891482, 4683.391159149357, 4746.28805679144, 4753.405824271966, 4775.140474714515, 93037.60443593352, 97170.51414742881, 99662.5016874911, 102372.0, 120661.0, 66343.0, 81775.5467335981, 84710.0, 86097.56951215329, 90256.548717256, 65002.67498662571, 70913.64543177251, 78820.0, 81258.59370703109, 83963.48109556723, 8151.551664658501, 9562.95218523903, 10101.292909496558, 10160.847587286049, 10194.643187488402, 55088.17367739567, 56154.719226403606, 56432.07463216467, 56755.71622141863, 57325.713371432874, 80480.59759701398, 80935.0, 82386.17613824025, 83983.5800820992, 85196.57401712952, 12606.747865042831, 13071.0, 13436.93281533586, 13914.304284785923, 14053.508127215498, 14519.274036298355, 14522.273886305431, 14634.92682536623, 14875.925620371829, 14910.701785964437, 13700.24648644334, 13746.725065498835, 13829.930850345683, 13937.372818223406, 13976.301184940916, 13203.801942971055, 13834.65413364674, 13861.584152475441, 14440.350184241945, 14452.494162704676, 13689.794653080013, 13707.314634268047, 14069.929650352093, 14166.929165354108, 14258.144511329354, 11527.250728702607, 11536.0, 11684.18210725241, 11712.0, 12107.152499324962, 9836.409815411098, 11455.001771289137, 11711.824322634997, 11735.530578776754, 11843.644690659294], "value": 7516.399994881371, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 115.0, 118.0, 147.0, 156.0, 176.0, 175.0, 118.0, 120.0], "value": 135.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 116.0, 138.0, 147.0, 102.0, 147.0, 143.0, 110.0, 141.0, 128.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 199.0, 194.0, 201.0, 250.0, 256.0, 198.0, 196.0, 197.0, 199.0], "value": 208.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 61.0, 87.0, 60.0, 58.0, 58.0, 58.0, 76.0, 60.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 71.0, 89.0, 72.0, 69.0, 74.0, 83.0, 69.0, 72.0, 88.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 135.0, 137.0, 85.0, 108.0, 125.0, 138.0, 132.0, 92.0, 132.0], "value": 116.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 123.0, 116.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 115.0], "value": 101.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 94.0, 78.0, 138.0, 134.0, 91.0, 88.0, 90.0, 97.0], "value": 98.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 57.0, 60.0, 61.0, 59.0, 60.0, 59.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 67.0, 84.0, 74.0, 74.0, 69.0, 68.0, 71.0, 72.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 76.0, 81.0, 105.0, 107.0, 103.0, 107.0, 84.0, 85.0, 86.0], "value": 94.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 150.0, 134.0, 150.0, 154.0, 144.0, 148.0, 164.0, 207.0, 158.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 190.0, 167.0, 164.0, 164.0, 162.0, 185.0, 160.0, 238.0, 228.0], "value": 182.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 66.0, 68.0, 65.0, 67.0, 66.0, 68.0, 65.0], "value": 66.7, "unit": "score"}]}]} 18:13:29 INFO - Return code: 0 18:13:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:13:29 ERROR - # TBPL SUCCESS # 18:13:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:13:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:13:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:13:29 INFO - 2017-02-01 18:13:29.793 screenresolution[1658:10297] starting screenresolution argv=screenresolution get 18:13:29 INFO - 2017-02-01 18:13:29.797 screenresolution[1658:10297] Display 0: 1600x1200x32@60 18:13:29 INFO - 2017-02-01 18:13:29.803 screenresolution[1659:10300] starting screenresolution argv=screenresolution list 18:13:29 INFO - Available Modes on Display 0 18:13:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:13:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:13:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:13:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:13:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:13:30 INFO - Intel Iris: 18:13:30 INFO - Chipset Model: Intel Iris 18:13:30 INFO - Type: GPU 18:13:30 INFO - Bus: Built-In 18:13:30 INFO - VRAM (Dynamic, Max): 1536 MB 18:13:30 INFO - Vendor: Intel (0x8086) 18:13:30 INFO - Device ID: 0x0a2e 18:13:30 INFO - Revision ID: 0x0009 18:13:30 INFO - Displays: 18:13:30 INFO - Display: 18:13:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:13:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:13:30 INFO - Display Serial Number: 1600x1200 60 18:13:30 INFO - Main Display: Yes 18:13:30 INFO - Mirror: Off 18:13:30 INFO - Online: Yes 18:13:30 INFO - Rotation: Supported 18:13:30 INFO - Return code: 0 18:13:30 INFO - Running post-action listener: _resource_record_post_action 18:13:30 INFO - [mozharness: 2017-02-02 02:13:30.043477Z] Finished run-tests step (success) 18:13:30 INFO - Running post-run listener: _resource_record_post_run 18:13:30 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 37992448; Write bytes: 499069440; Read time: 382; Write time: 1661 18:13:30 INFO - TinderboxPrint: CPU usage
53.9% 18:13:30 INFO - TinderboxPrint: I/O read bytes / time
37,992,448 / 382 18:13:30 INFO - TinderboxPrint: I/O write bytes / time
499,069,440 / 1,661 18:13:30 INFO - TinderboxPrint: CPU idle
2,205.9 (46.1%) 18:13:30 INFO - TinderboxPrint: CPU system
967.0 (20.2%) 18:13:30 INFO - TinderboxPrint: CPU user
1,616.8 (33.8%) 18:13:30 INFO - TinderboxPrint: Swap in / out
229,425,152 / 0 18:13:30 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 187546112; Write bytes: 186191872; Read time: 16798; Write time: 364 18:13:30 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 36022272; Write bytes: 305910272; Read time: 362; Write time: 1270 18:13:30 INFO - Running post-run listener: _upload_blobber_files 18:13:30 INFO - Blob upload gear active. 18:13:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:13:30 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 18:13:30 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'] 18:13:30 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 18:13:30 INFO - (blobuploader) - INFO - Open directory for files ... 18:13:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:13:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:13:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:13:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:13:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:13:32 INFO - (blobuploader) - INFO - Done attempting. 18:13:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:13:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:13:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:13:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:13:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:13:33 INFO - (blobuploader) - INFO - Done attempting. 18:13:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:13:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:13:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:13:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:13:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:13:35 INFO - (blobuploader) - INFO - Done attempting. 18:13:35 INFO - (blobuploader) - INFO - Iteration through files over. 18:13:35 INFO - Return code: 0 18:13:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:13:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:13:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/596d57f12b68da62247f375a45e7b94504e6d3b3c3798b7f598bee064fc6ced7ee8b1a4db247a6104207c89edc6e169f8a0ff774084d9eb3caaa7e66ffb05f1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c4c43da8ce105daa02309a4102d5f2057a0bcedc864b31dbc97ea63fb5620ea4a68d4db78b9a89751a9963c41fd34d621deb7a4a13ca32132306b4e9c5ef1bc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45949757c18f085a6b2f2074544fa88fd1cfe177d1e85f9dfe5817e80d67604101ced5b51e0fac49ad3ff9ff448bccda27173d428784e25b6e7a532948363183"} 18:13:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:13:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:13:35 INFO - Contents: 18:13:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/596d57f12b68da62247f375a45e7b94504e6d3b3c3798b7f598bee064fc6ced7ee8b1a4db247a6104207c89edc6e169f8a0ff774084d9eb3caaa7e66ffb05f1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c4c43da8ce105daa02309a4102d5f2057a0bcedc864b31dbc97ea63fb5620ea4a68d4db78b9a89751a9963c41fd34d621deb7a4a13ca32132306b4e9c5ef1bc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45949757c18f085a6b2f2074544fa88fd1cfe177d1e85f9dfe5817e80d67604101ced5b51e0fac49ad3ff9ff448bccda27173d428784e25b6e7a532948363183"} 18:13:35 INFO - Running post-run listener: copy_logs_to_upload_dir 18:13:35 INFO - Copying logs to upload dir... 18:13:35 INFO - mkdir: /builds/slave/test/build/upload/logs 18:13:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.134352 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-01 18:13:35.701589) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 18:13:35.704794) ========= 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.RmCFujgd4V/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.DW5FzU2QHz/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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/596d57f12b68da62247f375a45e7b94504e6d3b3c3798b7f598bee064fc6ced7ee8b1a4db247a6104207c89edc6e169f8a0ff774084d9eb3caaa7e66ffb05f1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c4c43da8ce105daa02309a4102d5f2057a0bcedc864b31dbc97ea63fb5620ea4a68d4db78b9a89751a9963c41fd34d621deb7a4a13ca32132306b4e9c5ef1bc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45949757c18f085a6b2f2074544fa88fd1cfe177d1e85f9dfe5817e80d67604101ced5b51e0fac49ad3ff9ff448bccda27173d428784e25b6e7a532948363183"} build_url:https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/cMoNR4FRRxuTK38rt9dYiA/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/596d57f12b68da62247f375a45e7b94504e6d3b3c3798b7f598bee064fc6ced7ee8b1a4db247a6104207c89edc6e169f8a0ff774084d9eb3caaa7e66ffb05f1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c4c43da8ce105daa02309a4102d5f2057a0bcedc864b31dbc97ea63fb5620ea4a68d4db78b9a89751a9963c41fd34d621deb7a4a13ca32132306b4e9c5ef1bc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45949757c18f085a6b2f2074544fa88fd1cfe177d1e85f9dfe5817e80d67604101ced5b51e0fac49ad3ff9ff448bccda27173d428784e25b6e7a532948363183"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 18:13:35.739639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 18:13:35.739985) ========= 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.RmCFujgd4V/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.DW5FzU2QHz/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005098 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 18:13:35.789446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 18:13:35.789763) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 18:13:35.790086) ========= ========= Total master_lag: 3.09 =========