builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0088 starttime: 1488213878.41 results: success (0) buildid: 20170227061609 builduid: 6437782d3061413d9509cf47047c1400 revision: a058f3e17dcf5ea2dfe7431d4f238dd352c473d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:38.407646) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:38.408043) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:38.408318) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:38.437538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:38.437928) ========= 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.lsaxpBwRz1/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.31EKeeK8Py/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-27 08:44:38-- 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% 15.2M=0.001s 2017-02-27 08:44:38 (15.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147366 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:38.609289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:38.612630) ========= 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.lsaxpBwRz1/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.31EKeeK8Py/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.027930 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:38.661983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-27 08:44:38.662322) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a058f3e17dcf5ea2dfe7431d4f238dd352c473d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a058f3e17dcf5ea2dfe7431d4f238dd352c473d2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lsaxpBwRz1/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.31EKeeK8Py/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-27 08:44:38,762 truncating revision to first 12 chars 2017-02-27 08:44:38,762 Setting DEBUG logging. 2017-02-27 08:44:38,762 attempt 1/10 2017-02-27 08:44:38,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a058f3e17dcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-27 08:44:40,755 unpacking tar archive at: mozilla-beta-a058f3e17dcf/testing/mozharness/ program finished with exit code 0 elapsedTime=2.268450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-27 08:44:40.954520) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:40.954846) ========= script_repo_revision: a058f3e17dcf5ea2dfe7431d4f238dd352c473d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:40.955217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:40.955478) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 08:44:40.975410) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-27 08:44:40.975794) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lsaxpBwRz1/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.31EKeeK8Py/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 08:44:41 INFO - MultiFileLogger online at 20170227 08:44:41 in /builds/slave/test 08:44:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:44:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:41 INFO - {'append_to_log': False, 08:44:41 INFO - 'base_work_dir': '/builds/slave/test', 08:44:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:44:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:41 INFO - 'branch': 'Mozilla-Beta', 08:44:41 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:41 INFO - 'config_files': ('talos/mac_config.py',), 08:44:41 INFO - 'default_actions': ('clobber', 08:44:41 INFO - 'read-buildbot-config', 08:44:41 INFO - 'download-and-extract', 08:44:41 INFO - 'populate-webroot', 08:44:41 INFO - 'create-virtualenv', 08:44:41 INFO - 'install', 08:44:41 INFO - 'run-tests'), 08:44:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:41 INFO - 'download_minidump_stackwalk': True, 08:44:41 INFO - 'download_symbols': 'ondemand', 08:44:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:41 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:41 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:41 INFO - 'installer_path': 'installer.exe', 08:44:41 INFO - 'log_level': 'info', 08:44:41 INFO - 'log_name': 'talos', 08:44:41 INFO - 'log_to_console': True, 08:44:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:44:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:44:41 INFO - 'opt_config_files': (), 08:44:41 INFO - 'pip_index': False, 08:44:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:44:41 INFO - 'cmd': ('bash', 08:44:41 INFO - '-c', 08:44:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:44:41 INFO - 'enabled': True, 08:44:41 INFO - 'halt_on_failure': False, 08:44:41 INFO - 'name': 'check_screen_resolution'},), 08:44:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:44:41 INFO - 'cmd': ('bash', 08:44:41 INFO - '-c', 08:44:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:44:41 INFO - 'enabled': True, 08:44:41 INFO - 'halt_on_failure': False, 08:44:41 INFO - 'name': 'check_screen_resolution'},), 08:44:41 INFO - 'run_cmd_checks_enabled': True, 08:44:41 INFO - 'sps_profile': False, 08:44:41 INFO - 'sps_profile_interval': 0, 08:44:41 INFO - 'suite': 'dromaeojs', 08:44:41 INFO - 'system_bits': '32', 08:44:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:41 INFO - 'title': 't-yosemite-r7-0088', 08:44:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:41 INFO - 'use_talos_json': True, 08:44:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:41 INFO - 'work_dir': 'build'} 08:44:41 INFO - [mozharness: 2017-02-27 16:44:41.189611Z] Running clobber step. 08:44:41 INFO - Running pre-action listener: _resource_record_pre_action 08:44:41 INFO - Running main action method: clobber 08:44:41 INFO - rmtree: /builds/slave/test/build 08:44:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:43 INFO - Running post-action listener: _resource_record_post_action 08:44:43 INFO - [mozharness: 2017-02-27 16:44:43.845856Z] Finished clobber step (success) 08:44:43 INFO - [mozharness: 2017-02-27 16:44:43.846047Z] Running read-buildbot-config step. 08:44:43 INFO - Running pre-action listener: _resource_record_pre_action 08:44:43 INFO - Running main action method: read_buildbot_config 08:44:43 INFO - Using buildbot properties: 08:44:43 INFO - { 08:44:43 INFO - "project": "", 08:44:43 INFO - "product": "firefox", 08:44:43 INFO - "script_repo_revision": "production", 08:44:43 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:44:43 INFO - "repository": "", 08:44:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:44:43 INFO - "buildid": "20170227061609", 08:44:43 INFO - "pgo_build": "False", 08:44:43 INFO - "basedir": "/builds/slave/test", 08:44:43 INFO - "buildnumber": 0, 08:44:43 INFO - "slavename": "t-yosemite-r7-0088", 08:44:43 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:44:43 INFO - "platform": "yosemite_r7", 08:44:43 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:44:43 INFO - "branch": "mozilla-beta", 08:44:43 INFO - "repo_path": "releases/mozilla-beta", 08:44:43 INFO - "revision": "a058f3e17dcf5ea2dfe7431d4f238dd352c473d2", 08:44:43 INFO - "stage_platform": "macosx64", 08:44:43 INFO - "builduid": "6437782d3061413d9509cf47047c1400", 08:44:43 INFO - "slavebuilddir": "test" 08:44:43 INFO - } 08:44:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 08:44:43 INFO - Running post-action listener: _resource_record_post_action 08:44:43 INFO - [mozharness: 2017-02-27 16:44:43.851874Z] Finished read-buildbot-config step (success) 08:44:43 INFO - [mozharness: 2017-02-27 16:44:43.852074Z] Running download-and-extract step. 08:44:43 INFO - Running pre-action listener: _resource_record_pre_action 08:44:43 INFO - Running main action method: download_and_extract 08:44:43 INFO - mkdir: /builds/slave/test/build/tests 08:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:43 INFO - trying https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 08:44:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 08:44:45 INFO - Downloaded 1165 bytes. 08:44:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:44:45 INFO - Using the following test package requirements: 08:44:45 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:44:45 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:44:45 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 08:44:45 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:44:45 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 08:44:45 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:44:45 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:44:45 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 08:44:45 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:44:45 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:44:45 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 08:44:45 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:44:45 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 08:44:45 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:44:45 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 08:44:45 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:44:45 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 08:44:45 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 08:44:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:44:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:44:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:44:45 INFO - Http code: 200 08:44:45 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 08:44:45 INFO - x-amz-cf-id: QP1_UKJbe6R7hqMOq2EKyNwuLsiLzlpHeIuA7iDo0v9FzTkjwZK-sw== 08:44:45 INFO - x-amz-version-id: xwfnyDTmyblAZ1ScwQYktceqJx5Z2kzK 08:44:46 INFO - Expected file size: 16093391 08:44:46 INFO - Obtained file size: 16093391 08:44:52 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:44:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:44:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:44:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:44:53 INFO - Http code: 200 08:44:53 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 08:44:53 INFO - x-amz-cf-id: cyCoGuBz8MAOuVxa8v2fh8Px0BsUEh1diqtXIrBL6GhAhVkofZVjPg== 08:44:53 INFO - x-amz-version-id: xwfnyDTmyblAZ1ScwQYktceqJx5Z2kzK 08:44:53 INFO - Expected file size: 16093391 08:44:53 INFO - Obtained file size: 16093391 08:45:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 08:45:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 08:45:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 08:45:00 INFO - Http code: 200 08:45:00 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 08:45:00 INFO - x-amz-cf-id: cUW85vX_2WuLDIxcza9chhqVhH-wWCWA29kOBC11LEWIeYtU5lSgYg== 08:45:00 INFO - x-amz-version-id: ZU3av8hUTT3XRKquvuAl9aD8LEfw1PVE 08:45:00 INFO - Expected file size: 14402992 08:45:00 INFO - Obtained file size: 14402992 08:45:01 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')]} 08:45:01 INFO - trying https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:45:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 08:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 08:45:03 INFO - Downloaded 82111645 bytes. 08:45:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:45:03 INFO - mkdir: /builds/slave/test/properties 08:45:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:03 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:03 INFO - Contents: 08:45:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:45:04 INFO - Running post-action listener: _resource_record_post_action 08:45:04 INFO - Running post-action listener: set_extra_try_arguments 08:45:04 INFO - [mozharness: 2017-02-27 16:45:04.194769Z] Finished download-and-extract step (success) 08:45:04 INFO - [mozharness: 2017-02-27 16:45:04.194916Z] Running populate-webroot step. 08:45:04 INFO - Running pre-action listener: _resource_record_pre_action 08:45:04 INFO - Running main action method: populate_webroot 08:45:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:04 INFO - '--tppagecycles', 08:45:04 INFO - '7'], 08:45:04 INFO - 'tests': ['tsvgm']}}, 08:45:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'talos_options': ['--disable-e10s'], 08:45:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'talos_options': ['--disable-e10s'], 08:45:04 INFO - 'tests': ['damp', 'tps']}, 08:45:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'tests': ['damp', 'tps']}, 08:45:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:04 INFO - 'tests': ['dromaeo_dom']}, 08:45:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:45:04 INFO - 'tests': ['basic_compositor_video']}, 08:45:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:45:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:04 INFO - 'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore', 08:45:04 INFO - 'tabpaint']}, 08:45:04 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore', 08:45:04 INFO - 'tabpaint']}, 08:45:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore', 08:45:04 INFO - 'tabpaint']}, 08:45:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore', 08:45:04 INFO - 'tabpaint']}, 08:45:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:04 INFO - 'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore', 08:45:04 INFO - 'tabpaint']}, 08:45:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:04 INFO - 'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore', 08:45:04 INFO - 'tabpaint']}, 08:45:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:04 INFO - 'tests': ['tsvgx', 08:45:04 INFO - 'tsvgr_opacity', 08:45:04 INFO - 'tart', 08:45:04 INFO - 'tscrollx', 08:45:04 INFO - 'cart']}, 08:45:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:04 INFO - 'tsvgr_opacity', 08:45:04 INFO - 'tart', 08:45:04 INFO - 'tscrollx', 08:45:04 INFO - 'cart']}, 08:45:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'talos_options': ['--disable-e10s'], 08:45:04 INFO - 'tests': ['tp5o']}, 08:45:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'tests': ['tp5o']}, 08:45:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'talos_options': ['--disable-e10s', 08:45:04 INFO - '--xperf_path', 08:45:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:04 INFO - 'tests': ['tp5n']}, 08:45:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'talos_options': ['--xperf_path', 08:45:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:04 INFO - 'tests': ['tp5n']}}, 08:45:04 INFO - 'talos.zip': {'path': '', 08:45:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:04 INFO - Running post-action listener: _resource_record_post_action 08:45:04 INFO - [mozharness: 2017-02-27 16:45:04.214279Z] Finished populate-webroot step (success) 08:45:04 INFO - [mozharness: 2017-02-27 16:45:04.214410Z] Running create-virtualenv step. 08:45:04 INFO - Running pre-action listener: _resource_record_pre_action 08:45:04 INFO - Running main action method: create_virtualenv 08:45:04 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:04 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 08:45:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:04 INFO - Using real prefix '/tools/python27' 08:45:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:05 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:07 INFO - Installing pip.................done. 08:45:07 INFO - Return code: 0 08:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:45:08 INFO - Reading from file tmpfile_stdout 08:45:08 INFO - Output received: 08:45:08 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) 08:45:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103144490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b0d7d6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f58d30>, '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 0x102dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f50b20>, '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.lsaxpBwRz1/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.31EKeeK8Py/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 08:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsaxpBwRz1/Render', 08:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:08 INFO - 'HOME': '/Users/cltbld', 08:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:08 INFO - 'LOGNAME': 'cltbld', 08:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:08 INFO - 'MOZ_NO_REMOTE': '1', 08:45:08 INFO - 'NO_EM_RESTART': '1', 08:45:08 INFO - 'PAGER': '/bin/cat', 08:45:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:08 INFO - 'PWD': '/builds/slave/test', 08:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:08 INFO - 'SHELL': '/bin/bash', 08:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.31EKeeK8Py/Listeners', 08:45:08 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 08:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:08 INFO - 'USER': 'cltbld', 08:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:08 INFO - 'XPC_FLAGS': '0x0', 08:45:08 INFO - 'XPC_SERVICE_NAME': '0', 08:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:08 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 08:45:08 INFO - Cleaning up... 08:45:08 INFO - Return code: 0 08:45:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103144490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b0d7d6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f58d30>, '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 0x102dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f50b20>, '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.lsaxpBwRz1/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.31EKeeK8Py/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 08:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsaxpBwRz1/Render', 08:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:08 INFO - 'HOME': '/Users/cltbld', 08:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:08 INFO - 'LOGNAME': 'cltbld', 08:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:08 INFO - 'MOZ_NO_REMOTE': '1', 08:45:08 INFO - 'NO_EM_RESTART': '1', 08:45:08 INFO - 'PAGER': '/bin/cat', 08:45:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:08 INFO - 'PWD': '/builds/slave/test', 08:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:08 INFO - 'SHELL': '/bin/bash', 08:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.31EKeeK8Py/Listeners', 08:45:08 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 08:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:08 INFO - 'USER': 'cltbld', 08:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:08 INFO - 'XPC_FLAGS': '0x0', 08:45:08 INFO - 'XPC_SERVICE_NAME': '0', 08:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:08 INFO - Downloading/unpacking psutil>=3.1.1 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:12 INFO - Installing collected packages: psutil 08:45:12 INFO - Running setup.py install for psutil 08:45:12 INFO - building 'psutil._psutil_osx' extension 08:45:12 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 08:45:12 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 08:45:12 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 08:45:13 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 08:45:13 INFO - building 'psutil._psutil_posix' extension 08:45:13 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 08:45:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:45:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:45:13 INFO - ^ 08:45:13 INFO - 1 warning generated. 08:45:13 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 08:45:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:13 INFO - Successfully installed psutil 08:45:13 INFO - Cleaning up... 08:45:13 INFO - Return code: 0 08:45:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:45:13 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')]} 08:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:13 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')]} 08:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:13 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 0x103144490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b0d7d6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f58d30>, '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 0x102dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f50b20>, '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.lsaxpBwRz1/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.31EKeeK8Py/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 08:45:13 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 08:45:13 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 08:45:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsaxpBwRz1/Render', 08:45:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:13 INFO - 'HOME': '/Users/cltbld', 08:45:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:13 INFO - 'LOGNAME': 'cltbld', 08:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:13 INFO - 'MOZ_NO_REMOTE': '1', 08:45:13 INFO - 'NO_EM_RESTART': '1', 08:45:13 INFO - 'PAGER': '/bin/cat', 08:45:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:13 INFO - 'PWD': '/builds/slave/test', 08:45:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:13 INFO - 'SHELL': '/bin/bash', 08:45:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.31EKeeK8Py/Listeners', 08:45:13 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 08:45:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:13 INFO - 'USER': 'cltbld', 08:45:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:13 INFO - 'XPC_FLAGS': '0x0', 08:45:13 INFO - 'XPC_SERVICE_NAME': '0', 08:45:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:45:16 INFO - Installing collected packages: mozsystemmonitor 08:45:16 INFO - Running setup.py install for mozsystemmonitor 08:45:16 INFO - Successfully installed mozsystemmonitor 08:45:16 INFO - Cleaning up... 08:45:16 INFO - Return code: 0 08:45:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:45:16 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')]} 08:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:16 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')]} 08:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:16 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 0x103144490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b0d7d6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f58d30>, '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 0x102dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f50b20>, '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.lsaxpBwRz1/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.31EKeeK8Py/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 08:45:16 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 08:45:16 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 08:45:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsaxpBwRz1/Render', 08:45:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:16 INFO - 'HOME': '/Users/cltbld', 08:45:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:16 INFO - 'LOGNAME': 'cltbld', 08:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:16 INFO - 'MOZ_NO_REMOTE': '1', 08:45:16 INFO - 'NO_EM_RESTART': '1', 08:45:16 INFO - 'PAGER': '/bin/cat', 08:45:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:16 INFO - 'PWD': '/builds/slave/test', 08:45:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:16 INFO - 'SHELL': '/bin/bash', 08:45:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.31EKeeK8Py/Listeners', 08:45:16 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 08:45:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:16 INFO - 'USER': 'cltbld', 08:45:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:16 INFO - 'XPC_FLAGS': '0x0', 08:45:16 INFO - 'XPC_SERVICE_NAME': '0', 08:45:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:17 INFO - Downloading/unpacking jsonschema==2.5.1 08:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:20 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:20 INFO - warning: no files found matching '*.txt' 08:45:20 INFO - no previously-included directories found matching 'build' 08:45:20 INFO - no previously-included directories found matching 'dist' 08:45:20 INFO - no previously-included directories found matching '.git*' 08:45:20 INFO - Installing collected packages: jsonschema, functools32 08:45:20 INFO - Running setup.py install for functools32 08:45:20 INFO - warning: no files found matching '*.txt' 08:45:20 INFO - no previously-included directories found matching 'build' 08:45:20 INFO - no previously-included directories found matching 'dist' 08:45:20 INFO - no previously-included directories found matching '.git*' 08:45:20 INFO - Successfully installed jsonschema functools32 08:45:20 INFO - Cleaning up... 08:45:20 INFO - Return code: 0 08:45:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:20 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 0x103144490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b0d7d6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f58d30>, '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 0x102dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f50b20>, '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.lsaxpBwRz1/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.31EKeeK8Py/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 08:45:20 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 08:45:20 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 08:45:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsaxpBwRz1/Render', 08:45:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:20 INFO - 'HOME': '/Users/cltbld', 08:45:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:20 INFO - 'LOGNAME': 'cltbld', 08:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:20 INFO - 'MOZ_NO_REMOTE': '1', 08:45:20 INFO - 'NO_EM_RESTART': '1', 08:45:20 INFO - 'PAGER': '/bin/cat', 08:45:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:20 INFO - 'PWD': '/builds/slave/test', 08:45:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:20 INFO - 'SHELL': '/bin/bash', 08:45:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.31EKeeK8Py/Listeners', 08:45:20 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 08:45:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:20 INFO - 'USER': 'cltbld', 08:45:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:20 INFO - 'XPC_FLAGS': '0x0', 08:45:20 INFO - 'XPC_SERVICE_NAME': '0', 08:45:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:45:20 INFO - Cleaning up... 08:45:20 INFO - Return code: 0 08:45:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:20 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 0x103144490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b0d7d6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f58d30>, '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 0x102dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f50b20>, '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.lsaxpBwRz1/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.31EKeeK8Py/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 08:45:20 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 08:45:20 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 08:45:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsaxpBwRz1/Render', 08:45:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:20 INFO - 'HOME': '/Users/cltbld', 08:45:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:20 INFO - 'LOGNAME': 'cltbld', 08:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:20 INFO - 'MOZ_NO_REMOTE': '1', 08:45:20 INFO - 'NO_EM_RESTART': '1', 08:45:20 INFO - 'PAGER': '/bin/cat', 08:45:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:20 INFO - 'PWD': '/builds/slave/test', 08:45:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:20 INFO - 'SHELL': '/bin/bash', 08:45:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.31EKeeK8Py/Listeners', 08:45:20 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 08:45:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:20 INFO - 'USER': 'cltbld', 08:45:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:20 INFO - 'XPC_FLAGS': '0x0', 08:45:20 INFO - 'XPC_SERVICE_NAME': '0', 08:45:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:20 INFO - Downloading/unpacking blobuploader==1.2.4 08:45:20 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 08:45:20 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 08:45:20 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 08:45:20 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 08:45:20 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 08:45:20 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 08:45:23 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:24 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 08:45:24 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 08:45:24 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 08:45:24 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 08:45:24 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 08:45:24 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 08:45:24 INFO - Downloading docopt-0.6.1.tar.gz 08:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:24 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:24 INFO - Running setup.py install for blobuploader 08:45:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:25 INFO - Running setup.py install for requests 08:45:25 INFO - Running setup.py install for docopt 08:45:25 INFO - Successfully installed blobuploader requests docopt 08:45:25 INFO - Cleaning up... 08:45:25 INFO - Return code: 0 08:45:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:25 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 0x103144490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b0d7d6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f58d30>, '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 0x102dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f50b20>, '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.lsaxpBwRz1/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.31EKeeK8Py/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 08:45:25 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 08:45:25 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 08:45:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsaxpBwRz1/Render', 08:45:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:25 INFO - 'HOME': '/Users/cltbld', 08:45:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:25 INFO - 'LOGNAME': 'cltbld', 08:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:25 INFO - 'MOZ_NO_REMOTE': '1', 08:45:25 INFO - 'NO_EM_RESTART': '1', 08:45:25 INFO - 'PAGER': '/bin/cat', 08:45:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:25 INFO - 'PWD': '/builds/slave/test', 08:45:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:25 INFO - 'SHELL': '/bin/bash', 08:45:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.31EKeeK8Py/Listeners', 08:45:25 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 08:45:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:25 INFO - 'USER': 'cltbld', 08:45:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:25 INFO - 'XPC_FLAGS': '0x0', 08:45:25 INFO - 'XPC_SERVICE_NAME': '0', 08:45:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:26 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-qYBS_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:26 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-y6GAui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:26 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-I0jNQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:26 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-jS2UhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:26 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-L89Jyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:26 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-GilTcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:26 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-DnyvsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:26 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ffMuvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:26 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-bC_eWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:26 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ma50b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:27 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-DL2XHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:27 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ltq5P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:27 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-xALdsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:27 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-IGrxWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:27 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ihXYCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:27 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-n1w2b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:27 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-AUTF9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:27 INFO - Running setup.py install for manifestparser 08:45:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for mozcrash 08:45:28 INFO - Running setup.py install for mozdebug 08:45:28 INFO - Running setup.py install for mozdevice 08:45:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Running setup.py install for mozfile 08:45:28 INFO - Running setup.py install for mozhttpd 08:45:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Running setup.py install for mozinfo 08:45:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Running setup.py install for mozInstall 08:45:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Running setup.py install for mozleak 08:45:29 INFO - Running setup.py install for mozlog 08:45:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for moznetwork 08:45:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for mozprocess 08:45:29 INFO - Running setup.py install for mozprofile 08:45:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for mozrunner 08:45:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for mozscreenshot 08:45:30 INFO - Running setup.py install for moztest 08:45:30 INFO - Running setup.py install for mozversion 08:45:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:30 INFO - Cleaning up... 08:45:30 INFO - Return code: 0 08:45:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:30 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 0x103144490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b0d7d6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f58d30>, '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 0x102dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f50b20>, '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.lsaxpBwRz1/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.31EKeeK8Py/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 08:45:30 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 08:45:30 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 08:45:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsaxpBwRz1/Render', 08:45:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:30 INFO - 'HOME': '/Users/cltbld', 08:45:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:30 INFO - 'LOGNAME': 'cltbld', 08:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:30 INFO - 'MOZ_NO_REMOTE': '1', 08:45:30 INFO - 'NO_EM_RESTART': '1', 08:45:30 INFO - 'PAGER': '/bin/cat', 08:45:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:30 INFO - 'PWD': '/builds/slave/test', 08:45:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:30 INFO - 'SHELL': '/bin/bash', 08:45:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.31EKeeK8Py/Listeners', 08:45:30 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 08:45:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:30 INFO - 'USER': 'cltbld', 08:45:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:30 INFO - 'XPC_FLAGS': '0x0', 08:45:30 INFO - 'XPC_SERVICE_NAME': '0', 08:45:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:30 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-BoLiix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:30 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-LFXyoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:30 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Af6xvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:30 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-JUrp8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:31 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-KSqxKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:31 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-yVs8Fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:31 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ZfVMsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:31 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-K530Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:31 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-xsn9Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:31 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-u4dfTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:31 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-YM9WRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:31 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-MYaG7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:31 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-kcJNd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:32 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)) 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:32 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-aRPhds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:32 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)) 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:32 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-VXjtXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:32 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)) 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:32 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-4XgP3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:32 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-X0qDif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:32 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)) 08:45:32 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)) 08:45:32 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)) 08:45:32 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)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:32 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 08:45:32 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 08:45:32 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 08:45:32 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 08:45:32 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 08:45:32 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 08:45:35 INFO - Downloading blessings-1.6.tar.gz 08:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:35 INFO - Installing collected packages: blessings 08:45:35 INFO - Running setup.py install for blessings 08:45:35 INFO - Successfully installed blessings 08:45:35 INFO - Cleaning up... 08:45:35 INFO - Return code: 0 08:45:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:35 INFO - Reading from file tmpfile_stdout 08:45:35 INFO - Current package versions: 08:45:35 INFO - blessings == 1.6 08:45:35 INFO - blobuploader == 1.2.4 08:45:35 INFO - docopt == 0.6.1 08:45:35 INFO - functools32 == 3.2.3-2 08:45:35 INFO - jsonschema == 2.5.1 08:45:35 INFO - manifestparser == 1.1 08:45:35 INFO - mozInstall == 1.12 08:45:35 INFO - mozcrash == 1.0 08:45:35 INFO - mozdebug == 0.1 08:45:35 INFO - mozdevice == 0.48 08:45:35 INFO - mozfile == 1.2 08:45:35 INFO - mozhttpd == 0.7 08:45:35 INFO - mozinfo == 0.9 08:45:35 INFO - mozleak == 0.1 08:45:35 INFO - mozlog == 3.4 08:45:35 INFO - moznetwork == 0.27 08:45:35 INFO - mozprocess == 0.23 08:45:35 INFO - mozprofile == 0.28 08:45:35 INFO - mozrunner == 6.13 08:45:35 INFO - mozscreenshot == 0.1 08:45:35 INFO - mozsystemmonitor == 0.3 08:45:35 INFO - moztest == 0.8 08:45:35 INFO - mozversion == 1.4 08:45:35 INFO - psutil == 3.1.1 08:45:35 INFO - requests == 1.2.3 08:45:35 INFO - wsgiref == 0.1.2 08:45:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:35 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')]} 08:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:36 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')]} 08:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:36 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 0x103144490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b0d7d6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f58d30>, '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 0x102dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f50b20>, '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.lsaxpBwRz1/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.31EKeeK8Py/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 08:45:36 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 08:45:36 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 08:45:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsaxpBwRz1/Render', 08:45:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:36 INFO - 'HOME': '/Users/cltbld', 08:45:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:36 INFO - 'LOGNAME': 'cltbld', 08:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:36 INFO - 'MOZ_NO_REMOTE': '1', 08:45:36 INFO - 'NO_EM_RESTART': '1', 08:45:36 INFO - 'PAGER': '/bin/cat', 08:45:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:36 INFO - 'PWD': '/builds/slave/test', 08:45:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:36 INFO - 'SHELL': '/bin/bash', 08:45:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.31EKeeK8Py/Listeners', 08:45:36 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 08:45:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:36 INFO - 'USER': 'cltbld', 08:45:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:36 INFO - 'XPC_FLAGS': '0x0', 08:45:36 INFO - 'XPC_SERVICE_NAME': '0', 08:45:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:36 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)) 08:45:36 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)) 08:45:36 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)) 08:45:36 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)) 08:45:36 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)) 08:45:36 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)) 08:45:36 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)) 08:45:36 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)) 08:45:36 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)) 08:45:36 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)) 08:45:36 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)) 08:45:36 INFO - Cleaning up... 08:45:36 INFO - Return code: 0 08:45:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:36 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')]} 08:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:36 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')]} 08:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:37 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 0x103144490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b0d7d6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f58d30>, '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 0x102dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f50b20>, '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.lsaxpBwRz1/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.31EKeeK8Py/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 08:45:37 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 08:45:37 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 08:45:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsaxpBwRz1/Render', 08:45:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:37 INFO - 'HOME': '/Users/cltbld', 08:45:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:37 INFO - 'LOGNAME': 'cltbld', 08:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:37 INFO - 'MOZ_NO_REMOTE': '1', 08:45:37 INFO - 'NO_EM_RESTART': '1', 08:45:37 INFO - 'PAGER': '/bin/cat', 08:45:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:37 INFO - 'PWD': '/builds/slave/test', 08:45:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:37 INFO - 'SHELL': '/bin/bash', 08:45:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.31EKeeK8Py/Listeners', 08:45:37 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 08:45:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:37 INFO - 'USER': 'cltbld', 08:45:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:37 INFO - 'XPC_FLAGS': '0x0', 08:45:37 INFO - 'XPC_SERVICE_NAME': '0', 08:45:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:45:37 INFO - Cleaning up... 08:45:37 INFO - Return code: 0 08:45:37 INFO - Running post-action listener: _resource_record_post_action 08:45:37 INFO - Running post-action listener: _start_resource_monitoring 08:45:37 INFO - Starting resource monitoring. 08:45:37 INFO - [mozharness: 2017-02-27 16:45:37.359325Z] Finished create-virtualenv step (success) 08:45:37 INFO - [mozharness: 2017-02-27 16:45:37.360371Z] Running install step. 08:45:37 INFO - Running pre-action listener: _resource_record_pre_action 08:45:37 INFO - Running main action method: install 08:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:37 INFO - Reading from file tmpfile_stdout 08:45:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:37 INFO - Reading from file tmpfile_stdout 08:45:37 INFO - Output received: 08:45:37 INFO - Usage: mozinstall [options] installer 08:45:37 INFO - Options: 08:45:37 INFO - -h, --help show this help message and exit 08:45:37 INFO - -d DEST, --destination=DEST 08:45:37 INFO - Directory to install application into. [default: 08:45:37 INFO - "/builds/slave/test"] 08:45:37 INFO - --app=APP Application being installed. [default: firefox] 08:45:37 INFO - mkdir: /builds/slave/test/build/application 08:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:45:59 INFO - Reading from file tmpfile_stdout 08:45:59 INFO - Output received: 08:45:59 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:45:59 INFO - Running post-action listener: _resource_record_post_action 08:45:59 INFO - [mozharness: 2017-02-27 16:45:59.969616Z] Finished install step (success) 08:45:59 INFO - [mozharness: 2017-02-27 16:45:59.969773Z] Running run-tests step. 08:45:59 INFO - Running pre-action listener: _resource_record_pre_action 08:45:59 INFO - Running main action method: run_tests 08:45:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:45:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:45:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:45:59 INFO - 2017-02-27 08:45:59.984 screenresolution[1616:7430] starting screenresolution argv=screenresolution get 08:45:59 INFO - 2017-02-27 08:45:59.987 screenresolution[1616:7430] Display 0: 1600x1200x32@60 08:45:59 INFO - 2017-02-27 08:45:59.993 screenresolution[1617:7432] starting screenresolution argv=screenresolution list 08:45:59 INFO - Available Modes on Display 0 08:45:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:45:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:45:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:45:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:46:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:46:00 INFO - Intel Iris: 08:46:00 INFO - Chipset Model: Intel Iris 08:46:00 INFO - Type: GPU 08:46:00 INFO - Bus: Built-In 08:46:00 INFO - VRAM (Dynamic, Max): 1536 MB 08:46:00 INFO - Vendor: Intel (0x8086) 08:46:00 INFO - Device ID: 0x0a2e 08:46:00 INFO - Revision ID: 0x0009 08:46:00 INFO - Displays: 08:46:00 INFO - Display: 08:46:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:46:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:46:00 INFO - Display Serial Number: 1600x1200 60 08:46:00 INFO - Main Display: Yes 08:46:00 INFO - Mirror: Off 08:46:00 INFO - Online: Yes 08:46:00 INFO - Rotation: Supported 08:46:00 INFO - Return code: 0 08:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:46:00 INFO - Python 2.7.3 08:46:00 INFO - Return code: 0 08:46:00 INFO - grabbing minidump binary from tooltool 08:46: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')]} 08:46: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 0x102f58d30>, '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 0x102dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f50b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:46: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 08:46: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 08:46: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 08:46:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:46:00 INFO - Return code: 0 08:46:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:46:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:46:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:46:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:46:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 08:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0088 --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 08:46:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsaxpBwRz1/Render', 08:46:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:00 INFO - 'HOME': '/Users/cltbld', 08:46:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:00 INFO - 'LOGNAME': 'cltbld', 08:46:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:46:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:00 INFO - 'MOZ_NO_REMOTE': '1', 08:46:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:46:00 INFO - 'NO_EM_RESTART': '1', 08:46:00 INFO - 'PAGER': '/bin/cat', 08:46:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:00 INFO - 'PWD': '/builds/slave/test', 08:46:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:46:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:00 INFO - 'SHELL': '/bin/bash', 08:46:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.31EKeeK8Py/Listeners', 08:46:00 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 08:46:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:00 INFO - 'USER': 'cltbld', 08:46:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:00 INFO - 'XPC_FLAGS': '0x0', 08:46:00 INFO - 'XPC_SERVICE_NAME': '0', 08:46:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 08:46:00 INFO - mozversion application_buildid: 20170227061609 08:46:00 INFO - mozversion application_changeset: a058f3e17dcf5ea2dfe7431d4f238dd352c473d2 08:46:00 INFO - mozversion application_display_name: Firefox 08:46:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:46:00 INFO - mozversion application_name: Firefox 08:46:00 INFO - mozversion application_remotingname: firefox 08:46:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:46:00 INFO - mozversion application_vendor: Mozilla 08:46:00 INFO - mozversion application_version: 52.0 08:46:00 INFO - mozversion platform_buildid: 20170227061609 08:46:00 INFO - mozversion platform_changeset: a058f3e17dcf5ea2dfe7431d4f238dd352c473d2 08:46:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:46:00 INFO - mozversion platform_version: 52.0 08:46:00 INFO - using testdate: 1488213960 08:46:00 INFO - actual date: 1488213960 08:46:00 INFO - starting webserver on 'localhost:49241' 08:46:00 INFO - SUITE-START | Running 2 tests 08:46:00 INFO - TEST-START | dromaeo_css 08:46:00 INFO - operating with platform_type : mac_ 08:46:00 INFO - Initialising browser for dromaeo_css test... 08:46:00 INFO - TEST-INFO | started process 1627 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmphAUIlb/profile http://localhost:49241/getInfo.html) 08:46:03 INFO - PROCESS | 1627 | __metrics Screen width/height:1600/1200 08:46:03 INFO - PROCESS | 1627 | colorDepth:24 08:46:03 INFO - PROCESS | 1627 | Browser inner width/height: 1024/689 08:46:03 INFO - PROCESS | 1627 | __metrics 08:46:03 INFO - PROCESS | 1627 | 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" 08:46:03 INFO - PROCESS | 1627 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:46:04 INFO - TEST-INFO | 1627: exit 0 08:46:04 INFO - Browser initialized. 08:46:04 INFO - Running cycle 1/1 for dromaeo_css test... 08:46:04 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmphAUIlb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:16 INFO - PROCESS | 1630 | RSS: Main: 167718912 08:46:16 INFO - PROCESS | 1630 | 08:49:20 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:49:22 INFO - PROCESS | 1630 | RSS: Main: 337993728 08:49:22 INFO - PROCESS | 1630 | 08:52:25 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:52:26 INFO - PROCESS | 1630 | RSS: Main: 302718976 08:52:26 INFO - PROCESS | 1630 | 08:55:28 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:55:29 INFO - PROCESS | 1630 | RSS: Main: 270790656 08:55:29 INFO - PROCESS | 1630 | 08:58:31 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:58:32 INFO - PROCESS | 1630 | RSS: Main: 275644416 08:58:32 INFO - PROCESS | 1630 | 09:01:35 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:01:35 INFO - PROCESS | 1630 | RSS: Main: 266604544 09:01:35 INFO - PROCESS | 1630 | 09:04:38 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:04:39 INFO - PROCESS | 1630 | RSS: Main: 484843520 09:04:39 INFO - PROCESS | 1630 | 09:04:39 INFO - PROCESS | 1630 | __start_tp_report 09:04:39 INFO - PROCESS | 1630 | _x_x_mozilla_page_load 09:04:39 INFO - PROCESS | 1630 | _x_x_mozilla_page_load_details 09:04:39 INFO - PROCESS | 1630 | |i|pagename|runs| 09:04:39 INFO - PROCESS | 1630 | |0;dojo.html;3481.56480439945;3502.6847583717467;3509.192885636305;3509.701675357593;3554.1825380162563;5859.6777177255235;5865.178874957499;5930.466258036776;5945.762169513214;5994.070919007555;5611.494965453108;5871.735771890265;5919.52643788497;5922.615030023046;5962.522998160148;5221.765020574065;5231.110711179109;5291.629585928987;5334.893302133955;5397.7031263280505;5192.636515443921;5207.010667973092;5210.609204309692;5375.81184658537;5392.325959255093;5237.842864714045;5244.265802787613;5270.420253772082;5285.8942821143555;5340.305760251182;5271.551918086948;5295.894082118374;5300.867478313035;5305.549028332596;5367.355917289911;5161.9159976405;5261.000409922102;5262.447443018505;5280.973595132038;5313.57491400687;5767.971160144172;5806.361300256968;5814.215080964058;5833.562482813763;5842.532597392198;6185.288691800411;6195.87608247837;6199.101130336121;6204.534659900481;6214.5649804513705;6247.156633854463;6250.124982502453;6253.280872699606;6263.937360626381;6269.87460250797;4972.627052971042;5846.0646296593195;5901.17383566301;5909.734061967221;5919;6322.146510221061;6425.903611445832;6436.871262574816;6444.291127975919;6465.450436712932;6076.878462430726;6197.442230199304;6199.969000155061;6203.7828675997025;6210.813675589739;6121.239585875146;6170.629762214281;6253;6256.155419018465;6262.34245404226;6134.589663226396;6166.753329866845;6173.104899789505;6217.875642487125;6220.813375598739;6194.163787888668;6213.881501329804;6216.2540495139965;6219.657918814509;6220.657863817533;4981.576565991859;5034.345535080416;5080.23796430531;5081.212412076134;5088.974555127201;3815.351390263662;4474.418325617649;4502.527234640381;4533.433320834895;4540.069285796404;5869.442402971797;5883.235179426647;5906.5570082244;5911.113333000085;5913.379095195029;6172.444479996821;6178.752849885954;6180.4437600615265;6180.47465965389;6187.319394866561;5835.620684655484;5873.530117590582;5892.410758924073;5958.940410595926;5985.431384018511;4977.129002424561;5315.548178404802;5555.2222688822785;5567.944320556823;5591.440855914458;6507.284198738135;6545.705443254969;6556.803295901131;6558.934410655927;6564.113844631009;4767.69010014348;6139.093519790236;6140.815775526741;6159.938400616115;6260.342664020212;6423.678816059085;6517.511186661114;6545.083688283549;6555.2789193189665;6561.704723287368;6177.6911154443;6182.28903676083;6199.938000619936;6201.2868520118955;6204.5036397089025;5111.437741848468;6132.110843927695;6135.355158799568;6144.525313924715;6210.844728881814;6060.121282414113;6152.846178845564;6176.227971503562;6185.84535386619;6192.411720886508;6175.228096487939;6177.382261773787;6193.907091393543;6197.783077592263;6206.317305096526;6098;6114.908276375769;6145.66198859067;6164.599301045418;6171.814845554641;5261.868698229899;6060.696965151813;6120.20334290948;6141.232345956755;6161.383861613982;6105.328413874559;6106.604636367124;6110.741024289734;6112.550925488426;6114.449440885189 09:04:39 INFO - PROCESS | 1630 | |1;ext.html;462.78017941477805;466.03763228932263;484.66800241834324;501.5205144822771;537.3310228765185;26117.608235876476;38154.80922595387;39264.80367598162;39404.80297598515;41433.79283103588;41360.79319603405;41374.793126034325;41809.7909510452;41939.95150121241;41954.37068443976;9463.952680236624;9617.182539484153;9629.229661627089;9632.133108020276;9666.323357364952;9331.020242874501;9435.716928492157;9435.716928492157;9450.527473626325;9477.241820654332;9458.196053335474;9473.100055494717;9476.763080922998;9489.620415183419;9491.620335186584;9413.435193888354;9431.434113953184;9436.764080897963;9439.008904065111;9446.38598491096;9463.006384329616;9523.047695230422;9543.856842147374;9544.665936692183;9553.283503737248;38822.80588597067;39177.82466526009;39204.019899502455;39251.803740981115;39295.60704392948;3242.7567932405163;3349.480830471281;3462.8961131166106;3592.8383222755037;3812.5615554211345;25573.616395754078;28460.715392846014;28664.712021070583;30341.848290758404;31291.53062704061;3147.496400575897;3212.851405622491;3276.918077048069;3304.884329048472;3334.1831251343574;479852.60073699756;482544.9999999965;484681;485089;485419;55741.1638825418;55960.72019639957;55963.720181398836;55999.720001399735;56105.43894561084;34367;34418;34545.13637159041;55020.89958200813;55255.72372138114;15955.521334359755;16247;16253.349866005465;16263.756043659354;16290.592735181715;10790.73023174427;12555;12646.367681615882;12647.0514711397;12663.810042849365;18805.247790088244;18813.529661758566;18824.81175188258;18856.434306970812;18863;7613;7679;7700.536897989364;7736.92263077362;7809.570473624005;832.6627715775121;957.3872721458272;972.8929817720045;1049.30745707834;1061.984070238947;30425;30568.69431305703;31623;31872.20319491985;32505;851.82537579796;918.5084934669471;967.3857100740939;1006.0492834271544;1056.2606175676904;8523.829523409497;14833.332500037308;15110;15291.929564930571;15716.978396404196;681681;686662;686832;687030;687328;54272.45727542674;54712.90574188494;54719.17921231185;54793.45206547963;55088;1227.098082909061;1251.5431867368345;1330.1221194011905;1365.1740696878642;1369.383777300219;28274.2931426716;29564.704352956196;29789.553156702234;29821.403571928873;30494.08517744471;48197.51802481931;48809.779755506395;48877;48906.266406003226;48913.51086489232;547385;553610;554111;554754.2262288824;638021;21791.673124903456;25046;25118.623220651338;25198.748012520373;26342.73657263403;42210;42293.577064228964;42579.361309581;42763.57236427596;43663.781681091394;35489.82255088708;35649.28701426009;35780.46329305114;35808.820955896095;36623.26753464969;35626.8218658905;35642.10894727652;36674.44988325231;36801;36820.26359472742;35324.82337588296;35730;35813.300140469924;35867.46198806968;36244.637553624125;30944.845275774376;31812.84093579517;31861.044168674976;32064.51903221407;32600;24197.274081777574;24401.877990609933;24436.218763471945;24510.509789804462;24633.137840175506 09:04:39 INFO - PROCESS | 1630 | |2;jquery.html;312.8920522419765;377.181516110041;384.91916697493537;394.6251061491584;407.74211557345586;19792.802071979295;20042.59914801705;20816.375508734724;20912.790872091293;21145.259915902945;11792.646220613375;11891.52433902645;12284.877151228486;12294.26234425935;12322;5307.389650190239;5588.441155884399;5593.188987596796;5596.944030559704;5597.916031259534;3737.1965027519077;4067.3288907330257;4269.914601707979;5134.691918484884;5516.200150978106;5172.689638621676;8031.638576264053;8101.837963240731;8120.4315697901175;8146.837063258761;6897.344752248553;7931;8007.159248278964;8019.318357939582;8120.593970301491;7406.111266648037;7655.732049378301;7719.536827790351;7741.380689544823;7774.883376749353;28738.425231495254;28980.42039159205;28995;29005.56491652627;29126.563101553493;2516.6099254615565;2731.658542682165;3059.342241418106;3384.1370450534955;3435.862565497377;16511.00933943967;16618;16703.832961670472;16711.415100471546;17500.12499375026;1958.5789055353025;1988.9104990275473;1996.1217064491577;2015.123421311734;2067.8449116316187;118637;121085.99999999911;145622;152280.05619522353;154077;18068.548286292684;21660;22193;22284.331470055924;22470.775292247195;36394.8180259097;36909.26181476355;37056.62943370532;37124.44313335302;37229.88310350694;10642.84035739449;11030.889691103146;11192.384418856878;11194.776104477865;11407.543698252142;9024.954875225581;9026.368154229272;9036.548172591343;9229.907700923039;9288.72133835986;9792.51037448139;9847.803043939224;9977.650782222587;9992.450415227087;10004.899951000396;3377.8986630401128;3644.362236608636;3741.30785804627;3755.49780087967;3756.38019726742;773.8645736996003;840.3487147754691;879.8944126704837;882.8631562107884;1037.8339465685453;20426.182952681727;20912;21214.89392553058;21216.78783212179;21244.575108497742;874.7725591346168;879.8812160358269;884.8849649545518;912.2018234045211;935.854942483916;10455.111315538265;11061.281016734047;11088.722781930355;11141.888581114084;11185.937335953071;574901;581442;585002;612482;637252;126016;134593;137001;137443;137546;844.2444012608804;959.5490119643756;1021.7343490692325;1023.8054769593754;1026.97432564185;18815.6236875259;18959;19399.3210237641;19447.222111115396;19599.824010559412;56576;57466.425335746106;59022;59910.70044649749;60893;81251.5937420309;83943.16056839598;84481.15518844733;84561;88333.55833220793;5494.697791621499;5950.9702451487465;7054.188768291712;7550.735724249625;8713;11446.885531144582;13265.270410127536;13357.53248636293;13478.393472293574;13710.38303276335;11199;11292.209545331747;11644.2431241969;11662.650120496399;11706.063514918957;11370.260933039326;11402.94298528502;11431.714207144887;11577.826332605186;11902.226355286879;11369.488373023069;11840.230385024946;12015.579454719393;12071.57749478764;12084.939575302067;7441.069866266716;7517.511361761468;7535.246475352421;7818.296353328228;7830.843383132419;5733.31200255972;11179.888201117885;11394;11515.19393642437;11885.76228475443 09:04:39 INFO - PROCESS | 1630 | |3;mootools.html;1344.9173415400599;1466.1496332127367;1521.0721459909453;1689.8394652508016;1865.8134186581344;7488.812779680511;7866.763997080083;7876.645550950207;7879.409044321677;7880.014998125234;7986.800329991753;8197.549134797584;8207.794805129875;8254.958725206381;8267.255946964771;2357.7995870350996;2388.152205966883;2391.7488663690324;2395.6765836612008;2401.1595941420537;2369.798567121788;2417.2627348658652;2417.347316224618;2418.2019933422016;2423.8424502407374;2333.894974726133;2360.1975328388344;2368.455255291284;2381.6903802505735;2384.3919800450863;2292.587334279829;2307.653851922208;2335.7781010804033;2336.6027775278244;2336.7429582745885;2349.6005679034433;2369.206315884181;2391.485830546441;2391.617341225413;2394.6048901931163;8309.709160179425;8321;8379;8392.328613710888;8395.202455766754;4315.244832154361;5033.521815427529;5147.356580427447;5153.407358153823;5213.3743950725775;3315.4860996545576;3536.469529570559;3620.529331186955;3625.3836847735947;3634.963650363489;1082.6373164989739;1087.6791346552786;1111.5331560744507;1125.943702814864;1128.2779021426293;10857.45712714369;10914.836277455845;10957.50691218897;10959.452027398598;10970.957759012881;3983.541892682321;4240.915181696349;4425.933610995838;4541.795619197144;4547.681662283675;8703.129687031373;8720.258778003814;8720.651173953098;8724.083971183061;8733.956330218309;4334.393184954109;5119.411267704188;5122.538971492583;5129.076766182123;5131.820386286537;4046.473958385391;4354.455693038371;4438.267685831802;4475.865724028285;4821.7589120543835;3672.8530858765885;3734.533183352081;3799.164183879542;3825.292320920583;3843.461915331856;1146.157574182975;1154.572808061023;1159.2986243322837;1168.8129899216256;1172.202902026613;882.1443200095897;906.5875026862761;925.7500474871747;929.5574411818704;940.7648087978006;5797.710114494258;5894.970525147347;5937.109433584997;6030.7889223876955;6125;876.6318146378536;925.833349997007;935.700575815746;961.6682244625594;974.9805003900024;3596.5324507813816;3790.2419516096893;3818.5608655004476;3847.5960024197616;3939.075368572141;9882.604695812088;10110.797784044425;10202.438865862448;10205.132563732166;10207.795844083077;9650.227981761442;10040.69877903664;10121.59513619447;10127.493625318704;10146.797064058677;7716.765317549278;7840.255175758294;7860.213978602094;7953.920460795433;7957.3634109271115;5135.409427915837;5516.61383703153;5591.832245032656;5878.29460464747;5888.558358123072;9259.67591134307;9302.720918372459;9432.669856554987;9450.054994500495;9489.952550237205;9229.215516680888;9471.573779180091;9494.715158545254;9613.471259080537;9654.56554455037;7146.428285737233;7230.060092187982;7271.709131634675;7292.489525733148;7336.633168341455;7789.221077892165;7885.723999659985;7890.329322007694;7898.644560994884;7906.52560846351;6955.547889387173;6990;7159.8568028640175;7231.2768723129375;7319.194888562361;6932.133483314586;6968.825779355557;7024.894626580707;7097.893531597134;7136.571805691675;6651.235107962646;6819;6825.931740682529;6827.726890924308;6830.009648601024;4812.951870481251;4847.903041939071;4848.830290939942;4914.213725803854;4920.286558449076;4483.193025255486;4825.6139508839915;4885.755712214304;4981.402231732215;4996.425411077773 09:04:39 INFO - PROCESS | 1630 | |4;prototype.html;285.52602679551944;294.6375957572186;308.4909898667199;319.270466982944;323.32102584572385;4458.41411981051;5051.924221136685;5196.558292545138;5204.557612602928;5258.740420259588;4160.836365090159;4708.4820669726305;5117;5136.871578210546;5148.974255128728;3545.060558951867;3667.9266414671692;3864.7487913285545;3922.7646341219474;4098.979505102485;3559.056849934769;3806.6193380661853;3886.436466712325;3982.8406863725418;4099.590040995907;3152.7950683205518;3418.658134186574;4009.7594144351287;4011.3982902564703;4025.496812898388;3652.397354436528;3905.0042239229097;3987.7009224308295;4004.1791432756213;4020.618041286073;3104.5498402731478;3175.25381535339;3207.3104282579357;3446.828078453338;3550.786952782841;5076.5177308156035;5082.059818933472;5091.516305950929;5091.919388769778;5106.514881086291;4645.3032045193495;4655.6973796703105;4658.301254811771;4673.462551806551;4702.670813043088;4806.903861922742;4861.73260470674;5075.289459475676;5268;5424.969255841377;3236.91907702307;3894.2600905828085;3901.2782635212575;3908.062065104383;3912.941305880414;5678.614981707693;5730.283714535683;5735.426457354273;5736.598438109334;5753.971230143906;3771.623357474502;3999.3601023836627;4025.2352053109817;4030.455888455021;4036.65688416482;3323.7673362864366;4007.73949693269;4085.611866872642;4094.0788322627172;4145.97927010369;4057.127717540743;4504.774761261924;4665.370175026396;4691.437027556647;4697.389339385926;4740.905181896412;4894.779734911866;5524.58565607581;5571.041772822192;5580.135079062752;1036.8600238967795;1147.4320211495196;1242.9813552796716;1306.876086565553;1324.582756431721;817.6892780743399;907.5326207003267;923.1553128887127;925.356876970499;928.9396189247677;4871.683340582851;4906;4918.262260660929;4929.288891109947;4948.628852836052;4447.822087116544;4906.380894304943;5071.934893672296;5360.249565060894;5408.486193811582;4418.403515525427;4598.724076555417;4916.065947470041;4922.507749225048;4928.0390323886495;2743.2867454461584;2797.3286411261556;2816.6339325427152;2819.873105710248;2823.647044119485;5010.642869277593;5137.280780690707;5360.705161216092;5447.264619276426;5559.972200138974;4778.426588809296;5227.5022787180205;5243.68537887728;5333.386660534011;5482.930828488406;4961.05739909416;5109.259157422227;5518.2826232590305;5532.834014979557;5579;4357.818792281589;4897.485763994871;4940.7035577865445;5077.339945807169;5353.732313384393;4323.718958267703;5278.5249327560705;5317.335333083364;5677.8864422710485;5710.428957104256;5002.674826136289;5147.841735609458;5904.704764761831;6008.699565021819;6014.939850601613;3249.7400207982832;3568.9114819980155;3679.1537946271974;3780.8865734028022;3787;5084.720340381166;5086.465921078234;5614.915776263441;5755.884882302415;5784.987627165314;4998.925016124834;5310.15906490026;5580.693061881636;5591;5611.158326251095;4629.768511574341;4932.186189278729;5314.627976041795;5562.137868630369;5591.832245032656;4155.1897380010605;4952.083864485082;5034.418679002237;5109.565686916654;5411.375482890873;4775.42694876617;5320.754339852764;5582.15310191797;5625.831225063254;5626.971865140648;4575.17646823575;5175.327207463006;5407.378151512627;5460.153676180198;5470.015397228537 09:04:39 INFO - PROCESS | 1630 | |5;yui.html;776.5690042026675;798.9600519974;807.3742849291798;820.9794755131123;840.4663038970252;13853.515126970546;14848.77726834097;15182.468613598527;15721.606959825982;15754.054756714606;13656.975726820503;13756.793648095287;14180.574582762509;14186.006979511438;14204.644883877909;821.273173241681;838.3335248477475;838.6142374507734;839.0560619303284;839.3369238301765;689.135135405066;711.0756017177674;711.4450728431832;713.1371041040347;841.7727213652311;748.6294284329265;863.1627321498169;889.5463313710022;893.566620189211;893.78995935955;893.9865902011443;897.1342654338562;897.349421669291;901.4906577783531;901.9503927283997;661.5303134774316;661.84777501175;661.9602823830586;662.3674390956674;662.6918482905423;14243.715125697428;14419.639509012359;14437.989340746151;14455.421783128662;14948;13859.584212473643;14187.077839940372;14232.715345693132;14466.855331446655;14494.637634059232;11214.775704485946;11233.382163980978;11392.25950313227;11761.882381176165;11956.760864782742;3737.3085979093953;3822.2546603412347;3833.29084119436;3931.7247792654525;4003.2393845169327;82453.17546824514;86852.56573717154;88818;95561;95925.08149837035;10703.357798532114;11004.944975275072;11201.495932682887;11260.662180134608;11899.643010709693;21806.563868722536;22060.558788824135;22076.33770986873;22077.558448831256;22095.116195352006;7551.546907185587;8107.1892810718455;8120.796980075427;8134.308583770446;8357.916420835714;4373;4374.671899607542;4378.715383500063;4406.317020861771;4539.182947069493;3485.3203625292826;3591.712662986955;3594.676479116892;3597.568291805;3599.4420864766003;644.0725355488082;648.4585371215088;648.8280605639414;649.5940037476577;650.4146268358515;537.2880932764103;597.2444857255575;603.4207161125281;662.8906230471919;668.759246671198;7241.348278654947;8287.861525854009;8666.350023748244;8963.551822408854;9136.543172841331;477.8041003188676;590.5275779376482;645.6932956845461;668.866226754651;678.4131726056925;4188.424555296072;4502.482214545304;4505.324201369821;4540.659450541222;4575.642810452632;101953.96092078117;104121.95878041274;104555.4772226134;105558.94441055645;105677.94322056836;67753.66123169352;84042;84849.15150848412;85618;88746;80482;80797.78803317955;81558.59220703976;82502.58748706339;84923;8501.914980850359;8715.302775777796;8730.607122679621;8785.780355491164;8864.06927272627;43785.46750863705;54005.45994540004;54070.729646351516;54402.911941760154;54836;69264.96102558365;77189;78095;78365.60817195878;78534.82197767153;11478.196526243082;11496;11583.247088939192;11676.416179191176;11920.284782913053;12087.214331068453;12126.696832579257;12247.142700010914;12414.317212553397;13099.869001309866;11370.374629395463;11565.248258863146;11769.52921883115;11818.231814932002;12260.754784904073;10488.737781555523;10692.572297108029;10906.2365634408;10943.398113103856;11222.382768947786;11709.824352634547;11726.179167458196;11735.471903764523;11847.940760296144;12107.33409662477;9452.621895124117;9870.85193722109;9879.50602469888;9973.3018688694;9976;8545.87181192295;8940.240079593308;9405.388649737744;9618.951905240428;10348.172146228435 09:04:39 INFO - PROCESS | 1630 | __end_tp_report 09:04:39 INFO - PROCESS | 1630 | __start_cc_report 09:04:39 INFO - PROCESS | 1630 | _x_x_mozilla_cycle_collect,1883 09:04:39 INFO - PROCESS | 1630 | __end_cc_report 09:04:39 INFO - PROCESS | 1630 | __startTimestamp1488215079224__endTimestamp 09:04:39 INFO - PROCESS | 1630 | 09:04:39 INFO - PROCESS | 1630 | ------- Summary: start ------- 09:04:39 INFO - PROCESS | 1630 | Number of tests: 6 09:04:39 INFO - PROCESS | 1630 | 09:04:39 INFO - PROCESS | 1630 | [#0] dojo.html Cycles:165 Average:5798.17 Median:6105.33 stddev:644.35 (10.6%) stddev-sans-first:620.16 09:04:39 INFO - PROCESS | 1630 | Values: 3481.6 3502.7 3509.2 3509.7 3554.2 5859.7 5865.2 5930.5 5945.8 5994.1 5611.5 5871.7 5919.5 5922.6 5962.5 5221.8 5231.1 5291.6 5334.9 5397.7 5192.6 5207.0 5210.6 5375.8 5392.3 5237.8 5244.3 5270.4 5285.9 5340.3 5271.6 5295.9 5300.9 5305.5 5367.4 5161.9 5261.0 5262.4 5281.0 5313.6 5768.0 5806.4 5814.2 5833.6 5842.5 6185.3 6195.9 6199.1 6204.5 6214.6 6247.2 6250.1 6253.3 6263.9 6269.9 4972.6 5846.1 5901.2 5909.7 5919.0 6322.1 6425.9 6436.9 6444.3 6465.5 6076.9 6197.4 6200.0 6203.8 6210.8 6121.2 6170.6 6253.0 6256.2 6262.3 6134.6 6166.8 6173.1 6217.9 6220.8 6194.2 6213.9 6216.3 6219.7 6220.7 4981.6 5034.3 5080.2 5081.2 5089.0 3815.4 4474.4 4502.5 4533.4 4540.1 5869.4 5883.2 5906.6 5911.1 5913.4 6172.4 6178.8 6180.4 6180.5 6187.3 5835.6 5873.5 5892.4 5958.9 5985.4 4977.1 5315.5 5555.2 5567.9 5591.4 6507.3 6545.7 6556.8 6558.9 6564.1 4767.7 6139.1 6140.8 6159.9 6260.3 6423.7 6517.5 6545.1 6555.3 6561.7 6177.7 6182.3 6199.9 6201.3 6204.5 5111.4 6132.1 6135.4 6144.5 6210.8 6060.1 6152.8 6176.2 6185.8 6192.4 6175.2 6177.4 6193.9 6197.8 6206.3 6098.0 6114.9 6145.7 6164.6 6171.8 5261.9 6060.7 6120.2 6141.2 6161.4 6105.3 6106.6 6110.7 6112.6 6114.4 09:04:39 INFO - PROCESS | 1630 | 09:04:39 INFO - PROCESS | 1630 | [#1] ext.html Cycles:180 Average:69644.97 Median:39227.91 stddev:157003.66 (400.2%) stddev-sans-first:157358.17 09:04:39 INFO - PROCESS | 1630 | Values: 462.8 466.0 484.7 501.5 537.3 26117.6 38154.8 39264.8 39404.8 41433.8 41360.8 41374.8 41809.8 41940.0 41954.4 9464.0 9617.2 9629.2 9632.1 9666.3 9331.0 9435.7 9435.7 9450.5 9477.2 9458.2 9473.1 9476.8 9489.6 9491.6 9413.4 9431.4 9436.8 9439.0 9446.4 9463.0 9523.0 9543.9 9544.7 9553.3 38822.8 39177.8 39204.0 39251.8 39295.6 3242.8 3349.5 3462.9 3592.8 3812.6 25573.6 28460.7 28664.7 30341.8 31291.5 3147.5 3212.9 3276.9 3304.9 3334.2 479852.6 482545.0 484681.0 485089.0 485419.0 55741.2 55960.7 55963.7 55999.7 56105.4 34367.0 34418.0 34545.1 55020.9 55255.7 15955.5 16247.0 16253.3 16263.8 16290.6 10790.7 12555.0 12646.4 12647.1 12663.8 18805.2 18813.5 18824.8 18856.4 18863.0 7613.0 7679.0 7700.5 7736.9 7809.6 832.7 957.4 972.9 1049.3 1062.0 30425.0 30568.7 31623.0 31872.2 32505.0 851.8 918.5 967.4 1006.0 1056.3 8523.8 14833.3 15110.0 15291.9 15717.0 681681.0 686662.0 686832.0 687030.0 687328.0 54272.5 54712.9 54719.2 54793.5 55088.0 1227.1 1251.5 1330.1 1365.2 1369.4 28274.3 29564.7 29789.6 29821.4 30494.1 48197.5 48809.8 48877.0 48906.3 48913.5 547385.0 553610.0 554111.0 554754.2 638021.0 21791.7 25046.0 25118.6 25198.7 26342.7 42210.0 42293.6 42579.4 42763.6 43663.8 35489.8 35649.3 35780.5 35808.8 36623.3 35626.8 35642.1 36674.4 36801.0 36820.3 35324.8 35730.0 35813.3 35867.5 36244.6 30944.8 31812.8 31861.0 32064.5 32600.0 24197.3 24401.9 24436.2 24510.5 24633.1 09:04:39 INFO - PROCESS | 1630 | 09:04:39 INFO - PROCESS | 1630 | [#2] jquery.html Cycles:180 Average:37505.78 Median:16092.95 stddev:100510.99 (624.6%) stddev-sans-first:100754.16 09:04:39 INFO - PROCESS | 1630 | Values: 312.9 377.2 384.9 394.6 407.7 19792.8 20042.6 20816.4 20912.8 21145.3 11792.6 11891.5 12284.9 12294.3 12322.0 5307.4 5588.4 5593.2 5596.9 5597.9 3737.2 4067.3 4269.9 5134.7 5516.2 5172.7 8031.6 8101.8 8120.4 8146.8 6897.3 7931.0 8007.2 8019.3 8120.6 7406.1 7655.7 7719.5 7741.4 7774.9 28738.4 28980.4 28995.0 29005.6 29126.6 2516.6 2731.7 3059.3 3384.1 3435.9 16511.0 16618.0 16703.8 16711.4 17500.1 1958.6 1988.9 1996.1 2015.1 2067.8 118637.0 121086.0 145622.0 152280.1 154077.0 18068.5 21660.0 22193.0 22284.3 22470.8 36394.8 36909.3 37056.6 37124.4 37229.9 10642.8 11030.9 11192.4 11194.8 11407.5 9025.0 9026.4 9036.5 9229.9 9288.7 9792.5 9847.8 9977.7 9992.5 10004.9 3377.9 3644.4 3741.3 3755.5 3756.4 773.9 840.3 879.9 882.9 1037.8 20426.2 20912.0 21214.9 21216.8 21244.6 874.8 879.9 884.9 912.2 935.9 10455.1 11061.3 11088.7 11141.9 11185.9 574901.0 581442.0 585002.0 612482.0 637252.0 126016.0 134593.0 137001.0 137443.0 137546.0 844.2 959.5 1021.7 1023.8 1027.0 18815.6 18959.0 19399.3 19447.2 19599.8 56576.0 57466.4 59022.0 59910.7 60893.0 81251.6 83943.2 84481.2 84561.0 88333.6 5494.7 5951.0 7054.2 7550.7 8713.0 11446.9 13265.3 13357.5 13478.4 13710.4 11199.0 11292.2 11644.2 11662.7 11706.1 11370.3 11402.9 11431.7 11577.8 11902.2 11369.5 11840.2 12015.6 12071.6 12084.9 7441.1 7517.5 7535.2 7818.3 7830.8 5733.3 11179.9 11394.0 11515.2 11885.8 09:04:39 INFO - PROCESS | 1630 | 09:04:39 INFO - PROCESS | 1630 | [#3] mootools.html Cycles:180 Average:5433.87 Median:5076.47 stddev:2956.44 (58.2%) stddev-sans-first:2948.76 09:04:39 INFO - PROCESS | 1630 | Values: 1344.9 1466.1 1521.1 1689.8 1865.8 7488.8 7866.8 7876.6 7879.4 7880.0 7986.8 8197.5 8207.8 8255.0 8267.3 2357.8 2388.2 2391.7 2395.7 2401.2 2369.8 2417.3 2417.3 2418.2 2423.8 2333.9 2360.2 2368.5 2381.7 2384.4 2292.6 2307.7 2335.8 2336.6 2336.7 2349.6 2369.2 2391.5 2391.6 2394.6 8309.7 8321.0 8379.0 8392.3 8395.2 4315.2 5033.5 5147.4 5153.4 5213.4 3315.5 3536.5 3620.5 3625.4 3635.0 1082.6 1087.7 1111.5 1125.9 1128.3 10857.5 10914.8 10957.5 10959.5 10971.0 3983.5 4240.9 4425.9 4541.8 4547.7 8703.1 8720.3 8720.7 8724.1 8734.0 4334.4 5119.4 5122.5 5129.1 5131.8 4046.5 4354.5 4438.3 4475.9 4821.8 3672.9 3734.5 3799.2 3825.3 3843.5 1146.2 1154.6 1159.3 1168.8 1172.2 882.1 906.6 925.8 929.6 940.8 5797.7 5895.0 5937.1 6030.8 6125.0 876.6 925.8 935.7 961.7 975.0 3596.5 3790.2 3818.6 3847.6 3939.1 9882.6 10110.8 10202.4 10205.1 10207.8 9650.2 10040.7 10121.6 10127.5 10146.8 7716.8 7840.3 7860.2 7953.9 7957.4 5135.4 5516.6 5591.8 5878.3 5888.6 9259.7 9302.7 9432.7 9450.1 9490.0 9229.2 9471.6 9494.7 9613.5 9654.6 7146.4 7230.1 7271.7 7292.5 7336.6 7789.2 7885.7 7890.3 7898.6 7906.5 6955.5 6990.0 7159.9 7231.3 7319.2 6932.1 6968.8 7024.9 7097.9 7136.6 6651.2 6819.0 6825.9 6827.7 6830.0 4813.0 4847.9 4848.8 4914.2 4920.3 4483.2 4825.6 4885.8 4981.4 4996.4 09:04:39 INFO - PROCESS | 1630 | 09:04:39 INFO - PROCESS | 1630 | [#4] prototype.html Cycles:180 Average:4371.36 Median:4911.22 stddev:1323.86 (27.0%) stddev-sans-first:1291.56 09:04:39 INFO - PROCESS | 1630 | Values: 285.5 294.6 308.5 319.3 323.3 4458.4 5051.9 5196.6 5204.6 5258.7 4160.8 4708.5 5117.0 5136.9 5149.0 3545.1 3667.9 3864.7 3922.8 4099.0 3559.1 3806.6 3886.4 3982.8 4099.6 3152.8 3418.7 4009.8 4011.4 4025.5 3652.4 3905.0 3987.7 4004.2 4020.6 3104.5 3175.3 3207.3 3446.8 3550.8 5076.5 5082.1 5091.5 5091.9 5106.5 4645.3 4655.7 4658.3 4673.5 4702.7 4806.9 4861.7 5075.3 5268.0 5425.0 3236.9 3894.3 3901.3 3908.1 3912.9 5678.6 5730.3 5735.4 5736.6 5754.0 3771.6 3999.4 4025.2 4030.5 4036.7 3323.8 4007.7 4085.6 4094.1 4146.0 4057.1 4504.8 4665.4 4691.4 4697.4 4740.9 4894.8 5524.6 5571.0 5580.1 1036.9 1147.4 1243.0 1306.9 1324.6 817.7 907.5 923.2 925.4 928.9 4871.7 4906.0 4918.3 4929.3 4948.6 4447.8 4906.4 5071.9 5360.2 5408.5 4418.4 4598.7 4916.1 4922.5 4928.0 2743.3 2797.3 2816.6 2819.9 2823.6 5010.6 5137.3 5360.7 5447.3 5560.0 4778.4 5227.5 5243.7 5333.4 5482.9 4961.1 5109.3 5518.3 5532.8 5579.0 4357.8 4897.5 4940.7 5077.3 5353.7 4323.7 5278.5 5317.3 5677.9 5710.4 5002.7 5147.8 5904.7 6008.7 6014.9 3249.7 3568.9 3679.2 3780.9 3787.0 5084.7 5086.5 5614.9 5755.9 5785.0 4998.9 5310.2 5580.7 5591.0 5611.2 4629.8 4932.2 5314.6 5562.1 5591.8 4155.2 4952.1 5034.4 5109.6 5411.4 4775.4 5320.8 5582.2 5625.8 5627.0 4575.2 5175.3 5407.4 5460.2 5470.0 09:04:39 INFO - PROCESS | 1630 | 09:04:39 INFO - PROCESS | 1630 | [#5] yui.html Cycles:180 Average:19875.21 Median:54236.82 stddev:28777.66 (53.1%) stddev-sans-first:28822.66 09:04:39 INFO - PROCESS | 1630 | Values: 776.6 799.0 807.4 821.0 840.5 13853.5 14848.8 15182.5 15721.6 15754.1 13657.0 13756.8 14180.6 14186.0 14204.6 821.3 838.3 838.6 839.1 839.3 689.1 711.1 711.4 713.1 841.8 748.6 863.2 889.5 893.6 893.8 894.0 897.1 897.3 901.5 902.0 661.5 661.8 662.0 662.4 662.7 14243.7 14419.6 14438.0 14455.4 14948.0 13859.6 14187.1 14232.7 14466.9 14494.6 11214.8 11233.4 11392.3 11761.9 11956.8 3737.3 3822.3 3833.3 3931.7 4003.2 82453.2 86852.6 88818.0 95561.0 95925.1 10703.4 11004.9 11201.5 11260.7 11899.6 21806.6 22060.6 22076.3 22077.6 22095.1 7551.5 8107.2 8120.8 8134.3 8357.9 4373.0 4374.7 4378.7 4406.3 4539.2 3485.3 3591.7 3594.7 3597.6 3599.4 644.1 648.5 648.8 649.6 650.4 537.3 597.2 603.4 662.9 668.8 7241.3 8287.9 8666.4 8963.6 9136.5 477.8 590.5 645.7 668.9 678.4 4188.4 4502.5 4505.3 4540.7 4575.6 101954.0 104122.0 104555.5 105558.9 105677.9 67753.7 84042.0 84849.2 85618.0 88746.0 80482.0 80797.8 81558.6 82502.6 84923.0 8501.9 8715.3 8730.6 8785.8 8864.1 43785.5 54005.5 54070.7 54402.9 54836.0 69265.0 77189.0 78095.0 78365.6 78534.8 11478.2 11496.0 11583.2 11676.4 11920.3 12087.2 12126.7 12247.1 12414.3 13099.9 11370.4 11565.2 11769.5 11818.2 12260.8 10488.7 10692.6 10906.2 10943.4 11222.4 11709.8 11726.2 11735.5 11847.9 12107.3 9452.6 9870.9 9879.5 9973.3 9976.0 8545.9 8940.2 9405.4 9619.0 10348.2 09:04:39 INFO - PROCESS | 1630 | -------- Summary: end -------- 09:04:39 INFO - PROCESS | 1630 | 09:04:39 INFO - TEST-INFO | 1630: exit 0 09:04:39 INFO - TEST-OK | dromaeo_css | took 1119288ms 09:04:39 INFO - TEST-START | kraken 09:04:39 INFO - operating with platform_type : mac_ 09:04:39 INFO - Initialising browser for kraken test... 09:04:39 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpOESwXb/profile http://localhost:49241/getInfo.html) 09:04:42 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 09:04:42 INFO - PROCESS | 1639 | colorDepth:24 09:04:42 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 09:04:42 INFO - PROCESS | 1639 | __metrics 09:04:42 INFO - PROCESS | 1639 | 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" 09:04:42 INFO - PROCESS | 1639 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:43 INFO - TEST-INFO | 1639: exit 0 09:04:43 INFO - Browser initialized. 09:04:43 INFO - Running cycle 1/1 for kraken test... 09:04:43 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpOESwXb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:55 INFO - PROCESS | 1641 | RSS: Main: 167759872 09:04:55 INFO - PROCESS | 1641 | 09:04:58 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:59 INFO - PROCESS | 1641 | RSS: Main: 218746880 09:04:59 INFO - PROCESS | 1641 | 09:05:01 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:05:02 INFO - PROCESS | 1641 | RSS: Main: 231030784 09:05:02 INFO - PROCESS | 1641 | 09:05:05 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:05:06 INFO - PROCESS | 1641 | RSS: Main: 327483392 09:05:06 INFO - PROCESS | 1641 | 09:05:08 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:05:08 INFO - PROCESS | 1641 | RSS: Main: 230227968 09:05:08 INFO - PROCESS | 1641 | 09:05:10 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:11 INFO - PROCESS | 1641 | RSS: Main: 232513536 09:05:11 INFO - PROCESS | 1641 | 09:05:14 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:14 INFO - PROCESS | 1641 | RSS: Main: 272674816 09:05:14 INFO - PROCESS | 1641 | 09:05:17 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:18 INFO - PROCESS | 1641 | RSS: Main: 270843904 09:05:18 INFO - PROCESS | 1641 | 09:05:20 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:05:21 INFO - PROCESS | 1641 | RSS: Main: 270180352 09:05:21 INFO - PROCESS | 1641 | 09:05:22 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:23 INFO - PROCESS | 1641 | RSS: Main: 248172544 09:05:23 INFO - PROCESS | 1641 | 09:05:25 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:26 INFO - PROCESS | 1641 | RSS: Main: 251645952 09:05:26 INFO - PROCESS | 1641 | 09:05:28 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:28 INFO - PROCESS | 1641 | RSS: Main: 253534208 09:05:28 INFO - PROCESS | 1641 | 09:05:31 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:32 INFO - PROCESS | 1641 | RSS: Main: 269361152 09:05:32 INFO - PROCESS | 1641 | 09:05:35 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:35 INFO - PROCESS | 1641 | RSS: Main: 263475200 09:05:35 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:05:37 INFO - PROCESS | 1641 | RSS: Main: 307433472 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | __start_tp_report 09:05:37 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 09:05:37 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 09:05:37 INFO - PROCESS | 1641 | |i|pagename|runs| 09:05:37 INFO - PROCESS | 1641 | |0;ai-astar;101;114;113;113;113;112;113;114;116;112 09:05:37 INFO - PROCESS | 1641 | |1;audio-beat-detection;142;106;108;142;108;106;107;105;137;112 09:05:37 INFO - PROCESS | 1641 | |2;audio-dft;185;184;185;193;183;180;183;184;185;182 09:05:37 INFO - PROCESS | 1641 | |3;audio-fft;79;58;59;88;62;58;58;59;70;62 09:05:37 INFO - PROCESS | 1641 | |4;audio-oscillator;85;72;93;94;92;76;87;68;68;90 09:05:37 INFO - PROCESS | 1641 | |5;imaging-gaussian-blur;89;88;89;87;89;87;89;86;88;86 09:05:37 INFO - PROCESS | 1641 | |6;imaging-darkroom;94;95;96;95;95;95;95;95;94;101 09:05:37 INFO - PROCESS | 1641 | |7;imaging-desaturate;82;81;80;80;81;88;81;83;82;83 09:05:37 INFO - PROCESS | 1641 | |8;json-parse-financial;54;55;54;55;56;55;56;55;54;54 09:05:37 INFO - PROCESS | 1641 | |9;json-stringify-tinderbox;65;66;71;75;71;68;69;67;69;70 09:05:37 INFO - PROCESS | 1641 | |10;stanford-crypto-aes;79;82;81;92;94;89;96;80;79;86 09:05:37 INFO - PROCESS | 1641 | |11;stanford-crypto-ccm;136;137;137;135;135;156;149;147;175;139 09:05:37 INFO - PROCESS | 1641 | |12;stanford-crypto-pbkdf2;160;160;162;163;160;160;161;159;158;161 09:05:37 INFO - PROCESS | 1641 | |13;stanford-crypto-sha256-iterative;65;65;66;65;66;66;66;65;65;64 09:05:37 INFO - PROCESS | 1641 | __end_tp_report 09:05:37 INFO - PROCESS | 1641 | __start_cc_report 09:05:37 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,2043 09:05:37 INFO - PROCESS | 1641 | __end_cc_report 09:05:37 INFO - PROCESS | 1641 | __startTimestamp1488215137796__endTimestamp 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | ------- Summary: start ------- 09:05:37 INFO - PROCESS | 1641 | Number of tests: 14 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:4.07 (3.6%) stddev-sans-first:1.22 09:05:37 INFO - PROCESS | 1641 | Values: 101.0 114.0 113.0 113.0 113.0 112.0 113.0 114.0 116.0 112.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#1] audio-beat-detection Cycles:10 Average:117.30 Median:110.00 stddev:16.06 (14.6%) stddev-sans-first:14.34 09:05:37 INFO - PROCESS | 1641 | Values: 142.0 106.0 108.0 142.0 108.0 106.0 107.0 105.0 137.0 112.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.50 stddev:3.41 (1.8%) stddev-sans-first:3.61 09:05:37 INFO - PROCESS | 1641 | Values: 185.0 184.0 185.0 193.0 183.0 180.0 183.0 184.0 185.0 182.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#3] audio-fft Cycles:10 Average:65.30 Median:62.00 stddev:10.47 (16.9%) stddev-sans-first:9.86 09:05:37 INFO - PROCESS | 1641 | Values: 79.0 58.0 59.0 88.0 62.0 58.0 58.0 59.0 70.0 62.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#4] audio-oscillator Cycles:10 Average:82.50 Median:88.50 stddev:10.48 (11.8%) stddev-sans-first:11.08 09:05:37 INFO - PROCESS | 1641 | Values: 85.0 72.0 93.0 94.0 92.0 76.0 87.0 68.0 68.0 90.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.50 stddev:1.23 (1.4%) stddev-sans-first:1.22 09:05:37 INFO - PROCESS | 1641 | Values: 89.0 88.0 89.0 87.0 89.0 87.0 89.0 86.0 88.0 86.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:95.00 stddev:2.01 (2.1%) stddev-sans-first:2.06 09:05:37 INFO - PROCESS | 1641 | Values: 94.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 101.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#7] imaging-desaturate Cycles:10 Average:82.10 Median:82.00 stddev:2.33 (2.8%) stddev-sans-first:2.47 09:05:37 INFO - PROCESS | 1641 | Values: 82.0 81.0 80.0 80.0 81.0 88.0 81.0 83.0 82.0 83.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:0.79 (1.4%) stddev-sans-first:0.78 09:05:37 INFO - PROCESS | 1641 | Values: 54.0 55.0 54.0 55.0 56.0 55.0 56.0 55.0 54.0 54.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.50 stddev:2.88 (4.2%) stddev-sans-first:2.65 09:05:37 INFO - PROCESS | 1641 | Values: 65.0 66.0 71.0 75.0 71.0 68.0 69.0 67.0 69.0 70.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:87.50 stddev:6.53 (7.5%) stddev-sans-first:6.44 09:05:37 INFO - PROCESS | 1641 | Values: 79.0 82.0 81.0 92.0 94.0 89.0 96.0 80.0 79.0 86.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:143.00 stddev:12.84 (9.0%) stddev-sans-first:13.24 09:05:37 INFO - PROCESS | 1641 | Values: 136.0 137.0 137.0 135.0 135.0 156.0 149.0 147.0 175.0 139.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 09:05:37 INFO - PROCESS | 1641 | Values: 160.0 160.0 162.0 163.0 160.0 160.0 161.0 159.0 158.0 161.0 09:05:37 INFO - PROCESS | 1641 | 09:05:37 INFO - PROCESS | 1641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 09:05:37 INFO - PROCESS | 1641 | Values: 65.0 65.0 66.0 65.0 66.0 66.0 66.0 65.0 65.0 64.0 09:05:37 INFO - PROCESS | 1641 | -------- Summary: end -------- 09:05:37 INFO - PROCESS | 1641 | 09:05:38 INFO - TEST-INFO | 1641: exit 0 09:05:38 INFO - TEST-OK | kraken | took 58975ms 09:05:38 INFO - SUITE-END | took 1178s 09:05:38 INFO - Completed test suite (00:19:38) 09:05:38 INFO - javascript benchmark 09:05:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3481.56480439945, 3502.6847583717467, 3509.192885636305, 3509.701675357593, 3554.1825380162563, 5859.6777177255235, 5865.178874957499, 5930.466258036776, 5945.762169513214, 5994.070919007555, 5611.494965453108, 5871.735771890265, 5919.52643788497, 5922.615030023046, 5962.522998160148, 5221.765020574065, 5231.110711179109, 5291.629585928987, 5334.893302133955, 5397.7031263280505, 5192.636515443921, 5207.010667973092, 5210.609204309692, 5375.81184658537, 5392.325959255093, 5237.842864714045, 5244.265802787613, 5270.420253772082, 5285.8942821143555, 5340.305760251182, 5271.551918086948, 5295.894082118374, 5300.867478313035, 5305.549028332596, 5367.355917289911, 5161.9159976405, 5261.000409922102, 5262.447443018505, 5280.973595132038, 5313.57491400687, 5767.971160144172, 5806.361300256968, 5814.215080964058, 5833.562482813763, 5842.532597392198, 6185.288691800411, 6195.87608247837, 6199.101130336121, 6204.534659900481, 6214.5649804513705, 6247.156633854463, 6250.124982502453, 6253.280872699606, 6263.937360626381, 6269.87460250797, 4972.627052971042, 5846.0646296593195, 5901.17383566301, 5909.734061967221, 5919.0, 6322.146510221061, 6425.903611445832, 6436.871262574816, 6444.291127975919, 6465.450436712932, 6076.878462430726, 6197.442230199304, 6199.969000155061, 6203.7828675997025, 6210.813675589739, 6121.239585875146, 6170.629762214281, 6253.0, 6256.155419018465, 6262.34245404226, 6134.589663226396, 6166.753329866845, 6173.104899789505, 6217.875642487125, 6220.813375598739, 6194.163787888668, 6213.881501329804, 6216.2540495139965, 6219.657918814509, 6220.657863817533, 4981.576565991859, 5034.345535080416, 5080.23796430531, 5081.212412076134, 5088.974555127201, 3815.351390263662, 4474.418325617649, 4502.527234640381, 4533.433320834895, 4540.069285796404, 5869.442402971797, 5883.235179426647, 5906.5570082244, 5911.113333000085, 5913.379095195029, 6172.444479996821, 6178.752849885954, 6180.4437600615265, 6180.47465965389, 6187.319394866561, 5835.620684655484, 5873.530117590582, 5892.410758924073, 5958.940410595926, 5985.431384018511, 4977.129002424561, 5315.548178404802, 5555.2222688822785, 5567.944320556823, 5591.440855914458, 6507.284198738135, 6545.705443254969, 6556.803295901131, 6558.934410655927, 6564.113844631009, 4767.69010014348, 6139.093519790236, 6140.815775526741, 6159.938400616115, 6260.342664020212, 6423.678816059085, 6517.511186661114, 6545.083688283549, 6555.2789193189665, 6561.704723287368, 6177.6911154443, 6182.28903676083, 6199.938000619936, 6201.2868520118955, 6204.5036397089025, 5111.437741848468, 6132.110843927695, 6135.355158799568, 6144.525313924715, 6210.844728881814, 6060.121282414113, 6152.846178845564, 6176.227971503562, 6185.84535386619, 6192.411720886508, 6175.228096487939, 6177.382261773787, 6193.907091393543, 6197.783077592263, 6206.317305096526, 6098.0, 6114.908276375769, 6145.66198859067, 6164.599301045418, 6171.814845554641, 5261.868698229899, 6060.696965151813, 6120.20334290948, 6141.232345956755, 6161.383861613982, 6105.328413874559, 6106.604636367124, 6110.741024289734, 6112.550925488426, 6114.449440885189], "value": 5759.068234750143, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.78017941477805, 466.03763228932263, 484.66800241834324, 501.5205144822771, 537.3310228765185, 26117.608235876476, 38154.80922595387, 39264.80367598162, 39404.80297598515, 41433.79283103588, 41360.79319603405, 41374.793126034325, 41809.7909510452, 41939.95150121241, 41954.37068443976, 9463.952680236624, 9617.182539484153, 9629.229661627089, 9632.133108020276, 9666.323357364952, 9331.020242874501, 9435.716928492157, 9435.716928492157, 9450.527473626325, 9477.241820654332, 9458.196053335474, 9473.100055494717, 9476.763080922998, 9489.620415183419, 9491.620335186584, 9413.435193888354, 9431.434113953184, 9436.764080897963, 9439.008904065111, 9446.38598491096, 9463.006384329616, 9523.047695230422, 9543.856842147374, 9544.665936692183, 9553.283503737248, 38822.80588597067, 39177.82466526009, 39204.019899502455, 39251.803740981115, 39295.60704392948, 3242.7567932405163, 3349.480830471281, 3462.8961131166106, 3592.8383222755037, 3812.5615554211345, 25573.616395754078, 28460.715392846014, 28664.712021070583, 30341.848290758404, 31291.53062704061, 3147.496400575897, 3212.851405622491, 3276.918077048069, 3304.884329048472, 3334.1831251343574, 479852.60073699756, 482544.9999999965, 484681.0, 485089.0, 485419.0, 55741.1638825418, 55960.72019639957, 55963.720181398836, 55999.720001399735, 56105.43894561084, 34367.0, 34418.0, 34545.13637159041, 55020.89958200813, 55255.72372138114, 15955.521334359755, 16247.0, 16253.349866005465, 16263.756043659354, 16290.592735181715, 10790.73023174427, 12555.0, 12646.367681615882, 12647.0514711397, 12663.810042849365, 18805.247790088244, 18813.529661758566, 18824.81175188258, 18856.434306970812, 18863.0, 7613.0, 7679.0, 7700.536897989364, 7736.92263077362, 7809.570473624005, 832.6627715775121, 957.3872721458272, 972.8929817720045, 1049.30745707834, 1061.984070238947, 30425.0, 30568.69431305703, 31623.0, 31872.20319491985, 32505.0, 851.82537579796, 918.5084934669471, 967.3857100740939, 1006.0492834271544, 1056.2606175676904, 8523.829523409497, 14833.332500037308, 15110.0, 15291.929564930571, 15716.978396404196, 681681.0, 686662.0, 686832.0, 687030.0, 687328.0, 54272.45727542674, 54712.90574188494, 54719.17921231185, 54793.45206547963, 55088.0, 1227.098082909061, 1251.5431867368345, 1330.1221194011905, 1365.1740696878642, 1369.383777300219, 28274.2931426716, 29564.704352956196, 29789.553156702234, 29821.403571928873, 30494.08517744471, 48197.51802481931, 48809.779755506395, 48877.0, 48906.266406003226, 48913.51086489232, 547385.0, 553610.0, 554111.0, 554754.2262288824, 638021.0, 21791.673124903456, 25046.0, 25118.623220651338, 25198.748012520373, 26342.73657263403, 42210.0, 42293.577064228964, 42579.361309581, 42763.57236427596, 43663.781681091394, 35489.82255088708, 35649.28701426009, 35780.46329305114, 35808.820955896095, 36623.26753464969, 35626.8218658905, 35642.10894727652, 36674.44988325231, 36801.0, 36820.26359472742, 35324.82337588296, 35730.0, 35813.300140469924, 35867.46198806968, 36244.637553624125, 30944.845275774376, 31812.84093579517, 31861.044168674976, 32064.51903221407, 32600.0, 24197.274081777574, 24401.877990609933, 24436.218763471945, 24510.509789804462, 24633.137840175506], "value": 19198.795073537858, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.8920522419765, 377.181516110041, 384.91916697493537, 394.6251061491584, 407.74211557345586, 19792.802071979295, 20042.59914801705, 20816.375508734724, 20912.790872091293, 21145.259915902945, 11792.646220613375, 11891.52433902645, 12284.877151228486, 12294.26234425935, 12322.0, 5307.389650190239, 5588.441155884399, 5593.188987596796, 5596.944030559704, 5597.916031259534, 3737.1965027519077, 4067.3288907330257, 4269.914601707979, 5134.691918484884, 5516.200150978106, 5172.689638621676, 8031.638576264053, 8101.837963240731, 8120.4315697901175, 8146.837063258761, 6897.344752248553, 7931.0, 8007.159248278964, 8019.318357939582, 8120.593970301491, 7406.111266648037, 7655.732049378301, 7719.536827790351, 7741.380689544823, 7774.883376749353, 28738.425231495254, 28980.42039159205, 28995.0, 29005.56491652627, 29126.563101553493, 2516.6099254615565, 2731.658542682165, 3059.342241418106, 3384.1370450534955, 3435.862565497377, 16511.00933943967, 16618.0, 16703.832961670472, 16711.415100471546, 17500.12499375026, 1958.5789055353025, 1988.9104990275473, 1996.1217064491577, 2015.123421311734, 2067.8449116316187, 118637.0, 121085.99999999911, 145622.0, 152280.05619522353, 154077.0, 18068.548286292684, 21660.0, 22193.0, 22284.331470055924, 22470.775292247195, 36394.8180259097, 36909.26181476355, 37056.62943370532, 37124.44313335302, 37229.88310350694, 10642.84035739449, 11030.889691103146, 11192.384418856878, 11194.776104477865, 11407.543698252142, 9024.954875225581, 9026.368154229272, 9036.548172591343, 9229.907700923039, 9288.72133835986, 9792.51037448139, 9847.803043939224, 9977.650782222587, 9992.450415227087, 10004.899951000396, 3377.8986630401128, 3644.362236608636, 3741.30785804627, 3755.49780087967, 3756.38019726742, 773.8645736996003, 840.3487147754691, 879.8944126704837, 882.8631562107884, 1037.8339465685453, 20426.182952681727, 20912.0, 21214.89392553058, 21216.78783212179, 21244.575108497742, 874.7725591346168, 879.8812160358269, 884.8849649545518, 912.2018234045211, 935.854942483916, 10455.111315538265, 11061.281016734047, 11088.722781930355, 11141.888581114084, 11185.937335953071, 574901.0, 581442.0, 585002.0, 612482.0, 637252.0, 126016.0, 134593.0, 137001.0, 137443.0, 137546.0, 844.2444012608804, 959.5490119643756, 1021.7343490692325, 1023.8054769593754, 1026.97432564185, 18815.6236875259, 18959.0, 19399.3210237641, 19447.222111115396, 19599.824010559412, 56576.0, 57466.425335746106, 59022.0, 59910.70044649749, 60893.0, 81251.5937420309, 83943.16056839598, 84481.15518844733, 84561.0, 88333.55833220793, 5494.697791621499, 5950.9702451487465, 7054.188768291712, 7550.735724249625, 8713.0, 11446.885531144582, 13265.270410127536, 13357.53248636293, 13478.393472293574, 13710.38303276335, 11199.0, 11292.209545331747, 11644.2431241969, 11662.650120496399, 11706.063514918957, 11370.260933039326, 11402.94298528502, 11431.714207144887, 11577.826332605186, 11902.226355286879, 11369.488373023069, 11840.230385024946, 12015.579454719393, 12071.57749478764, 12084.939575302067, 7441.069866266716, 7517.511361761468, 7535.246475352421, 7818.296353328228, 7830.843383132419, 5733.31200255972, 11179.888201117885, 11394.0, 11515.19393642437, 11885.76228475443], "value": 10858.945387293808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.9173415400599, 1466.1496332127367, 1521.0721459909453, 1689.8394652508016, 1865.8134186581344, 7488.812779680511, 7866.763997080083, 7876.645550950207, 7879.409044321677, 7880.014998125234, 7986.800329991753, 8197.549134797584, 8207.794805129875, 8254.958725206381, 8267.255946964771, 2357.7995870350996, 2388.152205966883, 2391.7488663690324, 2395.6765836612008, 2401.1595941420537, 2369.798567121788, 2417.2627348658652, 2417.347316224618, 2418.2019933422016, 2423.8424502407374, 2333.894974726133, 2360.1975328388344, 2368.455255291284, 2381.6903802505735, 2384.3919800450863, 2292.587334279829, 2307.653851922208, 2335.7781010804033, 2336.6027775278244, 2336.7429582745885, 2349.6005679034433, 2369.206315884181, 2391.485830546441, 2391.617341225413, 2394.6048901931163, 8309.709160179425, 8321.0, 8379.0, 8392.328613710888, 8395.202455766754, 4315.244832154361, 5033.521815427529, 5147.356580427447, 5153.407358153823, 5213.3743950725775, 3315.4860996545576, 3536.469529570559, 3620.529331186955, 3625.3836847735947, 3634.963650363489, 1082.6373164989739, 1087.6791346552786, 1111.5331560744507, 1125.943702814864, 1128.2779021426293, 10857.45712714369, 10914.836277455845, 10957.50691218897, 10959.452027398598, 10970.957759012881, 3983.541892682321, 4240.915181696349, 4425.933610995838, 4541.795619197144, 4547.681662283675, 8703.129687031373, 8720.258778003814, 8720.651173953098, 8724.083971183061, 8733.956330218309, 4334.393184954109, 5119.411267704188, 5122.538971492583, 5129.076766182123, 5131.820386286537, 4046.473958385391, 4354.455693038371, 4438.267685831802, 4475.865724028285, 4821.7589120543835, 3672.8530858765885, 3734.533183352081, 3799.164183879542, 3825.292320920583, 3843.461915331856, 1146.157574182975, 1154.572808061023, 1159.2986243322837, 1168.8129899216256, 1172.202902026613, 882.1443200095897, 906.5875026862761, 925.7500474871747, 929.5574411818704, 940.7648087978006, 5797.710114494258, 5894.970525147347, 5937.109433584997, 6030.7889223876955, 6125.0, 876.6318146378536, 925.833349997007, 935.700575815746, 961.6682244625594, 974.9805003900024, 3596.5324507813816, 3790.2419516096893, 3818.5608655004476, 3847.5960024197616, 3939.075368572141, 9882.604695812088, 10110.797784044425, 10202.438865862448, 10205.132563732166, 10207.795844083077, 9650.227981761442, 10040.69877903664, 10121.59513619447, 10127.493625318704, 10146.797064058677, 7716.765317549278, 7840.255175758294, 7860.213978602094, 7953.920460795433, 7957.3634109271115, 5135.409427915837, 5516.61383703153, 5591.832245032656, 5878.29460464747, 5888.558358123072, 9259.67591134307, 9302.720918372459, 9432.669856554987, 9450.054994500495, 9489.952550237205, 9229.215516680888, 9471.573779180091, 9494.715158545254, 9613.471259080537, 9654.56554455037, 7146.428285737233, 7230.060092187982, 7271.709131634675, 7292.489525733148, 7336.633168341455, 7789.221077892165, 7885.723999659985, 7890.329322007694, 7898.644560994884, 7906.52560846351, 6955.547889387173, 6990.0, 7159.8568028640175, 7231.2768723129375, 7319.194888562361, 6932.133483314586, 6968.825779355557, 7024.894626580707, 7097.893531597134, 7136.571805691675, 6651.235107962646, 6819.0, 6825.931740682529, 6827.726890924308, 6830.009648601024, 4812.951870481251, 4847.903041939071, 4848.830290939942, 4914.213725803854, 4920.286558449076, 4483.193025255486, 4825.6139508839915, 4885.755712214304, 4981.402231732215, 4996.425411077773], "value": 4422.130623365172, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.52602679551944, 294.6375957572186, 308.4909898667199, 319.270466982944, 323.32102584572385, 4458.41411981051, 5051.924221136685, 5196.558292545138, 5204.557612602928, 5258.740420259588, 4160.836365090159, 4708.4820669726305, 5117.0, 5136.871578210546, 5148.974255128728, 3545.060558951867, 3667.9266414671692, 3864.7487913285545, 3922.7646341219474, 4098.979505102485, 3559.056849934769, 3806.6193380661853, 3886.436466712325, 3982.8406863725418, 4099.590040995907, 3152.7950683205518, 3418.658134186574, 4009.7594144351287, 4011.3982902564703, 4025.496812898388, 3652.397354436528, 3905.0042239229097, 3987.7009224308295, 4004.1791432756213, 4020.618041286073, 3104.5498402731478, 3175.25381535339, 3207.3104282579357, 3446.828078453338, 3550.786952782841, 5076.5177308156035, 5082.059818933472, 5091.516305950929, 5091.919388769778, 5106.514881086291, 4645.3032045193495, 4655.6973796703105, 4658.301254811771, 4673.462551806551, 4702.670813043088, 4806.903861922742, 4861.73260470674, 5075.289459475676, 5268.0, 5424.969255841377, 3236.91907702307, 3894.2600905828085, 3901.2782635212575, 3908.062065104383, 3912.941305880414, 5678.614981707693, 5730.283714535683, 5735.426457354273, 5736.598438109334, 5753.971230143906, 3771.623357474502, 3999.3601023836627, 4025.2352053109817, 4030.455888455021, 4036.65688416482, 3323.7673362864366, 4007.73949693269, 4085.611866872642, 4094.0788322627172, 4145.97927010369, 4057.127717540743, 4504.774761261924, 4665.370175026396, 4691.437027556647, 4697.389339385926, 4740.905181896412, 4894.779734911866, 5524.58565607581, 5571.041772822192, 5580.135079062752, 1036.8600238967795, 1147.4320211495196, 1242.9813552796716, 1306.876086565553, 1324.582756431721, 817.6892780743399, 907.5326207003267, 923.1553128887127, 925.356876970499, 928.9396189247677, 4871.683340582851, 4906.0, 4918.262260660929, 4929.288891109947, 4948.628852836052, 4447.822087116544, 4906.380894304943, 5071.934893672296, 5360.249565060894, 5408.486193811582, 4418.403515525427, 4598.724076555417, 4916.065947470041, 4922.507749225048, 4928.0390323886495, 2743.2867454461584, 2797.3286411261556, 2816.6339325427152, 2819.873105710248, 2823.647044119485, 5010.642869277593, 5137.280780690707, 5360.705161216092, 5447.264619276426, 5559.972200138974, 4778.426588809296, 5227.5022787180205, 5243.68537887728, 5333.386660534011, 5482.930828488406, 4961.05739909416, 5109.259157422227, 5518.2826232590305, 5532.834014979557, 5579.0, 4357.818792281589, 4897.485763994871, 4940.7035577865445, 5077.339945807169, 5353.732313384393, 4323.718958267703, 5278.5249327560705, 5317.335333083364, 5677.8864422710485, 5710.428957104256, 5002.674826136289, 5147.841735609458, 5904.704764761831, 6008.699565021819, 6014.939850601613, 3249.7400207982832, 3568.9114819980155, 3679.1537946271974, 3780.8865734028022, 3787.0, 5084.720340381166, 5086.465921078234, 5614.915776263441, 5755.884882302415, 5784.987627165314, 4998.925016124834, 5310.15906490026, 5580.693061881636, 5591.0, 5611.158326251095, 4629.768511574341, 4932.186189278729, 5314.627976041795, 5562.137868630369, 5591.832245032656, 4155.1897380010605, 4952.083864485082, 5034.418679002237, 5109.565686916654, 5411.375482890873, 4775.42694876617, 5320.754339852764, 5582.15310191797, 5625.831225063254, 5626.971865140648, 4575.17646823575, 5175.327207463006, 5407.378151512627, 5460.153676180198, 5470.015397228537], "value": 3953.0703264292642, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.5690042026675, 798.9600519974, 807.3742849291798, 820.9794755131123, 840.4663038970252, 13853.515126970546, 14848.77726834097, 15182.468613598527, 15721.606959825982, 15754.054756714606, 13656.975726820503, 13756.793648095287, 14180.574582762509, 14186.006979511438, 14204.644883877909, 821.273173241681, 838.3335248477475, 838.6142374507734, 839.0560619303284, 839.3369238301765, 689.135135405066, 711.0756017177674, 711.4450728431832, 713.1371041040347, 841.7727213652311, 748.6294284329265, 863.1627321498169, 889.5463313710022, 893.566620189211, 893.78995935955, 893.9865902011443, 897.1342654338562, 897.349421669291, 901.4906577783531, 901.9503927283997, 661.5303134774316, 661.84777501175, 661.9602823830586, 662.3674390956674, 662.6918482905423, 14243.715125697428, 14419.639509012359, 14437.989340746151, 14455.421783128662, 14948.0, 13859.584212473643, 14187.077839940372, 14232.715345693132, 14466.855331446655, 14494.637634059232, 11214.775704485946, 11233.382163980978, 11392.25950313227, 11761.882381176165, 11956.760864782742, 3737.3085979093953, 3822.2546603412347, 3833.29084119436, 3931.7247792654525, 4003.2393845169327, 82453.17546824514, 86852.56573717154, 88818.0, 95561.0, 95925.08149837035, 10703.357798532114, 11004.944975275072, 11201.495932682887, 11260.662180134608, 11899.643010709693, 21806.563868722536, 22060.558788824135, 22076.33770986873, 22077.558448831256, 22095.116195352006, 7551.546907185587, 8107.1892810718455, 8120.796980075427, 8134.308583770446, 8357.916420835714, 4373.0, 4374.671899607542, 4378.715383500063, 4406.317020861771, 4539.182947069493, 3485.3203625292826, 3591.712662986955, 3594.676479116892, 3597.568291805, 3599.4420864766003, 644.0725355488082, 648.4585371215088, 648.8280605639414, 649.5940037476577, 650.4146268358515, 537.2880932764103, 597.2444857255575, 603.4207161125281, 662.8906230471919, 668.759246671198, 7241.348278654947, 8287.861525854009, 8666.350023748244, 8963.551822408854, 9136.543172841331, 477.8041003188676, 590.5275779376482, 645.6932956845461, 668.866226754651, 678.4131726056925, 4188.424555296072, 4502.482214545304, 4505.324201369821, 4540.659450541222, 4575.642810452632, 101953.96092078117, 104121.95878041274, 104555.4772226134, 105558.94441055645, 105677.94322056836, 67753.66123169352, 84042.0, 84849.15150848412, 85618.0, 88746.0, 80482.0, 80797.78803317955, 81558.59220703976, 82502.58748706339, 84923.0, 8501.914980850359, 8715.302775777796, 8730.607122679621, 8785.780355491164, 8864.06927272627, 43785.46750863705, 54005.45994540004, 54070.729646351516, 54402.911941760154, 54836.0, 69264.96102558365, 77189.0, 78095.0, 78365.60817195878, 78534.82197767153, 11478.196526243082, 11496.0, 11583.247088939192, 11676.416179191176, 11920.284782913053, 12087.214331068453, 12126.696832579257, 12247.142700010914, 12414.317212553397, 13099.869001309866, 11370.374629395463, 11565.248258863146, 11769.52921883115, 11818.231814932002, 12260.754784904073, 10488.737781555523, 10692.572297108029, 10906.2365634408, 10943.398113103856, 11222.382768947786, 11709.824352634547, 11726.179167458196, 11735.471903764523, 11847.940760296144, 12107.33409662477, 9452.621895124117, 9870.85193722109, 9879.50602469888, 9973.3018688694, 9976.0, 8545.87181192295, 8940.240079593308, 9405.388649737744, 9618.951905240428, 10348.172146228435], "value": 7170.232824300179, "unit": "score"}], "name": "dromaeo_css", "value": 7293.350706195657, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 114.0, 113.0, 113.0, 113.0, 112.0, 113.0, 114.0, 116.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 106.0, 108.0, 142.0, 108.0, 106.0, 107.0, 105.0, 137.0, 112.0], "value": 117.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 193.0, 183.0, 180.0, 183.0, 184.0, 185.0, 182.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 88.0, 62.0, 58.0, 58.0, 59.0, 70.0, 62.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 93.0, 94.0, 92.0, 76.0, 87.0, 68.0, 68.0, 90.0], "value": 82.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 87.0, 89.0, 87.0, 89.0, 86.0, 88.0, 86.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 101.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 80.0, 80.0, 81.0, 88.0, 81.0, 83.0, 82.0, 83.0], "value": 82.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 55.0, 56.0, 55.0, 56.0, 55.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 71.0, 75.0, 71.0, 68.0, 69.0, 67.0, 69.0, 70.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 81.0, 92.0, 94.0, 89.0, 96.0, 80.0, 79.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 137.0, 135.0, 135.0, 156.0, 149.0, 147.0, 175.0, 139.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 163.0, 160.0, 160.0, 161.0, 159.0, 158.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 64.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1406.9999999999998, "alertThreshold": 2.0}]} 09:05:39 INFO - Return code: 0 09:05:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:05:39 INFO - # TBPL SUCCESS # 09:05:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:05:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:05:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:05:39 INFO - 2017-02-27 09:05:39.146 screenresolution[1645:9894] starting screenresolution argv=screenresolution get 09:05:39 INFO - 2017-02-27 09:05:39.149 screenresolution[1645:9894] Display 0: 1600x1200x32@60 09:05:39 INFO - 2017-02-27 09:05:39.155 screenresolution[1646:9897] starting screenresolution argv=screenresolution list 09:05:39 INFO - Available Modes on Display 0 09:05:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:05:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:05:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:05:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:05:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:05:39 INFO - Intel Iris: 09:05:39 INFO - Chipset Model: Intel Iris 09:05:39 INFO - Type: GPU 09:05:39 INFO - Bus: Built-In 09:05:39 INFO - VRAM (Dynamic, Max): 1536 MB 09:05:39 INFO - Vendor: Intel (0x8086) 09:05:39 INFO - Device ID: 0x0a2e 09:05:39 INFO - Revision ID: 0x0009 09:05:39 INFO - Displays: 09:05:39 INFO - Display: 09:05:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:05:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:05:39 INFO - Display Serial Number: 1600x1200 60 09:05:39 INFO - Main Display: Yes 09:05:39 INFO - Mirror: Off 09:05:39 INFO - Online: Yes 09:05:39 INFO - Rotation: Supported 09:05:39 INFO - Return code: 0 09:05:39 INFO - Running post-action listener: _resource_record_post_action 09:05:39 INFO - [mozharness: 2017-02-27 17:05:39.395726Z] Finished run-tests step (success) 09:05:39 INFO - Running post-run listener: _resource_record_post_run 09:05:39 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 39101440; Write bytes: 501164544; Read time: 376; Write time: 1724 09:05:39 INFO - TinderboxPrint: CPU usage
53.6% 09:05:39 INFO - TinderboxPrint: I/O read bytes / time
39,101,440 / 376 09:05:39 INFO - TinderboxPrint: I/O write bytes / time
501,164,544 / 1,724 09:05:39 INFO - TinderboxPrint: CPU idle
2,231.1 (46.4%) 09:05:39 INFO - TinderboxPrint: CPU system
961.5 (20.0%) 09:05:39 INFO - TinderboxPrint: CPU user
1,613.1 (33.6%) 09:05:39 INFO - TinderboxPrint: Swap in / out
230,809,600 / 0 09:05:39 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 186851840; Write bytes: 180088832; Read time: 17713; Write time: 317 09:05:39 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 37315584; Write bytes: 307718656; Read time: 359; Write time: 1354 09:05:39 INFO - Running post-run listener: _upload_blobber_files 09:05:39 INFO - Blob upload gear active. 09:05:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05:39 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 09:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:05:40 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:05:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:41 INFO - (blobuploader) - INFO - Done attempting. 09:05:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:05:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:05:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:42 INFO - (blobuploader) - INFO - Done attempting. 09:05:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:05:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:44 INFO - (blobuploader) - INFO - Done attempting. 09:05:44 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:44 INFO - Return code: 0 09:05:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d641f374a435f4bd47605212de3d58385ba9865049c80807baa397954653f9e226f25136bf349877e1c0bf392b2be49654fa01de317e5104f603f15babdd3aae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b84c857249611c154c58c9afc86e1c693a33817ddf487a39f50efe568d15a834f40a8ca6dff17ca57b85942b1cb043bebcf2fdbdde7eb9d75b92fd3e96f7b140", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c4737ee29ba1b1d535e40b165f2b46be1da8b0b534b7c57cd52004cde22a3ad418ec349f8117c4e72d7502eb4d6ce29ddf433fd0d74627566662cfc29f7feb3"} 09:05:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:44 INFO - Contents: 09:05:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d641f374a435f4bd47605212de3d58385ba9865049c80807baa397954653f9e226f25136bf349877e1c0bf392b2be49654fa01de317e5104f603f15babdd3aae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b84c857249611c154c58c9afc86e1c693a33817ddf487a39f50efe568d15a834f40a8ca6dff17ca57b85942b1cb043bebcf2fdbdde7eb9d75b92fd3e96f7b140", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c4737ee29ba1b1d535e40b165f2b46be1da8b0b534b7c57cd52004cde22a3ad418ec349f8117c4e72d7502eb4d6ce29ddf433fd0d74627566662cfc29f7feb3"} 09:05:44 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:44 INFO - Copying logs to upload dir... 09:05:44 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.027249 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-27 09:05:45.047573) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 09:05:45.051373) ========= 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.lsaxpBwRz1/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.31EKeeK8Py/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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/Mozilla-Beta/sha512/d641f374a435f4bd47605212de3d58385ba9865049c80807baa397954653f9e226f25136bf349877e1c0bf392b2be49654fa01de317e5104f603f15babdd3aae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b84c857249611c154c58c9afc86e1c693a33817ddf487a39f50efe568d15a834f40a8ca6dff17ca57b85942b1cb043bebcf2fdbdde7eb9d75b92fd3e96f7b140", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c4737ee29ba1b1d535e40b165f2b46be1da8b0b534b7c57cd52004cde22a3ad418ec349f8117c4e72d7502eb4d6ce29ddf433fd0d74627566662cfc29f7feb3"} build_url:https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/Pj6tAhLESHO9i5CCJxAHew/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d641f374a435f4bd47605212de3d58385ba9865049c80807baa397954653f9e226f25136bf349877e1c0bf392b2be49654fa01de317e5104f603f15babdd3aae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b84c857249611c154c58c9afc86e1c693a33817ddf487a39f50efe568d15a834f40a8ca6dff17ca57b85942b1cb043bebcf2fdbdde7eb9d75b92fd3e96f7b140", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c4737ee29ba1b1d535e40b165f2b46be1da8b0b534b7c57cd52004cde22a3ad418ec349f8117c4e72d7502eb4d6ce29ddf433fd0d74627566662cfc29f7feb3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 09:05:45.091878) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:05:45.092429) ========= 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.lsaxpBwRz1/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.31EKeeK8Py/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005162 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:05:45.142347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 09:05:45.142670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 09:05:45.142989) ========= ========= Total master_lag: 0.19 =========