builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0252 starttime: 1476159923.76 results: success (0) buildid: 20161010190946 builduid: 6b884abb428d45748c94413fac20b7c9 revision: ece56e142a1e6d6d94ba55d67ae6f24ba6185d3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:23.759740) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:23.760427) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:23.760873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:23.786900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:23.787279) ========= 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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-10 21:25:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.4M=0.001s 2016-10-10 21:25:23 (21.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084254 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:23.893887) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:23.894262) ========= 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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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.026355 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:23.942940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 21:25:23.943315) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ece56e142a1e6d6d94ba55d67ae6f24ba6185d3b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ece56e142a1e6d6d94ba55d67ae6f24ba6185d3b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-10 21:25:24,026 truncating revision to first 12 chars 2016-10-10 21:25:24,026 Setting DEBUG logging. 2016-10-10 21:25:24,026 attempt 1/10 2016-10-10 21:25:24,026 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ece56e142a1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 21:25:25,225 unpacking tar archive at: mozilla-central-ece56e142a1e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.469430 ========= master_lag: 0.49 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 21:25:25.900595) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:25.900962) ========= script_repo_revision: ece56e142a1e6d6d94ba55d67ae6f24ba6185d3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:25.901365) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:25.901625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 21:25:25.923882) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-10 21:25:25.924512) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 21:25:26 INFO - MultiFileLogger online at 20161010 21:25:26 in /builds/slave/test 21:25:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:25:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:25:26 INFO - {'append_to_log': False, 21:25:26 INFO - 'base_work_dir': '/builds/slave/test', 21:25:26 INFO - 'blob_upload_branch': 'Firefox', 21:25:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:25:26 INFO - 'branch': 'Firefox', 21:25:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:25:26 INFO - 'config_files': ('talos/mac_config.py',), 21:25:26 INFO - 'default_actions': ('clobber', 21:25:26 INFO - 'read-buildbot-config', 21:25:26 INFO - 'download-and-extract', 21:25:26 INFO - 'populate-webroot', 21:25:26 INFO - 'create-virtualenv', 21:25:26 INFO - 'install', 21:25:26 INFO - 'run-tests'), 21:25:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:25:26 INFO - 'download_minidump_stackwalk': True, 21:25:26 INFO - 'download_symbols': 'ondemand', 21:25:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:25:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:25:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:25:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:25:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:25:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:25:26 INFO - 'installer_path': 'installer.exe', 21:25:26 INFO - 'log_level': 'info', 21:25:26 INFO - 'log_name': 'talos', 21:25:26 INFO - 'log_to_console': True, 21:25:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:25:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:25:26 INFO - 'opt_config_files': (), 21:25:26 INFO - 'pip_index': False, 21:25:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:25:26 INFO - 'cmd': ('bash', 21:25:26 INFO - '-c', 21:25:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:25:26 INFO - 'enabled': True, 21:25:26 INFO - 'halt_on_failure': False, 21:25:26 INFO - 'name': 'check_screen_resolution'},), 21:25:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:25:26 INFO - 'cmd': ('bash', 21:25:26 INFO - '-c', 21:25:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:25:26 INFO - 'enabled': True, 21:25:26 INFO - 'halt_on_failure': False, 21:25:26 INFO - 'name': 'check_screen_resolution'},), 21:25:26 INFO - 'run_cmd_checks_enabled': True, 21:25:26 INFO - 'sps_profile': False, 21:25:26 INFO - 'sps_profile_interval': 0, 21:25:26 INFO - 'suite': 'dromaeojs', 21:25:26 INFO - 'system_bits': '32', 21:25:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:25:26 INFO - 'title': 't-yosemite-r7-0252', 21:25:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:25:26 INFO - 'use_talos_json': True, 21:25:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:25:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:25:26 INFO - 'work_dir': 'build'} 21:25:26 INFO - [mozharness: 2016-10-11 04:25:26.125964Z] Running clobber step. 21:25:26 INFO - Running pre-action listener: _resource_record_pre_action 21:25:26 INFO - Running main action method: clobber 21:25:26 INFO - rmtree: /builds/slave/test/build 21:25:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:25:28 INFO - Running post-action listener: _resource_record_post_action 21:25:28 INFO - [mozharness: 2016-10-11 04:25:28.189949Z] Finished clobber step (success) 21:25:28 INFO - [mozharness: 2016-10-11 04:25:28.190116Z] Running read-buildbot-config step. 21:25:28 INFO - Running pre-action listener: _resource_record_pre_action 21:25:28 INFO - Running main action method: read_buildbot_config 21:25:28 INFO - Using buildbot properties: 21:25:28 INFO - { 21:25:28 INFO - "project": "", 21:25:28 INFO - "product": "firefox", 21:25:28 INFO - "script_repo_revision": "production", 21:25:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:25:28 INFO - "repository": "", 21:25:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:25:28 INFO - "buildid": "20161010190946", 21:25:28 INFO - "pgo_build": "False", 21:25:28 INFO - "basedir": "/builds/slave/test", 21:25:28 INFO - "buildnumber": 0, 21:25:28 INFO - "slavename": "t-yosemite-r7-0252", 21:25:28 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 21:25:28 INFO - "platform": "yosemite_r7", 21:25:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:25:28 INFO - "branch": "mozilla-central", 21:25:28 INFO - "repo_path": "mozilla-central", 21:25:28 INFO - "revision": "ece56e142a1e6d6d94ba55d67ae6f24ba6185d3b", 21:25:28 INFO - "stage_platform": "macosx64", 21:25:28 INFO - "builduid": "6b884abb428d45748c94413fac20b7c9", 21:25:28 INFO - "slavebuilddir": "test" 21:25:28 INFO - } 21:25:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 21:25:28 INFO - Running post-action listener: _resource_record_post_action 21:25:28 INFO - [mozharness: 2016-10-11 04:25:28.193567Z] Finished read-buildbot-config step (success) 21:25:28 INFO - [mozharness: 2016-10-11 04:25:28.193687Z] Running download-and-extract step. 21:25:28 INFO - Running pre-action listener: _resource_record_pre_action 21:25:28 INFO - Running main action method: download_and_extract 21:25:28 INFO - mkdir: /builds/slave/test/build/tests 21:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:28 INFO - trying https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 21:25:28 INFO - Downloading https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:25:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 21:25:29 INFO - Downloaded 1199 bytes. 21:25:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:25:29 INFO - Using the following test package requirements: 21:25:29 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:25:29 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:25:29 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 21:25:29 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:25:29 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 21:25:29 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:25:29 INFO - u'jsshell-mac.zip'], 21:25:29 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:25:29 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 21:25:29 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:25:29 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:25:29 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 21:25:29 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:25:29 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 21:25:29 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:25:29 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 21:25:29 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:25:29 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 21:25:29 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:25:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:25:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:25:29 INFO - Fetch https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:25:29 INFO - Http code: 200 21:25:29 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 21:25:29 INFO - x-amz-cf-id: n1p_hNgB3dLN_iiGQ7QSU2fz-Yc0yFldCGGsKp7rtkJkHFBOfotuYw== 21:25:29 INFO - x-amz-version-id: v1Sry89zwOFJSoBTkXNb.Cb5h6npTJrZ 21:25:30 INFO - Expected file size: 16508392 21:25:30 INFO - Obtained file size: 16508392 21:25:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:25:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:25:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:25:36 INFO - Fetch https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:25:37 INFO - Http code: 200 21:25:37 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 21:25:37 INFO - x-amz-cf-id: ahv612cYsMROaSrl4a7s0F3_boDkTb3wb-XLkaRw49JRHb08-LrQCA== 21:25:37 INFO - x-amz-version-id: v1Sry89zwOFJSoBTkXNb.Cb5h6npTJrZ 21:25:37 INFO - Expected file size: 16508392 21:25:37 INFO - Obtained file size: 16508392 21:25:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 21:25:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:25:43 INFO - Fetch https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 21:25:44 INFO - Http code: 200 21:25:44 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 21:25:44 INFO - x-amz-cf-id: F66cery6WpRtK-Bp_ReVPuhXEwInfYB4rx5kXCiFeghi0Ls0owr1rw== 21:25:44 INFO - x-amz-version-id: CdSoqrnYny3k_apvNmMK73LjJrz0UpX0 21:25:44 INFO - Expected file size: 14409006 21:25:44 INFO - Obtained file size: 14409006 21:25:45 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')]} 21:25:45 INFO - trying https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:25:45 INFO - Downloading https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 21:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 21:25:48 INFO - Downloaded 111703178 bytes. 21:25:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:25:48 INFO - mkdir: /builds/slave/test/properties 21:25:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:25:48 INFO - Writing to file /builds/slave/test/properties/build_url 21:25:48 INFO - Contents: 21:25:48 INFO - build_url:https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:25:49 INFO - Running post-action listener: _resource_record_post_action 21:25:49 INFO - Running post-action listener: set_extra_try_arguments 21:25:49 INFO - [mozharness: 2016-10-11 04:25:49.599003Z] Finished download-and-extract step (success) 21:25:49 INFO - [mozharness: 2016-10-11 04:25:49.599120Z] Running populate-webroot step. 21:25:49 INFO - Running pre-action listener: _resource_record_pre_action 21:25:49 INFO - Running main action method: populate_webroot 21:25:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:25:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:25:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:25:49 INFO - '--tppagecycles', 21:25:49 INFO - '7'], 21:25:49 INFO - 'tests': ['tsvgm']}}, 21:25:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:25:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:25:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:25:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:25:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:25:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:25:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:49 INFO - 'talos_options': ['--disable-e10s'], 21:25:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:25:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:25:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:49 INFO - 'talos_options': ['--disable-e10s'], 21:25:49 INFO - 'tests': ['damp', 'tps']}, 21:25:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:49 INFO - 'tests': ['damp', 'tps']}, 21:25:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:25:49 INFO - 'tests': ['dromaeo_dom']}, 21:25:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:25:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:25:49 INFO - 'tests': ['basic_compositor_video']}, 21:25:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:25:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:25:49 INFO - 'tests': ['a11yr', 21:25:49 INFO - 'ts_paint', 21:25:49 INFO - 'tpaint', 21:25:49 INFO - 'sessionrestore', 21:25:49 INFO - 'sessionrestore_no_auto_restore', 21:25:49 INFO - 'tabpaint']}, 21:25:49 INFO - 'other-e10s': {'tests': ['a11yr', 21:25:49 INFO - 'ts_paint', 21:25:49 INFO - 'tpaint', 21:25:49 INFO - 'sessionrestore', 21:25:49 INFO - 'sessionrestore_no_auto_restore', 21:25:49 INFO - 'tabpaint']}, 21:25:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:25:49 INFO - 'ts_paint', 21:25:49 INFO - 'tpaint', 21:25:49 INFO - 'sessionrestore', 21:25:49 INFO - 'sessionrestore_no_auto_restore', 21:25:49 INFO - 'tabpaint']}, 21:25:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:25:49 INFO - 'ts_paint', 21:25:49 INFO - 'tpaint', 21:25:49 INFO - 'sessionrestore', 21:25:49 INFO - 'sessionrestore_no_auto_restore', 21:25:49 INFO - 'tabpaint']}, 21:25:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:25:49 INFO - 'tests': ['a11yr', 21:25:49 INFO - 'ts_paint', 21:25:49 INFO - 'tpaint', 21:25:49 INFO - 'sessionrestore', 21:25:49 INFO - 'sessionrestore_no_auto_restore', 21:25:49 INFO - 'tabpaint']}, 21:25:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:25:49 INFO - 'tests': ['a11yr', 21:25:49 INFO - 'ts_paint', 21:25:49 INFO - 'tpaint', 21:25:49 INFO - 'sessionrestore', 21:25:49 INFO - 'sessionrestore_no_auto_restore', 21:25:49 INFO - 'tabpaint']}, 21:25:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:25:49 INFO - 'tests': ['tsvgx', 21:25:49 INFO - 'tsvgr_opacity', 21:25:49 INFO - 'tart', 21:25:49 INFO - 'tscrollx', 21:25:49 INFO - 'cart']}, 21:25:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:25:49 INFO - 'tsvgr_opacity', 21:25:49 INFO - 'tart', 21:25:49 INFO - 'tscrollx', 21:25:49 INFO - 'cart']}, 21:25:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:49 INFO - 'talos_options': ['--disable-e10s'], 21:25:49 INFO - 'tests': ['tp5o']}, 21:25:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:49 INFO - 'tests': ['tp5o']}, 21:25:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:49 INFO - 'talos_options': ['--disable-e10s', 21:25:49 INFO - '--xperf_path', 21:25:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:25:49 INFO - 'tests': ['tp5n']}, 21:25:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:49 INFO - 'talos_options': ['--xperf_path', 21:25:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:25:49 INFO - 'tests': ['tp5n']}}, 21:25:49 INFO - 'talos.zip': {'path': '', 21:25:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:25:49 INFO - Running post-action listener: _resource_record_post_action 21:25:49 INFO - [mozharness: 2016-10-11 04:25:49.617990Z] Finished populate-webroot step (success) 21:25:49 INFO - [mozharness: 2016-10-11 04:25:49.618113Z] Running create-virtualenv step. 21:25:49 INFO - Running pre-action listener: _resource_record_pre_action 21:25:49 INFO - Running main action method: create_virtualenv 21:25:49 INFO - Creating virtualenv /builds/slave/test/build/venv 21:25:49 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 21:25:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:25:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:25:49 INFO - Using real prefix '/tools/python27' 21:25:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:25:50 INFO - Installing distribute.............................................................................................................................................................................................done. 21:25:53 INFO - Installing pip.................done. 21:25:53 INFO - Return code: 0 21:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:25:53 INFO - Reading from file tmpfile_stdout 21:25:53 INFO - Output received: 21:25:53 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) 21:25:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:25: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')]} 21:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25: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')]} 21:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10421a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104190570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faff24929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10402ed30>, '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 0x103e54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104026b20>, '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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 21:25:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:25:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C9cafC2Sxw/Render', 21:25:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:25:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:25:53 INFO - 'HOME': '/Users/cltbld', 21:25:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:25:53 INFO - 'LOGNAME': 'cltbld', 21:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:53 INFO - 'MOZ_NO_REMOTE': '1', 21:25:53 INFO - 'NO_EM_RESTART': '1', 21:25:53 INFO - 'PAGER': '/bin/cat', 21:25:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:53 INFO - 'PWD': '/builds/slave/test', 21:25:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:25:53 INFO - 'SHELL': '/bin/bash', 21:25:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xjmP8DzxnQ/Listeners', 21:25:53 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 21:25:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:25:53 INFO - 'USER': 'cltbld', 21:25:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:25:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:53 INFO - 'XPC_FLAGS': '0x0', 21:25:53 INFO - 'XPC_SERVICE_NAME': '0', 21:25:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:53 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 21:25:53 INFO - Cleaning up... 21:25:53 INFO - Return code: 0 21:25:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:25: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')]} 21:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25: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')]} 21:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10421a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104190570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faff24929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10402ed30>, '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 0x103e54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104026b20>, '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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 21:25:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:25:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C9cafC2Sxw/Render', 21:25:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:25:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:25:53 INFO - 'HOME': '/Users/cltbld', 21:25:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:25:53 INFO - 'LOGNAME': 'cltbld', 21:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:53 INFO - 'MOZ_NO_REMOTE': '1', 21:25:53 INFO - 'NO_EM_RESTART': '1', 21:25:53 INFO - 'PAGER': '/bin/cat', 21:25:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:53 INFO - 'PWD': '/builds/slave/test', 21:25:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:25:53 INFO - 'SHELL': '/bin/bash', 21:25:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xjmP8DzxnQ/Listeners', 21:25:53 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 21:25:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:25:53 INFO - 'USER': 'cltbld', 21:25:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:25:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:53 INFO - 'XPC_FLAGS': '0x0', 21:25:53 INFO - 'XPC_SERVICE_NAME': '0', 21:25:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:54 INFO - Downloading/unpacking psutil>=3.1.1 21:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:25:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:25:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:25:57 INFO - Installing collected packages: psutil 21:25:57 INFO - Running setup.py install for psutil 21:25:57 INFO - building 'psutil._psutil_osx' extension 21:25:57 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 21:25:58 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 21:25:58 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 21:25:58 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 21:25:58 INFO - building 'psutil._psutil_posix' extension 21:25:58 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 21:25:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:25:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:25:58 INFO - ^ 21:25:58 INFO - 1 warning generated. 21:25:58 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 21:25:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:25:58 INFO - Successfully installed psutil 21:25:58 INFO - Cleaning up... 21:25:58 INFO - Return code: 0 21:25:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:25:58 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')]} 21:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:58 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')]} 21:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:58 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 0x10421a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104190570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faff24929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10402ed30>, '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 0x103e54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104026b20>, '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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 21:25:58 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 21:25:58 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 21:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C9cafC2Sxw/Render', 21:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:25:58 INFO - 'HOME': '/Users/cltbld', 21:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:25:58 INFO - 'LOGNAME': 'cltbld', 21:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:58 INFO - 'MOZ_NO_REMOTE': '1', 21:25:58 INFO - 'NO_EM_RESTART': '1', 21:25:58 INFO - 'PAGER': '/bin/cat', 21:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:58 INFO - 'PWD': '/builds/slave/test', 21:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:25:58 INFO - 'SHELL': '/bin/bash', 21:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xjmP8DzxnQ/Listeners', 21:25:58 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 21:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:25:58 INFO - 'USER': 'cltbld', 21:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:58 INFO - 'XPC_FLAGS': '0x0', 21:25:58 INFO - 'XPC_SERVICE_NAME': '0', 21:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:25:59 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 21:25:59 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 21:25:59 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 21:25:59 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 21:25:59 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 21:25:59 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 21:26:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:26:01 INFO - Installing collected packages: mozsystemmonitor 21:26:01 INFO - Running setup.py install for mozsystemmonitor 21:26:01 INFO - Successfully installed mozsystemmonitor 21:26:01 INFO - Cleaning up... 21:26:02 INFO - Return code: 0 21:26:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:26:02 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')]} 21:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:02 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')]} 21:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:02 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 0x10421a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104190570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faff24929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10402ed30>, '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 0x103e54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104026b20>, '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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 21:26:02 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 21:26:02 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 21:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C9cafC2Sxw/Render', 21:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:26:02 INFO - 'HOME': '/Users/cltbld', 21:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:26:02 INFO - 'LOGNAME': 'cltbld', 21:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:02 INFO - 'MOZ_NO_REMOTE': '1', 21:26:02 INFO - 'NO_EM_RESTART': '1', 21:26:02 INFO - 'PAGER': '/bin/cat', 21:26:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:02 INFO - 'PWD': '/builds/slave/test', 21:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:26:02 INFO - 'SHELL': '/bin/bash', 21:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xjmP8DzxnQ/Listeners', 21:26:02 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 21:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:26:02 INFO - 'USER': 'cltbld', 21:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:02 INFO - 'XPC_FLAGS': '0x0', 21:26:02 INFO - 'XPC_SERVICE_NAME': '0', 21:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:02 INFO - Downloading/unpacking jsonschema==2.5.1 21:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:26:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:05 INFO - Downloading functools32-3.2.3-2.tar.gz 21:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:26:05 INFO - warning: no files found matching '*.txt' 21:26:05 INFO - no previously-included directories found matching 'build' 21:26:05 INFO - no previously-included directories found matching 'dist' 21:26:05 INFO - no previously-included directories found matching '.git*' 21:26:05 INFO - Installing collected packages: jsonschema, functools32 21:26:05 INFO - Running setup.py install for functools32 21:26:05 INFO - warning: no files found matching '*.txt' 21:26:05 INFO - no previously-included directories found matching 'build' 21:26:05 INFO - no previously-included directories found matching 'dist' 21:26:05 INFO - no previously-included directories found matching '.git*' 21:26:05 INFO - Successfully installed jsonschema functools32 21:26:05 INFO - Cleaning up... 21:26:05 INFO - Return code: 0 21:26:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:05 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 0x10421a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104190570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faff24929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10402ed30>, '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 0x103e54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104026b20>, '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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 21:26:05 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 21:26:05 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 21:26:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C9cafC2Sxw/Render', 21:26:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:26:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:26:05 INFO - 'HOME': '/Users/cltbld', 21:26:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:26:05 INFO - 'LOGNAME': 'cltbld', 21:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:05 INFO - 'MOZ_NO_REMOTE': '1', 21:26:05 INFO - 'NO_EM_RESTART': '1', 21:26:05 INFO - 'PAGER': '/bin/cat', 21:26:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:05 INFO - 'PWD': '/builds/slave/test', 21:26:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:26:05 INFO - 'SHELL': '/bin/bash', 21:26:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xjmP8DzxnQ/Listeners', 21:26:05 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 21:26:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:26:05 INFO - 'USER': 'cltbld', 21:26:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:26:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:05 INFO - 'XPC_FLAGS': '0x0', 21:26:05 INFO - 'XPC_SERVICE_NAME': '0', 21:26:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:26:05 INFO - Cleaning up... 21:26:05 INFO - Return code: 0 21:26:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:05 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 0x10421a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104190570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faff24929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10402ed30>, '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 0x103e54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104026b20>, '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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 21:26:05 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 21:26:05 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 21:26:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C9cafC2Sxw/Render', 21:26:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:26:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:26:05 INFO - 'HOME': '/Users/cltbld', 21:26:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:26:05 INFO - 'LOGNAME': 'cltbld', 21:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:05 INFO - 'MOZ_NO_REMOTE': '1', 21:26:05 INFO - 'NO_EM_RESTART': '1', 21:26:05 INFO - 'PAGER': '/bin/cat', 21:26:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:05 INFO - 'PWD': '/builds/slave/test', 21:26:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:26:05 INFO - 'SHELL': '/bin/bash', 21:26:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xjmP8DzxnQ/Listeners', 21:26:05 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 21:26:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:26:05 INFO - 'USER': 'cltbld', 21:26:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:26:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:05 INFO - 'XPC_FLAGS': '0x0', 21:26:05 INFO - 'XPC_SERVICE_NAME': '0', 21:26:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:06 INFO - Downloading/unpacking blobuploader==1.2.4 21:26:06 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 21:26:06 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 21:26:06 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 21:26:06 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 21:26:06 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 21:26:06 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 21:26:08 INFO - Downloading blobuploader-1.2.4.tar.gz 21:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:26:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:26: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 21:26: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 21:26: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 21:26: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 21:26: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 21:26: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 21:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:26:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:09 INFO - Downloading docopt-0.6.1.tar.gz 21:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:26:09 INFO - Installing collected packages: blobuploader, requests, docopt 21:26:09 INFO - Running setup.py install for blobuploader 21:26:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:26:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:26:10 INFO - Running setup.py install for requests 21:26:10 INFO - Running setup.py install for docopt 21:26:10 INFO - Successfully installed blobuploader requests docopt 21:26:10 INFO - Cleaning up... 21:26:10 INFO - Return code: 0 21:26:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:26:10 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')]} 21:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:10 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')]} 21:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:10 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 0x10421a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104190570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faff24929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10402ed30>, '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 0x103e54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104026b20>, '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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 21:26:10 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 21:26:10 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 21:26:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C9cafC2Sxw/Render', 21:26:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:26:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:26:10 INFO - 'HOME': '/Users/cltbld', 21:26:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:26:10 INFO - 'LOGNAME': 'cltbld', 21:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:10 INFO - 'MOZ_NO_REMOTE': '1', 21:26:10 INFO - 'NO_EM_RESTART': '1', 21:26:10 INFO - 'PAGER': '/bin/cat', 21:26:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:10 INFO - 'PWD': '/builds/slave/test', 21:26:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:26:10 INFO - 'SHELL': '/bin/bash', 21:26:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xjmP8DzxnQ/Listeners', 21:26:10 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 21:26:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:26:10 INFO - 'USER': 'cltbld', 21:26:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:26:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:10 INFO - 'XPC_FLAGS': '0x0', 21:26:10 INFO - 'XPC_SERVICE_NAME': '0', 21:26:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:26:11 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-zGEmHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:26:11 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-ZeLiaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:26:11 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-8zKLlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:26:11 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-pHKJbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:26:11 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-d07xi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:26:11 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-lzHpct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:26:11 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-tFehUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:26:11 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-XzVagY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:26:11 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-lG3o6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:26:11 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-CCahg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:26:12 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-ZCydJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:26:12 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-OhJSzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:26:12 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-HqaONK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:26:12 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-qwP953-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:12 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-JflMSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:26:12 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-ouMMoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:26:12 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-qA3LA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:26:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:26:12 INFO - Running setup.py install for manifestparser 21:26:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:26:12 INFO - Running setup.py install for mozcrash 21:26:13 INFO - Running setup.py install for mozdebug 21:26:13 INFO - Running setup.py install for mozdevice 21:26:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:26:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:26:13 INFO - Running setup.py install for mozfile 21:26:13 INFO - Running setup.py install for mozhttpd 21:26:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:26:13 INFO - Running setup.py install for mozinfo 21:26:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:26:13 INFO - Running setup.py install for mozInstall 21:26:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:26:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:26:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:26:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:26:13 INFO - Running setup.py install for mozleak 21:26:14 INFO - Running setup.py install for mozlog 21:26:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:26:14 INFO - Running setup.py install for moznetwork 21:26:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:26:14 INFO - Running setup.py install for mozprocess 21:26:14 INFO - Running setup.py install for mozprofile 21:26:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:26:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:26:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:26:14 INFO - Running setup.py install for mozrunner 21:26:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:26:14 INFO - Running setup.py install for mozscreenshot 21:26:15 INFO - Running setup.py install for moztest 21:26:15 INFO - Running setup.py install for mozversion 21:26:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:26:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:26:15 INFO - Cleaning up... 21:26:15 INFO - Return code: 0 21:26:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:26: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')]} 21:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26: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')]} 21:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:15 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 0x10421a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104190570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faff24929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10402ed30>, '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 0x103e54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104026b20>, '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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 21:26:15 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 21:26:15 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 21:26:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C9cafC2Sxw/Render', 21:26:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:26:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:26:15 INFO - 'HOME': '/Users/cltbld', 21:26:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:26:15 INFO - 'LOGNAME': 'cltbld', 21:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:15 INFO - 'MOZ_NO_REMOTE': '1', 21:26:15 INFO - 'NO_EM_RESTART': '1', 21:26:15 INFO - 'PAGER': '/bin/cat', 21:26:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:15 INFO - 'PWD': '/builds/slave/test', 21:26:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:26:15 INFO - 'SHELL': '/bin/bash', 21:26:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xjmP8DzxnQ/Listeners', 21:26:15 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 21:26:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:26:15 INFO - 'USER': 'cltbld', 21:26:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:26:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:15 INFO - 'XPC_FLAGS': '0x0', 21:26:15 INFO - 'XPC_SERVICE_NAME': '0', 21:26:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:26:15 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-8sJnuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:26:15 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)) 21:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:26:15 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-BPk5Lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:26:15 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-fMBqd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:26:16 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)) 21:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:26:16 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-xhBegn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:26:16 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)) 21:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:26:16 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-1PTB9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:26:16 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)) 21:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:26:16 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-mEEv4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:26:16 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)) 21:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:26:16 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-S4CdMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:26:16 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)) 21:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:26:16 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-xEiTTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:26:16 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)) 21:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:26:16 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-cbHVAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:26:16 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)) 21:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:26:16 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-U22iqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:26:16 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)) 21:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:26:16 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-f3txAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:26:16 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)) 21:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:26:16 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-ceGolD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:26:16 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)) 21:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:26:16 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-t32dY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:26:17 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)) 21:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:26:17 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-Fg_vNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:17 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-nn8zDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:17 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)) 21:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:26:17 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-sakoU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:26:17 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-s5sksj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:26:17 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)) 21:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:26:17 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)) 21:26:17 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)) 21:26:17 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)) 21:26:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:20 INFO - Downloading blessings-1.6.tar.gz 21:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:26:20 INFO - Installing collected packages: blessings 21:26:20 INFO - Running setup.py install for blessings 21:26:20 INFO - Successfully installed blessings 21:26:20 INFO - Cleaning up... 21:26:20 INFO - Return code: 0 21:26:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:26:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:26:20 INFO - Reading from file tmpfile_stdout 21:26:20 INFO - Current package versions: 21:26:20 INFO - blessings == 1.6 21:26:20 INFO - blobuploader == 1.2.4 21:26:20 INFO - docopt == 0.6.1 21:26:20 INFO - functools32 == 3.2.3-2 21:26:20 INFO - jsonschema == 2.5.1 21:26:20 INFO - manifestparser == 1.1 21:26:20 INFO - mozInstall == 1.12 21:26:20 INFO - mozcrash == 0.17 21:26:20 INFO - mozdebug == 0.1 21:26:20 INFO - mozdevice == 0.48 21:26:20 INFO - mozfile == 1.2 21:26:20 INFO - mozhttpd == 0.7 21:26:20 INFO - mozinfo == 0.9 21:26:20 INFO - mozleak == 0.1 21:26:20 INFO - mozlog == 3.4 21:26:20 INFO - moznetwork == 0.27 21:26:20 INFO - mozprocess == 0.23 21:26:20 INFO - mozprofile == 0.28 21:26:20 INFO - mozrunner == 6.12 21:26:20 INFO - mozscreenshot == 0.1 21:26:20 INFO - mozsystemmonitor == 0.3 21:26:20 INFO - moztest == 0.7 21:26:20 INFO - mozversion == 1.4 21:26:20 INFO - psutil == 3.1.1 21:26:20 INFO - requests == 1.2.3 21:26:20 INFO - wsgiref == 0.1.2 21:26:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:26: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')]} 21:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:21 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')]} 21:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:21 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 0x10421a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104190570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faff24929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10402ed30>, '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 0x103e54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104026b20>, '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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 21:26:21 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 21:26:21 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 21:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C9cafC2Sxw/Render', 21:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:26:21 INFO - 'HOME': '/Users/cltbld', 21:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:26:21 INFO - 'LOGNAME': 'cltbld', 21:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:21 INFO - 'MOZ_NO_REMOTE': '1', 21:26:21 INFO - 'NO_EM_RESTART': '1', 21:26:21 INFO - 'PAGER': '/bin/cat', 21:26:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:21 INFO - 'PWD': '/builds/slave/test', 21:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:26:21 INFO - 'SHELL': '/bin/bash', 21:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xjmP8DzxnQ/Listeners', 21:26:21 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 21:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:26:21 INFO - 'USER': 'cltbld', 21:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:21 INFO - 'XPC_FLAGS': '0x0', 21:26:21 INFO - 'XPC_SERVICE_NAME': '0', 21:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:21 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)) 21:26:21 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)) 21:26:21 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)) 21:26:21 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)) 21:26:21 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)) 21:26:21 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)) 21:26:21 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)) 21:26:21 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)) 21:26:21 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)) 21:26:21 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)) 21:26:21 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)) 21:26:21 INFO - Cleaning up... 21:26:21 INFO - Return code: 0 21:26:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:26:21 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')]} 21:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:21 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')]} 21:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10421a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104190570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faff24929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10402ed30>, '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 0x103e54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104026b20>, '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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 21:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:26:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C9cafC2Sxw/Render', 21:26:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:26:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:26:22 INFO - 'HOME': '/Users/cltbld', 21:26:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:26:22 INFO - 'LOGNAME': 'cltbld', 21:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:22 INFO - 'MOZ_NO_REMOTE': '1', 21:26:22 INFO - 'NO_EM_RESTART': '1', 21:26:22 INFO - 'PAGER': '/bin/cat', 21:26:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:22 INFO - 'PWD': '/builds/slave/test', 21:26:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:26:22 INFO - 'SHELL': '/bin/bash', 21:26:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xjmP8DzxnQ/Listeners', 21:26:22 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 21:26:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:26:22 INFO - 'USER': 'cltbld', 21:26:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:26:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:22 INFO - 'XPC_FLAGS': '0x0', 21:26:22 INFO - 'XPC_SERVICE_NAME': '0', 21:26:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:26:22 INFO - Cleaning up... 21:26:22 INFO - Return code: 0 21:26:22 INFO - Running post-action listener: _resource_record_post_action 21:26:22 INFO - Running post-action listener: _start_resource_monitoring 21:26:22 INFO - Starting resource monitoring. 21:26:22 INFO - [mozharness: 2016-10-11 04:26:22.430467Z] Finished create-virtualenv step (success) 21:26:22 INFO - [mozharness: 2016-10-11 04:26:22.431546Z] Running install step. 21:26:22 INFO - Running pre-action listener: _resource_record_pre_action 21:26:22 INFO - Running main action method: install 21:26:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:26:22 INFO - Reading from file tmpfile_stdout 21:26:22 INFO - Detecting whether we're running mozinstall >=1.0... 21:26:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:26:22 INFO - Reading from file tmpfile_stdout 21:26:22 INFO - Output received: 21:26:22 INFO - Usage: mozinstall [options] installer 21:26:22 INFO - Options: 21:26:22 INFO - -h, --help show this help message and exit 21:26:22 INFO - -d DEST, --destination=DEST 21:26:22 INFO - Directory to install application into. [default: 21:26:22 INFO - "/builds/slave/test"] 21:26:22 INFO - --app=APP Application being installed. [default: firefox] 21:26:22 INFO - mkdir: /builds/slave/test/build/application 21:26:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:26:57 INFO - Reading from file tmpfile_stdout 21:26:57 INFO - Output received: 21:26:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:26:57 INFO - Running post-action listener: _resource_record_post_action 21:26:57 INFO - [mozharness: 2016-10-11 04:26:57.071586Z] Finished install step (success) 21:26:57 INFO - [mozharness: 2016-10-11 04:26:57.071735Z] Running run-tests step. 21:26:57 INFO - Running pre-action listener: _resource_record_pre_action 21:26:57 INFO - Running main action method: run_tests 21:26:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:26:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:26:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:26:57 INFO - 2016-10-10 21:26:57.086 screenresolution[1648:7608] starting screenresolution argv=screenresolution get 21:26:57 INFO - 2016-10-10 21:26:57.088 screenresolution[1648:7608] Display 0: 1600x1200x32@60 21:26:57 INFO - 2016-10-10 21:26:57.094 screenresolution[1649:7610] starting screenresolution argv=screenresolution list 21:26:57 INFO - Available Modes on Display 0 21:26:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:26:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:26:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:26:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:26:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:26:57 INFO - Intel Iris: 21:26:57 INFO - Chipset Model: Intel Iris 21:26:57 INFO - Type: GPU 21:26:57 INFO - Bus: Built-In 21:26:57 INFO - VRAM (Dynamic, Max): 1536 MB 21:26:57 INFO - Vendor: Intel (0x8086) 21:26:57 INFO - Device ID: 0x0a2e 21:26:57 INFO - Revision ID: 0x0009 21:26:57 INFO - Displays: 21:26:57 INFO - Display: 21:26:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:26:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:26:57 INFO - Display Serial Number: 1600x1200 60 21:26:57 INFO - Main Display: Yes 21:26:57 INFO - Mirror: Off 21:26:57 INFO - Online: Yes 21:26:57 INFO - Rotation: Supported 21:26:57 INFO - Return code: 0 21:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:26:57 INFO - Python 2.7.3 21:26:57 INFO - Return code: 0 21:26:57 INFO - grabbing minidump binary from tooltool 21:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:57 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 0x10402ed30>, '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 0x103e54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104026b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:26:57 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 21:26:57 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 21:26:57 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 21:26:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:26:57 INFO - Return code: 0 21:26:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:26:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:26:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:26:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:26:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0252', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0252 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C9cafC2Sxw/Render', 21:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:26:57 INFO - 'HOME': '/Users/cltbld', 21:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:26:57 INFO - 'LOGNAME': 'cltbld', 21:26:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:26:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:57 INFO - 'MOZ_NO_REMOTE': '1', 21:26:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:26:57 INFO - 'NO_EM_RESTART': '1', 21:26:57 INFO - 'PAGER': '/bin/cat', 21:26:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:57 INFO - 'PWD': '/builds/slave/test', 21:26:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:26:57 INFO - 'SHELL': '/bin/bash', 21:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xjmP8DzxnQ/Listeners', 21:26:57 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 21:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:26:57 INFO - 'USER': 'cltbld', 21:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:57 INFO - 'XPC_FLAGS': '0x0', 21:26:57 INFO - 'XPC_SERVICE_NAME': '0', 21:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:26:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0252', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:26:57 INFO - mozversion application_buildid: 20161010190946 21:26:57 INFO - mozversion application_changeset: ece56e142a1e6d6d94ba55d67ae6f24ba6185d3b 21:26:57 INFO - mozversion application_display_name: Nightly 21:26:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:26:57 INFO - mozversion application_name: Firefox 21:26:57 INFO - mozversion application_remotingname: firefox 21:26:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:26:57 INFO - mozversion application_vendor: Mozilla 21:26:57 INFO - mozversion application_version: 52.0a1 21:26:57 INFO - mozversion platform_buildid: 20161010190946 21:26:57 INFO - mozversion platform_changeset: ece56e142a1e6d6d94ba55d67ae6f24ba6185d3b 21:26:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:26:57 INFO - mozversion platform_version: 52.0a1 21:26:57 INFO - using testdate: 1476160017 21:26:57 INFO - actual date: 1476160017 21:26:57 INFO - starting webserver on 'localhost:49277' 21:26:57 INFO - SUITE-START | Running 2 tests 21:26:57 INFO - TEST-START | dromaeo_css 21:26:57 INFO - operating with platform_type : mac_ 21:26:57 INFO - Initialising browser for dromaeo_css test... 21:26:57 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpnKU8eq/profile http://localhost:49277/getInfo.html) 21:26:59 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 21:26:59 INFO - PROCESS | 1659 | colorDepth:24 21:26:59 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 21:26:59 INFO - PROCESS | 1659 | __metrics 21:27:00 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:27:00 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:27:00 INFO - TEST-INFO | 1659: exit 0 21:27:00 INFO - Browser initialized. 21:27:00 INFO - Running cycle 1/1 for dromaeo_css test... 21:27:00 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpnKU8eq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:27:12 INFO - PROCESS | 1661 | RSS: Main: 235220992 21:27:12 INFO - PROCESS | 1661 | 21:28:04 INFO - PROCESS | 1661 | 1476160084449 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:30:16 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 21:30:18 INFO - PROCESS | 1661 | RSS: Main: 422424576 21:30:18 INFO - PROCESS | 1661 | 21:33:21 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 21:33:22 INFO - PROCESS | 1661 | RSS: Main: 374558720 21:33:22 INFO - PROCESS | 1661 | 21:36:24 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 21:36:25 INFO - PROCESS | 1661 | RSS: Main: 366632960 21:36:25 INFO - PROCESS | 1661 | 21:39:27 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 21:39:28 INFO - PROCESS | 1661 | RSS: Main: 343777280 21:39:28 INFO - PROCESS | 1661 | 21:42:31 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 21:42:32 INFO - PROCESS | 1661 | RSS: Main: 332201984 21:42:32 INFO - PROCESS | 1661 | 21:45:35 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 21:45:36 INFO - PROCESS | 1661 | RSS: Main: 595865600 21:45:36 INFO - PROCESS | 1661 | 21:45:36 INFO - PROCESS | 1661 | __start_tp_report 21:45:36 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 21:45:36 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 21:45:36 INFO - PROCESS | 1661 | |i|pagename|runs| 21:45:36 INFO - PROCESS | 1661 | |0;dojo.html;3024.6219222597174;3342.247994201305;3360.6639336066382;3390.8643654253833;3407.182276253698;5580.804671836487;5663.490285874275;5681.091025435931;5709.628874123179;5750.683712395817;5618.606697531174;5673.063944449172;5673.659580425167;5690.2887139107615;5697.715114244292;4310.849120280791;5133.974330128344;5178.974105129488;5190.854920342056;5202.323697919265;5270.341207349082;5277;5278.419373868871;5287;5291.206319052154;5212.869678258036;5212.869678258055;5253.159494480884;5265.65773224741;5292.232626269189;5289.100852855024;5307.283516725251;5320.693526256705;5321.201819727072;5345.492178243061;5081.618878584121;5120.897582048376;5163.63854530183;5220.1647736362;5223.6343455958095;5615.494605485485;5616.241807355996;5647.29408823897;5683.431656834325;5693.231413759131;6181.96909015452;6183.350748171422;6202.565820392574;6202.81391558254;6229.6573688447115;5056.696598204119;6128.172696685935;6136.631802091889;6265.7493700251935;6292.244930608311;5712.457316554921;5752.9137062943255;5766.711664416763;5782.479576838105;5833.125031245348;6296.496280297565;6332.271788744353;6346.809595712136;6351.460125889259;6373.872522549523;5938.584299099021;6042.637441753509;6113;6130.01919692847;6133.1413602095745;6133.579501509479;6148.754049838046;6166.784162554289;6197.070439434031;6234.470070044097;6140.293866205444;6163.445289923929;6172.166757487771;6179.949408600549;6193.473554747897;6167.198264225622;6202.503799696014;6206.627602343874;6211.503079753609;6228.4705800007505;4734.479207287196;4859.1010663027455;4868.172410690191;4868.659193856467;4916.459189489154;4398.73607583546;4405.31717583775;4421.579949904753;4440.111977604427;4479.372887795711;5694.231278777394;5731.942680573225;5739.483446489836;5751.9424805751405;5764;6100.969495152496;6113.816585502442;6147.770445910835;6245.937540624626;6261.186045814015;4908.699194713404;5652.18043383707;5701.429857014348;5710.229119068956;5713.171590119493;5329.413764485904;5336.839894803162;5348.277982472394;5358.27663265462;5362.51737343641;6322.747090116344;6361.268454127742;6372.968135159294;6382.8723425531225;6392.616443013434;6155.384461553809;6161.260648722182;6224.844378890564;6245.28179259391;6280.623162610258;6310.463610592968;6316.305206427198;6325.240971083499;6326.746930122744;6332.52506062038;6122.2959359674205;6142.692865356804;6149.508039356751;6151;6172.845678858064;6099.603525770811;6107.249501910372;6113.689152827286;6142.232220972379;6232.781852635136;5982.1325907744;5991.460768530853;6006.249218847644;6018.608790428608;6061.575689701678;5740.311162660508;5982.7307771149535;5988.910166347596;5992.790252341321;5996.8800623988145;5714.114312281603;5777.971110144423;5790.855228619318;5809.24479817621;5828.184054232495;5003.54968052877;5938.703064846654;5962.522998160223;5992.490638295793;6019.247594050744;5857.502112320501;5864.706764661835;5874.765009399747;5905.645661260338;5908.202392677105 21:45:36 INFO - PROCESS | 1661 | |1;ext.html;466.6616702890405;481.94939531349206;512.5950499105704;514.0002694758695;550.1692444408947;24500.87749561252;33340.66659333412;39428.01429964252;40323.39514907275;43272;41970.37044444336;42342.78828605852;42448;42458.575414245846;42492;9687.128158465737;9870.111689947904;9876.111149996499;9883.456409897453;9888.11007009369;8746.956265218696;8996.730098097067;11953.820692689616;12236.26582405054;12265.938670306636;12145.574904878331;12212.69468263296;12220.69448263796;12227.63317100484;12230.348902898128;12157.270563766202;12227.327496987662;12236.082293827998;12252.571160009356;12265.202761820454;8688.47869127848;8912.8663070054;11597.4201289936;11984.161108722394;11998.400079995965;40803.38794918079;40945.181096378205;40976;41027;41103.588964110575;3223.8065716057113;3258.071449636866;3422.5550678411646;3691.8154092295276;3936.15372694872;30250.69749302523;30487.542686859713;30718.84640576805;30959.690403095905;31342;2782.916512504628;3124.5938028056207;3132.216945763559;3213.5822343095483;3219.8551065201887;471509;473897;475476;476610.6169469165;477303;48337.75831120892;57212;57776.71111644415;57804.71097644569;57931.42068579345;60079;60114;60125.39874601198;60164.69917650384;60165.09752353718;15497.45758898433;15875.285612147482;15891.602709932344;15913.204339782964;15923.52229433119;11231.438428078563;12457.1902826316;12513.562025329253;12515.937420312841;12522.749545009048;13534.526291579747;13848.515301964382;15226.162561059027;15462.226888655523;15542.689146217012;6878.449724022066;6931.6483285759805;6994.860102797916;7015.824604384829;7088.432925365958;866.6836604639261;909.9454032758056;955.8040601676639;960.3757557587624;989.4113002763344;27333.45333093327;27545.509994594882;28187;28918.698658560414;29016.41967160645;1002.9749256268651;1039.2413538117216;1049.2550289294534;1100.7908497385472;1199.580146948561;11561.959423651911;14814.703705925822;15015.474458393905;15162.469313573973;15464.458743943907;552729;555624;555865;556458.095866579;559397;54340.45659543354;54445.91108177814;54480.45519544833;54513.90972180534;54561.72719136458;1212.3150420012664;1222.3093951917317;1250.6748245456065;1304.2370213425252;1329.9933500332436;28179.71820281771;29939.55090673685;29954.700452995192;30561.23596910095;30737.231569210948;46325;46689.996500525194;46785;46873.53126468691;47054;523629.67296144454;524158;525808;525942;526000;25033.249002529952;25748.485030299664;25767.484650306513;25902.352441188366;25930.740692593587;43653.97676851376;43820.78089609532;43907.12185756203;44254.89362765956;44368.778156109016;29911.102666920026;36863.81568092143;36944.63055369412;37226.81386593158;38656.42015369828;36624.45063323999;37081.62918370782;37728;37860.21397860192;38260.617393825705;35918.640813591526;36207.63792362148;36782;36811.63188368189;37214;26579.867100665146;28386.43227135487;30485.932992345162;32884.50673239951;33348.66651333456;22861.771382285966;22925.541489170457;24378.390540236636;25025.624615631143;25061.624075638516 21:45:36 INFO - PROCESS | 1661 | |2;jquery.html;349.37985076489247;371.60609753661123;372.2666347295828;379.38918341470236;399.4268225096986;14872.405103795849;15051.397944082237;15996.360145594163;20482.795172048274;20908.581828363425;19701;20202.19191232349;20781.48046298843;20937.37187884362;21042.89478552609;4797.328374027639;5847.532197424206;6169;6170.568060235785;6177.073438984144;5969.701514924258;6041.72812223451;6096.390360963913;6114.541409394314;6124.969375153118;5663.830085097454;5913.2608423947;5989.970050149743;6031.577789554733;6040;5879.794207202749;5939.940600593982;5943.3462319144855;5945.37573554777;5950.404959504058;4933.506649335073;5145.742712864342;5149.227615857614;5208.713520756357;5218;21117.47206319839;23000.42498937523;23770.434920540618;24171.274861754177;25134.874325628436;2097.024883429213;2380.642903564462;2461.064795377745;2479.5164942836154;2663.8668066596592;9814.656487022992;9859.408435493822;10354.378737275712;10360.896391036069;10378.740531486774;1746.292751435658;1864.5711486358214;1883.3125909043101;1920.7407000055093;1961.0390908454897;68890.3110968889;82825;84718.57640711819;90100.54949725275;108636;8990.595423205972;9408.905910940803;9546.90453095474;9695.806083878282;10739;10331.845022324671;12262.570810021785;12269.325187114795;12367.134300599051;12382.318972456422;7887.723929662434;7912.960435197902;7951.681932722742;8012;8087.959560202279;6914.792556223321;8290.419670622998;8378.8324233515;8604.48373097616;8712;3167.7307428868803;3775.9244815103543;3850.172212974224;3868.052327179859;3909.2181563687377;1605.3819279577447;1869.3270422647836;1877.1552801239498;1932.159510612888;1957.9608407831763;830.0122853803954;868.6264906090315;888.7022847346083;894.4856707393275;949.4730424614405;18981.905090474735;20693.89653051755;20762.377128686163;20781.376558703265;20903.477413064797;886.3972498700946;897.4205398498559;905.8097799462187;913.8035322405715;934.4720233068294;10569.365838049742;10910.836337454944;10916.454177291103;10939.781204375868;10962.287451315638;583759;583990;588741;598663;603421;92948;104706;111463.92575591194;119113.61772764669;121301.78698213081;922.0687106022965;930.4091901642506;966.3042609321277;968.331851022792;969.539468752337;14915.477958271409;18027.909860450614;18371.724424133383;18404;18537.15343615167;52274;52336.738316308176;53212.935741285735;53396.73301633467;53718;72185;75849;76197.23802762124;76502.4699506018;76875.61562192377;6962.686679099554;7894.447388682737;8051.35589152878;8090.959545202471;8411.074781774123;10651.201159913193;13104.475820967054;13500.459981600627;13523.391447384694;13527.526536571173;10936.781264374828;10963.506642201279;11458.427078645867;11501.82747258775;11504.827427588425;10394;10941.671749847517;11071.225014248925;11236.325820450798;11619.709507262387;9130.406523575946;9638.662646807328;11771.11716621274;11864.11019173548;11962.461689223832;6081.239845019372;7249.238829922993;7271.636418179176;7396.889046664412;7612.467127301257;9116.4074335168;10198.541065652213;11511.481983310603;11514.596989105341;11625.6512304631 21:45:36 INFO - PROCESS | 1661 | |3;mootools.html;1348.2719331560957;1500.8799296056313;1516.5298757385212;1700.7193813020845;1886.773587169539;7627.351675107616;8051.516908985465;8241.217084376989;8636.438631488949;8709.608067636957;8500.829983400345;8575.78560535987;8576.528290943996;8576.785580360494;8586.398952073358;2305.3545007397915;2335.1243283768586;2336.6845475860796;2337.3805941425453;2340.0405833608224;2245.2702871566726;2255.875926824024;2294.3231746634783;2295.517941232335;2297.632378819389;2304.8617082974993;2324.070371851256;2334.5525774020048;2334.9299521014314;2338.918137865175;2285.6228722260807;2301.5166814968875;2303.7926586607286;2309.2494939144844;2315.120254303371;2262.3552287597954;2301.275098344033;2305.7809508096702;2307.86152830829;2308.803751681109;8481.194286542768;8602.31181505478;8646.956765216133;8654.134586541295;8666.176713212235;5150.793968241266;5327.653702509325;5337.332833395825;5337.412884582693;5347;3437.9484307735406;3458.15275257561;3518.7009104225917;3523.3834079036064;3528.2237907660274;1061.1722856172198;1064.547567283909;1065.6536625596634;1082.112667612558;1084.5310837889351;11224.214304998572;11269.154813389028;11338.71653208668;11425.542978280942;11427.771444571063;3663.908402289964;4337.0892112656065;4512.435945506812;4517.819287228474;4533.795979180944;8876.467411955304;8899.466032038099;8929.196372326522;8931.866022009675;8956.328275379372;5152.7166005869285;5160.251763494272;5165.715885626251;5167.302414174038;5171.50870667286;4079.5078992110816;4298.720583162084;4386.232409328355;4464.687471876938;4848.3697119374965;3405.7956522608724;3739.1586892948867;3758.9436158457647;3759.49246851677;3765.2657731742597;969.2391472693902;1110.0186167690633;1133.4672703829187;1142.6172232302106;1148.5463242019523;872.358816270041;888.8400087984224;910.8360495110811;913.7669894176943;920.7652048727665;4651.953480465152;5691.77232910679;5742.138679198154;5809.82570522885;5813.505852002627;424.22367068265004;431.624486696576;435.6623616697085;442.5729171349599;446.7319608235033;3386.475096360019;3969.384745364473;4015.0765323975647;4036.313826649418;4076.612721791425;10206.642767503101;10466.895331046591;10592.205584581034;10601.416922069206;10603.57585696579;10525.578976840841;10532.420716860493;10536.631217907336;10559;10560.102391296672;7744.41916856238;7893.802654933673;7944.285014348737;8070.677172913135;8077.9902512187155;5710.4004079572705;5729.9713501432225;5760.452756988079;5820.417958204146;5859.531237501075;9538.761530961781;9835.704928852147;9849.753756156153;9866.112049915542;9875.111239988435;8427.662893484192;9113.954430227806;9947.104760571583;9951.651692190739;9953;7450.739224127129;7614.695412183451;7913.287804097428;8039.477433966774;8144.429889907887;7949.7217597383815;8038.477498962548;8046.637901294339;8069.991251093613;8144.83710325802;7132.6790294437915;7140.357367836919;7151.892721609076;7211.062561866924;7341.155767086853;6946.9652651736415;7026.402755765817;7069.964650176922;7071.5049946505305;7095;6780.72877084911;6914.619695916773;6917.412019978358;6926.0649812276715;6926.134233220848;4811.639127065414;4924.842661974505;4932.284818701197;4966.652334336562;5102.209157580581;4842.903141937212;4906.043321552405;4977.278294647328;5003.449620541664;5115.104856649997 21:45:36 INFO - PROCESS | 1661 | |4;prototype.html;300.26734767168097;301.68172577930284;309.3966764808623;313.5704085402998;315.73233467627495;3681.6686498215154;4733.928991065137;5108.4125325587565;5239.764210610522;5293;4725.952740472603;5005.524475174861;5076.390833100033;5132.461091585376;5139.8458046258675;3325.325515305589;3349.7271037005903;4016.5380981187245;4017.5781542938007;4018.236535058337;3715.238376132886;3989.6010398960016;4025.154717509312;4027.859024934128;4045.968278089083;3110.9001424038684;3954.861579844706;3958.5645578986287;3961.1681546875193;3987.820548075329;3608.3324584951606;3941.2117576484675;3942.940855887164;3943.9014024649327;3958.21880153929;2588.896444142232;3251.2522119912314;3344.7993120412852;3403.4894765785084;3418.4701371287492;5106.770195341219;5121.513456221653;5125.948740512622;5127.84616461503;5127.923136141415;3747.756395834262;3762.924741505182;4505.211587972124;4506.481754598198;4534.455865296152;5081.441041485434;5224.749127127213;5468.343798744176;5536.557075433956;5540.889182216373;2824.039826458993;3129.749620030392;3659.4327879178504;3751.1934933989323;3762.529683789526;5257.579393648537;5728.41973766396;5760.7695692172265;5786.797462088849;5800.854978625568;3195.5206718992335;3736.7745993680246;3792.867249646249;3801.8099095045136;3811.561670407883;3369.1240277527527;3738.719596030309;3849.826757795906;3860.610180335077;3868.574456809749;3697.0793073471655;4462.553744625511;4476.806364881185;4480.820767169277;4510.255807791677;5403;5450;5456.563474921997;5504.944950550524;5510.393856675762;1173.7183076061683;1207.3057991654834;1285.8199852020725;1291.17299021883;1303.9282839443922;700.6111608057577;800.4636893281515;801.7995501124719;804.9053287528956;809.554744890308;3578.8389522471552;4139.522800847302;4139.606737359946;4236.661067114624;4247.851325203665;4596.7012144211185;4654.394233989268;4659.930101048487;4687.531246875354;4702.636235491669;3459.78573712824;3795.0322667719556;4177.60050383119;4286.556662702292;4325.891852703708;2139.5344189230427;2347.730011048717;2353.0922615666454;2441.9511609767706;2452.565249329127;4306.913861722748;4316.942349124484;4685.430380822395;4771.5467030632035;4773.7110980035195;4339.615100221832;4620.699654522446;4691.780137164294;4702.435707715028;4727.598154156935;4289.978550107229;4307.246231909466;4572.545772839083;4715.137520679313;4855.587275081658;4674.439067311944;4682.946337074131;4683.437987441393;4704.811807527661;4747.572718455355;3945.664618507344;4134.503859536875;4318.611324980767;4586.54134586552;4640.607817654758;4220;4459.554044595515;4622.722636641813;4779.689320194177;4896.681715688612;2789.4560560691284;2964.2589352661835;3250.349930014054;3260.739140868677;3285.671432856695;3970.4441378207653;3978.90052748672;4642.419697537808;4662.13514594165;4699.671023028355;4150.215407374858;4929.162042452864;5354.9464505354445;5404.297441332602;5423.674579525241;4725.574698277172;4898.755062246944;5068.163752980717;5503.064479038493;5516.751746171512;4498.91002179948;5116.462771408948;5411.215373770702;5421.512063914267;5425.565954723692;4670.953290467051;5445.863853403696;5449.400565937823;5462.317210348707;5505.439970413777;4442.888927776831;5323.228131920927;5325.508857519901;5334.159714898354;5387.272718182995 21:45:36 INFO - PROCESS | 1661 | |5;yui.html;692.5463821197116;713.2012146396037;723.2694978072149;742.4691345687833;749.6401727170961;14923.850761492382;15062.472813451532;15069.849301506996;15479.226038698076;15560.922195389036;13966.441342346294;14104.64738381541;14121.929390353034;14132.293385330744;14132.293385330744;659.9901001484982;689.3416786968434;690.0511796280115;691.9446444284445;817.3869597801634;680.5882441123124;681.6421378776132;824.8762685597178;854.0989256334565;861.0958493581745;897.4615230861497;908.2416182487631;913.5158366065996;914.3782228084899;917.1149840404008;909.3997961345547;910.1762904571374;911.1890417528372;913.0641092879785;918.0727465260069;520.5159201942192;535.159799115389;669.4644284572371;671.3253180553561;672.2034389248707;13847.584572462742;14314.42742290307;14376.209308488029;14653.194074325907;14677.339519721532;13983.860161398357;14540.563783086418;14616.123032618078;14659.560213193514;14687.706245875022;11841.171118021743;11933.284002959763;11935.820962685566;11969.940150299193;12322.876771232262;3839.4816699745734;3845.6731177849915;3846.442265871461;3892.4161375793574;3910.1788624388914;107789;111894;111973.88026119716;119100.40449797695;119355.20967185499;10908.290961087503;11048.613298534512;11068.667939961813;11105.555777768961;11335.319880807177;21952.231671891408;22312.776872231396;22316;22333.55332893333;22350.994205260802;8053.476524025919;8137.877931831027;8146.470479418819;8226.712065077812;8360.958195208985;4467.7319360838455;4492.011757413364;4535.9773201133785;4542.909141817145;4589.0821835633005;3599.046252743025;3738.457923601117;3741;3741.8690345837763;3745.5318085239346;674.5278305186389;682.2427105912433;699.6431819771952;701.0675801184412;713.5219403000002;569.4049718044653;618.913352130702;639.2744235292884;681.2982627893277;695.7217113154778;8548.914510854936;8832.470051796912;9048.457092574467;9690.37012594179;10511.421871796972;647.7580648351383;647.8121344810047;650.3366566102549;672.6300534705892;698.8462538241579;4128.979355103205;4484.282514797616;4692.895782182555;4732.787024583902;4749.691270067504;121510;141858;144764;153174.23412883087;155477;70839.2290192739;76683;114288;128735.06897396546;132834.67165328417;108144;112267.43866280616;113015;114469;114705;9013.729588112366;9070;9080.40977336471;9148.862767058632;9325.347225694137;47864;53475.6631084226;56117.71941140268;58186.4181358181;59450;59527.40472595218;61221.69389153026;91329;91777;93540;12950.546730864751;13144.779529015452;13181.670458238621;13249.735005300034;13733.793993089912;14502.782458263346;14883.702325953636;15252.161131137895;15254.237288135328;15748.842511575196;13957.930210348883;14138.50515231962;14190.503332383318;14562.854371456573;14807.963442559349;13650.453981840616;13904;14311.20931418405;14436.783448248494;14613.561593152222;13399;13810.861891380957;14141.010129290851;14281;14427.206503642401;11337;11599.652010439362;11635.020258997472;11840.763184736084;11893.345865977455;9678.564464598969;9739.464329461947;10015.749606259902;10604.522796474332;11136.443177841238 21:45:36 INFO - PROCESS | 1661 | __end_tp_report 21:45:36 INFO - PROCESS | 1661 | __start_cc_report 21:45:36 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1900 21:45:36 INFO - PROCESS | 1661 | __end_cc_report 21:45:36 INFO - PROCESS | 1661 | __startTimestamp1476161136104__endTimestamp 21:45:36 INFO - PROCESS | 1661 | 21:45:36 INFO - PROCESS | 1661 | ------- Summary: start ------- 21:45:36 INFO - PROCESS | 1661 | Number of tests: 6 21:45:36 INFO - PROCESS | 1661 | 21:45:36 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5693.47 Median:5833.13 stddev:645.86 (11.1%) stddev-sans-first:612.97 21:45:36 INFO - PROCESS | 1661 | Values: 3024.6 3342.2 3360.7 3390.9 3407.2 5580.8 5663.5 5681.1 5709.6 5750.7 5618.6 5673.1 5673.7 5690.3 5697.7 4310.8 5134.0 5179.0 5190.9 5202.3 5270.3 5277.0 5278.4 5287.0 5291.2 5212.9 5212.9 5253.2 5265.7 5292.2 5289.1 5307.3 5320.7 5321.2 5345.5 5081.6 5120.9 5163.6 5220.2 5223.6 5615.5 5616.2 5647.3 5683.4 5693.2 6182.0 6183.4 6202.6 6202.8 6229.7 5056.7 6128.2 6136.6 6265.7 6292.2 5712.5 5752.9 5766.7 5782.5 5833.1 6296.5 6332.3 6346.8 6351.5 6373.9 5938.6 6042.6 6113.0 6130.0 6133.1 6133.6 6148.8 6166.8 6197.1 6234.5 6140.3 6163.4 6172.2 6179.9 6193.5 6167.2 6202.5 6206.6 6211.5 6228.5 4734.5 4859.1 4868.2 4868.7 4916.5 4398.7 4405.3 4421.6 4440.1 4479.4 5694.2 5731.9 5739.5 5751.9 5764.0 6101.0 6113.8 6147.8 6245.9 6261.2 4908.7 5652.2 5701.4 5710.2 5713.2 5329.4 5336.8 5348.3 5358.3 5362.5 6322.7 6361.3 6373.0 6382.9 6392.6 6155.4 6161.3 6224.8 6245.3 6280.6 6310.5 6316.3 6325.2 6326.7 6332.5 6122.3 6142.7 6149.5 6151.0 6172.8 6099.6 6107.2 6113.7 6142.2 6232.8 5982.1 5991.5 6006.2 6018.6 6061.6 5740.3 5982.7 5988.9 5992.8 5996.9 5714.1 5778.0 5790.9 5809.2 5828.2 5003.5 5938.7 5962.5 5992.5 6019.2 5857.5 5864.7 5874.8 5905.6 5908.2 21:45:36 INFO - PROCESS | 1661 | 21:45:36 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:65165.22 Median:36796.82 stddev:138492.39 (376.4%) stddev-sans-first:138795.71 21:45:36 INFO - PROCESS | 1661 | Values: 466.7 481.9 512.6 514.0 550.2 24500.9 33340.7 39428.0 40323.4 43272.0 41970.4 42342.8 42448.0 42458.6 42492.0 9687.1 9870.1 9876.1 9883.5 9888.1 8747.0 8996.7 11953.8 12236.3 12265.9 12145.6 12212.7 12220.7 12227.6 12230.3 12157.3 12227.3 12236.1 12252.6 12265.2 8688.5 8912.9 11597.4 11984.2 11998.4 40803.4 40945.2 40976.0 41027.0 41103.6 3223.8 3258.1 3422.6 3691.8 3936.2 30250.7 30487.5 30718.8 30959.7 31342.0 2782.9 3124.6 3132.2 3213.6 3219.9 471509.0 473897.0 475476.0 476610.6 477303.0 48337.8 57212.0 57776.7 57804.7 57931.4 60079.0 60114.0 60125.4 60164.7 60165.1 15497.5 15875.3 15891.6 15913.2 15923.5 11231.4 12457.2 12513.6 12515.9 12522.7 13534.5 13848.5 15226.2 15462.2 15542.7 6878.4 6931.6 6994.9 7015.8 7088.4 866.7 909.9 955.8 960.4 989.4 27333.5 27545.5 28187.0 28918.7 29016.4 1003.0 1039.2 1049.3 1100.8 1199.6 11562.0 14814.7 15015.5 15162.5 15464.5 552729.0 555624.0 555865.0 556458.1 559397.0 54340.5 54445.9 54480.5 54513.9 54561.7 1212.3 1222.3 1250.7 1304.2 1330.0 28179.7 29939.6 29954.7 30561.2 30737.2 46325.0 46690.0 46785.0 46873.5 47054.0 523629.7 524158.0 525808.0 525942.0 526000.0 25033.2 25748.5 25767.5 25902.4 25930.7 43654.0 43820.8 43907.1 44254.9 44368.8 29911.1 36863.8 36944.6 37226.8 38656.4 36624.5 37081.6 37728.0 37860.2 38260.6 35918.6 36207.6 36782.0 36811.6 37214.0 26579.9 28386.4 30485.9 32884.5 33348.7 22861.8 22925.5 24378.4 25025.6 25061.6 21:45:36 INFO - PROCESS | 1661 | 21:45:36 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:33032.28 Median:2598.38 stddev:97871.04 (3766.6%) stddev-sans-first:98114.83 21:45:36 INFO - PROCESS | 1661 | Values: 349.4 371.6 372.3 379.4 399.4 14872.4 15051.4 15996.4 20482.8 20908.6 19701.0 20202.2 20781.5 20937.4 21042.9 4797.3 5847.5 6169.0 6170.6 6177.1 5969.7 6041.7 6096.4 6114.5 6125.0 5663.8 5913.3 5990.0 6031.6 6040.0 5879.8 5939.9 5943.3 5945.4 5950.4 4933.5 5145.7 5149.2 5208.7 5218.0 21117.5 23000.4 23770.4 24171.3 25134.9 2097.0 2380.6 2461.1 2479.5 2663.9 9814.7 9859.4 10354.4 10360.9 10378.7 1746.3 1864.6 1883.3 1920.7 1961.0 68890.3 82825.0 84718.6 90100.5 108636.0 8990.6 9408.9 9546.9 9695.8 10739.0 10331.8 12262.6 12269.3 12367.1 12382.3 7887.7 7913.0 7951.7 8012.0 8088.0 6914.8 8290.4 8378.8 8604.5 8712.0 3167.7 3775.9 3850.2 3868.1 3909.2 1605.4 1869.3 1877.2 1932.2 1958.0 830.0 868.6 888.7 894.5 949.5 18981.9 20693.9 20762.4 20781.4 20903.5 886.4 897.4 905.8 913.8 934.5 10569.4 10910.8 10916.5 10939.8 10962.3 583759.0 583990.0 588741.0 598663.0 603421.0 92948.0 104706.0 111463.9 119113.6 121301.8 922.1 930.4 966.3 968.3 969.5 14915.5 18027.9 18371.7 18404.0 18537.2 52274.0 52336.7 53212.9 53396.7 53718.0 72185.0 75849.0 76197.2 76502.5 76875.6 6962.7 7894.4 8051.4 8091.0 8411.1 10651.2 13104.5 13500.5 13523.4 13527.5 10936.8 10963.5 11458.4 11501.8 11504.8 10394.0 10941.7 11071.2 11236.3 11619.7 9130.4 9638.7 11771.1 11864.1 11962.5 6081.2 7249.2 7271.6 7396.9 7612.5 9116.4 10198.5 11511.5 11514.6 11625.7 21:45:36 INFO - PROCESS | 1661 | 21:45:36 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5530.26 Median:4971.97 stddev:3120.63 (62.8%) stddev-sans-first:3113.55 21:45:36 INFO - PROCESS | 1661 | Values: 1348.3 1500.9 1516.5 1700.7 1886.8 7627.4 8051.5 8241.2 8636.4 8709.6 8500.8 8575.8 8576.5 8576.8 8586.4 2305.4 2335.1 2336.7 2337.4 2340.0 2245.3 2255.9 2294.3 2295.5 2297.6 2304.9 2324.1 2334.6 2334.9 2338.9 2285.6 2301.5 2303.8 2309.2 2315.1 2262.4 2301.3 2305.8 2307.9 2308.8 8481.2 8602.3 8647.0 8654.1 8666.2 5150.8 5327.7 5337.3 5337.4 5347.0 3437.9 3458.2 3518.7 3523.4 3528.2 1061.2 1064.5 1065.7 1082.1 1084.5 11224.2 11269.2 11338.7 11425.5 11427.8 3663.9 4337.1 4512.4 4517.8 4533.8 8876.5 8899.5 8929.2 8931.9 8956.3 5152.7 5160.3 5165.7 5167.3 5171.5 4079.5 4298.7 4386.2 4464.7 4848.4 3405.8 3739.2 3758.9 3759.5 3765.3 969.2 1110.0 1133.5 1142.6 1148.5 872.4 888.8 910.8 913.8 920.8 4652.0 5691.8 5742.1 5809.8 5813.5 424.2 431.6 435.7 442.6 446.7 3386.5 3969.4 4015.1 4036.3 4076.6 10206.6 10466.9 10592.2 10601.4 10603.6 10525.6 10532.4 10536.6 10559.0 10560.1 7744.4 7893.8 7944.3 8070.7 8078.0 5710.4 5730.0 5760.5 5820.4 5859.5 9538.8 9835.7 9849.8 9866.1 9875.1 8427.7 9114.0 9947.1 9951.7 9953.0 7450.7 7614.7 7913.3 8039.5 8144.4 7949.7 8038.5 8046.6 8070.0 8144.8 7132.7 7140.4 7151.9 7211.1 7341.2 6947.0 7026.4 7070.0 7071.5 7095.0 6780.7 6914.6 6917.4 6926.1 6926.1 4811.6 4924.8 4932.3 4966.7 5102.2 4842.9 4906.0 4977.3 5003.4 5115.1 21:45:36 INFO - PROCESS | 1661 | 21:45:36 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4097.88 Median:4489.87 stddev:1271.29 (28.3%) stddev-sans-first:1242.49 21:45:36 INFO - PROCESS | 1661 | Values: 300.3 301.7 309.4 313.6 315.7 3681.7 4733.9 5108.4 5239.8 5293.0 4726.0 5005.5 5076.4 5132.5 5139.8 3325.3 3349.7 4016.5 4017.6 4018.2 3715.2 3989.6 4025.2 4027.9 4046.0 3110.9 3954.9 3958.6 3961.2 3987.8 3608.3 3941.2 3942.9 3943.9 3958.2 2588.9 3251.3 3344.8 3403.5 3418.5 5106.8 5121.5 5125.9 5127.8 5127.9 3747.8 3762.9 4505.2 4506.5 4534.5 5081.4 5224.7 5468.3 5536.6 5540.9 2824.0 3129.7 3659.4 3751.2 3762.5 5257.6 5728.4 5760.8 5786.8 5800.9 3195.5 3736.8 3792.9 3801.8 3811.6 3369.1 3738.7 3849.8 3860.6 3868.6 3697.1 4462.6 4476.8 4480.8 4510.3 5403.0 5450.0 5456.6 5504.9 5510.4 1173.7 1207.3 1285.8 1291.2 1303.9 700.6 800.5 801.8 804.9 809.6 3578.8 4139.5 4139.6 4236.7 4247.9 4596.7 4654.4 4659.9 4687.5 4702.6 3459.8 3795.0 4177.6 4286.6 4325.9 2139.5 2347.7 2353.1 2442.0 2452.6 4306.9 4316.9 4685.4 4771.5 4773.7 4339.6 4620.7 4691.8 4702.4 4727.6 4290.0 4307.2 4572.5 4715.1 4855.6 4674.4 4682.9 4683.4 4704.8 4747.6 3945.7 4134.5 4318.6 4586.5 4640.6 4220.0 4459.6 4622.7 4779.7 4896.7 2789.5 2964.3 3250.3 3260.7 3285.7 3970.4 3978.9 4642.4 4662.1 4699.7 4150.2 4929.2 5354.9 5404.3 5423.7 4725.6 4898.8 5068.2 5503.1 5516.8 4498.9 5116.5 5411.2 5421.5 5425.6 4671.0 5445.9 5449.4 5462.3 5505.4 4442.9 5323.2 5325.5 5334.2 5387.3 21:45:36 INFO - PROCESS | 1661 | 21:45:36 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:23759.91 Median:3743.70 stddev:37548.06 (1003.0%) stddev-sans-first:37613.44 21:45:36 INFO - PROCESS | 1661 | Values: 692.5 713.2 723.3 742.5 749.6 14923.9 15062.5 15069.8 15479.2 15560.9 13966.4 14104.6 14121.9 14132.3 14132.3 660.0 689.3 690.1 691.9 817.4 680.6 681.6 824.9 854.1 861.1 897.5 908.2 913.5 914.4 917.1 909.4 910.2 911.2 913.1 918.1 520.5 535.2 669.5 671.3 672.2 13847.6 14314.4 14376.2 14653.2 14677.3 13983.9 14540.6 14616.1 14659.6 14687.7 11841.2 11933.3 11935.8 11969.9 12322.9 3839.5 3845.7 3846.4 3892.4 3910.2 107789.0 111894.0 111973.9 119100.4 119355.2 10908.3 11048.6 11068.7 11105.6 11335.3 21952.2 22312.8 22316.0 22333.6 22351.0 8053.5 8137.9 8146.5 8226.7 8361.0 4467.7 4492.0 4536.0 4542.9 4589.1 3599.0 3738.5 3741.0 3741.9 3745.5 674.5 682.2 699.6 701.1 713.5 569.4 618.9 639.3 681.3 695.7 8548.9 8832.5 9048.5 9690.4 10511.4 647.8 647.8 650.3 672.6 698.8 4129.0 4484.3 4692.9 4732.8 4749.7 121510.0 141858.0 144764.0 153174.2 155477.0 70839.2 76683.0 114288.0 128735.1 132834.7 108144.0 112267.4 113015.0 114469.0 114705.0 9013.7 9070.0 9080.4 9148.9 9325.3 47864.0 53475.7 56117.7 58186.4 59450.0 59527.4 61221.7 91329.0 91777.0 93540.0 12950.5 13144.8 13181.7 13249.7 13733.8 14502.8 14883.7 15252.2 15254.2 15748.8 13957.9 14138.5 14190.5 14562.9 14808.0 13650.5 13904.0 14311.2 14436.8 14613.6 13399.0 13810.9 14141.0 14281.0 14427.2 11337.0 11599.7 11635.0 11840.8 11893.3 9678.6 9739.5 10015.7 10604.5 11136.4 21:45:36 INFO - PROCESS | 1661 | -------- Summary: end -------- 21:45:36 INFO - PROCESS | 1661 | 21:45:36 INFO - TEST-INFO | 1661: exit 0 21:45:36 INFO - TEST-OK | dromaeo_css | took 1119074ms 21:45:36 INFO - TEST-START | kraken 21:45:36 INFO - operating with platform_type : mac_ 21:45:36 INFO - Initialising browser for kraken test... 21:45:36 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpQmMenR/profile http://localhost:49277/getInfo.html) 21:45:39 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 21:45:39 INFO - PROCESS | 1672 | colorDepth:24 21:45:39 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 21:45:39 INFO - PROCESS | 1672 | __metrics 21:45:39 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:45:39 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:45:40 INFO - TEST-INFO | 1672: exit 0 21:45:40 INFO - Browser initialized. 21:45:40 INFO - Running cycle 1/1 for kraken test... 21:45:40 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpQmMenR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:45:52 INFO - PROCESS | 1673 | RSS: Main: 235073536 21:45:52 INFO - PROCESS | 1673 | 21:45:54 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 21:45:55 INFO - PROCESS | 1673 | RSS: Main: 293564416 21:45:55 INFO - PROCESS | 1673 | 21:45:58 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 21:45:59 INFO - PROCESS | 1673 | RSS: Main: 293502976 21:45:59 INFO - PROCESS | 1673 | 21:46:02 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 21:46:03 INFO - PROCESS | 1673 | RSS: Main: 383234048 21:46:03 INFO - PROCESS | 1673 | 21:46:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 21:46:05 INFO - PROCESS | 1673 | RSS: Main: 285192192 21:46:05 INFO - PROCESS | 1673 | 21:46:07 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:46:08 INFO - PROCESS | 1673 | RSS: Main: 289280000 21:46:08 INFO - PROCESS | 1673 | 21:46:11 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 21:46:11 INFO - PROCESS | 1673 | RSS: Main: 324734976 21:46:11 INFO - PROCESS | 1673 | 21:46:14 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 21:46:15 INFO - PROCESS | 1673 | RSS: Main: 328564736 21:46:15 INFO - PROCESS | 1673 | 21:46:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 21:46:18 INFO - PROCESS | 1673 | RSS: Main: 324792320 21:46:18 INFO - PROCESS | 1673 | 21:46:20 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:46:20 INFO - PROCESS | 1673 | RSS: Main: 302952448 21:46:20 INFO - PROCESS | 1673 | 21:46:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:46:23 INFO - PROCESS | 1673 | RSS: Main: 304717824 21:46:23 INFO - PROCESS | 1673 | 21:46:25 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:46:26 INFO - PROCESS | 1673 | RSS: Main: 311734272 21:46:26 INFO - PROCESS | 1673 | 21:46:29 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:46:30 INFO - PROCESS | 1673 | RSS: Main: 317640704 21:46:30 INFO - PROCESS | 1673 | 21:46:32 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:46:33 INFO - PROCESS | 1673 | RSS: Main: 318185472 21:46:33 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 21:46:35 INFO - PROCESS | 1673 | RSS: Main: 361828352 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | __start_tp_report 21:46:35 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 21:46:35 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 21:46:35 INFO - PROCESS | 1673 | |i|pagename|runs| 21:46:35 INFO - PROCESS | 1673 | |0;ai-astar;113;114;113;113;114;113;113;114;113;113 21:46:35 INFO - PROCESS | 1673 | |1;audio-beat-detection;168;140;160;150;112;114;116;115;144;112 21:46:35 INFO - PROCESS | 1673 | |2;audio-dft;184;184;183;184;184;181;182;181;180;181 21:46:35 INFO - PROCESS | 1673 | |3;audio-fft;77;49;55;105;90;84;49;73;136;81 21:46:35 INFO - PROCESS | 1673 | |4;audio-oscillator;88;69;90;69;68;68;91;68;66;89 21:46:35 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;117;131;103;85;91;85;89;86;88;86 21:46:35 INFO - PROCESS | 1673 | |6;imaging-darkroom;97;96;97;97;98;97;97;98;102;98 21:46:35 INFO - PROCESS | 1673 | |7;imaging-desaturate;83;85;83;84;84;84;83;84;87;84 21:46:35 INFO - PROCESS | 1673 | |8;json-parse-financial;54;54;53;50;54;55;55;53;54;53 21:46:35 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;64;74;72;77;70;70;68;71;69;71 21:46:35 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;86;85;86;85;85;86;87;89;91;88 21:46:35 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;148;144;145;159;155;144;144;145;179;135 21:46:35 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;172;171;171;176;170;168;173;170;170;169 21:46:35 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;69;68;69;70;70;68;69;67;67;69 21:46:35 INFO - PROCESS | 1673 | __end_tp_report 21:46:35 INFO - PROCESS | 1673 | __start_cc_report 21:46:35 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,2045 21:46:35 INFO - PROCESS | 1673 | __end_cc_report 21:46:35 INFO - PROCESS | 1673 | __startTimestamp1476161195540__endTimestamp 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | ------- Summary: start ------- 21:46:35 INFO - PROCESS | 1673 | Number of tests: 14 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:46:35 INFO - PROCESS | 1673 | Values: 113.0 114.0 113.0 113.0 114.0 113.0 113.0 114.0 113.0 113.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:142.00 stddev:21.78 (15.3%) stddev-sans-first:19.09 21:46:35 INFO - PROCESS | 1673 | Values: 168.0 140.0 160.0 150.0 112.0 114.0 116.0 115.0 144.0 112.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:182.40 Median:183.50 stddev:1.58 (0.9%) stddev-sans-first:1.56 21:46:35 INFO - PROCESS | 1673 | Values: 184.0 184.0 183.0 184.0 184.0 181.0 182.0 181.0 180.0 181.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:79.90 Median:75.00 stddev:26.84 (35.8%) stddev-sans-first:28.45 21:46:35 INFO - PROCESS | 1673 | Values: 77.0 49.0 55.0 105.0 90.0 84.0 49.0 73.0 136.0 81.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:78.50 stddev:11.16 (14.2%) stddev-sans-first:11.05 21:46:35 INFO - PROCESS | 1673 | Values: 88.0 69.0 90.0 69.0 68.0 68.0 91.0 68.0 66.0 89.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:86.00 stddev:15.97 (18.6%) stddev-sans-first:15.04 21:46:35 INFO - PROCESS | 1673 | Values: 117.0 131.0 103.0 85.0 91.0 85.0 89.0 86.0 88.0 86.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:97.70 Median:97.00 stddev:1.64 (1.7%) stddev-sans-first:1.72 21:46:35 INFO - PROCESS | 1673 | Values: 97.0 96.0 97.0 97.0 98.0 97.0 97.0 98.0 102.0 98.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:1.20 (1.4%) stddev-sans-first:1.20 21:46:35 INFO - PROCESS | 1673 | Values: 83.0 85.0 83.0 84.0 84.0 84.0 83.0 84.0 87.0 84.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.43 (2.7%) stddev-sans-first:1.51 21:46:35 INFO - PROCESS | 1673 | Values: 54.0 54.0 53.0 50.0 54.0 55.0 55.0 53.0 54.0 53.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:3.47 (4.9%) stddev-sans-first:2.74 21:46:35 INFO - PROCESS | 1673 | Values: 64.0 74.0 72.0 77.0 70.0 70.0 68.0 71.0 69.0 71.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:1.99 (2.3%) stddev-sans-first:2.09 21:46:35 INFO - PROCESS | 1673 | Values: 86.0 85.0 86.0 85.0 85.0 86.0 87.0 89.0 91.0 88.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:146.50 stddev:12.17 (8.3%) stddev-sans-first:12.89 21:46:35 INFO - PROCESS | 1673 | Values: 148.0 144.0 145.0 159.0 155.0 144.0 144.0 145.0 179.0 135.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:171.00 stddev:2.26 (1.3%) stddev-sans-first:2.37 21:46:35 INFO - PROCESS | 1673 | Values: 172.0 171.0 171.0 176.0 170.0 168.0 173.0 170.0 170.0 169.0 21:46:35 INFO - PROCESS | 1673 | 21:46:35 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 21:46:35 INFO - PROCESS | 1673 | Values: 69.0 68.0 69.0 70.0 70.0 68.0 69.0 67.0 67.0 69.0 21:46:35 INFO - PROCESS | 1673 | -------- Summary: end -------- 21:46:35 INFO - PROCESS | 1673 | 21:46:36 INFO - TEST-INFO | 1673: exit 0 21:46:36 INFO - TEST-OK | kraken | took 59693ms 21:46:36 INFO - SUITE-END | took 1178s 21:46:36 INFO - Completed test suite (00:19:39) 21:46:36 INFO - javascript benchmark 21:46:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3024.6219222597174, 3342.247994201305, 3360.6639336066382, 3390.8643654253833, 3407.182276253698, 5580.804671836487, 5663.490285874275, 5681.091025435931, 5709.628874123179, 5750.683712395817, 5618.606697531174, 5673.063944449172, 5673.659580425167, 5690.2887139107615, 5697.715114244292, 4310.849120280791, 5133.974330128344, 5178.974105129488, 5190.854920342056, 5202.323697919265, 5270.341207349082, 5277.0, 5278.419373868871, 5287.0, 5291.206319052154, 5212.869678258036, 5212.869678258055, 5253.159494480884, 5265.65773224741, 5292.232626269189, 5289.100852855024, 5307.283516725251, 5320.693526256705, 5321.201819727072, 5345.492178243061, 5081.618878584121, 5120.897582048376, 5163.63854530183, 5220.1647736362, 5223.6343455958095, 5615.494605485485, 5616.241807355996, 5647.29408823897, 5683.431656834325, 5693.231413759131, 6181.96909015452, 6183.350748171422, 6202.565820392574, 6202.81391558254, 6229.6573688447115, 5056.696598204119, 6128.172696685935, 6136.631802091889, 6265.7493700251935, 6292.244930608311, 5712.457316554921, 5752.9137062943255, 5766.711664416763, 5782.479576838105, 5833.125031245348, 6296.496280297565, 6332.271788744353, 6346.809595712136, 6351.460125889259, 6373.872522549523, 5938.584299099021, 6042.637441753509, 6113.0, 6130.01919692847, 6133.1413602095745, 6133.579501509479, 6148.754049838046, 6166.784162554289, 6197.070439434031, 6234.470070044097, 6140.293866205444, 6163.445289923929, 6172.166757487771, 6179.949408600549, 6193.473554747897, 6167.198264225622, 6202.503799696014, 6206.627602343874, 6211.503079753609, 6228.4705800007505, 4734.479207287196, 4859.1010663027455, 4868.172410690191, 4868.659193856467, 4916.459189489154, 4398.73607583546, 4405.31717583775, 4421.579949904753, 4440.111977604427, 4479.372887795711, 5694.231278777394, 5731.942680573225, 5739.483446489836, 5751.9424805751405, 5764.0, 6100.969495152496, 6113.816585502442, 6147.770445910835, 6245.937540624626, 6261.186045814015, 4908.699194713404, 5652.18043383707, 5701.429857014348, 5710.229119068956, 5713.171590119493, 5329.413764485904, 5336.839894803162, 5348.277982472394, 5358.27663265462, 5362.51737343641, 6322.747090116344, 6361.268454127742, 6372.968135159294, 6382.8723425531225, 6392.616443013434, 6155.384461553809, 6161.260648722182, 6224.844378890564, 6245.28179259391, 6280.623162610258, 6310.463610592968, 6316.305206427198, 6325.240971083499, 6326.746930122744, 6332.52506062038, 6122.2959359674205, 6142.692865356804, 6149.508039356751, 6151.0, 6172.845678858064, 6099.603525770811, 6107.249501910372, 6113.689152827286, 6142.232220972379, 6232.781852635136, 5982.1325907744, 5991.460768530853, 6006.249218847644, 6018.608790428608, 6061.575689701678, 5740.311162660508, 5982.7307771149535, 5988.910166347596, 5992.790252341321, 5996.8800623988145, 5714.114312281603, 5777.971110144423, 5790.855228619318, 5809.24479817621, 5828.184054232495, 5003.54968052877, 5938.703064846654, 5962.522998160223, 5992.490638295793, 6019.247594050744, 5857.502112320501, 5864.706764661835, 5874.765009399747, 5905.645661260338, 5908.202392677105], "value": 5652.018147571564, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.6616702890405, 481.94939531349206, 512.5950499105704, 514.0002694758695, 550.1692444408947, 24500.87749561252, 33340.66659333412, 39428.01429964252, 40323.39514907275, 43272.0, 41970.37044444336, 42342.78828605852, 42448.0, 42458.575414245846, 42492.0, 9687.128158465737, 9870.111689947904, 9876.111149996499, 9883.456409897453, 9888.11007009369, 8746.956265218696, 8996.730098097067, 11953.820692689616, 12236.26582405054, 12265.938670306636, 12145.574904878331, 12212.69468263296, 12220.69448263796, 12227.63317100484, 12230.348902898128, 12157.270563766202, 12227.327496987662, 12236.082293827998, 12252.571160009356, 12265.202761820454, 8688.47869127848, 8912.8663070054, 11597.4201289936, 11984.161108722394, 11998.400079995965, 40803.38794918079, 40945.181096378205, 40976.0, 41027.0, 41103.588964110575, 3223.8065716057113, 3258.071449636866, 3422.5550678411646, 3691.8154092295276, 3936.15372694872, 30250.69749302523, 30487.542686859713, 30718.84640576805, 30959.690403095905, 31342.0, 2782.916512504628, 3124.5938028056207, 3132.216945763559, 3213.5822343095483, 3219.8551065201887, 471509.0, 473897.0, 475476.0, 476610.6169469165, 477303.0, 48337.75831120892, 57212.0, 57776.71111644415, 57804.71097644569, 57931.42068579345, 60079.0, 60114.0, 60125.39874601198, 60164.69917650384, 60165.09752353718, 15497.45758898433, 15875.285612147482, 15891.602709932344, 15913.204339782964, 15923.52229433119, 11231.438428078563, 12457.1902826316, 12513.562025329253, 12515.937420312841, 12522.749545009048, 13534.526291579747, 13848.515301964382, 15226.162561059027, 15462.226888655523, 15542.689146217012, 6878.449724022066, 6931.6483285759805, 6994.860102797916, 7015.824604384829, 7088.432925365958, 866.6836604639261, 909.9454032758056, 955.8040601676639, 960.3757557587624, 989.4113002763344, 27333.45333093327, 27545.509994594882, 28187.0, 28918.698658560414, 29016.41967160645, 1002.9749256268651, 1039.2413538117216, 1049.2550289294534, 1100.7908497385472, 1199.580146948561, 11561.959423651911, 14814.703705925822, 15015.474458393905, 15162.469313573973, 15464.458743943907, 552729.0, 555624.0, 555865.0, 556458.095866579, 559397.0, 54340.45659543354, 54445.91108177814, 54480.45519544833, 54513.90972180534, 54561.72719136458, 1212.3150420012664, 1222.3093951917317, 1250.6748245456065, 1304.2370213425252, 1329.9933500332436, 28179.71820281771, 29939.55090673685, 29954.700452995192, 30561.23596910095, 30737.231569210948, 46325.0, 46689.996500525194, 46785.0, 46873.53126468691, 47054.0, 523629.67296144454, 524158.0, 525808.0, 525942.0, 526000.0, 25033.249002529952, 25748.485030299664, 25767.484650306513, 25902.352441188366, 25930.740692593587, 43653.97676851376, 43820.78089609532, 43907.12185756203, 44254.89362765956, 44368.778156109016, 29911.102666920026, 36863.81568092143, 36944.63055369412, 37226.81386593158, 38656.42015369828, 36624.45063323999, 37081.62918370782, 37728.0, 37860.21397860192, 38260.617393825705, 35918.640813591526, 36207.63792362148, 36782.0, 36811.63188368189, 37214.0, 26579.867100665146, 28386.43227135487, 30485.932992345162, 32884.50673239951, 33348.66651333456, 22861.771382285966, 22925.541489170457, 24378.390540236636, 25025.624615631143, 25061.624075638516], "value": 19482.416184414782, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.37985076489247, 371.60609753661123, 372.2666347295828, 379.38918341470236, 399.4268225096986, 14872.405103795849, 15051.397944082237, 15996.360145594163, 20482.795172048274, 20908.581828363425, 19701.0, 20202.19191232349, 20781.48046298843, 20937.37187884362, 21042.89478552609, 4797.328374027639, 5847.532197424206, 6169.0, 6170.568060235785, 6177.073438984144, 5969.701514924258, 6041.72812223451, 6096.390360963913, 6114.541409394314, 6124.969375153118, 5663.830085097454, 5913.2608423947, 5989.970050149743, 6031.577789554733, 6040.0, 5879.794207202749, 5939.940600593982, 5943.3462319144855, 5945.37573554777, 5950.404959504058, 4933.506649335073, 5145.742712864342, 5149.227615857614, 5208.713520756357, 5218.0, 21117.47206319839, 23000.42498937523, 23770.434920540618, 24171.274861754177, 25134.874325628436, 2097.024883429213, 2380.642903564462, 2461.064795377745, 2479.5164942836154, 2663.8668066596592, 9814.656487022992, 9859.408435493822, 10354.378737275712, 10360.896391036069, 10378.740531486774, 1746.292751435658, 1864.5711486358214, 1883.3125909043101, 1920.7407000055093, 1961.0390908454897, 68890.3110968889, 82825.0, 84718.57640711819, 90100.54949725275, 108636.0, 8990.595423205972, 9408.905910940803, 9546.90453095474, 9695.806083878282, 10739.0, 10331.845022324671, 12262.570810021785, 12269.325187114795, 12367.134300599051, 12382.318972456422, 7887.723929662434, 7912.960435197902, 7951.681932722742, 8012.0, 8087.959560202279, 6914.792556223321, 8290.419670622998, 8378.8324233515, 8604.48373097616, 8712.0, 3167.7307428868803, 3775.9244815103543, 3850.172212974224, 3868.052327179859, 3909.2181563687377, 1605.3819279577447, 1869.3270422647836, 1877.1552801239498, 1932.159510612888, 1957.9608407831763, 830.0122853803954, 868.6264906090315, 888.7022847346083, 894.4856707393275, 949.4730424614405, 18981.905090474735, 20693.89653051755, 20762.377128686163, 20781.376558703265, 20903.477413064797, 886.3972498700946, 897.4205398498559, 905.8097799462187, 913.8035322405715, 934.4720233068294, 10569.365838049742, 10910.836337454944, 10916.454177291103, 10939.781204375868, 10962.287451315638, 583759.0, 583990.0, 588741.0, 598663.0, 603421.0, 92948.0, 104706.0, 111463.92575591194, 119113.61772764669, 121301.78698213081, 922.0687106022965, 930.4091901642506, 966.3042609321277, 968.331851022792, 969.539468752337, 14915.477958271409, 18027.909860450614, 18371.724424133383, 18404.0, 18537.15343615167, 52274.0, 52336.738316308176, 53212.935741285735, 53396.73301633467, 53718.0, 72185.0, 75849.0, 76197.23802762124, 76502.4699506018, 76875.61562192377, 6962.686679099554, 7894.447388682737, 8051.35589152878, 8090.959545202471, 8411.074781774123, 10651.201159913193, 13104.475820967054, 13500.459981600627, 13523.391447384694, 13527.526536571173, 10936.781264374828, 10963.506642201279, 11458.427078645867, 11501.82747258775, 11504.827427588425, 10394.0, 10941.671749847517, 11071.225014248925, 11236.325820450798, 11619.709507262387, 9130.406523575946, 9638.662646807328, 11771.11716621274, 11864.11019173548, 11962.461689223832, 6081.239845019372, 7249.238829922993, 7271.636418179176, 7396.889046664412, 7612.467127301257, 9116.4074335168, 10198.541065652213, 11511.481983310603, 11514.596989105341, 11625.6512304631], "value": 9106.603119083084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.2719331560957, 1500.8799296056313, 1516.5298757385212, 1700.7193813020845, 1886.773587169539, 7627.351675107616, 8051.516908985465, 8241.217084376989, 8636.438631488949, 8709.608067636957, 8500.829983400345, 8575.78560535987, 8576.528290943996, 8576.785580360494, 8586.398952073358, 2305.3545007397915, 2335.1243283768586, 2336.6845475860796, 2337.3805941425453, 2340.0405833608224, 2245.2702871566726, 2255.875926824024, 2294.3231746634783, 2295.517941232335, 2297.632378819389, 2304.8617082974993, 2324.070371851256, 2334.5525774020048, 2334.9299521014314, 2338.918137865175, 2285.6228722260807, 2301.5166814968875, 2303.7926586607286, 2309.2494939144844, 2315.120254303371, 2262.3552287597954, 2301.275098344033, 2305.7809508096702, 2307.86152830829, 2308.803751681109, 8481.194286542768, 8602.31181505478, 8646.956765216133, 8654.134586541295, 8666.176713212235, 5150.793968241266, 5327.653702509325, 5337.332833395825, 5337.412884582693, 5347.0, 3437.9484307735406, 3458.15275257561, 3518.7009104225917, 3523.3834079036064, 3528.2237907660274, 1061.1722856172198, 1064.547567283909, 1065.6536625596634, 1082.112667612558, 1084.5310837889351, 11224.214304998572, 11269.154813389028, 11338.71653208668, 11425.542978280942, 11427.771444571063, 3663.908402289964, 4337.0892112656065, 4512.435945506812, 4517.819287228474, 4533.795979180944, 8876.467411955304, 8899.466032038099, 8929.196372326522, 8931.866022009675, 8956.328275379372, 5152.7166005869285, 5160.251763494272, 5165.715885626251, 5167.302414174038, 5171.50870667286, 4079.5078992110816, 4298.720583162084, 4386.232409328355, 4464.687471876938, 4848.3697119374965, 3405.7956522608724, 3739.1586892948867, 3758.9436158457647, 3759.49246851677, 3765.2657731742597, 969.2391472693902, 1110.0186167690633, 1133.4672703829187, 1142.6172232302106, 1148.5463242019523, 872.358816270041, 888.8400087984224, 910.8360495110811, 913.7669894176943, 920.7652048727665, 4651.953480465152, 5691.77232910679, 5742.138679198154, 5809.82570522885, 5813.505852002627, 424.22367068265004, 431.624486696576, 435.6623616697085, 442.5729171349599, 446.7319608235033, 3386.475096360019, 3969.384745364473, 4015.0765323975647, 4036.313826649418, 4076.612721791425, 10206.642767503101, 10466.895331046591, 10592.205584581034, 10601.416922069206, 10603.57585696579, 10525.578976840841, 10532.420716860493, 10536.631217907336, 10559.0, 10560.102391296672, 7744.41916856238, 7893.802654933673, 7944.285014348737, 8070.677172913135, 8077.9902512187155, 5710.4004079572705, 5729.9713501432225, 5760.452756988079, 5820.417958204146, 5859.531237501075, 9538.761530961781, 9835.704928852147, 9849.753756156153, 9866.112049915542, 9875.111239988435, 8427.662893484192, 9113.954430227806, 9947.104760571583, 9951.651692190739, 9953.0, 7450.739224127129, 7614.695412183451, 7913.287804097428, 8039.477433966774, 8144.429889907887, 7949.7217597383815, 8038.477498962548, 8046.637901294339, 8069.991251093613, 8144.83710325802, 7132.6790294437915, 7140.357367836919, 7151.892721609076, 7211.062561866924, 7341.155767086853, 6946.9652651736415, 7026.402755765817, 7069.964650176922, 7071.5049946505305, 7095.0, 6780.72877084911, 6914.619695916773, 6917.412019978358, 6926.0649812276715, 6926.134233220848, 4811.639127065414, 4924.842661974505, 4932.284818701197, 4966.652334336562, 5102.209157580581, 4842.903141937212, 4906.043321552405, 4977.278294647328, 5003.449620541664, 5115.104856649997], "value": 4365.721093461319, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.26734767168097, 301.68172577930284, 309.3966764808623, 313.5704085402998, 315.73233467627495, 3681.6686498215154, 4733.928991065137, 5108.4125325587565, 5239.764210610522, 5293.0, 4725.952740472603, 5005.524475174861, 5076.390833100033, 5132.461091585376, 5139.8458046258675, 3325.325515305589, 3349.7271037005903, 4016.5380981187245, 4017.5781542938007, 4018.236535058337, 3715.238376132886, 3989.6010398960016, 4025.154717509312, 4027.859024934128, 4045.968278089083, 3110.9001424038684, 3954.861579844706, 3958.5645578986287, 3961.1681546875193, 3987.820548075329, 3608.3324584951606, 3941.2117576484675, 3942.940855887164, 3943.9014024649327, 3958.21880153929, 2588.896444142232, 3251.2522119912314, 3344.7993120412852, 3403.4894765785084, 3418.4701371287492, 5106.770195341219, 5121.513456221653, 5125.948740512622, 5127.84616461503, 5127.923136141415, 3747.756395834262, 3762.924741505182, 4505.211587972124, 4506.481754598198, 4534.455865296152, 5081.441041485434, 5224.749127127213, 5468.343798744176, 5536.557075433956, 5540.889182216373, 2824.039826458993, 3129.749620030392, 3659.4327879178504, 3751.1934933989323, 3762.529683789526, 5257.579393648537, 5728.41973766396, 5760.7695692172265, 5786.797462088849, 5800.854978625568, 3195.5206718992335, 3736.7745993680246, 3792.867249646249, 3801.8099095045136, 3811.561670407883, 3369.1240277527527, 3738.719596030309, 3849.826757795906, 3860.610180335077, 3868.574456809749, 3697.0793073471655, 4462.553744625511, 4476.806364881185, 4480.820767169277, 4510.255807791677, 5403.0, 5450.0, 5456.563474921997, 5504.944950550524, 5510.393856675762, 1173.7183076061683, 1207.3057991654834, 1285.8199852020725, 1291.17299021883, 1303.9282839443922, 700.6111608057577, 800.4636893281515, 801.7995501124719, 804.9053287528956, 809.554744890308, 3578.8389522471552, 4139.522800847302, 4139.606737359946, 4236.661067114624, 4247.851325203665, 4596.7012144211185, 4654.394233989268, 4659.930101048487, 4687.531246875354, 4702.636235491669, 3459.78573712824, 3795.0322667719556, 4177.60050383119, 4286.556662702292, 4325.891852703708, 2139.5344189230427, 2347.730011048717, 2353.0922615666454, 2441.9511609767706, 2452.565249329127, 4306.913861722748, 4316.942349124484, 4685.430380822395, 4771.5467030632035, 4773.7110980035195, 4339.615100221832, 4620.699654522446, 4691.780137164294, 4702.435707715028, 4727.598154156935, 4289.978550107229, 4307.246231909466, 4572.545772839083, 4715.137520679313, 4855.587275081658, 4674.439067311944, 4682.946337074131, 4683.437987441393, 4704.811807527661, 4747.572718455355, 3945.664618507344, 4134.503859536875, 4318.611324980767, 4586.54134586552, 4640.607817654758, 4220.0, 4459.554044595515, 4622.722636641813, 4779.689320194177, 4896.681715688612, 2789.4560560691284, 2964.2589352661835, 3250.349930014054, 3260.739140868677, 3285.671432856695, 3970.4441378207653, 3978.90052748672, 4642.419697537808, 4662.13514594165, 4699.671023028355, 4150.215407374858, 4929.162042452864, 5354.9464505354445, 5404.297441332602, 5423.674579525241, 4725.574698277172, 4898.755062246944, 5068.163752980717, 5503.064479038493, 5516.751746171512, 4498.91002179948, 5116.462771408948, 5411.215373770702, 5421.512063914267, 5425.565954723692, 4670.953290467051, 5445.863853403696, 5449.400565937823, 5462.317210348707, 5505.439970413777, 4442.888927776831, 5323.228131920927, 5325.508857519901, 5334.159714898354, 5387.272718182995], "value": 3705.1546812591278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.5463821197116, 713.2012146396037, 723.2694978072149, 742.4691345687833, 749.6401727170961, 14923.850761492382, 15062.472813451532, 15069.849301506996, 15479.226038698076, 15560.922195389036, 13966.441342346294, 14104.64738381541, 14121.929390353034, 14132.293385330744, 14132.293385330744, 659.9901001484982, 689.3416786968434, 690.0511796280115, 691.9446444284445, 817.3869597801634, 680.5882441123124, 681.6421378776132, 824.8762685597178, 854.0989256334565, 861.0958493581745, 897.4615230861497, 908.2416182487631, 913.5158366065996, 914.3782228084899, 917.1149840404008, 909.3997961345547, 910.1762904571374, 911.1890417528372, 913.0641092879785, 918.0727465260069, 520.5159201942192, 535.159799115389, 669.4644284572371, 671.3253180553561, 672.2034389248707, 13847.584572462742, 14314.42742290307, 14376.209308488029, 14653.194074325907, 14677.339519721532, 13983.860161398357, 14540.563783086418, 14616.123032618078, 14659.560213193514, 14687.706245875022, 11841.171118021743, 11933.284002959763, 11935.820962685566, 11969.940150299193, 12322.876771232262, 3839.4816699745734, 3845.6731177849915, 3846.442265871461, 3892.4161375793574, 3910.1788624388914, 107789.0, 111894.0, 111973.88026119716, 119100.40449797695, 119355.20967185499, 10908.290961087503, 11048.613298534512, 11068.667939961813, 11105.555777768961, 11335.319880807177, 21952.231671891408, 22312.776872231396, 22316.0, 22333.55332893333, 22350.994205260802, 8053.476524025919, 8137.877931831027, 8146.470479418819, 8226.712065077812, 8360.958195208985, 4467.7319360838455, 4492.011757413364, 4535.9773201133785, 4542.909141817145, 4589.0821835633005, 3599.046252743025, 3738.457923601117, 3741.0, 3741.8690345837763, 3745.5318085239346, 674.5278305186389, 682.2427105912433, 699.6431819771952, 701.0675801184412, 713.5219403000002, 569.4049718044653, 618.913352130702, 639.2744235292884, 681.2982627893277, 695.7217113154778, 8548.914510854936, 8832.470051796912, 9048.457092574467, 9690.37012594179, 10511.421871796972, 647.7580648351383, 647.8121344810047, 650.3366566102549, 672.6300534705892, 698.8462538241579, 4128.979355103205, 4484.282514797616, 4692.895782182555, 4732.787024583902, 4749.691270067504, 121510.0, 141858.0, 144764.0, 153174.23412883087, 155477.0, 70839.2290192739, 76683.0, 114288.0, 128735.06897396546, 132834.67165328417, 108144.0, 112267.43866280616, 113015.0, 114469.0, 114705.0, 9013.729588112366, 9070.0, 9080.40977336471, 9148.862767058632, 9325.347225694137, 47864.0, 53475.6631084226, 56117.71941140268, 58186.4181358181, 59450.0, 59527.40472595218, 61221.69389153026, 91329.0, 91777.0, 93540.0, 12950.546730864751, 13144.779529015452, 13181.670458238621, 13249.735005300034, 13733.793993089912, 14502.782458263346, 14883.702325953636, 15252.161131137895, 15254.237288135328, 15748.842511575196, 13957.930210348883, 14138.50515231962, 14190.503332383318, 14562.854371456573, 14807.963442559349, 13650.453981840616, 13904.0, 14311.20931418405, 14436.783448248494, 14613.561593152222, 13399.0, 13810.861891380957, 14141.010129290851, 14281.0, 14427.206503642401, 11337.0, 11599.652010439362, 11635.020258997472, 11840.763184736084, 11893.345865977455, 9678.564464598969, 9739.464329461947, 10015.749606259902, 10604.522796474332, 11136.443177841238], "value": 7732.893402062045, "unit": "score"}], "name": "dromaeo_css", "value": 7075.271057042102, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 140.0, 160.0, 150.0, 112.0, 114.0, 116.0, 115.0, 144.0, 112.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 184.0, 184.0, 181.0, 182.0, 181.0, 180.0, 181.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 49.0, 55.0, 105.0, 90.0, 84.0, 49.0, 73.0, 136.0, 81.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 90.0, 69.0, 68.0, 68.0, 91.0, 68.0, 66.0, 89.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 131.0, 103.0, 85.0, 91.0, 85.0, 89.0, 86.0, 88.0, 86.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 97.0, 98.0, 97.0, 97.0, 98.0, 102.0, 98.0], "value": 97.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 83.0, 84.0, 84.0, 84.0, 83.0, 84.0, 87.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 50.0, 54.0, 55.0, 55.0, 53.0, 54.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 72.0, 77.0, 70.0, 70.0, 68.0, 71.0, 69.0, 71.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 85.0, 86.0, 87.0, 89.0, 91.0, 88.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 144.0, 145.0, 159.0, 155.0, 144.0, 144.0, 145.0, 179.0, 135.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 171.0, 176.0, 170.0, 168.0, 173.0, 170.0, 170.0, 169.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 70.0, 70.0, 68.0, 69.0, 67.0, 67.0, 69.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1463.5, "alertThreshold": 2.0}]} 21:46:36 INFO - Return code: 0 21:46:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:46:36 INFO - # TBPL SUCCESS # 21:46:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:46:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:46:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:46:36 INFO - 2016-10-10 21:46:36.858 screenresolution[1677:9968] starting screenresolution argv=screenresolution get 21:46:36 INFO - 2016-10-10 21:46:36.861 screenresolution[1677:9968] Display 0: 1600x1200x32@60 21:46:36 INFO - 2016-10-10 21:46:36.867 screenresolution[1678:9971] starting screenresolution argv=screenresolution list 21:46:36 INFO - Available Modes on Display 0 21:46:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:46:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:46:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:46:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:46:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:46:37 INFO - Intel Iris: 21:46:37 INFO - Chipset Model: Intel Iris 21:46:37 INFO - Type: GPU 21:46:37 INFO - Bus: Built-In 21:46:37 INFO - VRAM (Dynamic, Max): 1536 MB 21:46:37 INFO - Vendor: Intel (0x8086) 21:46:37 INFO - Device ID: 0x0a2e 21:46:37 INFO - Revision ID: 0x0009 21:46:37 INFO - Displays: 21:46:37 INFO - Display: 21:46:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:46:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:46:37 INFO - Display Serial Number: 1600x1200 60 21:46:37 INFO - Main Display: Yes 21:46:37 INFO - Mirror: Off 21:46:37 INFO - Online: Yes 21:46:37 INFO - Rotation: Supported 21:46:37 INFO - Return code: 0 21:46:37 INFO - Running post-action listener: _resource_record_post_action 21:46:37 INFO - [mozharness: 2016-10-11 04:46:37.103202Z] Finished run-tests step (success) 21:46:37 INFO - Running post-run listener: _resource_record_post_run 21:46:37 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37405696; Write bytes: 708501504; Read time: 250; Write time: 1953 21:46:37 INFO - TinderboxPrint: CPU usage
53.7% 21:46:37 INFO - TinderboxPrint: I/O read bytes / time
37,405,696 / 250 21:46:37 INFO - TinderboxPrint: I/O write bytes / time
708,501,504 / 1,953 21:46:37 INFO - TinderboxPrint: CPU idle
2,250.9 (46.3%) 21:46:37 INFO - TinderboxPrint: CPU system
970.0 (20.0%) 21:46:37 INFO - TinderboxPrint: CPU user
1,636.8 (33.7%) 21:46:37 INFO - TinderboxPrint: Swap in / out
445,440,000 / 0 21:46:37 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 396124672; Write bytes: 389531648; Read time: 29329; Write time: 783 21:46:37 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 35562496; Write bytes: 297900032; Read time: 231; Write time: 1119 21:46:37 INFO - Running post-run listener: _upload_blobber_files 21:46:37 INFO - Blob upload gear active. 21:46:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:46:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:46:38 INFO - (blobuploader) - INFO - Open directory for files ... 21:46:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:46:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:46:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:39 INFO - (blobuploader) - INFO - Done attempting. 21:46:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:46:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:46:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:40 INFO - (blobuploader) - INFO - Done attempting. 21:46:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:46:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:46:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:42 INFO - (blobuploader) - INFO - Done attempting. 21:46:42 INFO - (blobuploader) - INFO - Iteration through files over. 21:46:42 INFO - Return code: 0 21:46:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:46:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:46:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af7bdb8001f8e7e8ca22c4c1928a4e49f2fff11631f71029e423974f3c647c143ce245522880de29122f545d8aeac6305c650686ed4263400e7ea6ce023d3aec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a5bb7e9dd2d71a5d32a046218bb712f2f15fa0b54dbbaeca3de4ee6b9d05d931ccc0846075e5baeaf93cadde3ddca2b8cff29b99b410967b65c77463b7db540", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a49a82560e7e2d041c76950c0a1d02fb011f5a1f37cb54d98d791c75a24f5360f49e923b2f0da950b333cd0f17a2409c331a3649824ef83e66458d23c8ea36f"} 21:46:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:46:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:46:42 INFO - Contents: 21:46:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af7bdb8001f8e7e8ca22c4c1928a4e49f2fff11631f71029e423974f3c647c143ce245522880de29122f545d8aeac6305c650686ed4263400e7ea6ce023d3aec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a5bb7e9dd2d71a5d32a046218bb712f2f15fa0b54dbbaeca3de4ee6b9d05d931ccc0846075e5baeaf93cadde3ddca2b8cff29b99b410967b65c77463b7db540", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a49a82560e7e2d041c76950c0a1d02fb011f5a1f37cb54d98d791c75a24f5360f49e923b2f0da950b333cd0f17a2409c331a3649824ef83e66458d23c8ea36f"} 21:46:42 INFO - Running post-run listener: copy_logs_to_upload_dir 21:46:42 INFO - Copying logs to upload dir... 21:46:42 INFO - mkdir: /builds/slave/test/build/upload/logs 21:46:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.496203 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-10 21:46:42.462898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 21:46:42.466232) ========= 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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af7bdb8001f8e7e8ca22c4c1928a4e49f2fff11631f71029e423974f3c647c143ce245522880de29122f545d8aeac6305c650686ed4263400e7ea6ce023d3aec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a5bb7e9dd2d71a5d32a046218bb712f2f15fa0b54dbbaeca3de4ee6b9d05d931ccc0846075e5baeaf93cadde3ddca2b8cff29b99b410967b65c77463b7db540", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a49a82560e7e2d041c76950c0a1d02fb011f5a1f37cb54d98d791c75a24f5360f49e923b2f0da950b333cd0f17a2409c331a3649824ef83e66458d23c8ea36f"} build_url:https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011099 build_url: 'https://queue.taskcluster.net/v1/task/IEg2HFWiTwuWpe4SYJAoLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af7bdb8001f8e7e8ca22c4c1928a4e49f2fff11631f71029e423974f3c647c143ce245522880de29122f545d8aeac6305c650686ed4263400e7ea6ce023d3aec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a5bb7e9dd2d71a5d32a046218bb712f2f15fa0b54dbbaeca3de4ee6b9d05d931ccc0846075e5baeaf93cadde3ddca2b8cff29b99b410967b65c77463b7db540", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a49a82560e7e2d041c76950c0a1d02fb011f5a1f37cb54d98d791c75a24f5360f49e923b2f0da950b333cd0f17a2409c331a3649824ef83e66458d23c8ea36f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 21:46:42.502226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:46:42.502656) ========= 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.C9cafC2Sxw/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.xjmP8DzxnQ/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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.005352 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:46:42.554474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 21:46:42.555196) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 21:46:42.555962) ========= ========= Total master_lag: 0.65 =========