builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0324 starttime: 1479910767.99 results: success (0) buildid: 20161123024236 builduid: 85a1cea35edb4fd995bfdfa93b1c438a revision: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:27.989564) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:27.989997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:27.990288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:28.025802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:28.026195) ========= 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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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-11-23 06:19:28-- 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% 29.4M=0s 2016-11-23 06:19:28 (29.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:28.162975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:28.163385) ========= 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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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.024928 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:28.212259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 06:19:28.212640) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I8uYvJTBUD/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.9D8OJPq4YE/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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-11-23 06:19:28,310 truncating revision to first 12 chars 2016-11-23 06:19:28,311 Setting DEBUG logging. 2016-11-23 06:19:28,311 attempt 1/10 2016-11-23 06:19:28,311 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/e5ed1abefc08?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 06:19:29,342 unpacking tar archive at: cedar-e5ed1abefc08/testing/mozharness/ program finished with exit code 0 elapsedTime=1.317942 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 06:19:29.554204) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:29.554522) ========= script_repo_revision: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:29.554939) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:29.555219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 06:19:29.574667) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-23 06:19:29.575033) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I8uYvJTBUD/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.9D8OJPq4YE/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 06:19:29 INFO - MultiFileLogger online at 20161123 06:19:29 in /builds/slave/test 06:19:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 06:19:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:19:29 INFO - {'append_to_log': False, 06:19:29 INFO - 'base_work_dir': '/builds/slave/test', 06:19:29 INFO - 'blob_upload_branch': 'Cedar', 06:19:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:19:29 INFO - 'branch': 'Cedar', 06:19:29 INFO - 'buildbot_json_path': 'buildprops.json', 06:19:29 INFO - 'config_files': ('talos/mac_config.py',), 06:19:29 INFO - 'default_actions': ('clobber', 06:19:29 INFO - 'read-buildbot-config', 06:19:29 INFO - 'download-and-extract', 06:19:29 INFO - 'populate-webroot', 06:19:29 INFO - 'create-virtualenv', 06:19:29 INFO - 'install', 06:19:29 INFO - 'run-tests'), 06:19:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:19:29 INFO - 'download_minidump_stackwalk': True, 06:19:29 INFO - 'download_symbols': 'ondemand', 06:19:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:19:29 INFO - 'tooltool.py': '/tools/tooltool.py', 06:19:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:19:29 INFO - '/tools/misc-python/virtualenv.py')}, 06:19:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:19:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:19:29 INFO - 'installer_path': 'installer.exe', 06:19:29 INFO - 'log_level': 'info', 06:19:29 INFO - 'log_name': 'talos', 06:19:29 INFO - 'log_to_console': True, 06:19:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:19:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:19:29 INFO - 'opt_config_files': (), 06:19:29 INFO - 'pip_index': False, 06:19:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:19:29 INFO - 'cmd': ('bash', 06:19:29 INFO - '-c', 06:19:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:19:29 INFO - 'enabled': True, 06:19:29 INFO - 'halt_on_failure': False, 06:19:29 INFO - 'name': 'check_screen_resolution'},), 06:19:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:19:29 INFO - 'cmd': ('bash', 06:19:29 INFO - '-c', 06:19:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:19:29 INFO - 'enabled': True, 06:19:29 INFO - 'halt_on_failure': False, 06:19:29 INFO - 'name': 'check_screen_resolution'},), 06:19:29 INFO - 'run_cmd_checks_enabled': True, 06:19:29 INFO - 'sps_profile': False, 06:19:29 INFO - 'sps_profile_interval': 0, 06:19:29 INFO - 'suite': 'dromaeojs', 06:19:29 INFO - 'system_bits': '32', 06:19:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:19:29 INFO - 'title': 't-yosemite-r7-0324', 06:19:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:19:29 INFO - 'use_talos_json': True, 06:19:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:19:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:19:29 INFO - 'work_dir': 'build'} 06:19:29 INFO - [mozharness: 2016-11-23 14:19:29.774907Z] Running clobber step. 06:19:29 INFO - Running pre-action listener: _resource_record_pre_action 06:19:29 INFO - Running main action method: clobber 06:19:29 INFO - rmtree: /builds/slave/test/build 06:19:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:19:32 INFO - Running post-action listener: _resource_record_post_action 06:19:32 INFO - [mozharness: 2016-11-23 14:19:32.232855Z] Finished clobber step (success) 06:19:32 INFO - [mozharness: 2016-11-23 14:19:32.233019Z] Running read-buildbot-config step. 06:19:32 INFO - Running pre-action listener: _resource_record_pre_action 06:19:32 INFO - Running main action method: read_buildbot_config 06:19:32 INFO - Using buildbot properties: 06:19:32 INFO - { 06:19:32 INFO - "project": "", 06:19:32 INFO - "product": "firefox", 06:19:32 INFO - "script_repo_revision": "default", 06:19:32 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 06:19:32 INFO - "repository": "", 06:19:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 06:19:32 INFO - "buildid": "20161123024236", 06:19:32 INFO - "pgo_build": "False", 06:19:32 INFO - "basedir": "/builds/slave/test", 06:19:32 INFO - "buildnumber": 0, 06:19:32 INFO - "slavename": "t-yosemite-r7-0324", 06:19:32 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:19:32 INFO - "platform": "yosemite_r7", 06:19:32 INFO - "scheduler": "tests-cedar-macosx64-talos", 06:19:32 INFO - "branch": "cedar", 06:19:32 INFO - "repo_path": "projects/cedar", 06:19:32 INFO - "revision": "e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7", 06:19:32 INFO - "stage_platform": "macosx64", 06:19:32 INFO - "builduid": "85a1cea35edb4fd995bfdfa93b1c438a", 06:19:32 INFO - "slavebuilddir": "test" 06:19:32 INFO - } 06:19:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 06:19:32 INFO - Running post-action listener: _resource_record_post_action 06:19:32 INFO - [mozharness: 2016-11-23 14:19:32.236414Z] Finished read-buildbot-config step (success) 06:19:32 INFO - [mozharness: 2016-11-23 14:19:32.236547Z] Running download-and-extract step. 06:19:32 INFO - Running pre-action listener: _resource_record_pre_action 06:19:32 INFO - Running main action method: download_and_extract 06:19:32 INFO - mkdir: /builds/slave/test/build/tests 06:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:32 INFO - trying https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 06:19:32 INFO - Downloading https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 06:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 06:19:33 INFO - Downloaded 1199 bytes. 06:19:33 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 06:19:33 INFO - Using the following test package requirements: 06:19:33 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:19:33 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:19:33 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 06:19:33 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:19:33 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 06:19:33 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:19:33 INFO - u'jsshell-mac.zip'], 06:19:33 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:19:33 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 06:19:33 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:19:33 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:19:33 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 06:19:33 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:19:33 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 06:19:33 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:19:33 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 06:19:33 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:19:33 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 06:19:33 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:19:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:19:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:19:33 INFO - Fetch https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:19:34 INFO - Http code: 200 06:19:34 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 06:19:34 INFO - x-amz-cf-id: uuJT4himzav0Fz8nRuj9kqnnyQQiyYagtlqZjcUfpiY0Ss1Zi3L9rA== 06:19:34 INFO - x-amz-version-id: jGbqWHfb.3mnwUz6A4ZS_ENEuUkFX662 06:19:34 INFO - Expected file size: 16267074 06:19:34 INFO - Obtained file size: 16267074 06:19:41 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:19:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:19:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:19:41 INFO - Fetch https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:19:41 INFO - Http code: 200 06:19:41 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 06:19:41 INFO - x-amz-cf-id: GdAe7u3-eSlh_czD7vVt3iG0HivKBddZ7TlnuBwRWL97MV8OSy9Lgw== 06:19:41 INFO - x-amz-version-id: jGbqWHfb.3mnwUz6A4ZS_ENEuUkFX662 06:19:41 INFO - Expected file size: 16267074 06:19:41 INFO - Obtained file size: 16267074 06:19:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 06:19:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:19:48 INFO - Fetch https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 06:19:49 INFO - Http code: 200 06:19:49 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 06:19:49 INFO - x-amz-cf-id: WzlUIRCHVJWKygYqpLZhRL4vwtmI5v_Ct2unznw7Nb0OBQ3i-VmrJQ== 06:19:49 INFO - x-amz-version-id: s6OZtePjbbwrV.MVvz5JoF4FleTR6cQD 06:19:49 INFO - Expected file size: 14409506 06:19:49 INFO - Obtained file size: 14409506 06:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:49 INFO - trying https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:19:49 INFO - Downloading https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 06:19:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 06:19:53 INFO - Downloaded 107541276 bytes. 06:19:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:19:53 INFO - mkdir: /builds/slave/test/properties 06:19:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:19:53 INFO - Writing to file /builds/slave/test/properties/build_url 06:19:53 INFO - Contents: 06:19:53 INFO - build_url:https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:19:53 INFO - Running post-action listener: _resource_record_post_action 06:19:53 INFO - Running post-action listener: set_extra_try_arguments 06:19:53 INFO - [mozharness: 2016-11-23 14:19:53.994126Z] Finished download-and-extract step (success) 06:19:53 INFO - [mozharness: 2016-11-23 14:19:53.994268Z] Running populate-webroot step. 06:19:53 INFO - Running pre-action listener: _resource_record_pre_action 06:19:53 INFO - Running main action method: populate_webroot 06:19:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:19:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:19:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:19:54 INFO - '--tppagecycles', 06:19:54 INFO - '7'], 06:19:54 INFO - 'tests': ['tsvgm']}}, 06:19:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:19:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:19:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:19:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:19:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:19:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:19:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:19:54 INFO - 'talos_options': ['--disable-e10s'], 06:19:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:19:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:19:54 INFO - 'talos_options': ['--disable-e10s'], 06:19:54 INFO - 'tests': ['damp', 'tps']}, 06:19:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:19:54 INFO - 'tests': ['damp', 'tps']}, 06:19:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:19:54 INFO - 'tests': ['dromaeo_dom']}, 06:19:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:19:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:19:54 INFO - 'tests': ['basic_compositor_video']}, 06:19:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:19:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:19:54 INFO - 'tests': ['a11yr', 06:19:54 INFO - 'ts_paint', 06:19:54 INFO - 'tpaint', 06:19:54 INFO - 'sessionrestore', 06:19:54 INFO - 'sessionrestore_no_auto_restore', 06:19:54 INFO - 'tabpaint']}, 06:19:54 INFO - 'other-e10s': {'tests': ['a11yr', 06:19:54 INFO - 'ts_paint', 06:19:54 INFO - 'tpaint', 06:19:54 INFO - 'sessionrestore', 06:19:54 INFO - 'sessionrestore_no_auto_restore', 06:19:54 INFO - 'tabpaint']}, 06:19:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:19:54 INFO - 'ts_paint', 06:19:54 INFO - 'tpaint', 06:19:54 INFO - 'sessionrestore', 06:19:54 INFO - 'sessionrestore_no_auto_restore', 06:19:54 INFO - 'tabpaint']}, 06:19:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:19:54 INFO - 'ts_paint', 06:19:54 INFO - 'tpaint', 06:19:54 INFO - 'sessionrestore', 06:19:54 INFO - 'sessionrestore_no_auto_restore', 06:19:54 INFO - 'tabpaint']}, 06:19:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:19:54 INFO - 'tests': ['a11yr', 06:19:54 INFO - 'ts_paint', 06:19:54 INFO - 'tpaint', 06:19:54 INFO - 'sessionrestore', 06:19:54 INFO - 'sessionrestore_no_auto_restore', 06:19:54 INFO - 'tabpaint']}, 06:19:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:19:54 INFO - 'tests': ['a11yr', 06:19:54 INFO - 'ts_paint', 06:19:54 INFO - 'tpaint', 06:19:54 INFO - 'sessionrestore', 06:19:54 INFO - 'sessionrestore_no_auto_restore', 06:19:54 INFO - 'tabpaint']}, 06:19:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:19:54 INFO - 'tests': ['tsvgx', 06:19:54 INFO - 'tsvgr_opacity', 06:19:54 INFO - 'tart', 06:19:54 INFO - 'tscrollx', 06:19:54 INFO - 'cart']}, 06:19:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:19:54 INFO - 'tsvgr_opacity', 06:19:54 INFO - 'tart', 06:19:54 INFO - 'tscrollx', 06:19:54 INFO - 'cart']}, 06:19:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:19:54 INFO - 'talos_options': ['--disable-e10s'], 06:19:54 INFO - 'tests': ['tp5o']}, 06:19:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:19:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:19:54 INFO - 'talos_options': ['--disable-e10s', 06:19:54 INFO - '--xperf_path', 06:19:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:54 INFO - 'tests': ['tp5n']}, 06:19:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:19:54 INFO - 'talos_options': ['--xperf_path', 06:19:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:54 INFO - 'tests': ['tp5n']}}, 06:19:54 INFO - 'talos.zip': {'path': '', 06:19:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:19:54 INFO - Running post-action listener: _resource_record_post_action 06:19:54 INFO - [mozharness: 2016-11-23 14:19:54.012342Z] Finished populate-webroot step (success) 06:19:54 INFO - [mozharness: 2016-11-23 14:19:54.012475Z] Running create-virtualenv step. 06:19:54 INFO - Running pre-action listener: _resource_record_pre_action 06:19:54 INFO - Running main action method: create_virtualenv 06:19:54 INFO - Creating virtualenv /builds/slave/test/build/venv 06:19:54 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 06:19:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:19:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:19:54 INFO - Using real prefix '/tools/python27' 06:19:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:19:54 INFO - Installing distribute.............................................................................................................................................................................................done. 06:19:57 INFO - Installing pip.................done. 06:19:57 INFO - Return code: 0 06:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:19:57 INFO - Reading from file tmpfile_stdout 06:19:57 INFO - Output received: 06:19:57 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) 06:19:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:57 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 0x101b353f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8fb5cd8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10194bd30>, '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 0x1017b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101943b20>, '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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 06:19:57 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 06:19:57 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 06:19:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I8uYvJTBUD/Render', 06:19:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:57 INFO - 'HOME': '/Users/cltbld', 06:19:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:57 INFO - 'LOGNAME': 'cltbld', 06:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:57 INFO - 'MOZ_NO_REMOTE': '1', 06:19:57 INFO - 'NO_EM_RESTART': '1', 06:19:57 INFO - 'PAGER': '/bin/cat', 06:19:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:57 INFO - 'PWD': '/builds/slave/test', 06:19:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:57 INFO - 'SHELL': '/bin/bash', 06:19:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9D8OJPq4YE/Listeners', 06:19:57 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 06:19:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:57 INFO - 'USER': 'cltbld', 06:19:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:57 INFO - 'XPC_FLAGS': '0x0', 06:19:57 INFO - 'XPC_SERVICE_NAME': '0', 06:19:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:58 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 06:19:58 INFO - Cleaning up... 06:19:58 INFO - Return code: 0 06:19:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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', '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 0x101b353f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8fb5cd8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10194bd30>, '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 0x1017b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101943b20>, '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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 06:19: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:19: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 psutil>=3.1.1 06:19:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I8uYvJTBUD/Render', 06:19:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:58 INFO - 'HOME': '/Users/cltbld', 06:19:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:58 INFO - 'LOGNAME': 'cltbld', 06:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:58 INFO - 'MOZ_NO_REMOTE': '1', 06:19:58 INFO - 'NO_EM_RESTART': '1', 06:19:58 INFO - 'PAGER': '/bin/cat', 06:19:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:58 INFO - 'PWD': '/builds/slave/test', 06:19:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:58 INFO - 'SHELL': '/bin/bash', 06:19:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9D8OJPq4YE/Listeners', 06:19:58 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 06:19:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:58 INFO - 'USER': 'cltbld', 06:19:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:58 INFO - 'XPC_FLAGS': '0x0', 06:19:58 INFO - 'XPC_SERVICE_NAME': '0', 06:19:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:58 INFO - Downloading/unpacking psutil>=3.1.1 06:19:58 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 06:19:58 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 06:19:58 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 06:19:58 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 06:19:58 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 06:19:58 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 06:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:20:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:20:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:20:01 INFO - Installing collected packages: psutil 06:20:01 INFO - Running setup.py install for psutil 06:20:01 INFO - building 'psutil._psutil_osx' extension 06:20:01 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 06:20:02 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 06:20:02 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 06:20:02 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 06:20:02 INFO - building 'psutil._psutil_posix' extension 06:20:02 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 06:20:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:20:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:20:02 INFO - ^ 06:20:02 INFO - 1 warning generated. 06:20:02 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 06:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:20:02 INFO - Successfully installed psutil 06:20:02 INFO - Cleaning up... 06:20:03 INFO - Return code: 0 06:20:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b353f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8fb5cd8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10194bd30>, '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 0x1017b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101943b20>, '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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 06:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:20:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I8uYvJTBUD/Render', 06:20:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:03 INFO - 'HOME': '/Users/cltbld', 06:20:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:03 INFO - 'LOGNAME': 'cltbld', 06:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:03 INFO - 'MOZ_NO_REMOTE': '1', 06:20:03 INFO - 'NO_EM_RESTART': '1', 06:20:03 INFO - 'PAGER': '/bin/cat', 06:20:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:03 INFO - 'PWD': '/builds/slave/test', 06:20:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:03 INFO - 'SHELL': '/bin/bash', 06:20:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9D8OJPq4YE/Listeners', 06:20:03 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 06:20:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:03 INFO - 'USER': 'cltbld', 06:20:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:03 INFO - 'XPC_FLAGS': '0x0', 06:20:03 INFO - 'XPC_SERVICE_NAME': '0', 06:20:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:20:05 INFO - Installing collected packages: mozsystemmonitor 06:20:05 INFO - Running setup.py install for mozsystemmonitor 06:20:06 INFO - Successfully installed mozsystemmonitor 06:20:06 INFO - Cleaning up... 06:20:06 INFO - Return code: 0 06:20:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:06 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 0x101b353f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8fb5cd8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10194bd30>, '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 0x1017b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101943b20>, '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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 06:20:06 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 06:20:06 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 06:20:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I8uYvJTBUD/Render', 06:20:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:06 INFO - 'HOME': '/Users/cltbld', 06:20:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:06 INFO - 'LOGNAME': 'cltbld', 06:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:06 INFO - 'MOZ_NO_REMOTE': '1', 06:20:06 INFO - 'NO_EM_RESTART': '1', 06:20:06 INFO - 'PAGER': '/bin/cat', 06:20:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:06 INFO - 'PWD': '/builds/slave/test', 06:20:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:06 INFO - 'SHELL': '/bin/bash', 06:20:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9D8OJPq4YE/Listeners', 06:20:06 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 06:20:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:06 INFO - 'USER': 'cltbld', 06:20:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:06 INFO - 'XPC_FLAGS': '0x0', 06:20:06 INFO - 'XPC_SERVICE_NAME': '0', 06:20:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:06 INFO - Downloading/unpacking jsonschema==2.5.1 06:20: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 06:20: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 06:20: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 06:20: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 06:20: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 06:20: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 06:20:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:20:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:20: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 06:20: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 06:20: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 06:20: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 06:20: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 06:20: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 06:20:09 INFO - Downloading functools32-3.2.3-2.tar.gz 06:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:20:09 INFO - warning: no files found matching '*.txt' 06:20:09 INFO - no previously-included directories found matching 'build' 06:20:09 INFO - no previously-included directories found matching 'dist' 06:20:09 INFO - no previously-included directories found matching '.git*' 06:20:09 INFO - Installing collected packages: jsonschema, functools32 06:20:09 INFO - Running setup.py install for functools32 06:20:09 INFO - warning: no files found matching '*.txt' 06:20:09 INFO - no previously-included directories found matching 'build' 06:20:09 INFO - no previously-included directories found matching 'dist' 06:20:09 INFO - no previously-included directories found matching '.git*' 06:20:09 INFO - Successfully installed jsonschema functools32 06:20:09 INFO - Cleaning up... 06:20:09 INFO - Return code: 0 06:20:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101b353f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8fb5cd8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10194bd30>, '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 0x1017b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101943b20>, '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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 06:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:20:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I8uYvJTBUD/Render', 06:20:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:09 INFO - 'HOME': '/Users/cltbld', 06:20:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:09 INFO - 'LOGNAME': 'cltbld', 06:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:09 INFO - 'MOZ_NO_REMOTE': '1', 06:20:09 INFO - 'NO_EM_RESTART': '1', 06:20:09 INFO - 'PAGER': '/bin/cat', 06:20:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:09 INFO - 'PWD': '/builds/slave/test', 06:20:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:09 INFO - 'SHELL': '/bin/bash', 06:20:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9D8OJPq4YE/Listeners', 06:20:09 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 06:20:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:09 INFO - 'USER': 'cltbld', 06:20:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:09 INFO - 'XPC_FLAGS': '0x0', 06:20:09 INFO - 'XPC_SERVICE_NAME': '0', 06:20:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:20:09 INFO - Cleaning up... 06:20:09 INFO - Return code: 0 06:20:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101b353f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8fb5cd8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10194bd30>, '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 0x1017b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101943b20>, '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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 06:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:20:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I8uYvJTBUD/Render', 06:20:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:09 INFO - 'HOME': '/Users/cltbld', 06:20:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:09 INFO - 'LOGNAME': 'cltbld', 06:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:09 INFO - 'MOZ_NO_REMOTE': '1', 06:20:09 INFO - 'NO_EM_RESTART': '1', 06:20:09 INFO - 'PAGER': '/bin/cat', 06:20:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:09 INFO - 'PWD': '/builds/slave/test', 06:20:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:09 INFO - 'SHELL': '/bin/bash', 06:20:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9D8OJPq4YE/Listeners', 06:20:09 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 06:20:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:09 INFO - 'USER': 'cltbld', 06:20:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:09 INFO - 'XPC_FLAGS': '0x0', 06:20:09 INFO - 'XPC_SERVICE_NAME': '0', 06:20:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:10 INFO - Downloading/unpacking blobuploader==1.2.4 06:20:10 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 06:20:10 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 06:20:10 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 06:20:10 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 06:20:10 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 06:20:10 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 06:20:12 INFO - Downloading blobuploader-1.2.4.tar.gz 06:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:20:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:20:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:13 INFO - Downloading docopt-0.6.1.tar.gz 06:20:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:20:13 INFO - Installing collected packages: blobuploader, requests, docopt 06:20:13 INFO - Running setup.py install for blobuploader 06:20:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:20:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:20:14 INFO - Running setup.py install for requests 06:20:14 INFO - Running setup.py install for docopt 06:20:14 INFO - Successfully installed blobuploader requests docopt 06:20:14 INFO - Cleaning up... 06:20:14 INFO - Return code: 0 06:20:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:14 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 0x101b353f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8fb5cd8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10194bd30>, '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 0x1017b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101943b20>, '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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 06:20:14 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 06:20:14 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 06:20:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I8uYvJTBUD/Render', 06:20:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:14 INFO - 'HOME': '/Users/cltbld', 06:20:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:14 INFO - 'LOGNAME': 'cltbld', 06:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:14 INFO - 'MOZ_NO_REMOTE': '1', 06:20:14 INFO - 'NO_EM_RESTART': '1', 06:20:14 INFO - 'PAGER': '/bin/cat', 06:20:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:14 INFO - 'PWD': '/builds/slave/test', 06:20:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:14 INFO - 'SHELL': '/bin/bash', 06:20:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9D8OJPq4YE/Listeners', 06:20:14 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 06:20:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:14 INFO - 'USER': 'cltbld', 06:20:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:14 INFO - 'XPC_FLAGS': '0x0', 06:20:14 INFO - 'XPC_SERVICE_NAME': '0', 06:20:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:20:15 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-XyXZcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:20:15 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-49e8nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:20:15 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-XKWd8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:20:15 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-EN50Xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:20:15 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-QJe0xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:20:15 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-fRQTeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:20:15 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-eW8OM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:20:15 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-t5_zmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:20:15 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-UEuqGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:20:16 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-dO5FrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:20:16 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-L10h8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:20:16 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-CMeQSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:20:16 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-vtfUhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:20:16 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-civIIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:16 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-w6ME75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:20:16 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-9KDlTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:20:16 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-F2Bxp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:20:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:20:16 INFO - Running setup.py install for manifestparser 06:20:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:20:17 INFO - Running setup.py install for mozcrash 06:20:17 INFO - Running setup.py install for mozdebug 06:20:17 INFO - Running setup.py install for mozdevice 06:20:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:20:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:20:17 INFO - Running setup.py install for mozfile 06:20:17 INFO - Running setup.py install for mozhttpd 06:20:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:20:17 INFO - Running setup.py install for mozinfo 06:20:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:20:17 INFO - Running setup.py install for mozInstall 06:20:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:20:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:20:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:20:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:20:18 INFO - Running setup.py install for mozleak 06:20:18 INFO - Running setup.py install for mozlog 06:20:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:20:18 INFO - Running setup.py install for moznetwork 06:20:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:20:18 INFO - Running setup.py install for mozprocess 06:20:18 INFO - Running setup.py install for mozprofile 06:20:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:20:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:20:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:20:18 INFO - Running setup.py install for mozrunner 06:20:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:20:19 INFO - Running setup.py install for mozscreenshot 06:20:19 INFO - Running setup.py install for moztest 06:20:19 INFO - Running setup.py install for mozversion 06:20:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:20:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:20:19 INFO - Cleaning up... 06:20:19 INFO - Return code: 0 06:20:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:20:19 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')]} 06:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:19 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')]} 06:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:19 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 0x101b353f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8fb5cd8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10194bd30>, '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 0x1017b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101943b20>, '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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 06:20:19 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 06:20:19 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 06:20:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I8uYvJTBUD/Render', 06:20:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:19 INFO - 'HOME': '/Users/cltbld', 06:20:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:19 INFO - 'LOGNAME': 'cltbld', 06:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:19 INFO - 'MOZ_NO_REMOTE': '1', 06:20:19 INFO - 'NO_EM_RESTART': '1', 06:20:19 INFO - 'PAGER': '/bin/cat', 06:20:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:19 INFO - 'PWD': '/builds/slave/test', 06:20:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:19 INFO - 'SHELL': '/bin/bash', 06:20:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9D8OJPq4YE/Listeners', 06:20:19 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 06:20:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:19 INFO - 'USER': 'cltbld', 06:20:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:19 INFO - 'XPC_FLAGS': '0x0', 06:20:19 INFO - 'XPC_SERVICE_NAME': '0', 06:20:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:20:19 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-Zi9Ghx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:20:19 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)) 06:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:20:19 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-TYkXat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:20:19 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-dYVdNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:20:20 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)) 06:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:20:20 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-4Mvc_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:20:20 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-XQZvXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:20:20 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)) 06:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:20:20 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-nX8XDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:20:20 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)) 06:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:20:20 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-okEJhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:20:20 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)) 06:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:20:20 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-IPrmft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:20:20 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)) 06:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:20:20 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-tLbnFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:20:20 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)) 06:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:20:20 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-P8Am7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:20:20 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)) 06:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:20:20 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-8N0JsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:20:20 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)) 06:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:20:20 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-3DfL8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:20:21 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)) 06:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:20:21 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-uZefwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:20:21 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)) 06:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:20:21 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-5FQmyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:20:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:21 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-VhgrBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:21 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)) 06:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:20:21 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-VsM3LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:20:21 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)) 06:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:20:21 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-pzYg3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:20:21 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)) 06:20:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:20:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:20:21 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)) 06:20:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:20:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:20:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:24 INFO - Downloading blessings-1.6.tar.gz 06:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:20:24 INFO - Installing collected packages: blessings 06:20:24 INFO - Running setup.py install for blessings 06:20:24 INFO - Successfully installed blessings 06:20:24 INFO - Cleaning up... 06:20:24 INFO - Return code: 0 06:20:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:20:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:20:24 INFO - Reading from file tmpfile_stdout 06:20:24 INFO - Current package versions: 06:20:24 INFO - blessings == 1.6 06:20:24 INFO - blobuploader == 1.2.4 06:20:24 INFO - docopt == 0.6.1 06:20:24 INFO - functools32 == 3.2.3-2 06:20:24 INFO - jsonschema == 2.5.1 06:20:24 INFO - manifestparser == 1.1 06:20:24 INFO - mozInstall == 1.12 06:20:24 INFO - mozcrash == 1.0 06:20:24 INFO - mozdebug == 0.1 06:20:24 INFO - mozdevice == 0.49 06:20:24 INFO - mozfile == 1.2 06:20:24 INFO - mozhttpd == 0.7 06:20:24 INFO - mozinfo == 0.9 06:20:24 INFO - mozleak == 0.1 06:20:24 INFO - mozlog == 3.4 06:20:24 INFO - moznetwork == 0.27 06:20:24 INFO - mozprocess == 0.23 06:20:24 INFO - mozprofile == 0.28 06:20:24 INFO - mozrunner == 6.13 06:20:24 INFO - mozscreenshot == 0.1 06:20:24 INFO - mozsystemmonitor == 0.3 06:20:24 INFO - moztest == 0.7 06:20:24 INFO - mozversion == 1.4 06:20:24 INFO - psutil == 3.1.1 06:20:24 INFO - requests == 1.2.3 06:20:24 INFO - wsgiref == 0.1.2 06:20:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:20:24 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')]} 06:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:25 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 0x101b353f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8fb5cd8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10194bd30>, '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 0x1017b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101943b20>, '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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 06:20:25 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 06:20:25 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 06:20:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I8uYvJTBUD/Render', 06:20:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:25 INFO - 'HOME': '/Users/cltbld', 06:20:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:25 INFO - 'LOGNAME': 'cltbld', 06:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:25 INFO - 'MOZ_NO_REMOTE': '1', 06:20:25 INFO - 'NO_EM_RESTART': '1', 06:20:25 INFO - 'PAGER': '/bin/cat', 06:20:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:25 INFO - 'PWD': '/builds/slave/test', 06:20:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:25 INFO - 'SHELL': '/bin/bash', 06:20:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9D8OJPq4YE/Listeners', 06:20:25 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 06:20:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:25 INFO - 'USER': 'cltbld', 06:20:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:25 INFO - 'XPC_FLAGS': '0x0', 06:20:25 INFO - 'XPC_SERVICE_NAME': '0', 06:20:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:25 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)) 06:20:25 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)) 06:20:25 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)) 06:20:25 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)) 06:20:25 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)) 06:20:25 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)) 06:20:25 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)) 06:20:25 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)) 06:20:25 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)) 06:20:25 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)) 06:20:25 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)) 06:20:25 INFO - Cleaning up... 06:20:25 INFO - Return code: 0 06:20:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:26 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 0x101b353f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8fb5cd8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10194bd30>, '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 0x1017b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101943b20>, '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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 06:20:26 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 06:20:26 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 06:20:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I8uYvJTBUD/Render', 06:20:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:26 INFO - 'HOME': '/Users/cltbld', 06:20:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:26 INFO - 'LOGNAME': 'cltbld', 06:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:26 INFO - 'MOZ_NO_REMOTE': '1', 06:20:26 INFO - 'NO_EM_RESTART': '1', 06:20:26 INFO - 'PAGER': '/bin/cat', 06:20:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:26 INFO - 'PWD': '/builds/slave/test', 06:20:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:26 INFO - 'SHELL': '/bin/bash', 06:20:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9D8OJPq4YE/Listeners', 06:20:26 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 06:20:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:26 INFO - 'USER': 'cltbld', 06:20:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:26 INFO - 'XPC_FLAGS': '0x0', 06:20:26 INFO - 'XPC_SERVICE_NAME': '0', 06:20:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:20:26 INFO - Cleaning up... 06:20:26 INFO - Return code: 0 06:20:26 INFO - Running post-action listener: _resource_record_post_action 06:20:26 INFO - Running post-action listener: _start_resource_monitoring 06:20:26 INFO - Starting resource monitoring. 06:20:26 INFO - [mozharness: 2016-11-23 14:20:26.341010Z] Finished create-virtualenv step (success) 06:20:26 INFO - [mozharness: 2016-11-23 14:20:26.341963Z] Running install step. 06:20:26 INFO - Running pre-action listener: _resource_record_pre_action 06:20:26 INFO - Running main action method: install 06:20:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:20:26 INFO - Reading from file tmpfile_stdout 06:20:26 INFO - Detecting whether we're running mozinstall >=1.0... 06:20:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:20:26 INFO - Reading from file tmpfile_stdout 06:20:26 INFO - Output received: 06:20:26 INFO - Usage: mozinstall [options] installer 06:20:26 INFO - Options: 06:20:26 INFO - -h, --help show this help message and exit 06:20:26 INFO - -d DEST, --destination=DEST 06:20:26 INFO - Directory to install application into. [default: 06:20:26 INFO - "/builds/slave/test"] 06:20:26 INFO - --app=APP Application being installed. [default: firefox] 06:20:26 INFO - mkdir: /builds/slave/test/build/application 06:20:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:20:59 INFO - Reading from file tmpfile_stdout 06:20:59 INFO - Output received: 06:20:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:20:59 INFO - Running post-action listener: _resource_record_post_action 06:20:59 INFO - [mozharness: 2016-11-23 14:20:59.798154Z] Finished install step (success) 06:20:59 INFO - [mozharness: 2016-11-23 14:20:59.798262Z] Running run-tests step. 06:20:59 INFO - Running pre-action listener: _resource_record_pre_action 06:20:59 INFO - Running main action method: run_tests 06:20:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:20:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:20:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:20:59 INFO - 2016-11-23 06:20:59.812 screenresolution[1622:7462] starting screenresolution argv=screenresolution get 06:20:59 INFO - 2016-11-23 06:20:59.815 screenresolution[1622:7462] Display 0: 1600x1200x32@60 06:20:59 INFO - 2016-11-23 06:20:59.820 screenresolution[1623:7465] starting screenresolution argv=screenresolution list 06:20:59 INFO - Available Modes on Display 0 06:20:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:20:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:20:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:20:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:21:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:21:00 INFO - Intel Iris: 06:21:00 INFO - Chipset Model: Intel Iris 06:21:00 INFO - Type: GPU 06:21:00 INFO - Bus: Built-In 06:21:00 INFO - VRAM (Dynamic, Max): 1536 MB 06:21:00 INFO - Vendor: Intel (0x8086) 06:21:00 INFO - Device ID: 0x0a2e 06:21:00 INFO - Revision ID: 0x0009 06:21:00 INFO - Displays: 06:21:00 INFO - Display: 06:21:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:21:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:21:00 INFO - Display Serial Number: 1600x1200 60 06:21:00 INFO - Main Display: Yes 06:21:00 INFO - Mirror: Off 06:21:00 INFO - Online: Yes 06:21:00 INFO - Rotation: Supported 06:21:00 INFO - Return code: 0 06:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:21:00 INFO - Python 2.7.3 06:21:00 INFO - Return code: 0 06:21:00 INFO - grabbing minidump binary from tooltool 06:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:00 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 0x10194bd30>, '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 0x1017b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101943b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:21:00 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 06:21:00 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 06:21:00 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 06:21:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:21:00 INFO - Return code: 0 06:21:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:21:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:21:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:21:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:21:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0324', '--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 06:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0324 --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 06:21:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I8uYvJTBUD/Render', 06:21:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:00 INFO - 'HOME': '/Users/cltbld', 06:21:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:00 INFO - 'LOGNAME': 'cltbld', 06:21:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:21:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:00 INFO - 'MOZ_NO_REMOTE': '1', 06:21:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:21:00 INFO - 'NO_EM_RESTART': '1', 06:21:00 INFO - 'PAGER': '/bin/cat', 06:21:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:00 INFO - 'PWD': '/builds/slave/test', 06:21:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:21:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:00 INFO - 'SHELL': '/bin/bash', 06:21:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9D8OJPq4YE/Listeners', 06:21:00 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 06:21:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:00 INFO - 'USER': 'cltbld', 06:21:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:00 INFO - 'XPC_FLAGS': '0x0', 06:21:00 INFO - 'XPC_SERVICE_NAME': '0', 06:21:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0324', '--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 06:21:00 INFO - mozversion application_buildid: 20161123024236 06:21:00 INFO - mozversion application_changeset: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 06:21:00 INFO - mozversion application_display_name: Nightly 06:21:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:21:00 INFO - mozversion application_name: Firefox 06:21:00 INFO - mozversion application_remotingname: firefox 06:21:00 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 06:21:00 INFO - mozversion application_vendor: Mozilla 06:21:00 INFO - mozversion application_version: 53.0a1 06:21:00 INFO - mozversion platform_buildid: 20161123024236 06:21:00 INFO - mozversion platform_changeset: e5ed1abefc08d819a0f1d5d78ba961ff07ec1ae7 06:21:00 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 06:21:00 INFO - mozversion platform_version: 53.0a1 06:21:00 INFO - using testdate: 1479910860 06:21:00 INFO - actual date: 1479910860 06:21:00 INFO - starting webserver on 'localhost:49237' 06:21:00 INFO - SUITE-START | Running 2 tests 06:21:00 INFO - TEST-START | dromaeo_css 06:21:00 INFO - operating with platform_type : mac_ 06:21:00 INFO - Initialising browser for dromaeo_css test... 06:21:00 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmp1JqRZL/profile http://localhost:49237/getInfo.html) 06:21:03 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 06:21:03 INFO - PROCESS | 1633 | colorDepth:24 06:21:03 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 06:21:03 INFO - PROCESS | 1633 | __metrics 06:21:03 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:21:03 INFO - PROCESS | 1633 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:21:04 INFO - TEST-INFO | 1633: exit 0 06:21:04 INFO - Browser initialized. 06:21:04 INFO - Running cycle 1/1 for dromaeo_css test... 06:21:04 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmp1JqRZL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:16 INFO - PROCESS | 1635 | RSS: Main: 244248576 06:21:16 INFO - PROCESS | 1635 | 06:22:07 INFO - PROCESS | 1635 | 1479910927440 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] 06:24:20 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 06:24:23 INFO - PROCESS | 1635 | RSS: Main: 475942912 06:24:23 INFO - PROCESS | 1635 | 06:27:26 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 06:27:27 INFO - PROCESS | 1635 | RSS: Main: 372899840 06:27:27 INFO - PROCESS | 1635 | 06:30:29 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 06:30:30 INFO - PROCESS | 1635 | RSS: Main: 344190976 06:30:30 INFO - PROCESS | 1635 | 06:33:32 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 06:33:33 INFO - PROCESS | 1635 | RSS: Main: 354975744 06:33:33 INFO - PROCESS | 1635 | 06:36:36 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 06:36:37 INFO - PROCESS | 1635 | RSS: Main: 335552512 06:36:37 INFO - PROCESS | 1635 | 06:39:40 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 06:39:41 INFO - PROCESS | 1635 | RSS: Main: 378368000 06:39:41 INFO - PROCESS | 1635 | 06:39:41 INFO - PROCESS | 1635 | __start_tp_report 06:39:41 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 06:39:41 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 06:39:41 INFO - PROCESS | 1635 | |i|pagename|runs| 06:39:41 INFO - PROCESS | 1635 | |0;dojo.html;3250.122466933928;3269.738420926326;3279.3113446176308;3297.505374193869;3313.536104945308;5453.318335208094;5476.452354764521;5498.505134537891;5520.420355862631;5573.888522229553;4960.950390496103;5518.475744804237;5519.089350257203;5592.888142237153;5601.103823388259;4897.412310522743;5057.963117560909;5102.234664800272;5103.770330335125;5158.097332966735;5111.233315002761;5182.792688292464;5194.039102766001;5214.348206474191;5249.632525723201;4964.975175124137;5080.949190508085;5088.109580823341;5108.233764935252;5199;5033.798648054073;5082.644214904958;5085.720285384303;5093.388793344785;5095.898082038376;4963.726995015273;5028.421731500887;5032;5045.772940217662;5065.696058236481;5505.504504594565;5505.724713764296;5517.531009864127;5524.696141712204;5531.446855314477;5889.381614930457;5907.438793314628;5911.379305172938;5917.822465326047;5938.465538101548;5953.315368732608;5977.790777322816;5992;5994.370591087916;6004.519638428916;5521.503064724154;5579.804706835323;5590.413006634286;5594.468525490072;5595.580331475156;6183.907241391383;6223.159873417121;6228.844278893064;6292;6307.432331090224;5896.911546326808;5910.615809972338;5916.881662366729;5933.851653708692;5949.524038076944;4911.729854857946;5961.2846458425265;5962.34414214436;5973;6087.208662873798;4982.476839931827;5966.940330596639;5976.013957697019;5994.340622531518;6005.669688167105;5891.528677705774;5928.881422371528;5945.821625351246;5950.85122871923;5956.493698035715;4701.623870090384;4758.310045043519;4769.117713223065;4774.474807771142;4787.569118779326;4256.6807489438415;4296.591823776736;4322.740635561876;4355.651547876226;4360.585744354281;5684.175794509773;5690.2887139107615;5761.423857614205;5775.88448231033;5795.88408231833;6103.969480152571;6109.327973922865;6119.632822030692;6122.234720659918;6133.601315914451;5687.829365119053;5699.772009119672;5754.712264386764;5763.625364351304;5785.987452195849;5130.871728206825;5182.585393168612;5188.844334669966;5200.869978250574;5241.868953276123;6304.369563043659;6337.207849018872;6353.841153971003;6363.5545511813725;6378.617282963037;4840;5990.910136347871;6104.38956104386;6107.175531303217;6137.938620613915;6178.752849885954;6242.313345531897;6242.500599952084;6254.21822272216;6341.873162536631;5962.105684147413;5982.730777115127;6003.8198854034445;6030.005049166838;6043.244594425697;6045.093236014633;6081.878362432815;6082.11809287642;6085.543584231112;6087.965045942289;5674.2623458950075;5726.742296596746;5776.56675749312;5885.941140588539;5896.587238893237;5797.449242321973;5813.09896965971;5836.503897168788;5848.122781582797;5890.852728681646;5495.587830912617;5684.488396044376;5708.514776244066;5708.971455142698;5721.256236689203;5799.4780469757925;5835.037218859011;5847.912281315868;5866.50134738552;5911.940880591139;5711.942880571141;5712.7714891403875;5734.913976290442;5738.598298119092;5747.367789543064 06:39:41 INFO - PROCESS | 1635 | |1;ext.html;473.92891066340036;508.28078269249016;513.6789506558401;536.0725944116681;536.1635848077;37808.81095594521;38947.22105557887;38953.41569876454;39094.80452597733;39210.0197495062;36762.26475470489;37540.43689344662;40878.795606022;41057.7947110264;41121.794391028;8339.708110216143;9215.677451289206;9372.8594071089;9383.765405864873;9385.812283754354;8352.872362231112;11001.944990275077;11248.26886252395;11272.66182014541;11479.311241325548;11035.282706624044;11092.223544351898;11097.889021109806;11114.49984750684;11122.55509779608;8378.958105209435;8570.742877713616;11054.557817687282;11122.61070862524;11137.387443690593;8458.830823383498;8529.616167272488;10812.080973117294;11090.500927458284;11100.000999910048;38427.42358864619;38834.61165388338;38851.611483885084;38906;38919.61080389217;3246.2209069823307;3292.42382583047;3316.8839090631714;3471.179564685648;3521.9647803521893;28984.855075724696;29560.40879182426;30215.09354719362;30224.24439389011;30273.394532109454;3233.0300909727225;3238.740900727936;3295.340931813647;3327.96672033279;3329;447850;468745;472588.6370568125;473130;475036.2496375061;56636.43363566394;56913.14630280549;56966.7151664239;56983;57016;60493.69753151294;60615.09077363843;60622.69688651529;60634.09048864271;60692.69653651792;15352.846471535142;15582.298796554182;15587.142707150988;15590.9220453897;15597.766033509506;11009.779804403866;11171.497282622302;12128.939355303344;12168.939155304166;12172.513099475922;14598.854011459962;19006.429807105807;19217.61564768697;19352.129154188096;19434.416967490997;6643.2028156620545;7783.455158138876;7870.881936770953;7884.763457096296;7899.881501777478;861.7156338408311;947.8672985781996;976.345848281653;1083.707399002265;1112.8887111288968;28520;29608.963641354614;29651.569336502944;29946.850265748533;30334.241643959078;1033.9379637221791;1099.9175061870392;1118.6532175025768;1150.7813515432042;1178.9174757766873;14100.788488172686;15183.468578599695;15198.544043678707;15217.695646087017;15497.612559686098;623856;628718;630343.5104962988;631047;830493;47190.76404617955;55192.44807551953;56020;56074.158887616715;59397.51506212379;1303.5633062923837;1335.4858379523953;1348.43365786368;1349.568138195768;1351.709382482771;29918.102456926328;30176.813753180108;30262.69737302599;30333.393332133674;30886.91895783637;49569.00861982812;50022.49977500179;50104.248436272755;50126.74936625294;50158.749206253735;550581;550974;551349;552721;560545;40362;40366.59633403746;40865.1826963465;41010.58989410187;41090.58909410868;44463.77768111139;45317;45575;45724.54275457203;45784;37633.2473350537;38177.809110954266;38205.61794382021;38638.80680596579;38775.80612096922;29712.70287297186;30899.69100308968;37821.62178378181;38453;38545.807270963465;36186.73346432862;36788.08029799276;37319;37356.06609834776;37729.43405848969;29608.703912961457;31741.8412907934;32321.676783231866;33832.830835846646;34511.30977380489;23578.17476388318;24487.020519179034;24527.264182074567;24862.07687779901;25044.874775626733 06:39:41 INFO - PROCESS | 1635 | |2;jquery.html;348.16961546711116;365.4664190282188;369.92601479704047;377.1608171817706;400.6594394764451;13734.381952812122;14585.416583336668;19783.208671653152;19936.70094948577;20739.481512962182;16970.23633936473;20083.899580502115;20639.587208255827;20703.17187312506;20946.581068378622;5642.915356269649;5935.9703201483935;5981.282246130449;5998.7600495980105;6002.369751176129;4178.35235538492;4336.8265269389185;4410.62509686677;5850.210221620069;5899.852503687399;4417.425734654506;5871;6299.307076221612;6589.571677840925;6599.934000660004;6313.842153946142;6426.8714625707225;6560.048792925047;6579.901301480481;6583.93416065838;5693.003724348223;5693.231413759131;5695.316562012544;5696.715164241771;5714.171445140473;24263.63604545933;24392.87803560971;25147;25573;25608.615870761954;2358.2925122463193;2411;2420.479596886678;2420.673209116764;2446.2661201639617;14818.333175007043;15475.690486190326;15625.531234062997;15644.68710625781;16196;1770.6104656975574;1771.9557011074826;1836.2746715047615;1844.8062953389835;1883.4914573065332;112998.52511061703;117201;117706;117789.41105294504;118290;10456.477176141163;10490.580376784996;10816.295926018496;10940.288881222696;11086.501107450184;11925.34410607425;12048.33734144613;12630.684232894251;12649.810252846215;12650.177738446971;8194.385421093442;8262.752117436487;8375.539345336065;8529.061803201643;8548.829023419621;6728.865422691519;6955.304469553004;8373.336513710421;8393.328533717287;8577.699780507652;5625.059354522683;6480.611163330215;6498.447631951242;6631.535792494576;6645.435138013323;1788.7942886568212;1829.3748470943972;1832.7525784019253;1834.238790901761;1836.97244541332;822.9300509456643;888.4979986307716;911.1799380557551;978.5938835383379;1019.9796004079877;21433.035513401934;22232.444188895406;22257.3322800313;22299;22301.107955681917;952.6475204174361;973.5132433783108;973.532704301939;992.0922356044283;994.1847684898314;10973.561057557608;11373.31760094397;11763.705907352214;11774.175807693551;11813.11401644863;547493;556618;557416.2129189409;563383;573254;107066;108104;108260.91739082665;113952;114061;957.1242313283268;1013.7009582173276;1014.2950649298814;1039.8076355874186;1044.336846102715;18887.622247555246;19172;19399.515012124808;19430.708539371637;19484.610307793482;51152;51931.48068519266;52300.73849630728;52369.214461783864;52824.735876320374;71320.64339678269;72259.63870180615;72798;72847.63576182086;74186.51626967538;7780.649870755717;8066.7579972600915;8089.797755056171;8110.270075693216;8356.707515236938;11156;13155.144915580457;13178.472861085449;13628.591142265748;13675;10804.621838235624;11502.309861408008;11533.769324613293;11822.82265765997;11952.223105498115;11407.828882566933;11444.885551144382;11470.254433461798;11625.593104241649;11802.645920622395;11601.477933492844;11685;11886.34625095628;11990.520379185084;12088.697782555506;7888.447808653339;8114;8114.43198976066;8315.376346774137;8318.584070796314;11437.485313161094;11452.026577740651;11685.649430517098;11800.108973301596;11831.822522661994 06:39:41 INFO - PROCESS | 1635 | |3;mootools.html;1341.2697620070098;1470.037125682678;1504.3756840911021;1664.9667006659868;1842.9907850460745;7303.415726741861;7693.269139431752;8047.718329858449;8312.584370781451;8320.33437325014;8193.672253109884;8274.089850116497;8279.958600207006;8288;8292.958535207315;1705.3775371989198;1909.2458478900826;2278.8290878184202;2282.543491301738;2290.4617414907484;2086.259377920839;2229.9219527316545;2300.5858945389823;2311.768823117683;2319.431739223884;2262.1856131792542;2271.7501074881748;2272.397814579138;2273.124846933934;2277.39648993017;2236.206146817881;2255.785700358463;2259.401258666455;2261.8303627228024;2262.6832243485924;2237.339984704516;2280.281711260964;2280.361498780344;2282.0301371917035;2283.9885800571055;8291.170882911721;8327.625256863455;8421.70524031656;8422.957885210595;8456.196661317226;4246.830126794925;5183.377994640668;5199.246109314128;5202.895942081175;5204.531592156724;3255.251292202783;3457.2048428861503;3537.8407971641336;3540.5751309842726;3544.946825797615;980.5881529757519;1016.5323950982557;1017.277732809706;1025.52825700178;1081.2755453845941;10854.728631784268;10855.728606784893;10857.837132443019;10867.782644347148;10872.293300935493;4410.713303635253;4421.9336709949375;4601.792919318638;4648.302754586772;4658.510856360102;9393.859092113624;9418.434893906388;9425.528723563795;9433.433993960385;9477.573509192103;5174.637775355689;5177.559907407837;5182.326297581366;5187.325647665779;5187.870303242374;4273.188094262143;4390.3414487827085;4421.53573874745;4662.160811054043;4668.323093151474;3508.561429821272;3670.632936706308;3706.5737440194184;3810.237952409529;3816.5038544988975;1238.9256644601173;1241.1932244041445;1243.1173866554848;1254.6976298492186;1255.7174635706892;786.2609147401539;832.3923535818886;862.1809281182776;873.8601823708176;924.7503174142944;5554.166874968787;5570.637908535932;5658.74535645897;5663.292088488939;5820.3888591698105;764.9885251721229;882.4705176893813;906.392716879679;939.1031564855547;945.7919257763281;3724.5530536335273;3762.9059273518383;3806.410006449005;3842.442845787345;3844.6732027777953;9588.904110958802;10063.5471403787;10075;10080.899191008142;10086.646967356108;10031.896491385942;10036.347637403545;10044.29689921713;10054.145397641136;10062.949685251528;6101.60339577926;7515.8496830063095;7695.076590809139;7703.922960770433;7793.324435246449;5003.074431230234;5545.750441230073;5677.489025987681;5692.231548740867;5887.970560147171;9246.4914429707;9272.72181834546;9292.907070929205;9318.394304370195;9499.667511637059;8792.47245165292;9066.594677824947;9452.527373631428;9576.521173941135;9594.18449431806;6625.635590042594;7101.502894797314;7238.203797582157;7240.456965727697;7246.5289756165685;7393.8151546211775;7630.8092297693;7884.1327453978865;7901.130875603794;8023.277904988579;6384.87230255383;7053.0830991970715;7138.535995160298;7206.83794861529;7307.890381644386;6986.441084713312;7000.334968178015;7048.400885924754;7099.574025558483;7119.252478489684;6410.967945160431;6578.342165783383;6637.933620663925;6649.60102393858;6725.125733654593;4381.802818873095;4808.269023151733;4808.807647694193;4878.536539028786;4962.776675049704;4764.737939413366;4768.499307572655;4898.902021959612;4963.354763880672;5043.596512279082 06:39:41 INFO - PROCESS | 1635 | |4;prototype.html;266.568159581478;292.5786866911647;297.60715855071317;301.6726851366267;308.4155525279595;4564.657650676204;4941.505849415061;4989.600831933446;5016.749162541872;5020.899582008362;4438.489573699026;4601.447826260845;4681;4707.293905914106;4826.806927722896;3764.1442539124496;3805.6574908258253;3829.782982294879;3873.573906870242;3904.7852368119743;3878.2437424702193;3881.4371916072155;3889.9805500972457;3894.7273690841653;3900.2979463696524;3245.7241134503597;3321.80069195849;3352.5306457096026;3609.2934852549633;3697.0018095114438;3823.541175058983;3831.578526362098;3834.9866320181986;3847.5960024197616;3855.267499175148;3374.24539239594;3387.813670248135;3388.3731509670542;3392.0841372829445;3405.2848901730667;4709.202130516109;4852.344933434012;4858.854234372974;4874.756262186912;4886.291487734258;4030.717849750519;4223.936640950388;4265.936010959838;4313.749012786288;4340.0740159918405;5115.590752739772;5146.401067460945;5156.510131537498;5161.793528258865;5164.690118592896;3666.853325866962;3673.1000904778234;3684.889453316405;3691.298653255873;3695.002349365683;5107.785798687325;5376.274202982626;5393.730313484389;5404.1083221268445;5419.3225846769155;3557.7153827693724;3733.2720119576966;3734.7572407793405;3735.4210097434943;3737.6075512071384;3430.2110514581786;3570.6072332043454;3771.5474143102456;3804.2500449793406;3804.5814960354337;3778.263238668488;4147.52303485097;4161.77227717824;4295.355696645465;4309.59058889405;5000.474950130257;5161.406438259573;5169.776995891727;5186.611004174702;5187.896242075138;999.9600015999424;1011.600417834951;1012.9949350253202;1220.1215125109907;1223.8164275358768;674.2717864706106;797.6330887791565;837.6858677995751;877.1141147441131;885.3271513649544;4015.7751885674566;4039.0111317624746;4039.8990025249605;4238.915221695549;4646.721196728207;4873.537013983737;4975.875603109879;5006.374203224597;5048.268001139814;5049.621278404061;4304.612584867315;4594.839180628662;4665.626749860003;4674;4702.31816386622;2243.6971008913915;2363.168544378086;2609.595512695535;2611.764941155305;2612.2555071804823;4547.886302842389;5204.5576126028955;5224.782508814498;5236.345456817898;5237.580993520509;4194.706370554032;4592.494825569184;4606.98646297814;5059.367579052619;5578.931587626789;5033.270175824485;5719.857003574777;5726.513246374022;5740.770369185186;5783.450572195718;5392.110301800316;5407.485903946901;5411.269478620493;5461.644993075437;5469.890602187855;4570.9029832839215;5053.599535255512;5228.8757917048015;5270.7101109439345;5318.680879147263;4739.502352253102;5126.410462796826;5156.819511317086;5677.403872593318;5749.482546570829;3146.7639927005107;3545.5535680380453;3638.8523926802595;3646.5259516262718;3751.9624803752704;4416.779161041871;5349.4650534946195;5361.490658387447;5395.244665746877;5434.619576629598;4402.5597440255715;4521.97739011316;4576.88557786058;5061.190209566599;5129.461406552407;5281.075811732854;5285.735713214401;5304.363476382859;5340.332458442695;5340.93181363721;4835.564799168092;4876.634252431011;5128.974355128201;5153.727383111676;5188.766505507337;5118.948810511996;5141.2288156776785;5155.355580552431;5255.343082114736;5274.261603375608;4201.264778663783;4237.5762423758615;4485.46174459067;5083.38999320084;5124.256982737556 06:39:41 INFO - PROCESS | 1635 | |5;yui.html;673.2863165045053;718.971241150354;722.032476481515;751.6692655231699;757.2881491398089;11622;12281.631551053482;14792.260386980663;14869.553913382615;14877.925610371947;12216.755664886698;12885.613431597043;13326.533571325006;13570.050096493225;13571.52499662512;651.9837004074889;671.8824205763996;675.0987431778557;680.2619158213345;806.753940048285;675.8918573028317;814.1939479914901;823.115151212446;824.7278398128633;825.8307047055339;886.175856453498;886.7251152142824;887.8401887660218;890.6838072484239;890.8530092534724;881.6737807011383;881.7178502879082;882.5895958379352;882.748416701237;885.3050355470989;508.6032894342382;524.897644959233;624.1137584629837;639.4724352409281;654.0548906829633;14170.008099433044;14203.502877399242;14214.076085054437;14214.076085054541;14224.431022759078;12996.805047924288;13111.737765244641;13378.531751388655;13382.598522044354;13432.395542200527;12109.757804843943;12234.388280585936;12262.325572093621;12273;12324.568640097643;4273.679474039428;4309.547497512747;4359.476862776455;4419.0940857124215;4556;72724.63637681778;74854.87717684293;80604;82100.61094501463;85239.57380213121;8592.52741099233;9258.490783006999;10371;10389.792204156025;10963.83554246687;19994.400167994983;20033.09851056706;20202.191912323342;20203.898980505004;20478.488037798877;7681.347085497683;7728.033995750531;7780.49426787257;7829.686812527549;7847.411444141712;3710.5361829771277;3993.66053885423;4185.434966279574;4199.580041995776;4372.978135109304;3297.3405318936307;3348.9665103348657;3409.4033544130175;3416.3850506908993;3447.6552344765323;618.7865186510646;628.9371062893674;633.2970402852922;642.3448082955452;652.5138771615177;596.7195418153461;599.4185639929261;619.44250174843;653.5784419049686;672.1832972937904;8584.270337021424;9034.19340050425;9073.77315567103;9105.954470227607;9143.679971200976;550.243415303957;566.3486989961577;590.9519789442371;606.5056978562545;681.4071757570945;3901.31726947783;4301.526832048472;4481.663875209372;4558.361829343895;4562.133194692998;95546.04453955371;99442.5027874856;100003.49998250107;101542.49228753809;119580.60838783176;84026.15973840306;84830;87233;88711;89291;79227;79258.20741792624;79636.60181699054;82036.48799315975;82880;6673.899891501728;8301.750947471586;8648.740537783877;8749.606267717842;9318.440893546409;43405.13189736251;50264;52051.2192317108;54554;55388.169177463176;61374;65864.34135658582;71506.64246678734;72980;76614.61692691724;12014.63956081319;12202.96274816615;12258.387080646111;12669;12771.552995645108;13821.861781382058;14002.57992260234;14042.438302468196;14300.856991429953;14753.852461475677;12993.480260789462;13001.934990324988;13071.542496012595;13322.933385333012;13550.39023243976;12914.547990820276;12915.741685166431;13010.349482525646;13503.459861605426;13711.382987765774;12677.429515671633;12863.935680321538;12881.8067728986;12983.221006739626;13019.869801301866;10746.355218686904;10888.183386245904;11109.666709998713;11310.377929213972;11331.716707082389;10817.18871084656;10868.402237876993;10958.945205273923;11035.613753518588;11098.389588572705 06:39:41 INFO - PROCESS | 1635 | __end_tp_report 06:39:41 INFO - PROCESS | 1635 | __start_cc_report 06:39:41 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,2843 06:39:41 INFO - PROCESS | 1635 | __end_cc_report 06:39:41 INFO - PROCESS | 1635 | __startTimestamp1479911981102__endTimestamp 06:39:41 INFO - PROCESS | 1635 | 06:39:41 INFO - PROCESS | 1635 | ------- Summary: start ------- 06:39:41 INFO - PROCESS | 1635 | Number of tests: 6 06:39:41 INFO - PROCESS | 1635 | 06:39:41 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5563.19 Median:5738.60 stddev:624.27 (10.9%) stddev-sans-first:599.24 06:39:41 INFO - PROCESS | 1635 | Values: 3250.1 3269.7 3279.3 3297.5 3313.5 5453.3 5476.5 5498.5 5520.4 5573.9 4961.0 5518.5 5519.1 5592.9 5601.1 4897.4 5058.0 5102.2 5103.8 5158.1 5111.2 5182.8 5194.0 5214.3 5249.6 4965.0 5080.9 5088.1 5108.2 5199.0 5033.8 5082.6 5085.7 5093.4 5095.9 4963.7 5028.4 5032.0 5045.8 5065.7 5505.5 5505.7 5517.5 5524.7 5531.4 5889.4 5907.4 5911.4 5917.8 5938.5 5953.3 5977.8 5992.0 5994.4 6004.5 5521.5 5579.8 5590.4 5594.5 5595.6 6183.9 6223.2 6228.8 6292.0 6307.4 5896.9 5910.6 5916.9 5933.9 5949.5 4911.7 5961.3 5962.3 5973.0 6087.2 4982.5 5966.9 5976.0 5994.3 6005.7 5891.5 5928.9 5945.8 5950.9 5956.5 4701.6 4758.3 4769.1 4774.5 4787.6 4256.7 4296.6 4322.7 4355.7 4360.6 5684.2 5690.3 5761.4 5775.9 5795.9 6104.0 6109.3 6119.6 6122.2 6133.6 5687.8 5699.8 5754.7 5763.6 5786.0 5130.9 5182.6 5188.8 5200.9 5241.9 6304.4 6337.2 6353.8 6363.6 6378.6 4840.0 5990.9 6104.4 6107.2 6137.9 6178.8 6242.3 6242.5 6254.2 6341.9 5962.1 5982.7 6003.8 6030.0 6043.2 6045.1 6081.9 6082.1 6085.5 6088.0 5674.3 5726.7 5776.6 5885.9 5896.6 5797.4 5813.1 5836.5 5848.1 5890.9 5495.6 5684.5 5708.5 5709.0 5721.3 5799.5 5835.0 5847.9 5866.5 5911.9 5711.9 5712.8 5734.9 5738.6 5747.4 06:39:41 INFO - PROCESS | 1635 | 06:39:41 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:69500.31 Median:37681.34 stddev:152765.41 (405.4%) stddev-sans-first:153106.05 06:39:41 INFO - PROCESS | 1635 | Values: 473.9 508.3 513.7 536.1 536.2 37808.8 38947.2 38953.4 39094.8 39210.0 36762.3 37540.4 40878.8 41057.8 41121.8 8339.7 9215.7 9372.9 9383.8 9385.8 8352.9 11001.9 11248.3 11272.7 11479.3 11035.3 11092.2 11097.9 11114.5 11122.6 8379.0 8570.7 11054.6 11122.6 11137.4 8458.8 8529.6 10812.1 11090.5 11100.0 38427.4 38834.6 38851.6 38906.0 38919.6 3246.2 3292.4 3316.9 3471.2 3522.0 28984.9 29560.4 30215.1 30224.2 30273.4 3233.0 3238.7 3295.3 3328.0 3329.0 447850.0 468745.0 472588.6 473130.0 475036.2 56636.4 56913.1 56966.7 56983.0 57016.0 60493.7 60615.1 60622.7 60634.1 60692.7 15352.8 15582.3 15587.1 15590.9 15597.8 11009.8 11171.5 12128.9 12168.9 12172.5 14598.9 19006.4 19217.6 19352.1 19434.4 6643.2 7783.5 7870.9 7884.8 7899.9 861.7 947.9 976.3 1083.7 1112.9 28520.0 29609.0 29651.6 29946.9 30334.2 1033.9 1099.9 1118.7 1150.8 1178.9 14100.8 15183.5 15198.5 15217.7 15497.6 623856.0 628718.0 630343.5 631047.0 830493.0 47190.8 55192.4 56020.0 56074.2 59397.5 1303.6 1335.5 1348.4 1349.6 1351.7 29918.1 30176.8 30262.7 30333.4 30886.9 49569.0 50022.5 50104.2 50126.7 50158.7 550581.0 550974.0 551349.0 552721.0 560545.0 40362.0 40366.6 40865.2 41010.6 41090.6 44463.8 45317.0 45575.0 45724.5 45784.0 37633.2 38177.8 38205.6 38638.8 38775.8 29712.7 30899.7 37821.6 38453.0 38545.8 36186.7 36788.1 37319.0 37356.1 37729.4 29608.7 31741.8 32321.7 33832.8 34511.3 23578.2 24487.0 24527.3 24862.1 25044.9 06:39:41 INFO - PROCESS | 1635 | 06:39:41 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:33400.17 Median:2384.65 stddev:93200.62 (3908.4%) stddev-sans-first:93429.03 06:39:41 INFO - PROCESS | 1635 | Values: 348.2 365.5 369.9 377.2 400.7 13734.4 14585.4 19783.2 19936.7 20739.5 16970.2 20083.9 20639.6 20703.2 20946.6 5642.9 5936.0 5981.3 5998.8 6002.4 4178.4 4336.8 4410.6 5850.2 5899.9 4417.4 5871.0 6299.3 6589.6 6599.9 6313.8 6426.9 6560.0 6579.9 6583.9 5693.0 5693.2 5695.3 5696.7 5714.2 24263.6 24392.9 25147.0 25573.0 25608.6 2358.3 2411.0 2420.5 2420.7 2446.3 14818.3 15475.7 15625.5 15644.7 16196.0 1770.6 1772.0 1836.3 1844.8 1883.5 112998.5 117201.0 117706.0 117789.4 118290.0 10456.5 10490.6 10816.3 10940.3 11086.5 11925.3 12048.3 12630.7 12649.8 12650.2 8194.4 8262.8 8375.5 8529.1 8548.8 6728.9 6955.3 8373.3 8393.3 8577.7 5625.1 6480.6 6498.4 6631.5 6645.4 1788.8 1829.4 1832.8 1834.2 1837.0 822.9 888.5 911.2 978.6 1020.0 21433.0 22232.4 22257.3 22299.0 22301.1 952.6 973.5 973.5 992.1 994.2 10973.6 11373.3 11763.7 11774.2 11813.1 547493.0 556618.0 557416.2 563383.0 573254.0 107066.0 108104.0 108260.9 113952.0 114061.0 957.1 1013.7 1014.3 1039.8 1044.3 18887.6 19172.0 19399.5 19430.7 19484.6 51152.0 51931.5 52300.7 52369.2 52824.7 71320.6 72259.6 72798.0 72847.6 74186.5 7780.6 8066.8 8089.8 8110.3 8356.7 11156.0 13155.1 13178.5 13628.6 13675.0 10804.6 11502.3 11533.8 11822.8 11952.2 11407.8 11444.9 11470.3 11625.6 11802.6 11601.5 11685.0 11886.3 11990.5 12088.7 7888.4 8114.0 8114.4 8315.4 8318.6 11437.5 11452.0 11685.6 11800.1 11831.8 06:39:41 INFO - PROCESS | 1635 | 06:39:41 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5394.20 Median:5176.10 stddev:2977.56 (57.5%) stddev-sans-first:2970.33 06:39:41 INFO - PROCESS | 1635 | Values: 1341.3 1470.0 1504.4 1665.0 1843.0 7303.4 7693.3 8047.7 8312.6 8320.3 8193.7 8274.1 8280.0 8288.0 8293.0 1705.4 1909.2 2278.8 2282.5 2290.5 2086.3 2229.9 2300.6 2311.8 2319.4 2262.2 2271.8 2272.4 2273.1 2277.4 2236.2 2255.8 2259.4 2261.8 2262.7 2237.3 2280.3 2280.4 2282.0 2284.0 8291.2 8327.6 8421.7 8423.0 8456.2 4246.8 5183.4 5199.2 5202.9 5204.5 3255.3 3457.2 3537.8 3540.6 3544.9 980.6 1016.5 1017.3 1025.5 1081.3 10854.7 10855.7 10857.8 10867.8 10872.3 4410.7 4421.9 4601.8 4648.3 4658.5 9393.9 9418.4 9425.5 9433.4 9477.6 5174.6 5177.6 5182.3 5187.3 5187.9 4273.2 4390.3 4421.5 4662.2 4668.3 3508.6 3670.6 3706.6 3810.2 3816.5 1238.9 1241.2 1243.1 1254.7 1255.7 786.3 832.4 862.2 873.9 924.8 5554.2 5570.6 5658.7 5663.3 5820.4 765.0 882.5 906.4 939.1 945.8 3724.6 3762.9 3806.4 3842.4 3844.7 9588.9 10063.5 10075.0 10080.9 10086.6 10031.9 10036.3 10044.3 10054.1 10062.9 6101.6 7515.8 7695.1 7703.9 7793.3 5003.1 5545.8 5677.5 5692.2 5888.0 9246.5 9272.7 9292.9 9318.4 9499.7 8792.5 9066.6 9452.5 9576.5 9594.2 6625.6 7101.5 7238.2 7240.5 7246.5 7393.8 7630.8 7884.1 7901.1 8023.3 6384.9 7053.1 7138.5 7206.8 7307.9 6986.4 7000.3 7048.4 7099.6 7119.3 6411.0 6578.3 6637.9 6649.6 6725.1 4381.8 4808.3 4808.8 4878.5 4962.8 4764.7 4768.5 4898.9 4963.4 5043.6 06:39:41 INFO - PROCESS | 1635 | 06:39:41 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4201.71 Median:4656.17 stddev:1288.48 (27.7%) stddev-sans-first:1257.79 06:39:41 INFO - PROCESS | 1635 | Values: 266.6 292.6 297.6 301.7 308.4 4564.7 4941.5 4989.6 5016.7 5020.9 4438.5 4601.4 4681.0 4707.3 4826.8 3764.1 3805.7 3829.8 3873.6 3904.8 3878.2 3881.4 3890.0 3894.7 3900.3 3245.7 3321.8 3352.5 3609.3 3697.0 3823.5 3831.6 3835.0 3847.6 3855.3 3374.2 3387.8 3388.4 3392.1 3405.3 4709.2 4852.3 4858.9 4874.8 4886.3 4030.7 4223.9 4265.9 4313.7 4340.1 5115.6 5146.4 5156.5 5161.8 5164.7 3666.9 3673.1 3684.9 3691.3 3695.0 5107.8 5376.3 5393.7 5404.1 5419.3 3557.7 3733.3 3734.8 3735.4 3737.6 3430.2 3570.6 3771.5 3804.3 3804.6 3778.3 4147.5 4161.8 4295.4 4309.6 5000.5 5161.4 5169.8 5186.6 5187.9 1000.0 1011.6 1013.0 1220.1 1223.8 674.3 797.6 837.7 877.1 885.3 4015.8 4039.0 4039.9 4238.9 4646.7 4873.5 4975.9 5006.4 5048.3 5049.6 4304.6 4594.8 4665.6 4674.0 4702.3 2243.7 2363.2 2609.6 2611.8 2612.3 4547.9 5204.6 5224.8 5236.3 5237.6 4194.7 4592.5 4607.0 5059.4 5578.9 5033.3 5719.9 5726.5 5740.8 5783.5 5392.1 5407.5 5411.3 5461.6 5469.9 4570.9 5053.6 5228.9 5270.7 5318.7 4739.5 5126.4 5156.8 5677.4 5749.5 3146.8 3545.6 3638.9 3646.5 3752.0 4416.8 5349.5 5361.5 5395.2 5434.6 4402.6 4522.0 4576.9 5061.2 5129.5 5281.1 5285.7 5304.4 5340.3 5340.9 4835.6 4876.6 5129.0 5153.7 5188.8 5118.9 5141.2 5155.4 5255.3 5274.3 4201.3 4237.6 4485.5 5083.4 5124.3 06:39:41 INFO - PROCESS | 1635 | 06:39:41 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19522.38 Median:4560.25 stddev:27782.24 (609.2%) stddev-sans-first:27824.13 06:39:41 INFO - PROCESS | 1635 | Values: 673.3 719.0 722.0 751.7 757.3 11622.0 12281.6 14792.3 14869.6 14877.9 12216.8 12885.6 13326.5 13570.1 13571.5 652.0 671.9 675.1 680.3 806.8 675.9 814.2 823.1 824.7 825.8 886.2 886.7 887.8 890.7 890.9 881.7 881.7 882.6 882.7 885.3 508.6 524.9 624.1 639.5 654.1 14170.0 14203.5 14214.1 14214.1 14224.4 12996.8 13111.7 13378.5 13382.6 13432.4 12109.8 12234.4 12262.3 12273.0 12324.6 4273.7 4309.5 4359.5 4419.1 4556.0 72724.6 74854.9 80604.0 82100.6 85239.6 8592.5 9258.5 10371.0 10389.8 10963.8 19994.4 20033.1 20202.2 20203.9 20478.5 7681.3 7728.0 7780.5 7829.7 7847.4 3710.5 3993.7 4185.4 4199.6 4373.0 3297.3 3349.0 3409.4 3416.4 3447.7 618.8 628.9 633.3 642.3 652.5 596.7 599.4 619.4 653.6 672.2 8584.3 9034.2 9073.8 9106.0 9143.7 550.2 566.3 591.0 606.5 681.4 3901.3 4301.5 4481.7 4558.4 4562.1 95546.0 99442.5 100003.5 101542.5 119580.6 84026.2 84830.0 87233.0 88711.0 89291.0 79227.0 79258.2 79636.6 82036.5 82880.0 6673.9 8301.8 8648.7 8749.6 9318.4 43405.1 50264.0 52051.2 54554.0 55388.2 61374.0 65864.3 71506.6 72980.0 76614.6 12014.6 12203.0 12258.4 12669.0 12771.6 13821.9 14002.6 14042.4 14300.9 14753.9 12993.5 13001.9 13071.5 13322.9 13550.4 12914.5 12915.7 13010.3 13503.5 13711.4 12677.4 12863.9 12881.8 12983.2 13019.9 10746.4 10888.2 11109.7 11310.4 11331.7 10817.2 10868.4 10958.9 11035.6 11098.4 06:39:41 INFO - PROCESS | 1635 | -------- Summary: end -------- 06:39:41 INFO - PROCESS | 1635 | 06:39:41 INFO - TEST-INFO | 1635: exit 0 06:39:41 INFO - TEST-OK | dromaeo_css | took 1121354ms 06:39:41 INFO - TEST-START | kraken 06:39:41 INFO - operating with platform_type : mac_ 06:39:41 INFO - Initialising browser for kraken test... 06:39:41 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmpE2W2te/profile http://localhost:49237/getInfo.html) 06:39:44 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 06:39:44 INFO - PROCESS | 1646 | colorDepth:24 06:39:44 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 06:39:44 INFO - PROCESS | 1646 | __metrics 06:39:44 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:39:44 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:39:45 INFO - TEST-INFO | 1646: exit 0 06:39:45 INFO - Browser initialized. 06:39:45 INFO - Running cycle 1/1 for kraken test... 06:39:45 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmpE2W2te/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:39:57 INFO - PROCESS | 1647 | RSS: Main: 244051968 06:39:57 INFO - PROCESS | 1647 | 06:40:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 06:40:01 INFO - PROCESS | 1647 | RSS: Main: 294707200 06:40:01 INFO - PROCESS | 1647 | 06:40:03 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 06:40:04 INFO - PROCESS | 1647 | RSS: Main: 294629376 06:40:04 INFO - PROCESS | 1647 | 06:40:07 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 06:40:08 INFO - PROCESS | 1647 | RSS: Main: 387080192 06:40:08 INFO - PROCESS | 1647 | 06:40:10 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 06:40:10 INFO - PROCESS | 1647 | RSS: Main: 288649216 06:40:10 INFO - PROCESS | 1647 | 06:40:12 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:40:13 INFO - PROCESS | 1647 | RSS: Main: 292061184 06:40:13 INFO - PROCESS | 1647 | 06:40:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 06:40:16 INFO - PROCESS | 1647 | RSS: Main: 334475264 06:40:16 INFO - PROCESS | 1647 | 06:40:19 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 06:40:20 INFO - PROCESS | 1647 | RSS: Main: 337776640 06:40:20 INFO - PROCESS | 1647 | 06:40:23 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 06:40:23 INFO - PROCESS | 1647 | RSS: Main: 333750272 06:40:23 INFO - PROCESS | 1647 | 06:40:25 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:40:26 INFO - PROCESS | 1647 | RSS: Main: 310734848 06:40:26 INFO - PROCESS | 1647 | 06:40:27 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:40:28 INFO - PROCESS | 1647 | RSS: Main: 312631296 06:40:28 INFO - PROCESS | 1647 | 06:40:30 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:40:31 INFO - PROCESS | 1647 | RSS: Main: 314568704 06:40:31 INFO - PROCESS | 1647 | 06:40:34 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:40:35 INFO - PROCESS | 1647 | RSS: Main: 332931072 06:40:35 INFO - PROCESS | 1647 | 06:40:38 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:40:38 INFO - PROCESS | 1647 | RSS: Main: 326447104 06:40:38 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 06:40:40 INFO - PROCESS | 1647 | RSS: Main: 369930240 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | __start_tp_report 06:40:40 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 06:40:40 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 06:40:40 INFO - PROCESS | 1647 | |i|pagename|runs| 06:40:40 INFO - PROCESS | 1647 | |0;ai-astar;114;113;113;114;113;114;113;112;113;114 06:40:40 INFO - PROCESS | 1647 | |1;audio-beat-detection;151;114;115;179;101;130;143;139;128;110 06:40:40 INFO - PROCESS | 1647 | |2;audio-dft;182;183;182;186;186;181;180;181;183;181 06:40:40 INFO - PROCESS | 1647 | |3;audio-fft;81;58;59;86;62;61;60;57;73;57 06:40:40 INFO - PROCESS | 1647 | |4;audio-oscillator;80;96;87;70;68;70;80;67;68;83 06:40:40 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;94;84;88;90;87;86;90;91;94;84 06:40:40 INFO - PROCESS | 1647 | |6;imaging-darkroom;94;94;94;94;93;95;94;94;94;103 06:40:40 INFO - PROCESS | 1647 | |7;imaging-desaturate;84;85;101;130;88;84;86;83;86;84 06:40:40 INFO - PROCESS | 1647 | |8;json-parse-financial;56;53;55;54;55;55;54;54;54;55 06:40:40 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;66;74;74;78;73;72;72;72;71;72 06:40:40 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;88;87;86;86;86;97;109;109;107;86 06:40:40 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;147;148;148;150;147;151;146;148;188;162 06:40:40 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;175;172;174;174;173;174;174;172;173;173 06:40:40 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;68;68;67;68;66;67;66;64;63;79 06:40:40 INFO - PROCESS | 1647 | __end_tp_report 06:40:40 INFO - PROCESS | 1647 | __start_cc_report 06:40:40 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2110 06:40:40 INFO - PROCESS | 1647 | __end_cc_report 06:40:40 INFO - PROCESS | 1647 | __startTimestamp1479912040836__endTimestamp 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | ------- Summary: start ------- 06:40:40 INFO - PROCESS | 1647 | Number of tests: 14 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 06:40:40 INFO - PROCESS | 1647 | Values: 114.0 113.0 113.0 114.0 113.0 114.0 113.0 112.0 113.0 114.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:134.50 stddev:23.11 (17.2%) stddev-sans-first:23.35 06:40:40 INFO - PROCESS | 1647 | Values: 151.0 114.0 115.0 179.0 101.0 130.0 143.0 139.0 128.0 110.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:182.50 Median:182.50 stddev:2.07 (1.1%) stddev-sans-first:2.19 06:40:40 INFO - PROCESS | 1647 | Values: 182.0 183.0 182.0 186.0 186.0 181.0 180.0 181.0 183.0 181.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:65.40 Median:61.50 stddev:10.66 (17.3%) stddev-sans-first:9.70 06:40:40 INFO - PROCESS | 1647 | Values: 81.0 58.0 59.0 86.0 62.0 61.0 60.0 57.0 73.0 57.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:80.00 stddev:9.86 (12.3%) stddev-sans-first:10.39 06:40:40 INFO - PROCESS | 1647 | Values: 80.0 96.0 87.0 70.0 68.0 70.0 80.0 67.0 68.0 83.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:90.00 stddev:3.65 (4.1%) stddev-sans-first:3.35 06:40:40 INFO - PROCESS | 1647 | Values: 94.0 84.0 88.0 90.0 87.0 86.0 90.0 91.0 94.0 84.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:94.00 stddev:2.88 (3.1%) stddev-sans-first:3.04 06:40:40 INFO - PROCESS | 1647 | Values: 94.0 94.0 94.0 94.0 93.0 95.0 94.0 94.0 94.0 103.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:91.10 Median:84.50 stddev:14.63 (17.3%) stddev-sans-first:15.29 06:40:40 INFO - PROCESS | 1647 | Values: 84.0 85.0 101.0 130.0 88.0 84.0 86.0 83.0 86.0 84.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:0.85 (1.5%) stddev-sans-first:0.71 06:40:40 INFO - PROCESS | 1647 | Values: 56.0 53.0 55.0 54.0 55.0 55.0 54.0 54.0 54.0 55.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.50 stddev:2.99 (4.1%) stddev-sans-first:2.09 06:40:40 INFO - PROCESS | 1647 | Values: 66.0 74.0 74.0 78.0 73.0 72.0 72.0 72.0 71.0 72.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:94.10 Median:86.00 stddev:10.38 (12.1%) stddev-sans-first:10.77 06:40:40 INFO - PROCESS | 1647 | Values: 88.0 87.0 86.0 86.0 86.0 97.0 109.0 109.0 107.0 86.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:153.50 Median:149.00 stddev:12.96 (8.7%) stddev-sans-first:13.53 06:40:40 INFO - PROCESS | 1647 | Values: 147.0 148.0 148.0 150.0 147.0 151.0 146.0 148.0 188.0 162.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:174.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 06:40:40 INFO - PROCESS | 1647 | Values: 175.0 172.0 174.0 174.0 173.0 174.0 174.0 172.0 173.0 173.0 06:40:40 INFO - PROCESS | 1647 | 06:40:40 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:4.35 (6.4%) stddev-sans-first:4.61 06:40:40 INFO - PROCESS | 1647 | Values: 68.0 68.0 67.0 68.0 66.0 67.0 66.0 64.0 63.0 79.0 06:40:40 INFO - PROCESS | 1647 | -------- Summary: end -------- 06:40:40 INFO - PROCESS | 1647 | 06:40:41 INFO - TEST-INFO | 1647: exit 0 06:40:41 INFO - TEST-OK | kraken | took 60158ms 06:40:41 INFO - SUITE-END | took 1181s 06:40:41 INFO - Completed test suite (00:19:41) 06:40:41 INFO - javascript benchmark 06:40:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3250.122466933928, 3269.738420926326, 3279.3113446176308, 3297.505374193869, 3313.536104945308, 5453.318335208094, 5476.452354764521, 5498.505134537891, 5520.420355862631, 5573.888522229553, 4960.950390496103, 5518.475744804237, 5519.089350257203, 5592.888142237153, 5601.103823388259, 4897.412310522743, 5057.963117560909, 5102.234664800272, 5103.770330335125, 5158.097332966735, 5111.233315002761, 5182.792688292464, 5194.039102766001, 5214.348206474191, 5249.632525723201, 4964.975175124137, 5080.949190508085, 5088.109580823341, 5108.233764935252, 5199.0, 5033.798648054073, 5082.644214904958, 5085.720285384303, 5093.388793344785, 5095.898082038376, 4963.726995015273, 5028.421731500887, 5032.0, 5045.772940217662, 5065.696058236481, 5505.504504594565, 5505.724713764296, 5517.531009864127, 5524.696141712204, 5531.446855314477, 5889.381614930457, 5907.438793314628, 5911.379305172938, 5917.822465326047, 5938.465538101548, 5953.315368732608, 5977.790777322816, 5992.0, 5994.370591087916, 6004.519638428916, 5521.503064724154, 5579.804706835323, 5590.413006634286, 5594.468525490072, 5595.580331475156, 6183.907241391383, 6223.159873417121, 6228.844278893064, 6292.0, 6307.432331090224, 5896.911546326808, 5910.615809972338, 5916.881662366729, 5933.851653708692, 5949.524038076944, 4911.729854857946, 5961.2846458425265, 5962.34414214436, 5973.0, 6087.208662873798, 4982.476839931827, 5966.940330596639, 5976.013957697019, 5994.340622531518, 6005.669688167105, 5891.528677705774, 5928.881422371528, 5945.821625351246, 5950.85122871923, 5956.493698035715, 4701.623870090384, 4758.310045043519, 4769.117713223065, 4774.474807771142, 4787.569118779326, 4256.6807489438415, 4296.591823776736, 4322.740635561876, 4355.651547876226, 4360.585744354281, 5684.175794509773, 5690.2887139107615, 5761.423857614205, 5775.88448231033, 5795.88408231833, 6103.969480152571, 6109.327973922865, 6119.632822030692, 6122.234720659918, 6133.601315914451, 5687.829365119053, 5699.772009119672, 5754.712264386764, 5763.625364351304, 5785.987452195849, 5130.871728206825, 5182.585393168612, 5188.844334669966, 5200.869978250574, 5241.868953276123, 6304.369563043659, 6337.207849018872, 6353.841153971003, 6363.5545511813725, 6378.617282963037, 4840.0, 5990.910136347871, 6104.38956104386, 6107.175531303217, 6137.938620613915, 6178.752849885954, 6242.313345531897, 6242.500599952084, 6254.21822272216, 6341.873162536631, 5962.105684147413, 5982.730777115127, 6003.8198854034445, 6030.005049166838, 6043.244594425697, 6045.093236014633, 6081.878362432815, 6082.11809287642, 6085.543584231112, 6087.965045942289, 5674.2623458950075, 5726.742296596746, 5776.56675749312, 5885.941140588539, 5896.587238893237, 5797.449242321973, 5813.09896965971, 5836.503897168788, 5848.122781582797, 5890.852728681646, 5495.587830912617, 5684.488396044376, 5708.514776244066, 5708.971455142698, 5721.256236689203, 5799.4780469757925, 5835.037218859011, 5847.912281315868, 5866.50134738552, 5911.940880591139, 5711.942880571141, 5712.7714891403875, 5734.913976290442, 5738.598298119092, 5747.367789543064], "value": 5524.1989456358115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.92891066340036, 508.28078269249016, 513.6789506558401, 536.0725944116681, 536.1635848077, 37808.81095594521, 38947.22105557887, 38953.41569876454, 39094.80452597733, 39210.0197495062, 36762.26475470489, 37540.43689344662, 40878.795606022, 41057.7947110264, 41121.794391028, 8339.708110216143, 9215.677451289206, 9372.8594071089, 9383.765405864873, 9385.812283754354, 8352.872362231112, 11001.944990275077, 11248.26886252395, 11272.66182014541, 11479.311241325548, 11035.282706624044, 11092.223544351898, 11097.889021109806, 11114.49984750684, 11122.55509779608, 8378.958105209435, 8570.742877713616, 11054.557817687282, 11122.61070862524, 11137.387443690593, 8458.830823383498, 8529.616167272488, 10812.080973117294, 11090.500927458284, 11100.000999910048, 38427.42358864619, 38834.61165388338, 38851.611483885084, 38906.0, 38919.61080389217, 3246.2209069823307, 3292.42382583047, 3316.8839090631714, 3471.179564685648, 3521.9647803521893, 28984.855075724696, 29560.40879182426, 30215.09354719362, 30224.24439389011, 30273.394532109454, 3233.0300909727225, 3238.740900727936, 3295.340931813647, 3327.96672033279, 3329.0, 447850.0, 468745.0, 472588.6370568125, 473130.0, 475036.2496375061, 56636.43363566394, 56913.14630280549, 56966.7151664239, 56983.0, 57016.0, 60493.69753151294, 60615.09077363843, 60622.69688651529, 60634.09048864271, 60692.69653651792, 15352.846471535142, 15582.298796554182, 15587.142707150988, 15590.9220453897, 15597.766033509506, 11009.779804403866, 11171.497282622302, 12128.939355303344, 12168.939155304166, 12172.513099475922, 14598.854011459962, 19006.429807105807, 19217.61564768697, 19352.129154188096, 19434.416967490997, 6643.2028156620545, 7783.455158138876, 7870.881936770953, 7884.763457096296, 7899.881501777478, 861.7156338408311, 947.8672985781996, 976.345848281653, 1083.707399002265, 1112.8887111288968, 28520.0, 29608.963641354614, 29651.569336502944, 29946.850265748533, 30334.241643959078, 1033.9379637221791, 1099.9175061870392, 1118.6532175025768, 1150.7813515432042, 1178.9174757766873, 14100.788488172686, 15183.468578599695, 15198.544043678707, 15217.695646087017, 15497.612559686098, 623856.0, 628718.0, 630343.5104962988, 631047.0, 830493.0, 47190.76404617955, 55192.44807551953, 56020.0, 56074.158887616715, 59397.51506212379, 1303.5633062923837, 1335.4858379523953, 1348.43365786368, 1349.568138195768, 1351.709382482771, 29918.102456926328, 30176.813753180108, 30262.69737302599, 30333.393332133674, 30886.91895783637, 49569.00861982812, 50022.49977500179, 50104.248436272755, 50126.74936625294, 50158.749206253735, 550581.0, 550974.0, 551349.0, 552721.0, 560545.0, 40362.0, 40366.59633403746, 40865.1826963465, 41010.58989410187, 41090.58909410868, 44463.77768111139, 45317.0, 45575.0, 45724.54275457203, 45784.0, 37633.2473350537, 38177.809110954266, 38205.61794382021, 38638.80680596579, 38775.80612096922, 29712.70287297186, 30899.69100308968, 37821.62178378181, 38453.0, 38545.807270963465, 36186.73346432862, 36788.08029799276, 37319.0, 37356.06609834776, 37729.43405848969, 29608.703912961457, 31741.8412907934, 32321.676783231866, 33832.830835846646, 34511.30977380489, 23578.17476388318, 24487.020519179034, 24527.264182074567, 24862.07687779901, 25044.874775626733], "value": 19987.97507878345, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.16961546711116, 365.4664190282188, 369.92601479704047, 377.1608171817706, 400.6594394764451, 13734.381952812122, 14585.416583336668, 19783.208671653152, 19936.70094948577, 20739.481512962182, 16970.23633936473, 20083.899580502115, 20639.587208255827, 20703.17187312506, 20946.581068378622, 5642.915356269649, 5935.9703201483935, 5981.282246130449, 5998.7600495980105, 6002.369751176129, 4178.35235538492, 4336.8265269389185, 4410.62509686677, 5850.210221620069, 5899.852503687399, 4417.425734654506, 5871.0, 6299.307076221612, 6589.571677840925, 6599.934000660004, 6313.842153946142, 6426.8714625707225, 6560.048792925047, 6579.901301480481, 6583.93416065838, 5693.003724348223, 5693.231413759131, 5695.316562012544, 5696.715164241771, 5714.171445140473, 24263.63604545933, 24392.87803560971, 25147.0, 25573.0, 25608.615870761954, 2358.2925122463193, 2411.0, 2420.479596886678, 2420.673209116764, 2446.2661201639617, 14818.333175007043, 15475.690486190326, 15625.531234062997, 15644.68710625781, 16196.0, 1770.6104656975574, 1771.9557011074826, 1836.2746715047615, 1844.8062953389835, 1883.4914573065332, 112998.52511061703, 117201.0, 117706.0, 117789.41105294504, 118290.0, 10456.477176141163, 10490.580376784996, 10816.295926018496, 10940.288881222696, 11086.501107450184, 11925.34410607425, 12048.33734144613, 12630.684232894251, 12649.810252846215, 12650.177738446971, 8194.385421093442, 8262.752117436487, 8375.539345336065, 8529.061803201643, 8548.829023419621, 6728.865422691519, 6955.304469553004, 8373.336513710421, 8393.328533717287, 8577.699780507652, 5625.059354522683, 6480.611163330215, 6498.447631951242, 6631.535792494576, 6645.435138013323, 1788.7942886568212, 1829.3748470943972, 1832.7525784019253, 1834.238790901761, 1836.97244541332, 822.9300509456643, 888.4979986307716, 911.1799380557551, 978.5938835383379, 1019.9796004079877, 21433.035513401934, 22232.444188895406, 22257.3322800313, 22299.0, 22301.107955681917, 952.6475204174361, 973.5132433783108, 973.532704301939, 992.0922356044283, 994.1847684898314, 10973.561057557608, 11373.31760094397, 11763.705907352214, 11774.175807693551, 11813.11401644863, 547493.0, 556618.0, 557416.2129189409, 563383.0, 573254.0, 107066.0, 108104.0, 108260.91739082665, 113952.0, 114061.0, 957.1242313283268, 1013.7009582173276, 1014.2950649298814, 1039.8076355874186, 1044.336846102715, 18887.622247555246, 19172.0, 19399.515012124808, 19430.708539371637, 19484.610307793482, 51152.0, 51931.48068519266, 52300.73849630728, 52369.214461783864, 52824.735876320374, 71320.64339678269, 72259.63870180615, 72798.0, 72847.63576182086, 74186.51626967538, 7780.649870755717, 8066.7579972600915, 8089.797755056171, 8110.270075693216, 8356.707515236938, 11156.0, 13155.144915580457, 13178.472861085449, 13628.591142265748, 13675.0, 10804.621838235624, 11502.309861408008, 11533.769324613293, 11822.82265765997, 11952.223105498115, 11407.828882566933, 11444.885551144382, 11470.254433461798, 11625.593104241649, 11802.645920622395, 11601.477933492844, 11685.0, 11886.34625095628, 11990.520379185084, 12088.697782555506, 7888.447808653339, 8114.0, 8114.43198976066, 8315.376346774137, 8318.584070796314, 11437.485313161094, 11452.026577740651, 11685.649430517098, 11800.108973301596, 11831.822522661994], "value": 9655.714791607636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.2697620070098, 1470.037125682678, 1504.3756840911021, 1664.9667006659868, 1842.9907850460745, 7303.415726741861, 7693.269139431752, 8047.718329858449, 8312.584370781451, 8320.33437325014, 8193.672253109884, 8274.089850116497, 8279.958600207006, 8288.0, 8292.958535207315, 1705.3775371989198, 1909.2458478900826, 2278.8290878184202, 2282.543491301738, 2290.4617414907484, 2086.259377920839, 2229.9219527316545, 2300.5858945389823, 2311.768823117683, 2319.431739223884, 2262.1856131792542, 2271.7501074881748, 2272.397814579138, 2273.124846933934, 2277.39648993017, 2236.206146817881, 2255.785700358463, 2259.401258666455, 2261.8303627228024, 2262.6832243485924, 2237.339984704516, 2280.281711260964, 2280.361498780344, 2282.0301371917035, 2283.9885800571055, 8291.170882911721, 8327.625256863455, 8421.70524031656, 8422.957885210595, 8456.196661317226, 4246.830126794925, 5183.377994640668, 5199.246109314128, 5202.895942081175, 5204.531592156724, 3255.251292202783, 3457.2048428861503, 3537.8407971641336, 3540.5751309842726, 3544.946825797615, 980.5881529757519, 1016.5323950982557, 1017.277732809706, 1025.52825700178, 1081.2755453845941, 10854.728631784268, 10855.728606784893, 10857.837132443019, 10867.782644347148, 10872.293300935493, 4410.713303635253, 4421.9336709949375, 4601.792919318638, 4648.302754586772, 4658.510856360102, 9393.859092113624, 9418.434893906388, 9425.528723563795, 9433.433993960385, 9477.573509192103, 5174.637775355689, 5177.559907407837, 5182.326297581366, 5187.325647665779, 5187.870303242374, 4273.188094262143, 4390.3414487827085, 4421.53573874745, 4662.160811054043, 4668.323093151474, 3508.561429821272, 3670.632936706308, 3706.5737440194184, 3810.237952409529, 3816.5038544988975, 1238.9256644601173, 1241.1932244041445, 1243.1173866554848, 1254.6976298492186, 1255.7174635706892, 786.2609147401539, 832.3923535818886, 862.1809281182776, 873.8601823708176, 924.7503174142944, 5554.166874968787, 5570.637908535932, 5658.74535645897, 5663.292088488939, 5820.3888591698105, 764.9885251721229, 882.4705176893813, 906.392716879679, 939.1031564855547, 945.7919257763281, 3724.5530536335273, 3762.9059273518383, 3806.410006449005, 3842.442845787345, 3844.6732027777953, 9588.904110958802, 10063.5471403787, 10075.0, 10080.899191008142, 10086.646967356108, 10031.896491385942, 10036.347637403545, 10044.29689921713, 10054.145397641136, 10062.949685251528, 6101.60339577926, 7515.8496830063095, 7695.076590809139, 7703.922960770433, 7793.324435246449, 5003.074431230234, 5545.750441230073, 5677.489025987681, 5692.231548740867, 5887.970560147171, 9246.4914429707, 9272.72181834546, 9292.907070929205, 9318.394304370195, 9499.667511637059, 8792.47245165292, 9066.594677824947, 9452.527373631428, 9576.521173941135, 9594.18449431806, 6625.635590042594, 7101.502894797314, 7238.203797582157, 7240.456965727697, 7246.5289756165685, 7393.8151546211775, 7630.8092297693, 7884.1327453978865, 7901.130875603794, 8023.277904988579, 6384.87230255383, 7053.0830991970715, 7138.535995160298, 7206.83794861529, 7307.890381644386, 6986.441084713312, 7000.334968178015, 7048.400885924754, 7099.574025558483, 7119.252478489684, 6410.967945160431, 6578.342165783383, 6637.933620663925, 6649.60102393858, 6725.125733654593, 4381.802818873095, 4808.269023151733, 4808.807647694193, 4878.536539028786, 4962.776675049704, 4764.737939413366, 4768.499307572655, 4898.902021959612, 4963.354763880672, 5043.596512279082], "value": 4356.673778351739, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.568159581478, 292.5786866911647, 297.60715855071317, 301.6726851366267, 308.4155525279595, 4564.657650676204, 4941.505849415061, 4989.600831933446, 5016.749162541872, 5020.899582008362, 4438.489573699026, 4601.447826260845, 4681.0, 4707.293905914106, 4826.806927722896, 3764.1442539124496, 3805.6574908258253, 3829.782982294879, 3873.573906870242, 3904.7852368119743, 3878.2437424702193, 3881.4371916072155, 3889.9805500972457, 3894.7273690841653, 3900.2979463696524, 3245.7241134503597, 3321.80069195849, 3352.5306457096026, 3609.2934852549633, 3697.0018095114438, 3823.541175058983, 3831.578526362098, 3834.9866320181986, 3847.5960024197616, 3855.267499175148, 3374.24539239594, 3387.813670248135, 3388.3731509670542, 3392.0841372829445, 3405.2848901730667, 4709.202130516109, 4852.344933434012, 4858.854234372974, 4874.756262186912, 4886.291487734258, 4030.717849750519, 4223.936640950388, 4265.936010959838, 4313.749012786288, 4340.0740159918405, 5115.590752739772, 5146.401067460945, 5156.510131537498, 5161.793528258865, 5164.690118592896, 3666.853325866962, 3673.1000904778234, 3684.889453316405, 3691.298653255873, 3695.002349365683, 5107.785798687325, 5376.274202982626, 5393.730313484389, 5404.1083221268445, 5419.3225846769155, 3557.7153827693724, 3733.2720119576966, 3734.7572407793405, 3735.4210097434943, 3737.6075512071384, 3430.2110514581786, 3570.6072332043454, 3771.5474143102456, 3804.2500449793406, 3804.5814960354337, 3778.263238668488, 4147.52303485097, 4161.77227717824, 4295.355696645465, 4309.59058889405, 5000.474950130257, 5161.406438259573, 5169.776995891727, 5186.611004174702, 5187.896242075138, 999.9600015999424, 1011.600417834951, 1012.9949350253202, 1220.1215125109907, 1223.8164275358768, 674.2717864706106, 797.6330887791565, 837.6858677995751, 877.1141147441131, 885.3271513649544, 4015.7751885674566, 4039.0111317624746, 4039.8990025249605, 4238.915221695549, 4646.721196728207, 4873.537013983737, 4975.875603109879, 5006.374203224597, 5048.268001139814, 5049.621278404061, 4304.612584867315, 4594.839180628662, 4665.626749860003, 4674.0, 4702.31816386622, 2243.6971008913915, 2363.168544378086, 2609.595512695535, 2611.764941155305, 2612.2555071804823, 4547.886302842389, 5204.5576126028955, 5224.782508814498, 5236.345456817898, 5237.580993520509, 4194.706370554032, 4592.494825569184, 4606.98646297814, 5059.367579052619, 5578.931587626789, 5033.270175824485, 5719.857003574777, 5726.513246374022, 5740.770369185186, 5783.450572195718, 5392.110301800316, 5407.485903946901, 5411.269478620493, 5461.644993075437, 5469.890602187855, 4570.9029832839215, 5053.599535255512, 5228.8757917048015, 5270.7101109439345, 5318.680879147263, 4739.502352253102, 5126.410462796826, 5156.819511317086, 5677.403872593318, 5749.482546570829, 3146.7639927005107, 3545.5535680380453, 3638.8523926802595, 3646.5259516262718, 3751.9624803752704, 4416.779161041871, 5349.4650534946195, 5361.490658387447, 5395.244665746877, 5434.619576629598, 4402.5597440255715, 4521.97739011316, 4576.88557786058, 5061.190209566599, 5129.461406552407, 5281.075811732854, 5285.735713214401, 5304.363476382859, 5340.332458442695, 5340.93181363721, 4835.564799168092, 4876.634252431011, 5128.974355128201, 5153.727383111676, 5188.766505507337, 5118.948810511996, 5141.2288156776785, 5155.355580552431, 5255.343082114736, 5274.261603375608, 4201.264778663783, 4237.5762423758615, 4485.46174459067, 5083.38999320084, 5124.256982737556], "value": 3784.621752784317, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.2863165045053, 718.971241150354, 722.032476481515, 751.6692655231699, 757.2881491398089, 11622.0, 12281.631551053482, 14792.260386980663, 14869.553913382615, 14877.925610371947, 12216.755664886698, 12885.613431597043, 13326.533571325006, 13570.050096493225, 13571.52499662512, 651.9837004074889, 671.8824205763996, 675.0987431778557, 680.2619158213345, 806.753940048285, 675.8918573028317, 814.1939479914901, 823.115151212446, 824.7278398128633, 825.8307047055339, 886.175856453498, 886.7251152142824, 887.8401887660218, 890.6838072484239, 890.8530092534724, 881.6737807011383, 881.7178502879082, 882.5895958379352, 882.748416701237, 885.3050355470989, 508.6032894342382, 524.897644959233, 624.1137584629837, 639.4724352409281, 654.0548906829633, 14170.008099433044, 14203.502877399242, 14214.076085054437, 14214.076085054541, 14224.431022759078, 12996.805047924288, 13111.737765244641, 13378.531751388655, 13382.598522044354, 13432.395542200527, 12109.757804843943, 12234.388280585936, 12262.325572093621, 12273.0, 12324.568640097643, 4273.679474039428, 4309.547497512747, 4359.476862776455, 4419.0940857124215, 4556.0, 72724.63637681778, 74854.87717684293, 80604.0, 82100.61094501463, 85239.57380213121, 8592.52741099233, 9258.490783006999, 10371.0, 10389.792204156025, 10963.83554246687, 19994.400167994983, 20033.09851056706, 20202.191912323342, 20203.898980505004, 20478.488037798877, 7681.347085497683, 7728.033995750531, 7780.49426787257, 7829.686812527549, 7847.411444141712, 3710.5361829771277, 3993.66053885423, 4185.434966279574, 4199.580041995776, 4372.978135109304, 3297.3405318936307, 3348.9665103348657, 3409.4033544130175, 3416.3850506908993, 3447.6552344765323, 618.7865186510646, 628.9371062893674, 633.2970402852922, 642.3448082955452, 652.5138771615177, 596.7195418153461, 599.4185639929261, 619.44250174843, 653.5784419049686, 672.1832972937904, 8584.270337021424, 9034.19340050425, 9073.77315567103, 9105.954470227607, 9143.679971200976, 550.243415303957, 566.3486989961577, 590.9519789442371, 606.5056978562545, 681.4071757570945, 3901.31726947783, 4301.526832048472, 4481.663875209372, 4558.361829343895, 4562.133194692998, 95546.04453955371, 99442.5027874856, 100003.49998250107, 101542.49228753809, 119580.60838783176, 84026.15973840306, 84830.0, 87233.0, 88711.0, 89291.0, 79227.0, 79258.20741792624, 79636.60181699054, 82036.48799315975, 82880.0, 6673.899891501728, 8301.750947471586, 8648.740537783877, 8749.606267717842, 9318.440893546409, 43405.13189736251, 50264.0, 52051.2192317108, 54554.0, 55388.169177463176, 61374.0, 65864.34135658582, 71506.64246678734, 72980.0, 76614.61692691724, 12014.63956081319, 12202.96274816615, 12258.387080646111, 12669.0, 12771.552995645108, 13821.861781382058, 14002.57992260234, 14042.438302468196, 14300.856991429953, 14753.852461475677, 12993.480260789462, 13001.934990324988, 13071.542496012595, 13322.933385333012, 13550.39023243976, 12914.547990820276, 12915.741685166431, 13010.349482525646, 13503.459861605426, 13711.382987765774, 12677.429515671633, 12863.935680321538, 12881.8067728986, 12983.221006739626, 13019.869801301866, 10746.355218686904, 10888.183386245904, 11109.666709998713, 11310.377929213972, 11331.716707082389, 10817.18871084656, 10868.402237876993, 10958.945205273923, 11035.613753518588, 11098.389588572705], "value": 7145.95842170241, "unit": "score"}], "name": "dromaeo_css", "value": 7077.048054109249, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 112.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 115.0, 179.0, 101.0, 130.0, 143.0, 139.0, 128.0, 110.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 182.0, 186.0, 186.0, 181.0, 180.0, 181.0, 183.0, 181.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 86.0, 62.0, 61.0, 60.0, 57.0, 73.0, 57.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 96.0, 87.0, 70.0, 68.0, 70.0, 80.0, 67.0, 68.0, 83.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 84.0, 88.0, 90.0, 87.0, 86.0, 90.0, 91.0, 94.0, 84.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0, 94.0, 94.0, 103.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 101.0, 130.0, 88.0, 84.0, 86.0, 83.0, 86.0, 84.0], "value": 91.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 55.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 74.0, 78.0, 73.0, 72.0, 72.0, 72.0, 71.0, 72.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 86.0, 86.0, 97.0, 109.0, 109.0, 107.0, 86.0], "value": 94.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 150.0, 147.0, 151.0, 146.0, 148.0, 188.0, 162.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 174.0, 174.0, 173.0, 174.0, 174.0, 172.0, 173.0, 173.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 66.0, 67.0, 66.0, 64.0, 63.0, 79.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1459.3999999999999, "alertThreshold": 2.0}]} 06:40:42 INFO - Return code: 0 06:40:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:40:42 INFO - # TBPL SUCCESS # 06:40:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:40:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:40:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:40:42 INFO - 2016-11-23 06:40:42.160 screenresolution[1651:9966] starting screenresolution argv=screenresolution get 06:40:42 INFO - 2016-11-23 06:40:42.163 screenresolution[1651:9966] Display 0: 1600x1200x32@60 06:40:42 INFO - 2016-11-23 06:40:42.169 screenresolution[1652:9969] starting screenresolution argv=screenresolution list 06:40:42 INFO - Available Modes on Display 0 06:40:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:40:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:40:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:40:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:40:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:40:42 INFO - Intel Iris: 06:40:42 INFO - Chipset Model: Intel Iris 06:40:42 INFO - Type: GPU 06:40:42 INFO - Bus: Built-In 06:40:42 INFO - VRAM (Dynamic, Max): 1536 MB 06:40:42 INFO - Vendor: Intel (0x8086) 06:40:42 INFO - Device ID: 0x0a2e 06:40:42 INFO - Revision ID: 0x0009 06:40:42 INFO - Displays: 06:40:42 INFO - Display: 06:40:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:40:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:40:42 INFO - Display Serial Number: 1600x1200 60 06:40:42 INFO - Main Display: Yes 06:40:42 INFO - Mirror: Off 06:40:42 INFO - Online: Yes 06:40:42 INFO - Rotation: Supported 06:40:42 INFO - Return code: 0 06:40:42 INFO - Running post-action listener: _resource_record_post_action 06:40:42 INFO - [mozharness: 2016-11-23 14:40:42.412292Z] Finished run-tests step (success) 06:40:42 INFO - Running post-run listener: _resource_record_post_run 06:40:42 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37114880; Write bytes: 692952576; Read time: 235; Write time: 1954 06:40:42 INFO - TinderboxPrint: CPU usage
53.7% 06:40:42 INFO - TinderboxPrint: I/O read bytes / time
37,114,880 / 235 06:40:42 INFO - TinderboxPrint: I/O write bytes / time
692,952,576 / 1,954 06:40:42 INFO - TinderboxPrint: CPU idle
2,250.0 (46.3%) 06:40:42 INFO - TinderboxPrint: CPU system
975.8 (20.1%) 06:40:42 INFO - TinderboxPrint: CPU user
1,635.9 (33.6%) 06:40:42 INFO - TinderboxPrint: Swap in / out
419,950,592 / 0 06:40:42 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 374032896; Write bytes: 367994368; Read time: 29009; Write time: 747 06:40:42 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 35116032; Write bytes: 306538496; Read time: 218; Write time: 1156 06:40:42 INFO - Running post-run listener: _upload_blobber_files 06:40:42 INFO - Blob upload gear active. 06:40:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:40:42 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 06:40:42 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:40:42 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:40:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:40:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:40:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:40:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:40:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:40:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:40:44 INFO - (blobuploader) - INFO - Done attempting. 06:40:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:40:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:40:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:40:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:40:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:40:45 INFO - (blobuploader) - INFO - Done attempting. 06:40:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:40:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:40:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:40:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:40:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:40:47 INFO - (blobuploader) - INFO - Done attempting. 06:40:47 INFO - (blobuploader) - INFO - Iteration through files over. 06:40:47 INFO - Return code: 0 06:40:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:40:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:40:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e813cb8dcaec681eebf339dc0ce2b3789cbca166aa2bafee1599473bc01c24be94a67c16f8e9a14463ba0b563b745c534520a67a85e45689c12a45c97b39fcd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6975f5eaa1b74ddd70ba2833e4bc86a48b670cdd8c7d9abaddb260f9128d501e4cc883269b2be8892bb3592239e91caa039c7dd98132c1cd67e00083fd742f46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0653603a14275d989d9cee984107aaab665c9f9fcf7926035586b4b778f7ecf0674583fa436d381ea51a6f453e72d698db55129282c720b4999e846829b765b0"} 06:40:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:40:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:40:47 INFO - Contents: 06:40:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e813cb8dcaec681eebf339dc0ce2b3789cbca166aa2bafee1599473bc01c24be94a67c16f8e9a14463ba0b563b745c534520a67a85e45689c12a45c97b39fcd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6975f5eaa1b74ddd70ba2833e4bc86a48b670cdd8c7d9abaddb260f9128d501e4cc883269b2be8892bb3592239e91caa039c7dd98132c1cd67e00083fd742f46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0653603a14275d989d9cee984107aaab665c9f9fcf7926035586b4b778f7ecf0674583fa436d381ea51a6f453e72d698db55129282c720b4999e846829b765b0"} 06:40:47 INFO - Running post-run listener: copy_logs_to_upload_dir 06:40:47 INFO - Copying logs to upload dir... 06:40:47 INFO - mkdir: /builds/slave/test/build/upload/logs 06:40:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.202049 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-23 06:40:47.836598) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 06:40:47.840708) ========= 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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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/Cedar/sha512/e813cb8dcaec681eebf339dc0ce2b3789cbca166aa2bafee1599473bc01c24be94a67c16f8e9a14463ba0b563b745c534520a67a85e45689c12a45c97b39fcd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6975f5eaa1b74ddd70ba2833e4bc86a48b670cdd8c7d9abaddb260f9128d501e4cc883269b2be8892bb3592239e91caa039c7dd98132c1cd67e00083fd742f46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0653603a14275d989d9cee984107aaab665c9f9fcf7926035586b4b778f7ecf0674583fa436d381ea51a6f453e72d698db55129282c720b4999e846829b765b0"} build_url:https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010913 build_url: 'https://queue.taskcluster.net/v1/task/WlGxBgDkSs-_HxOeqvbfxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e813cb8dcaec681eebf339dc0ce2b3789cbca166aa2bafee1599473bc01c24be94a67c16f8e9a14463ba0b563b745c534520a67a85e45689c12a45c97b39fcd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6975f5eaa1b74ddd70ba2833e4bc86a48b670cdd8c7d9abaddb260f9128d501e4cc883269b2be8892bb3592239e91caa039c7dd98132c1cd67e00083fd742f46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0653603a14275d989d9cee984107aaab665c9f9fcf7926035586b4b778f7ecf0674583fa436d381ea51a6f453e72d698db55129282c720b4999e846829b765b0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 06:40:47.878247) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:40:47.878580) ========= 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.I8uYvJTBUD/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.9D8OJPq4YE/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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.005021 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:40:47.926785) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 06:40:47.927102) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 06:40:47.927415) ========= ========= Total master_lag: 0.20 =========