builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0300 starttime: 1487607495.15 results: success (0) buildid: 20170220065356 builduid: 057b554b936845118ecae128afce2f0b revision: d5727ae5c683f17949ce046f45b1c85ee707c523 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:15.148503) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:15.148935) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:15.149200) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:15.175726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:15.176067) ========= 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.yt3jpYjCQT/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.kTBopoDs1I/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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-20 08:18:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.9M=0.001s 2017-02-20 08:18:15 (17.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123999 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:15.324545) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:15.324859) ========= 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.yt3jpYjCQT/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.kTBopoDs1I/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.025706 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:15.373442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-20 08:18:15.373790) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d5727ae5c683f17949ce046f45b1c85ee707c523 --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-aurora --rev d5727ae5c683f17949ce046f45b1c85ee707c523 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yt3jpYjCQT/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.kTBopoDs1I/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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-20 08:18:15,483 truncating revision to first 12 chars 2017-02-20 08:18:15,483 Setting DEBUG logging. 2017-02-20 08:18:15,483 attempt 1/10 2017-02-20 08:18:15,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d5727ae5c683?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-20 08:18:17,125 unpacking tar archive at: mozilla-aurora-d5727ae5c683/testing/mozharness/ program finished with exit code 0 elapsedTime=1.913000 ========= master_lag: 0.43 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-20 08:18:17.715304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:17.715613) ========= script_repo_revision: d5727ae5c683f17949ce046f45b1c85ee707c523 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:17.716000) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:17.716253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-20 08:18:18.209937) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-20 08:18:18.210238) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yt3jpYjCQT/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.kTBopoDs1I/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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:18:18 INFO - MultiFileLogger online at 20170220 08:18:18 in /builds/slave/test 08:18:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:18:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:18 INFO - {'append_to_log': False, 08:18:18 INFO - 'base_work_dir': '/builds/slave/test', 08:18:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:18:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:18 INFO - 'branch': 'Mozilla-Aurora', 08:18:18 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:18 INFO - 'config_files': ('talos/mac_config.py',), 08:18:18 INFO - 'default_actions': ('clobber', 08:18:18 INFO - 'read-buildbot-config', 08:18:18 INFO - 'download-and-extract', 08:18:18 INFO - 'populate-webroot', 08:18:18 INFO - 'create-virtualenv', 08:18:18 INFO - 'install', 08:18:18 INFO - 'run-tests'), 08:18:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:18 INFO - 'download_minidump_stackwalk': True, 08:18:18 INFO - 'download_symbols': 'ondemand', 08:18:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:18 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:18 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:18 INFO - 'installer_path': 'installer.exe', 08:18:18 INFO - 'log_level': 'info', 08:18:18 INFO - 'log_name': 'talos', 08:18:18 INFO - 'log_to_console': True, 08:18:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:18:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:18:18 INFO - 'opt_config_files': (), 08:18:18 INFO - 'pip_index': False, 08:18:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:18:18 INFO - 'cmd': ('bash', 08:18:18 INFO - '-c', 08:18:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:18:18 INFO - 'enabled': True, 08:18:18 INFO - 'halt_on_failure': False, 08:18:18 INFO - 'name': 'check_screen_resolution'},), 08:18:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:18:18 INFO - 'cmd': ('bash', 08:18:18 INFO - '-c', 08:18:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:18:18 INFO - 'enabled': True, 08:18:18 INFO - 'halt_on_failure': False, 08:18:18 INFO - 'name': 'check_screen_resolution'},), 08:18:18 INFO - 'run_cmd_checks_enabled': True, 08:18:18 INFO - 'sps_profile': False, 08:18:18 INFO - 'sps_profile_interval': 0, 08:18:18 INFO - 'suite': 'dromaeojs', 08:18:18 INFO - 'system_bits': '32', 08:18:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:18 INFO - 'title': 't-yosemite-r7-0300', 08:18:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:18 INFO - 'use_talos_json': True, 08:18:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:18 INFO - 'work_dir': 'build'} 08:18:18 INFO - [mozharness: 2017-02-20 16:18:18.433916Z] Running clobber step. 08:18:18 INFO - Running pre-action listener: _resource_record_pre_action 08:18:18 INFO - Running main action method: clobber 08:18:18 INFO - rmtree: /builds/slave/test/build 08:18:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:20 INFO - Running post-action listener: _resource_record_post_action 08:18:20 INFO - [mozharness: 2017-02-20 16:18:20.953227Z] Finished clobber step (success) 08:18:20 INFO - [mozharness: 2017-02-20 16:18:20.953305Z] Running read-buildbot-config step. 08:18:20 INFO - Running pre-action listener: _resource_record_pre_action 08:18:20 INFO - Running main action method: read_buildbot_config 08:18:20 INFO - Using buildbot properties: 08:18:20 INFO - { 08:18:20 INFO - "project": "", 08:18:20 INFO - "product": "firefox", 08:18:20 INFO - "script_repo_revision": "production", 08:18:20 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:18:20 INFO - "repository": "", 08:18:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:18:20 INFO - "buildid": "20170220065356", 08:18:20 INFO - "pgo_build": "False", 08:18:20 INFO - "basedir": "/builds/slave/test", 08:18:20 INFO - "buildnumber": 7, 08:18:20 INFO - "slavename": "t-yosemite-r7-0300", 08:18:20 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:18:20 INFO - "platform": "yosemite_r7", 08:18:20 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:18:20 INFO - "branch": "mozilla-aurora", 08:18:20 INFO - "repo_path": "releases/mozilla-aurora", 08:18:20 INFO - "revision": "d5727ae5c683f17949ce046f45b1c85ee707c523", 08:18:20 INFO - "stage_platform": "macosx64", 08:18:20 INFO - "builduid": "057b554b936845118ecae128afce2f0b", 08:18:20 INFO - "slavebuilddir": "test" 08:18:20 INFO - } 08:18:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:18:20 INFO - Running post-action listener: _resource_record_post_action 08:18:20 INFO - [mozharness: 2017-02-20 16:18:20.956728Z] Finished read-buildbot-config step (success) 08:18:20 INFO - [mozharness: 2017-02-20 16:18:20.956835Z] Running download-and-extract step. 08:18:20 INFO - Running pre-action listener: _resource_record_pre_action 08:18:20 INFO - Running main action method: download_and_extract 08:18:20 INFO - mkdir: /builds/slave/test/build/tests 08:18: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:18:20 INFO - trying https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:18:20 INFO - Downloading https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:18:22 INFO - Downloaded 1199 bytes. 08:18:22 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:18:22 INFO - Using the following test package requirements: 08:18:22 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:18:22 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:22 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:18:22 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:22 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:18:22 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:22 INFO - u'jsshell-mac.zip'], 08:18:22 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:22 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:18:22 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:18:22 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:22 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:18:22 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:22 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:18:22 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:22 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:18:22 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:22 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:18:22 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:18:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:18:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:18:22 INFO - Fetch https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:18:23 INFO - Expected file size: 16359160 08:18:23 INFO - Obtained file size: 16359160 08:18:30 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:18:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:18:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:18:30 INFO - Fetch https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:18:31 INFO - Expected file size: 16359160 08:18:31 INFO - Obtained file size: 16359160 08:18:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:18:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:18:37 INFO - Fetch https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:18:38 INFO - Expected file size: 14403485 08:18:38 INFO - Obtained file size: 14403485 08:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:39 INFO - trying https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:18:39 INFO - Downloading https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:18:41 INFO - Downloaded 73962346 bytes. 08:18:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:18:41 INFO - mkdir: /builds/slave/test/properties 08:18:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:18:41 INFO - Writing to file /builds/slave/test/properties/build_url 08:18:41 INFO - Contents: 08:18:41 INFO - build_url:https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:18:42 INFO - Running post-action listener: _resource_record_post_action 08:18:42 INFO - Running post-action listener: set_extra_try_arguments 08:18:42 INFO - [mozharness: 2017-02-20 16:18:42.043565Z] Finished download-and-extract step (success) 08:18:42 INFO - [mozharness: 2017-02-20 16:18:42.043712Z] Running populate-webroot step. 08:18:42 INFO - Running pre-action listener: _resource_record_pre_action 08:18:42 INFO - Running main action method: populate_webroot 08:18:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:18:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:18:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:18:42 INFO - '--tppagecycles', 08:18:42 INFO - '7'], 08:18:42 INFO - 'tests': ['tsvgm']}}, 08:18:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:18:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:18:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:18:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:18:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:18:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:18:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:18:42 INFO - 'talos_options': ['--disable-e10s'], 08:18:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:18:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:18:42 INFO - 'talos_options': ['--disable-e10s'], 08:18:42 INFO - 'tests': ['damp', 'tps']}, 08:18:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:18:42 INFO - 'tests': ['damp', 'tps']}, 08:18:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:18:42 INFO - 'tests': ['dromaeo_dom']}, 08:18:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:18:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:18:42 INFO - 'tests': ['basic_compositor_video']}, 08:18:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:18:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:18:42 INFO - 'tests': ['a11yr', 08:18:42 INFO - 'ts_paint', 08:18:42 INFO - 'tpaint', 08:18:42 INFO - 'sessionrestore', 08:18:42 INFO - 'sessionrestore_no_auto_restore', 08:18:42 INFO - 'tabpaint']}, 08:18:42 INFO - 'other-e10s': {'tests': ['a11yr', 08:18:42 INFO - 'ts_paint', 08:18:42 INFO - 'tpaint', 08:18:42 INFO - 'sessionrestore', 08:18:42 INFO - 'sessionrestore_no_auto_restore', 08:18:42 INFO - 'tabpaint']}, 08:18:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:18:42 INFO - 'ts_paint', 08:18:42 INFO - 'tpaint', 08:18:42 INFO - 'sessionrestore', 08:18:42 INFO - 'sessionrestore_no_auto_restore', 08:18:42 INFO - 'tabpaint']}, 08:18:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:18:42 INFO - 'ts_paint', 08:18:42 INFO - 'tpaint', 08:18:42 INFO - 'sessionrestore', 08:18:42 INFO - 'sessionrestore_no_auto_restore', 08:18:42 INFO - 'tabpaint']}, 08:18:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:18:42 INFO - 'tests': ['a11yr', 08:18:42 INFO - 'ts_paint', 08:18:42 INFO - 'tpaint', 08:18:42 INFO - 'sessionrestore', 08:18:42 INFO - 'sessionrestore_no_auto_restore', 08:18:42 INFO - 'tabpaint']}, 08:18:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:18:42 INFO - 'tests': ['a11yr', 08:18:42 INFO - 'ts_paint', 08:18:42 INFO - 'tpaint', 08:18:42 INFO - 'sessionrestore', 08:18:42 INFO - 'sessionrestore_no_auto_restore', 08:18:42 INFO - 'tabpaint']}, 08:18:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:18:42 INFO - 'tests': ['tsvgx', 08:18:42 INFO - 'tsvgr_opacity', 08:18:42 INFO - 'tart', 08:18:42 INFO - 'tscrollx', 08:18:42 INFO - 'cart', 08:18:42 INFO - 'tsvg_static']}, 08:18:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:18:42 INFO - 'tsvgr_opacity', 08:18:42 INFO - 'tart', 08:18:42 INFO - 'tscrollx', 08:18:42 INFO - 'cart', 08:18:42 INFO - 'tsvg_static']}, 08:18:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:18:42 INFO - 'talos_options': ['--disable-e10s'], 08:18:42 INFO - 'tests': ['tp5o']}, 08:18:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:18:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:18:42 INFO - 'talos_options': ['--disable-e10s', 08:18:42 INFO - '--xperf_path', 08:18:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:42 INFO - 'tests': ['tp5n']}, 08:18:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:18:42 INFO - 'talos_options': ['--xperf_path', 08:18:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:42 INFO - 'tests': ['tp5n']}}, 08:18:42 INFO - 'talos.zip': {'path': '', 08:18:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:18:42 INFO - Running post-action listener: _resource_record_post_action 08:18:42 INFO - [mozharness: 2017-02-20 16:18:42.062689Z] Finished populate-webroot step (success) 08:18:42 INFO - [mozharness: 2017-02-20 16:18:42.062801Z] Running create-virtualenv step. 08:18:42 INFO - Running pre-action listener: _resource_record_pre_action 08:18:42 INFO - Running main action method: create_virtualenv 08:18:42 INFO - Creating virtualenv /builds/slave/test/build/venv 08:18:42 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:18:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:18:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:18:42 INFO - Using real prefix '/tools/python27' 08:18:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:18:42 INFO - Installing distribute.............................................................................................................................................................................................done. 08:18:45 INFO - Installing pip.................done. 08:18:45 INFO - Return code: 0 08:18:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:18:46 INFO - Reading from file tmpfile_stdout 08:18:46 INFO - Output received: 08:18:46 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:18:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:18:46 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:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:46 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:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:46 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 0x10a535b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc78c7b490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a313d30>, '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 0x10a23adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a308be8>, '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.yt3jpYjCQT/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.kTBopoDs1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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:18:46 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:18:46 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:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yt3jpYjCQT/Render', 08:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:46 INFO - 'HOME': '/Users/cltbld', 08:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:46 INFO - 'LOGNAME': 'cltbld', 08:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:46 INFO - 'MOZ_NO_REMOTE': '1', 08:18:46 INFO - 'NO_EM_RESTART': '1', 08:18:46 INFO - 'PAGER': '/bin/cat', 08:18:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:46 INFO - 'PWD': '/builds/slave/test', 08:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:46 INFO - 'SHELL': '/bin/bash', 08:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kTBopoDs1I/Listeners', 08:18:46 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:46 INFO - 'USER': 'cltbld', 08:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:46 INFO - 'XPC_FLAGS': '0x0', 08:18:46 INFO - 'XPC_SERVICE_NAME': '0', 08:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:46 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:18:46 INFO - Cleaning up... 08:18:46 INFO - Return code: 0 08:18:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:18:46 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:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:46 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:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:46 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 0x10a535b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc78c7b490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a313d30>, '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 0x10a23adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a308be8>, '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.yt3jpYjCQT/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.kTBopoDs1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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:18:46 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:18:46 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:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yt3jpYjCQT/Render', 08:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:46 INFO - 'HOME': '/Users/cltbld', 08:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:46 INFO - 'LOGNAME': 'cltbld', 08:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:46 INFO - 'MOZ_NO_REMOTE': '1', 08:18:46 INFO - 'NO_EM_RESTART': '1', 08:18:46 INFO - 'PAGER': '/bin/cat', 08:18:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:46 INFO - 'PWD': '/builds/slave/test', 08:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:46 INFO - 'SHELL': '/bin/bash', 08:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kTBopoDs1I/Listeners', 08:18:46 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:46 INFO - 'USER': 'cltbld', 08:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:46 INFO - 'XPC_FLAGS': '0x0', 08:18:46 INFO - 'XPC_SERVICE_NAME': '0', 08:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:46 INFO - Downloading/unpacking psutil>=3.1.1 08:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:18:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:50 INFO - Installing collected packages: psutil 08:18:50 INFO - Running setup.py install for psutil 08:18:50 INFO - building 'psutil._psutil_osx' extension 08:18:50 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:18:50 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:18:50 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:18:50 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:18:50 INFO - building 'psutil._psutil_posix' extension 08:18:50 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:18:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:18:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:18:51 INFO - ^ 08:18:51 INFO - 1 warning generated. 08:18:51 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:18:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:51 INFO - Successfully installed psutil 08:18:51 INFO - Cleaning up... 08:18:51 INFO - Return code: 0 08:18:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:18:51 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:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:51 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:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a535b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc78c7b490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a313d30>, '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 0x10a23adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a308be8>, '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.yt3jpYjCQT/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.kTBopoDs1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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:18:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:18:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yt3jpYjCQT/Render', 08:18:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:51 INFO - 'HOME': '/Users/cltbld', 08:18:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:51 INFO - 'LOGNAME': 'cltbld', 08:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:51 INFO - 'MOZ_NO_REMOTE': '1', 08:18:51 INFO - 'NO_EM_RESTART': '1', 08:18:51 INFO - 'PAGER': '/bin/cat', 08:18:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:51 INFO - 'PWD': '/builds/slave/test', 08:18:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:51 INFO - 'SHELL': '/bin/bash', 08:18:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kTBopoDs1I/Listeners', 08:18:51 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:18:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:51 INFO - 'USER': 'cltbld', 08:18:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:51 INFO - 'XPC_FLAGS': '0x0', 08:18:51 INFO - 'XPC_SERVICE_NAME': '0', 08:18:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:18:51 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:18:51 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:18:51 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:18:51 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:18:51 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:18:51 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:18:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:18:54 INFO - Installing collected packages: mozsystemmonitor 08:18:54 INFO - Running setup.py install for mozsystemmonitor 08:18:54 INFO - Successfully installed mozsystemmonitor 08:18:54 INFO - Cleaning up... 08:18:54 INFO - Return code: 0 08:18:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:18:54 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:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:54 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:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:54 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 0x10a535b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc78c7b490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a313d30>, '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 0x10a23adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a308be8>, '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.yt3jpYjCQT/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.kTBopoDs1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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:18:54 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:18:54 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:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yt3jpYjCQT/Render', 08:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:54 INFO - 'HOME': '/Users/cltbld', 08:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:54 INFO - 'LOGNAME': 'cltbld', 08:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:54 INFO - 'MOZ_NO_REMOTE': '1', 08:18:54 INFO - 'NO_EM_RESTART': '1', 08:18:54 INFO - 'PAGER': '/bin/cat', 08:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:54 INFO - 'PWD': '/builds/slave/test', 08:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:54 INFO - 'SHELL': '/bin/bash', 08:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kTBopoDs1I/Listeners', 08:18:54 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:54 INFO - 'USER': 'cltbld', 08:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:54 INFO - 'XPC_FLAGS': '0x0', 08:18:54 INFO - 'XPC_SERVICE_NAME': '0', 08:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:54 INFO - Downloading/unpacking jsonschema==2.5.1 08:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:18:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:18:57 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:18:57 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:18:57 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:18:57 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:18:57 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:18:57 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:18:57 INFO - Downloading functools32-3.2.3-2.tar.gz 08:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:18:57 INFO - warning: no files found matching '*.txt' 08:18:57 INFO - no previously-included directories found matching 'build' 08:18:57 INFO - no previously-included directories found matching 'dist' 08:18:57 INFO - no previously-included directories found matching '.git*' 08:18:57 INFO - Installing collected packages: jsonschema, functools32 08:18:57 INFO - Running setup.py install for functools32 08:18:58 INFO - warning: no files found matching '*.txt' 08:18:58 INFO - no previously-included directories found matching 'build' 08:18:58 INFO - no previously-included directories found matching 'dist' 08:18:58 INFO - no previously-included directories found matching '.git*' 08:18:58 INFO - Successfully installed jsonschema functools32 08:18:58 INFO - Cleaning up... 08:18:58 INFO - Return code: 0 08:18:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a535b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc78c7b490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a313d30>, '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 0x10a23adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a308be8>, '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.yt3jpYjCQT/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.kTBopoDs1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:18:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yt3jpYjCQT/Render', 08:18:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:58 INFO - 'HOME': '/Users/cltbld', 08:18:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:58 INFO - 'LOGNAME': 'cltbld', 08:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:58 INFO - 'MOZ_NO_REMOTE': '1', 08:18:58 INFO - 'NO_EM_RESTART': '1', 08:18:58 INFO - 'PAGER': '/bin/cat', 08:18:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:58 INFO - 'PWD': '/builds/slave/test', 08:18:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:58 INFO - 'SHELL': '/bin/bash', 08:18:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kTBopoDs1I/Listeners', 08:18:58 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:18:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:58 INFO - 'USER': 'cltbld', 08:18:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:58 INFO - 'XPC_FLAGS': '0x0', 08:18:58 INFO - 'XPC_SERVICE_NAME': '0', 08:18:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:18:58 INFO - Cleaning up... 08:18:58 INFO - Return code: 0 08:18:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a535b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc78c7b490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a313d30>, '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 0x10a23adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a308be8>, '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.yt3jpYjCQT/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.kTBopoDs1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:18:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yt3jpYjCQT/Render', 08:18:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:58 INFO - 'HOME': '/Users/cltbld', 08:18:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:58 INFO - 'LOGNAME': 'cltbld', 08:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:58 INFO - 'MOZ_NO_REMOTE': '1', 08:18:58 INFO - 'NO_EM_RESTART': '1', 08:18:58 INFO - 'PAGER': '/bin/cat', 08:18:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:58 INFO - 'PWD': '/builds/slave/test', 08:18:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:58 INFO - 'SHELL': '/bin/bash', 08:18:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kTBopoDs1I/Listeners', 08:18:58 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:18:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:58 INFO - 'USER': 'cltbld', 08:18:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:58 INFO - 'XPC_FLAGS': '0x0', 08:18:58 INFO - 'XPC_SERVICE_NAME': '0', 08:18:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:58 INFO - Downloading/unpacking blobuploader==1.2.4 08:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:01 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:01 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:19:01 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:19:01 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:19:01 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:19:01 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:19:01 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:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:19:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:02 INFO - Downloading docopt-0.6.1.tar.gz 08:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:02 INFO - Running setup.py install for blobuploader 08:19:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:19:02 INFO - Running setup.py install for requests 08:19:03 INFO - Running setup.py install for docopt 08:19:03 INFO - Successfully installed blobuploader requests docopt 08:19:03 INFO - Cleaning up... 08:19:03 INFO - Return code: 0 08:19:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:04 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 0x10a535b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc78c7b490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a313d30>, '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 0x10a23adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a308be8>, '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.yt3jpYjCQT/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.kTBopoDs1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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:19:04 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:19:04 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:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yt3jpYjCQT/Render', 08:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:04 INFO - 'HOME': '/Users/cltbld', 08:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:04 INFO - 'LOGNAME': 'cltbld', 08:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:04 INFO - 'MOZ_NO_REMOTE': '1', 08:19:04 INFO - 'NO_EM_RESTART': '1', 08:19:04 INFO - 'PAGER': '/bin/cat', 08:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:04 INFO - 'PWD': '/builds/slave/test', 08:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:04 INFO - 'SHELL': '/bin/bash', 08:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kTBopoDs1I/Listeners', 08:19:04 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:04 INFO - 'USER': 'cltbld', 08:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:04 INFO - 'XPC_FLAGS': '0x0', 08:19:04 INFO - 'XPC_SERVICE_NAME': '0', 08:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:04 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-0UjAlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:04 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-ZiBKWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:04 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-NUZxkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:04 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Wyq51B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:04 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-LfYrem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:05 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-afwTqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:05 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-qs4cZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:05 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Qj5EFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:05 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-O5ALcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:05 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Nyve47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:05 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Uygqk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:05 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-r6ZfML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:05 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-rMdKpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:05 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-fsUcMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:05 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-DF60Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:06 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-37yJGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:06 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-P2aziL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:06 INFO - Running setup.py install for manifestparser 08:19:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:19:06 INFO - Running setup.py install for mozcrash 08:19:06 INFO - Running setup.py install for mozdebug 08:19:06 INFO - Running setup.py install for mozdevice 08:19:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:19:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:19:06 INFO - Running setup.py install for mozfile 08:19:07 INFO - Running setup.py install for mozhttpd 08:19:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:19:07 INFO - Running setup.py install for mozinfo 08:19:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:19:07 INFO - Running setup.py install for mozInstall 08:19:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:19:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:19:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:19:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:19:07 INFO - Running setup.py install for mozleak 08:19:07 INFO - Running setup.py install for mozlog 08:19:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:19:07 INFO - Running setup.py install for moznetwork 08:19:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:19:07 INFO - Running setup.py install for mozprocess 08:19:08 INFO - Running setup.py install for mozprofile 08:19:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:19:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:19:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:19:08 INFO - Running setup.py install for mozrunner 08:19:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:19:08 INFO - Running setup.py install for mozscreenshot 08:19:08 INFO - Running setup.py install for moztest 08:19:08 INFO - Running setup.py install for mozversion 08:19:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:19:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:08 INFO - Cleaning up... 08:19:08 INFO - Return code: 0 08:19:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19: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:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:09 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 0x10a535b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc78c7b490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a313d30>, '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 0x10a23adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a308be8>, '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.yt3jpYjCQT/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.kTBopoDs1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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:19:09 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:19:09 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:19:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yt3jpYjCQT/Render', 08:19:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:09 INFO - 'HOME': '/Users/cltbld', 08:19:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:09 INFO - 'LOGNAME': 'cltbld', 08:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:09 INFO - 'MOZ_NO_REMOTE': '1', 08:19:09 INFO - 'NO_EM_RESTART': '1', 08:19:09 INFO - 'PAGER': '/bin/cat', 08:19:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:09 INFO - 'PWD': '/builds/slave/test', 08:19:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:09 INFO - 'SHELL': '/bin/bash', 08:19:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kTBopoDs1I/Listeners', 08:19:09 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:19:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:09 INFO - 'USER': 'cltbld', 08:19:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:09 INFO - 'XPC_FLAGS': '0x0', 08:19:09 INFO - 'XPC_SERVICE_NAME': '0', 08:19:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:09 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-E6ZxWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:09 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:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:09 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-zePyck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:09 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:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:09 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Do1vbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:09 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:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:09 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Ntz69R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:09 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-l9aRM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:10 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-BQ1Cx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:10 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-hsGNGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:10 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-KRZ1B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:10 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-LrRAQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:10 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-1TkIJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:10 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-UI6Rc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:10 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-aUN4HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:10 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-PtOwko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:10 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-o2xvG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:11 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:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:11 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-T4vOjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:11 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:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:11 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-TXYqAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:11 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:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:11 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Voee8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:11 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:19:11 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:19:11 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:19:11 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:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:11 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:19:11 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:19:11 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:19:11 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:19:11 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:19:11 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:19:14 INFO - Downloading blessings-1.6.tar.gz 08:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:14 INFO - Installing collected packages: blessings 08:19:14 INFO - Running setup.py install for blessings 08:19:14 INFO - Successfully installed blessings 08:19:14 INFO - Cleaning up... 08:19:14 INFO - Return code: 0 08:19:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:19:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:14 INFO - Reading from file tmpfile_stdout 08:19:14 INFO - Current package versions: 08:19:14 INFO - blessings == 1.6 08:19:14 INFO - blobuploader == 1.2.4 08:19:14 INFO - docopt == 0.6.1 08:19:14 INFO - functools32 == 3.2.3-2 08:19:14 INFO - jsonschema == 2.5.1 08:19:14 INFO - manifestparser == 1.1 08:19:14 INFO - mozInstall == 1.12 08:19:14 INFO - mozcrash == 1.0 08:19:14 INFO - mozdebug == 0.1 08:19:14 INFO - mozdevice == 0.49 08:19:14 INFO - mozfile == 1.2 08:19:14 INFO - mozhttpd == 0.7 08:19:14 INFO - mozinfo == 0.9 08:19:14 INFO - mozleak == 0.1 08:19:14 INFO - mozlog == 3.4 08:19:14 INFO - moznetwork == 0.27 08:19:14 INFO - mozprocess == 0.24 08:19:14 INFO - mozprofile == 0.28 08:19:14 INFO - mozrunner == 6.13 08:19:14 INFO - mozscreenshot == 0.1 08:19:14 INFO - mozsystemmonitor == 0.3 08:19:14 INFO - moztest == 0.8 08:19:14 INFO - mozversion == 1.4 08:19:14 INFO - psutil == 3.1.1 08:19:14 INFO - requests == 1.2.3 08:19:14 INFO - wsgiref == 0.1.2 08:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:14 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 0x10a535b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc78c7b490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a313d30>, '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 0x10a23adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a308be8>, '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.yt3jpYjCQT/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.kTBopoDs1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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:19:14 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:19:14 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:19:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yt3jpYjCQT/Render', 08:19:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:14 INFO - 'HOME': '/Users/cltbld', 08:19:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:14 INFO - 'LOGNAME': 'cltbld', 08:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:14 INFO - 'MOZ_NO_REMOTE': '1', 08:19:14 INFO - 'NO_EM_RESTART': '1', 08:19:14 INFO - 'PAGER': '/bin/cat', 08:19:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:14 INFO - 'PWD': '/builds/slave/test', 08:19:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:14 INFO - 'SHELL': '/bin/bash', 08:19:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kTBopoDs1I/Listeners', 08:19:14 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:19:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:14 INFO - 'USER': 'cltbld', 08:19:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:14 INFO - 'XPC_FLAGS': '0x0', 08:19:14 INFO - 'XPC_SERVICE_NAME': '0', 08:19:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:15 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:19:15 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:19:15 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:19:15 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:19:15 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:19:15 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:19:15 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:19:15 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:19:15 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:19:15 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:19:15 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:19:15 INFO - Cleaning up... 08:19:15 INFO - Return code: 0 08:19:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a535b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a538768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc78c7b490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a313d30>, '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 0x10a23adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a308be8>, '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.yt3jpYjCQT/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.kTBopoDs1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:19:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yt3jpYjCQT/Render', 08:19:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:15 INFO - 'HOME': '/Users/cltbld', 08:19:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:15 INFO - 'LOGNAME': 'cltbld', 08:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:15 INFO - 'MOZ_NO_REMOTE': '1', 08:19:15 INFO - 'NO_EM_RESTART': '1', 08:19:15 INFO - 'PAGER': '/bin/cat', 08:19:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:15 INFO - 'PWD': '/builds/slave/test', 08:19:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:15 INFO - 'SHELL': '/bin/bash', 08:19:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kTBopoDs1I/Listeners', 08:19:15 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:19:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:15 INFO - 'USER': 'cltbld', 08:19:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:15 INFO - 'XPC_FLAGS': '0x0', 08:19:15 INFO - 'XPC_SERVICE_NAME': '0', 08:19:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:19:15 INFO - Cleaning up... 08:19:15 INFO - Return code: 0 08:19:15 INFO - Running post-action listener: _resource_record_post_action 08:19:15 INFO - Running post-action listener: _start_resource_monitoring 08:19:15 INFO - Starting resource monitoring. 08:19:15 INFO - [mozharness: 2017-02-20 16:19:15.497522Z] Finished create-virtualenv step (success) 08:19:15 INFO - [mozharness: 2017-02-20 16:19:15.498484Z] Running install step. 08:19:15 INFO - Running pre-action listener: _resource_record_pre_action 08:19:15 INFO - Running main action method: install 08:19:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:15 INFO - Reading from file tmpfile_stdout 08:19:15 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:15 INFO - Reading from file tmpfile_stdout 08:19:15 INFO - Output received: 08:19:15 INFO - Usage: mozinstall [options] installer 08:19:15 INFO - Options: 08:19:15 INFO - -h, --help show this help message and exit 08:19:15 INFO - -d DEST, --destination=DEST 08:19:15 INFO - Directory to install application into. [default: 08:19:15 INFO - "/builds/slave/test"] 08:19:15 INFO - --app=APP Application being installed. [default: firefox] 08:19:15 INFO - mkdir: /builds/slave/test/build/application 08:19:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:19:35 INFO - Reading from file tmpfile_stdout 08:19:35 INFO - Output received: 08:19:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:19:35 INFO - Running post-action listener: _resource_record_post_action 08:19:35 INFO - [mozharness: 2017-02-20 16:19:35.590021Z] Finished install step (success) 08:19:35 INFO - [mozharness: 2017-02-20 16:19:35.590157Z] Running run-tests step. 08:19:35 INFO - Running pre-action listener: _resource_record_pre_action 08:19:35 INFO - Running main action method: run_tests 08:19:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:19:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:19:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:19:35 INFO - 2017-02-20 08:19:35.604 screenresolution[1625:7420] starting screenresolution argv=screenresolution get 08:19:35 INFO - 2017-02-20 08:19:35.607 screenresolution[1625:7420] Display 0: 1600x1200x32@60 08:19:35 INFO - 2017-02-20 08:19:35.613 screenresolution[1626:7423] starting screenresolution argv=screenresolution list 08:19:35 INFO - Available Modes on Display 0 08:19:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:19:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:19:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:19:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:19:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:19:35 INFO - Intel Iris: 08:19:35 INFO - Chipset Model: Intel Iris 08:19:35 INFO - Type: GPU 08:19:35 INFO - Bus: Built-In 08:19:35 INFO - VRAM (Dynamic, Max): 1536 MB 08:19:35 INFO - Vendor: Intel (0x8086) 08:19:35 INFO - Device ID: 0x0a2e 08:19:35 INFO - Revision ID: 0x0009 08:19:35 INFO - Displays: 08:19:35 INFO - Display: 08:19:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:19:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:19:35 INFO - Display Serial Number: 1600x1200 60 08:19:35 INFO - Main Display: Yes 08:19:35 INFO - Mirror: Off 08:19:35 INFO - Online: Yes 08:19:35 INFO - Rotation: Supported 08:19:35 INFO - Return code: 0 08:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:19:35 INFO - Python 2.7.3 08:19:35 INFO - Return code: 0 08:19:35 INFO - grabbing minidump binary from tooltool 08:19: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:19:35 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 0x10a313d30>, '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 0x10a23adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a308be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:19:35 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:19:35 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:19:35 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:19:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:35 INFO - Return code: 0 08:19:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:19:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:19:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:19:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:19:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--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:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0300 --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:19:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yt3jpYjCQT/Render', 08:19:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:35 INFO - 'HOME': '/Users/cltbld', 08:19:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:35 INFO - 'LOGNAME': 'cltbld', 08:19:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:19:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:35 INFO - 'MOZ_NO_REMOTE': '1', 08:19:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:19:35 INFO - 'NO_EM_RESTART': '1', 08:19:35 INFO - 'PAGER': '/bin/cat', 08:19:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:35 INFO - 'PWD': '/builds/slave/test', 08:19:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:19:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:35 INFO - 'SHELL': '/bin/bash', 08:19:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kTBopoDs1I/Listeners', 08:19:35 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:19:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:35 INFO - 'USER': 'cltbld', 08:19:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:35 INFO - 'XPC_FLAGS': '0x0', 08:19:35 INFO - 'XPC_SERVICE_NAME': '0', 08:19:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--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:19:36 INFO - mozversion application_buildid: 20170220065356 08:19:36 INFO - mozversion application_changeset: d5727ae5c683f17949ce046f45b1c85ee707c523 08:19:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:19:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:36 INFO - mozversion application_name: Firefox 08:19:36 INFO - mozversion application_remotingname: firefox-dev 08:19:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:19:36 INFO - mozversion application_vendor: Mozilla 08:19:36 INFO - mozversion application_version: 53.0a2 08:19:36 INFO - mozversion platform_buildid: 20170220065356 08:19:36 INFO - mozversion platform_changeset: d5727ae5c683f17949ce046f45b1c85ee707c523 08:19:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:19:36 INFO - mozversion platform_version: 53.0a2 08:19:36 INFO - using testdate: 1487607576 08:19:36 INFO - actual date: 1487607576 08:19:36 INFO - starting webserver on 'localhost:49235' 08:19:36 INFO - SUITE-START | Running 2 tests 08:19:36 INFO - TEST-START | dromaeo_css 08:19:36 INFO - operating with platform_type : mac_ 08:19:36 INFO - Initialising browser for dromaeo_css test... 08:19:36 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpOk92S_/profile http://localhost:49235/getInfo.html) 08:19:38 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 08:19:38 INFO - PROCESS | 1636 | colorDepth:24 08:19:38 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 08:19:38 INFO - PROCESS | 1636 | __metrics 08:19:39 INFO - PROCESS | 1636 | 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:19:39 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:39 INFO - TEST-INFO | 1636: exit 0 08:19:39 INFO - Browser initialized. 08:19:39 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:39 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpOk92S_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:51 INFO - PROCESS | 1638 | RSS: Main: 213286912 08:19:51 INFO - PROCESS | 1638 | 08:22:55 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 08:22:57 INFO - PROCESS | 1638 | RSS: Main: 332484608 08:22:57 INFO - PROCESS | 1638 | 08:24:40 INFO - PROCESS | 1638 | ************************* 08:24:40 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 08:24:40 INFO - PROCESS | 1638 | 08:24:40 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:24:40 INFO - PROCESS | 1638 | Full stack: 08:24:40 INFO - PROCESS | 1638 | ************************* 08:26:00 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 08:26:01 INFO - PROCESS | 1638 | RSS: Main: 355520512 08:26:01 INFO - PROCESS | 1638 | 08:29:04 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 08:29:04 INFO - PROCESS | 1638 | RSS: Main: 326819840 08:29:04 INFO - PROCESS | 1638 | 08:32:06 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 08:32:07 INFO - PROCESS | 1638 | RSS: Main: 312123392 08:32:07 INFO - PROCESS | 1638 | 08:35:11 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 08:35:11 INFO - PROCESS | 1638 | RSS: Main: 308817920 08:35:11 INFO - PROCESS | 1638 | 08:38:15 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 08:38:15 INFO - PROCESS | 1638 | RSS: Main: 360390656 08:38:15 INFO - PROCESS | 1638 | 08:38:15 INFO - PROCESS | 1638 | __start_tp_report 08:38:15 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 08:38:15 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 08:38:15 INFO - PROCESS | 1638 | |i|pagename|runs| 08:38:15 INFO - PROCESS | 1638 | |0;dojo.html;3365.1418888183516;3367.9727683056667;3371.359441706074;3389.864405423783;3431.9875636687175;5353.491418315259;5676.744546495407;5679;5719.370869204384;5723.141528770687;5667.971660141693;5727.856803579913;5743.310802703671;5744.138379243115;5754.1944127822135;5165.767540460679;5214.296070030554;5240.266362709223;5246.921296180561;5286.392064912546;5098;5187.507186817246;5310.336207974004;5310.6017048721305;5315.388730296027;4384.561543845606;5180.1452760294505;5258.7370631468275;5271.736413179326;5282.894342113155;5256.632035757499;5263.815766448156;5273.683578985273;5275.736213189363;5287.339082614692;5146.150885103991;5233.21501774733;5250.501202385767;5285.497877701612;5286.81496147633;5567;5575.996320662279;5603.439656034364;5706.828795136153;5723.427657234285;6136.194560805258;6189.597676151081;6217.813465596039;6262.530310226751;6293.622382657055;6223.315435302113;6305.716242769041;6306.400891915307;6311.08489269058;6338.080978258126;5724.656520608777;5773.480386765169;5785.27684039495;5801.767929282823;5812.215350927655;5188.22176673502;6292.1505596743855;6324.209473815773;6326.841828954313;6343.016832390987;6139.4001448443105;6146.78486252979;6155.169052177988;6168.444839964424;6193.628382297076;6241.18864547615;6246.063090536456;6290.24517057956;6306.558540902184;6319;6117.663528505975;6129.706382575503;6137.591499645514;6259.78090766821;6268.561200715906;6158.445739883432;6173.41352571505;6189.50483961282;6197.380261973857;6212.099245609361;5011.223260394645;5016.6237532184505;5034.546890779848;5042.6470147090085;5051.797928082909;3807.9619203807606;4433.334999749999;4455.5989960903025;4478.328250762346;4482.193205223091;5622.32532096151;5666;5667.489925906688;5776.046952252831;5784.1902133701315;6143.389059649631;6168.568200225941;6210.658413787195;6224.564280500412;6323.241211054703;5640.85897852557;5717.742701578439;5724.799632012943;5772.797952071742;5774.2782152230975;5394.3796463406425;5414.945850541523;5429.511343979061;5470.316210473691;5491.505764481216;6296.433321001132;6351.079093531504;6352.523560732963;6367.363263673596;6371.108044873628;5170.37955445349;6134.8039827316215;6247.750089996349;6272.560920735505;6350.618962862243;6356.11014457967;6376.043593461018;6378.425941665272;6379.393957574209;6381;6252.1559589456665;6252.218472690914;6270.592411493239;6278.4035516625845;6288.6855657217875;6112.10835914862;6128.295246046761;6156.415140561639;6190.628562286277;6208.4722798562625;6107.6640784757265;6114.692773002257;6121.056693971993;6134.589663226485;6141.731496609813;5901.439363260483;6110.285381942539;6118.314626315956;6119.441623354662;6127.220070483952;5803.216565763737;5854.385289544536;5897.882042359043;5919.112133180058;5952.375000624872;6097.390260973867;6119.41115851624;6119.837693858789;6133.738055536083;6148.262208535004;4697.318888761179;5838.948989181818;5941.22764040672;5947.643141411356;5968.22413086296 08:38:15 INFO - PROCESS | 1638 | |1;ext.html;458.98623041308764;493.11978119057477;508.9363230847528;516.9457206993266;539.919012148178;38230.61769382306;40389;40399.79800101003;40419.797901010454;40420.59579404205;42064.78967605158;42651.14697706044;42705.57294427055;42751;42764;8488.151184881493;8713.825723485526;9198.034206408347;9383.624655013791;9397.201237894787;10666.733331666732;11468.827967580452;11532.538698452094;11660.416979151008;11667.24162929411;11441.141914356414;11505.42472876357;11534.01960833326;11539.307641541493;11548.480318385651;8472.788180295542;8682.305415566803;11267.323960562393;11407.714807129805;11474.25417347874;10985.01134897855;11271.154663400195;11271.887281127165;11297.887021129765;11319.924607162306;41105.588944110474;41270.38094428586;41315.58684413177;41326.96682582959;41371.37942930858;3874.147687508772;3936.2521120987208;3938.330483817758;3951.7036222283446;3970.5433875104445;26500;29634.407311853643;29716.70283297161;29768.851155744083;31319.53020704691;3014.9095527134223;3200.3279311344413;3270.084376374619;3358.5589162096967;3413.812240326781;468347;477955;481886.9999999965;482731;482751;60150.79698406095;61059;61557.69221153955;61633.38366616366;61713.69143154255;66571.66714166495;66717.66641166763;66750.32747707711;66859.66570167118;66964.33035669678;16012.439564615182;16228.918855405647;16289.837101628833;16540.586485337964;16585.25366358517;11488.310701357945;11760.411979401168;11776.11679124069;12706.682332941566;12785;17999.871350725316;21081.472963176042;21651.891740541196;21658.675119873216;21661;8633.654653813777;8861.24679402245;8865.778355541033;8892.555372231363;8898.86651700225;846.327169899931;872.829798189347;879.5250564695122;887.054670213562;916.9679061232958;28861.56707649387;29989.70010299869;30150.69849301523;30690.53964190539;31004.53493197604;999.5102399824179;1017.5522769981185;1022.2231104360591;1031.1544533482622;1068.2522234435926;13847.653808654662;14326.355314010894;14519.564413067414;14592.562223133324;14681.77977330341;627810;632366;635294;636142;637310;51743;51910.96178076417;52076;52132;52152.739236303576;1340.3968214303407;1375.7936309553647;1379.186280094749;1387.5629176809273;1402.3479082226609;27460.588091178248;28663.713362866103;29052.854735726185;29446.411071778017;29451.410971780017;45465.77267113643;46131.3080303789;46204;46255.84360391017;46283.76858115688;559528;563211;563750;564615;564941;23116.653250200925;23655.763442365354;23688.763112369346;25972.870135649202;26319.868400657873;41442.1711565773;41663.166736665706;42132.57867421286;42403.575964239964;44004.77997609991;33415;33611.15972100717;34583.4812477808;36042.63957360393;36051.63948360483;34780.82609586936;35107;35134.82432587923;36222.09444763902;36271;34511.30977380489;35181.47227791534;35200.29599408049;35210;35340.64659353373;28097;29912.70087299099;30233.848830756586;30577.847110764305;30589.74921692661;18993.525161871064;22634.434139145993;23331.18340858062;23819.523609527365;23861.164859229844 08:38:15 INFO - PROCESS | 1638 | |2;jquery.html;397.45151690666876;398.94813674222354;402.9576894426087;405.64100770817817;425.2749062847845;20793.376198714042;20824.687629685566;21147.365579032616;21352.35942921713;21533;18679.066046697677;21511.354659360244;21656.783432165674;22200;22436.32691019272;4800.351952486413;5855.560832937525;5856.385079566648;5863.736131874055;5866.706664666771;5128.384593848725;5721.799737009205;5819.388964158745;6626.1386019817355;6705.1953765548205;6707.798766037026;6728.83177920551;6731.1922569291755;6732.83167920801;6734.956081807303;6369.554131210817;6473.4463728705;6530.706118224692;6542;6560.179977502812;5132.769025393866;5397.082495975694;5767.279090113736;5775.047117225653;5785.913211301791;13401.86598134016;13584.932075339659;13591.592252232449;13594;22791.658125128135;2523.2430270918653;2597.2078516052597;2626.5534859074005;2668.5730283154794;2677.2771351734923;9878.753031174278;9911.80176396468;9915.40507569541;10349.395843644248;10402.791944161074;1714.5027941896835;1763.7707098077296;1787.3744189533688;1800.6038671492252;1801.9369322073796;96020;139793;140202;142290;143389.2830535851;11742.589009384801;11880.702982425335;11902.523899043941;11959.940200298943;12072.577459788865;15592.298346574431;15602.531924042298;15918.283677234553;16070.11614361198;16105;8681.262092722189;8838.823223535494;8854.070322616033;8859.867101993475;8916.331275154389;7680.001599791991;8383.622736976851;8600.139986001475;8647.697330593524;8721.433106848035;4082.857100001486;4611.976940115345;4826.831060912851;4830.2513110467935;4854.781534830941;1972.8125828046313;2001.5396458814264;2015.2644284836222;2016.8184863362367;2019.697045443166;990.8662330585423;1009.8586197932295;1011.2718842433436;1011.4993078426226;1037.2998226197287;17670.823291767174;21550.89224553867;22595.20916767905;22616.982235799427;22758.65862012071;1034.2966782587912;1040.0691381213771;1045.6601604478424;1063.3991794636006;1069.1233188785122;10799.622013229498;11566.770768269831;11697.824532632018;11717.648470545897;11795.938365547141;683249;695695;702097;712677;714009;96336.73811202249;97728;120453.79546204426;134276;163227.1838640823;970.5005766091406;987.7382493639192;1011.185995273797;1012.9898701013043;1015.5379302417382;19788.017427031657;20862.956852157637;20892.47768805792;20919.37241882746;20928.16287348489;47734.522654774395;61113;61860.690696546226;62237.377626223155;63902.041469377065;74818.38135665226;87534;91128.08871911195;91408;92845.53577232071;8337.66649334044;8460.873086903825;8486.236238738544;8780.692675756318;8994.820103598022;9389.643277302644;11297;13680.042397032112;13939.024268301122;13951.930240348733;11572.421378931189;11622.70943226426;11713.41432928333;11804.468798904241;11869.525218991144;9434.669786557437;11527.538898443969;11669.941650291694;11817.350045747222;11829.408529573659;11666.358350290477;11710;11754.23597466162;11778.76442471163;12013.399330033639;8560.357973152162;8565.400421970651;8610.827783444422;8736.25741811953;8748.737537873874;7481.962590187014;7784.41616878725;7910.881336780068;9832.213422926292;11355.545778169111 08:38:15 INFO - PROCESS | 1638 | |3;mootools.html;1431.219985108116;1450.7243623711495;1463.1001933810705;1472.1902953375647;1474.1744623011111;8126.959365203174;8544.829103417927;8550.315974722023;8553.230209281164;8567.95716021419;7490.850182996337;7713.768586942387;8127.065387480441;8378.832423351545;8378.99452065753;2320.5242925200378;2357.929262122139;2362.645603159531;2365.2549446924163;2368.46709490365;2376.120835290945;2393.9521209575796;2409.5662780699467;2411.7347091819975;2414.8309618326725;2212;2235.7093577834858;2247.1011595361906;2278.305116939333;2279.042802023146;1971.822535971755;2320.6751054852334;2344.6600242964673;2349.9060037598474;2351.200591798788;2267.2971378872603;2318.2002209237785;2319.130326127702;2325.6976593042964;2332.8833558322017;8429.915700842974;8496.150384961516;8507.276881465083;8521.914780852174;8524.616392262364;5060.51925067118;5221.903400285944;5221.921671174935;5223.869403264911;5232.764525596357;3314.5691060162026;3419.1110311319235;3538.5930617979006;3589.5513060867393;3598.982005089958;1252.3362617812575;1256.8625394018427;1722.6726921884801;1772.0076757015984;1844.5019844641872;10509.421981790922;10910.127189824794;11002.614908478245;11146.164037697205;11171.106311495061;4410.713303635253;4527.071950250191;4566.840160594364;4568.840090596813;4570.154521413549;7894.250046245597;8235.341172706168;8750.124987501325;8866.689665861664;8874.86687699685;5149.433562308143;5161.2516185152945;5166.844994650167;5167.0957582422925;5169.069567477815;4607.470140933769;4735.100330937111;4803.303520989507;4835.323054772335;4843.806247750121;3606.1886075632774;3746.119661879456;3845.0964023454467;3869.342211823997;3872.244912242142;1186.7092562322287;1191.684203686024;1198.5565340823778;1200.0699457920182;1200.6218041317131;769.926856948589;849.6728759427541;888.8977767556685;899.7435730816686;915.3180880244261;5345.305110335709;5419.864503387447;5615.3823079462045;5775.768969241183;5791.073428251544;950.296780382512;959.2421986630624;985.113397941858;991.9057689519484;1017.765913839821;3579.94630080549;3624.2932628137787;3730.1420673245307;3768.2275133597545;3838.7504812187117;9943.651972180938;10157.339772914736;10188.847167292497;10207.7448063799;10230.6419275325;9581.089796469325;9988.600455981825;10038.397696138256;10098.242631802645;10108.29241953071;7777;7997.640106195236;8015.7595272141925;8021;8041.396895232764;5294.311739473844;5455.890882182413;5506.421825708243;5679.74441150141;5880.676562789087;9003.369764116711;9205;9389.10803473669;9435.57539910692;9549.90450095518;9473.384230025027;9543.809123817346;9583.952080239555;9618.615255389986;9722.659706910506;7040.859182816417;7297;7303.817404564928;7459.477836551389;7486.139094004259;8162.979627546557;8210.712625058095;8225.424220304521;8228.547429891414;8236.629351679068;7117.786466406016;7288.234735352924;7312.451566132668;7403.481756277009;7464.925350746423;7086.716531338895;7164.570125792469;7188.209296977224;7188.245234250328;7313;6345.587536810092;6489.9026514603265;6498.122753428227;6503.414692677682;6506.3818937200895;4435;4624.248844185351;4739.59713424349;4776.976115119541;4794.616430685467;4907.4847141051105;4988.6757360771435;5089.262057001788;5089.312942752681;5106.872328191825 08:38:15 INFO - PROCESS | 1638 | |4;prototype.html;328.47116143009737;350.63008526005063;356.4528448831043;361.84440690503084;375.5362127772201;4092.427060211569;5003.222566961943;5149.485051494853;5224.45143259958;5246.671496015783;4608.838690645828;4967.975160124194;5022.82420115296;5260.790018295795;5266.3153790007245;4106.9794651026705;4121.216968775923;4122.216778812031;4130.917381652365;4131.7520948743095;3158.5578019077348;3673.8978306507943;3764.4917936078555;3970.749213997596;4112.938305925413;3575.9284814303696;4079.530853951789;4103.507579090498;4106.558809577307;4119.691023173259;4102.856400025999;4110.383442483621;4116.300228961084;4121.340585506305;4133.689973252018;2900.0999000999;2912.8348660535744;3525.982370088133;3584.551931008624;3668.779873207616;4415.747968536038;5067.201143594008;5080.171138390177;5084.0934649506435;5101.744912754384;4356;4445.73325600465;4730.209176585831;4737.478877323491;4741.668083234141;4687.507811679793;5309.141800369878;5518.633633483612;5576.386597474275;5610.887782244373;4019.095703466726;4042;4046.615571520701;4051.412545180962;4062.431259623655;5228.379202447253;5303.946960530384;5417.972910135463;5853.32686741026;5890.823275301748;3541.769784963969;3593.1017245688577;3798.981005094957;4031.173609410064;4110.506739191256;3427.783136986334;3753.9061523462133;3936.5751795937717;3943.684505239574;3948.506436695413;4381.255186618218;4428.468583769968;4473.807834161237;4490.034642551867;4529.365888775574;4806.014766972762;5510.448955104457;5627.6948134677;5633.57748168889;5643.435656434323;1252.812078188279;1258.3267951645826;1282.3331867428885;1289.9806502902463;1301.563976068009;820.5651004967377;855.2644725536034;858.9312854971587;862.6887131559994;866.5450638414883;4444.400005999213;4474.843380481668;4637.652176086807;4739.715617062919;4759.668232237378;5054.519820617035;5213.530782229617;5440.564754819684;5453.863653408696;5495.670259784346;4188.434561334181;4508.233600287959;4982.377202849644;4993.450720420751;5288.814891478857;2434.6713193718974;2454.631805229194;2586.1207189555266;2810.400379648817;2811.943761124766;5526.198701188386;5545.3622833374675;5556.38864729224;5575;5583.738585872728;4404.691671583022;5061.595072394273;5387.326584176978;5403.702796346239;5844.59087863854;4804.25534042224;5897.321807992136;5927.911081333869;5942.524598032147;5945.316288626776;5307.283516725192;5673.234113394804;5696.373398926197;5763.9135412968;5765.538756899354;4926.891449423851;5096.847094587169;5337.519623233772;5488.835334939959;5601.131824567198;5756.459777236885;5820.700823174907;5829.688320128107;5835.9708201458725;5858.150568167677;3487.319972605419;3906.7851268180525;4052.5542190359624;4208.074223670787;4213.662906967374;4961.875953101201;5261;5391.948570028807;5580.916286255629;5645.576581756302;5395.974764794676;5513.5037846594;5515.338159420895;5555.777768889199;5632.380438151718;5512.944870551243;5516.558675305886;5521.723913804213;5530.529904958124;5545.066778546916;5142.9742851287;5466.7699767551985;5477.397486276586;5507.917381239365;5511.8425130723;5533.3083364579425;5596.776128954796;5612.298462692163;5612.550995920398;5627.380988091225;4679.3448917150945;5199.896002080013;5379.865503362447;5417.593680473901;5441.945580544144 08:38:15 INFO - PROCESS | 1638 | |5;yui.html;668.0513670587765;701.7508784381541;701.8420855307556;807.8182408957986;827.1686954610616;14417.207053612061;15271;15758.606034849134;15767.132807695572;15772.526824195264;12199.390030498484;14192.858071419283;14352.210628415432;14559.636009099779;14617.853821461782;835.1523203947997;851.9318454523655;868.0148031983713;881.4667126388539;888.2361169394316;702.732961474639;726.7129483853874;730.4010711216804;890.9955450222773;896.3008853094564;896.6323807239033;925.9259259259277;935.368626177331;940.9482478463682;941.5386460634274;927.4898805656895;929.0616477357917;929.972100836976;931.2596485793777;932.3054324528202;540.6891037653326;559.6530151306216;696.4428457234243;698.5075521757149;699.4439420660588;12260.632181034494;12480.875191248062;12515.687107822378;12540.122191446602;15658.982166159163;14374.209418482083;14439.494617688331;14461.566153015427;14478.131312121306;15155.545333640008;10934.01323015597;11392.772144557146;11532.654020379403;11712.590059347967;12103.91064804163;3676;3725.292194483067;3728.8694895678523;3882.9223415531815;3888.1640447303967;112763;114087;117012.41493792561;117151.4142429291;118076.22885656722;10751.40867252293;10907.890921090846;11316.377599231957;11639.883601164049;11720;23264;23277.3016809496;23337.18319858797;23762;23879.403014924766;7502.099748030271;7700;7717.382609391235;7733.033370828646;8023.1575684553445;4160.521540022936;4162;4252.936205956913;4318.589733975267;4406.1187762447635;3604.8377822998027;3669.321175582526;3676.8713095041544;3677.4667673187773;3700.833462494194;630.095812509051;639.6034458635676;642.9421352078242;653.6143675231541;663.9834004149839;543.9265699130646;554.2932760730101;651.6741629185407;673.6732684647942;707.3987110955646;9589.376690515093;10093.596256149673;10097.545610447547;10244.070127191368;10365.896341036643;570.3298624116646;580.1819434597197;591.5563327504372;637.8692368064536;715.3669002932443;4512.932306015412;4885.120678277873;4927.088488629615;4977.875553111201;4987.102321582078;92355;94393;103140;106621.46689266503;109249;78315.21684783194;94361;95627;95826.52086739521;96047;63573.68213158997;73642;73825.6308718453;76432;77256.2274377249;10722.24944253926;10834.02493775564;11055.613053543088;11182.88817111851;11194.888051119384;47942.041159175926;51281.99999999851;51952;52347;52537.474625254785;66567;68758;69119;70293.64853175702;70729.29270707433;12387.101925130373;12420.316882571546;12528.49886004586;12973.027022973503;13016.023798215361;13454.572557203626;13564.86435135636;14314.856851431352;14713.33789979432;15073.020253683475;12683.23900565969;13333.466661333438;13488.797668035184;13503.32483375847;13526.391312391163;12827.358632068546;13172.631484464244;13177.407016684463;13183.868161318263;13471.528496502968;12213.45039473208;12981.675458113245;13033.739325213632;13147.93426032902;13158.736825263633;10224.691235553615;10841.232815524218;10854.29447085937;10977.725556860823;11032.889671103187;8616.827663446822;9944.403335799876;10168.389896606228;10433.63482278147;10640.787184256425 08:38:15 INFO - PROCESS | 1638 | __end_tp_report 08:38:15 INFO - PROCESS | 1638 | __start_cc_report 08:38:15 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1685 08:38:15 INFO - PROCESS | 1638 | __end_cc_report 08:38:15 INFO - PROCESS | 1638 | __startTimestamp1487608695595__endTimestamp 08:38:15 INFO - PROCESS | 1638 | 08:38:15 INFO - PROCESS | 1638 | ------- Summary: start ------- 08:38:15 INFO - PROCESS | 1638 | Number of tests: 6 08:38:15 INFO - PROCESS | 1638 | 08:38:15 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5732.14 Median:5901.44 stddev:652.52 (11.1%) stddev-sans-first:627.54 08:38:15 INFO - PROCESS | 1638 | Values: 3365.1 3368.0 3371.4 3389.9 3432.0 5353.5 5676.7 5679.0 5719.4 5723.1 5668.0 5727.9 5743.3 5744.1 5754.2 5165.8 5214.3 5240.3 5246.9 5286.4 5098.0 5187.5 5310.3 5310.6 5315.4 4384.6 5180.1 5258.7 5271.7 5282.9 5256.6 5263.8 5273.7 5275.7 5287.3 5146.2 5233.2 5250.5 5285.5 5286.8 5567.0 5576.0 5603.4 5706.8 5723.4 6136.2 6189.6 6217.8 6262.5 6293.6 6223.3 6305.7 6306.4 6311.1 6338.1 5724.7 5773.5 5785.3 5801.8 5812.2 5188.2 6292.2 6324.2 6326.8 6343.0 6139.4 6146.8 6155.2 6168.4 6193.6 6241.2 6246.1 6290.2 6306.6 6319.0 6117.7 6129.7 6137.6 6259.8 6268.6 6158.4 6173.4 6189.5 6197.4 6212.1 5011.2 5016.6 5034.5 5042.6 5051.8 3808.0 4433.3 4455.6 4478.3 4482.2 5622.3 5666.0 5667.5 5776.0 5784.2 6143.4 6168.6 6210.7 6224.6 6323.2 5640.9 5717.7 5724.8 5772.8 5774.3 5394.4 5414.9 5429.5 5470.3 5491.5 6296.4 6351.1 6352.5 6367.4 6371.1 5170.4 6134.8 6247.8 6272.6 6350.6 6356.1 6376.0 6378.4 6379.4 6381.0 6252.2 6252.2 6270.6 6278.4 6288.7 6112.1 6128.3 6156.4 6190.6 6208.5 6107.7 6114.7 6121.1 6134.6 6141.7 5901.4 6110.3 6118.3 6119.4 6127.2 5803.2 5854.4 5897.9 5919.1 5952.4 6097.4 6119.4 6119.8 6133.7 6148.3 4697.3 5838.9 5941.2 5947.6 5968.2 08:38:15 INFO - PROCESS | 1638 | 08:38:15 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:68763.33 Median:35205.15 stddev:150222.96 (426.7%) stddev-sans-first:150556.84 08:38:15 INFO - PROCESS | 1638 | Values: 459.0 493.1 508.9 516.9 539.9 38230.6 40389.0 40399.8 40419.8 40420.6 42064.8 42651.1 42705.6 42751.0 42764.0 8488.2 8713.8 9198.0 9383.6 9397.2 10666.7 11468.8 11532.5 11660.4 11667.2 11441.1 11505.4 11534.0 11539.3 11548.5 8472.8 8682.3 11267.3 11407.7 11474.3 10985.0 11271.2 11271.9 11297.9 11319.9 41105.6 41270.4 41315.6 41327.0 41371.4 3874.1 3936.3 3938.3 3951.7 3970.5 26500.0 29634.4 29716.7 29768.9 31319.5 3014.9 3200.3 3270.1 3358.6 3413.8 468347.0 477955.0 481887.0 482731.0 482751.0 60150.8 61059.0 61557.7 61633.4 61713.7 66571.7 66717.7 66750.3 66859.7 66964.3 16012.4 16228.9 16289.8 16540.6 16585.3 11488.3 11760.4 11776.1 12706.7 12785.0 17999.9 21081.5 21651.9 21658.7 21661.0 8633.7 8861.2 8865.8 8892.6 8898.9 846.3 872.8 879.5 887.1 917.0 28861.6 29989.7 30150.7 30690.5 31004.5 999.5 1017.6 1022.2 1031.2 1068.3 13847.7 14326.4 14519.6 14592.6 14681.8 627810.0 632366.0 635294.0 636142.0 637310.0 51743.0 51911.0 52076.0 52132.0 52152.7 1340.4 1375.8 1379.2 1387.6 1402.3 27460.6 28663.7 29052.9 29446.4 29451.4 45465.8 46131.3 46204.0 46255.8 46283.8 559528.0 563211.0 563750.0 564615.0 564941.0 23116.7 23655.8 23688.8 25972.9 26319.9 41442.2 41663.2 42132.6 42403.6 44004.8 33415.0 33611.2 34583.5 36042.6 36051.6 34780.8 35107.0 35134.8 36222.1 36271.0 34511.3 35181.5 35200.3 35210.0 35340.6 28097.0 29912.7 30233.8 30577.8 30589.7 18993.5 22634.4 23331.2 23819.5 23861.2 08:38:15 INFO - PROCESS | 1638 | 08:38:15 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:38556.72 Median:2560.23 stddev:116673.05 (4557.1%) stddev-sans-first:116965.16 08:38:15 INFO - PROCESS | 1638 | Values: 397.5 398.9 403.0 405.6 425.3 20793.4 20824.7 21147.4 21352.4 21533.0 18679.1 21511.4 21656.8 22200.0 22436.3 4800.4 5855.6 5856.4 5863.7 5866.7 5128.4 5721.8 5819.4 6626.1 6705.2 6707.8 6728.8 6731.2 6732.8 6735.0 6369.6 6473.4 6530.7 6542.0 6560.2 5132.8 5397.1 5767.3 5775.0 5785.9 13401.9 13584.9 13591.6 13594.0 22791.7 2523.2 2597.2 2626.6 2668.6 2677.3 9878.8 9911.8 9915.4 10349.4 10402.8 1714.5 1763.8 1787.4 1800.6 1801.9 96020.0 139793.0 140202.0 142290.0 143389.3 11742.6 11880.7 11902.5 11959.9 12072.6 15592.3 15602.5 15918.3 16070.1 16105.0 8681.3 8838.8 8854.1 8859.9 8916.3 7680.0 8383.6 8600.1 8647.7 8721.4 4082.9 4612.0 4826.8 4830.3 4854.8 1972.8 2001.5 2015.3 2016.8 2019.7 990.9 1009.9 1011.3 1011.5 1037.3 17670.8 21550.9 22595.2 22617.0 22758.7 1034.3 1040.1 1045.7 1063.4 1069.1 10799.6 11566.8 11697.8 11717.6 11795.9 683249.0 695695.0 702097.0 712677.0 714009.0 96336.7 97728.0 120453.8 134276.0 163227.2 970.5 987.7 1011.2 1013.0 1015.5 19788.0 20863.0 20892.5 20919.4 20928.2 47734.5 61113.0 61860.7 62237.4 63902.0 74818.4 87534.0 91128.1 91408.0 92845.5 8337.7 8460.9 8486.2 8780.7 8994.8 9389.6 11297.0 13680.0 13939.0 13951.9 11572.4 11622.7 11713.4 11804.5 11869.5 9434.7 11527.5 11669.9 11817.4 11829.4 11666.4 11710.0 11754.2 11778.8 12013.4 8560.4 8565.4 8610.8 8736.3 8748.7 7482.0 7784.4 7910.9 9832.2 11355.5 08:38:15 INFO - PROCESS | 1638 | 08:38:15 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5474.99 Median:5164.05 stddev:2970.93 (57.5%) stddev-sans-first:2963.72 08:38:15 INFO - PROCESS | 1638 | Values: 1431.2 1450.7 1463.1 1472.2 1474.2 8127.0 8544.8 8550.3 8553.2 8568.0 7490.9 7713.8 8127.1 8378.8 8379.0 2320.5 2357.9 2362.6 2365.3 2368.5 2376.1 2394.0 2409.6 2411.7 2414.8 2212.0 2235.7 2247.1 2278.3 2279.0 1971.8 2320.7 2344.7 2349.9 2351.2 2267.3 2318.2 2319.1 2325.7 2332.9 8429.9 8496.2 8507.3 8521.9 8524.6 5060.5 5221.9 5221.9 5223.9 5232.8 3314.6 3419.1 3538.6 3589.6 3599.0 1252.3 1256.9 1722.7 1772.0 1844.5 10509.4 10910.1 11002.6 11146.2 11171.1 4410.7 4527.1 4566.8 4568.8 4570.2 7894.3 8235.3 8750.1 8866.7 8874.9 5149.4 5161.3 5166.8 5167.1 5169.1 4607.5 4735.1 4803.3 4835.3 4843.8 3606.2 3746.1 3845.1 3869.3 3872.2 1186.7 1191.7 1198.6 1200.1 1200.6 769.9 849.7 888.9 899.7 915.3 5345.3 5419.9 5615.4 5775.8 5791.1 950.3 959.2 985.1 991.9 1017.8 3579.9 3624.3 3730.1 3768.2 3838.8 9943.7 10157.3 10188.8 10207.7 10230.6 9581.1 9988.6 10038.4 10098.2 10108.3 7777.0 7997.6 8015.8 8021.0 8041.4 5294.3 5455.9 5506.4 5679.7 5880.7 9003.4 9205.0 9389.1 9435.6 9549.9 9473.4 9543.8 9584.0 9618.6 9722.7 7040.9 7297.0 7303.8 7459.5 7486.1 8163.0 8210.7 8225.4 8228.5 8236.6 7117.8 7288.2 7312.5 7403.5 7464.9 7086.7 7164.6 7188.2 7188.2 7313.0 6345.6 6489.9 6498.1 6503.4 6506.4 4435.0 4624.2 4739.6 4777.0 4794.6 4907.5 4988.7 5089.3 5089.3 5106.9 08:38:15 INFO - PROCESS | 1638 | 08:38:15 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4471.14 Median:5013.02 stddev:1364.71 (27.2%) stddev-sans-first:1332.65 08:38:15 INFO - PROCESS | 1638 | Values: 328.5 350.6 356.5 361.8 375.5 4092.4 5003.2 5149.5 5224.5 5246.7 4608.8 4968.0 5022.8 5260.8 5266.3 4107.0 4121.2 4122.2 4130.9 4131.8 3158.6 3673.9 3764.5 3970.7 4112.9 3575.9 4079.5 4103.5 4106.6 4119.7 4102.9 4110.4 4116.3 4121.3 4133.7 2900.1 2912.8 3526.0 3584.6 3668.8 4415.7 5067.2 5080.2 5084.1 5101.7 4356.0 4445.7 4730.2 4737.5 4741.7 4687.5 5309.1 5518.6 5576.4 5610.9 4019.1 4042.0 4046.6 4051.4 4062.4 5228.4 5303.9 5418.0 5853.3 5890.8 3541.8 3593.1 3799.0 4031.2 4110.5 3427.8 3753.9 3936.6 3943.7 3948.5 4381.3 4428.5 4473.8 4490.0 4529.4 4806.0 5510.4 5627.7 5633.6 5643.4 1252.8 1258.3 1282.3 1290.0 1301.6 820.6 855.3 858.9 862.7 866.5 4444.4 4474.8 4637.7 4739.7 4759.7 5054.5 5213.5 5440.6 5453.9 5495.7 4188.4 4508.2 4982.4 4993.5 5288.8 2434.7 2454.6 2586.1 2810.4 2811.9 5526.2 5545.4 5556.4 5575.0 5583.7 4404.7 5061.6 5387.3 5403.7 5844.6 4804.3 5897.3 5927.9 5942.5 5945.3 5307.3 5673.2 5696.4 5763.9 5765.5 4926.9 5096.8 5337.5 5488.8 5601.1 5756.5 5820.7 5829.7 5836.0 5858.2 3487.3 3906.8 4052.6 4208.1 4213.7 4961.9 5261.0 5391.9 5580.9 5645.6 5396.0 5513.5 5515.3 5555.8 5632.4 5512.9 5516.6 5521.7 5530.5 5545.1 5143.0 5466.8 5477.4 5507.9 5511.8 5533.3 5596.8 5612.3 5612.6 5627.4 4679.3 5199.9 5379.9 5417.6 5441.9 08:38:15 INFO - PROCESS | 1638 | 08:38:15 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20688.71 Median:3713.06 stddev:30193.07 (813.2%) stddev-sans-first:30240.35 08:38:15 INFO - PROCESS | 1638 | Values: 668.1 701.8 701.8 807.8 827.2 14417.2 15271.0 15758.6 15767.1 15772.5 12199.4 14192.9 14352.2 14559.6 14617.9 835.2 851.9 868.0 881.5 888.2 702.7 726.7 730.4 891.0 896.3 896.6 925.9 935.4 940.9 941.5 927.5 929.1 930.0 931.3 932.3 540.7 559.7 696.4 698.5 699.4 12260.6 12480.9 12515.7 12540.1 15659.0 14374.2 14439.5 14461.6 14478.1 15155.5 10934.0 11392.8 11532.7 11712.6 12103.9 3676.0 3725.3 3728.9 3882.9 3888.2 112763.0 114087.0 117012.4 117151.4 118076.2 10751.4 10907.9 11316.4 11639.9 11720.0 23264.0 23277.3 23337.2 23762.0 23879.4 7502.1 7700.0 7717.4 7733.0 8023.2 4160.5 4162.0 4252.9 4318.6 4406.1 3604.8 3669.3 3676.9 3677.5 3700.8 630.1 639.6 642.9 653.6 664.0 543.9 554.3 651.7 673.7 707.4 9589.4 10093.6 10097.5 10244.1 10365.9 570.3 580.2 591.6 637.9 715.4 4512.9 4885.1 4927.1 4977.9 4987.1 92355.0 94393.0 103140.0 106621.5 109249.0 78315.2 94361.0 95627.0 95826.5 96047.0 63573.7 73642.0 73825.6 76432.0 77256.2 10722.2 10834.0 11055.6 11182.9 11194.9 47942.0 51282.0 51952.0 52347.0 52537.5 66567.0 68758.0 69119.0 70293.6 70729.3 12387.1 12420.3 12528.5 12973.0 13016.0 13454.6 13564.9 14314.9 14713.3 15073.0 12683.2 13333.5 13488.8 13503.3 13526.4 12827.4 13172.6 13177.4 13183.9 13471.5 12213.5 12981.7 13033.7 13147.9 13158.7 10224.7 10841.2 10854.3 10977.7 11032.9 8616.8 9944.4 10168.4 10433.6 10640.8 08:38:15 INFO - PROCESS | 1638 | -------- Summary: end -------- 08:38:15 INFO - PROCESS | 1638 | 08:38:16 INFO - TEST-INFO | 1638: exit 0 08:38:16 INFO - TEST-OK | dromaeo_css | took 1120086ms 08:38:16 INFO - TEST-START | kraken 08:38:16 INFO - operating with platform_type : mac_ 08:38:16 INFO - Initialising browser for kraken test... 08:38:16 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpVd0MDo/profile http://localhost:49235/getInfo.html) 08:38:18 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 08:38:18 INFO - PROCESS | 1648 | colorDepth:24 08:38:18 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 08:38:18 INFO - PROCESS | 1648 | __metrics 08:38:18 INFO - PROCESS | 1648 | 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:38:18 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:38:19 INFO - TEST-INFO | 1648: exit 0 08:38:19 INFO - Browser initialized. 08:38:19 INFO - Running cycle 1/1 for kraken test... 08:38:19 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpVd0MDo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:31 INFO - PROCESS | 1649 | RSS: Main: 213741568 08:38:31 INFO - PROCESS | 1649 | 08:38:34 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:35 INFO - PROCESS | 1649 | RSS: Main: 267055104 08:38:35 INFO - PROCESS | 1649 | 08:38:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 08:38:38 INFO - PROCESS | 1649 | RSS: Main: 275382272 08:38:38 INFO - PROCESS | 1649 | 08:38:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 08:38:42 INFO - PROCESS | 1649 | RSS: Main: 373411840 08:38:42 INFO - PROCESS | 1649 | 08:38:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 08:38:44 INFO - PROCESS | 1649 | RSS: Main: 276520960 08:38:44 INFO - PROCESS | 1649 | 08:38:46 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:47 INFO - PROCESS | 1649 | RSS: Main: 277753856 08:38:47 INFO - PROCESS | 1649 | 08:38:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:50 INFO - PROCESS | 1649 | RSS: Main: 318111744 08:38:50 INFO - PROCESS | 1649 | 08:38:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 08:38:54 INFO - PROCESS | 1649 | RSS: Main: 317759488 08:38:54 INFO - PROCESS | 1649 | 08:38:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 08:38:57 INFO - PROCESS | 1649 | RSS: Main: 317161472 08:38:57 INFO - PROCESS | 1649 | 08:38:59 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:00 INFO - PROCESS | 1649 | RSS: Main: 295739392 08:39:00 INFO - PROCESS | 1649 | 08:39:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:02 INFO - PROCESS | 1649 | RSS: Main: 297570304 08:39:02 INFO - PROCESS | 1649 | 08:39:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:05 INFO - PROCESS | 1649 | RSS: Main: 302092288 08:39:05 INFO - PROCESS | 1649 | 08:39:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:39:09 INFO - PROCESS | 1649 | RSS: Main: 317730816 08:39:09 INFO - PROCESS | 1649 | 08:39:11 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:12 INFO - PROCESS | 1649 | RSS: Main: 311500800 08:39:12 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 08:39:14 INFO - PROCESS | 1649 | RSS: Main: 355844096 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | __start_tp_report 08:39:14 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 08:39:14 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 08:39:14 INFO - PROCESS | 1649 | |i|pagename|runs| 08:39:14 INFO - PROCESS | 1649 | |0;ai-astar;117;115;114;114;114;114;114;113;113;113 08:39:14 INFO - PROCESS | 1649 | |1;audio-beat-detection;141;111;109;142;112;110;110;107;127;109 08:39:14 INFO - PROCESS | 1649 | |2;audio-dft;186;188;261;201;182;183;184;183;185;184 08:39:14 INFO - PROCESS | 1649 | |3;audio-fft;82;59;58;86;60;67;57;58;63;47 08:39:14 INFO - PROCESS | 1649 | |4;audio-oscillator;87;71;86;71;68;69;81;68;80;112 08:39:14 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;88;88;88;84;90;84;94;84;88;84 08:39:14 INFO - PROCESS | 1649 | |6;imaging-darkroom;93;94;94;95;94;94;93;94;94;94 08:39:14 INFO - PROCESS | 1649 | |7;imaging-desaturate;86;86;86;87;84;87;85;85;87;84 08:39:14 INFO - PROCESS | 1649 | |8;json-parse-financial;56;54;54;54;56;56;56;57;57;56 08:39:14 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;63;71;74;72;72;69;68;67;66;68 08:39:14 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;84;95;82;86;85;83;83;82;87;84 08:39:14 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;138;138;148;138;137;138;139;140;182;183 08:39:14 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;199;170;167;169;169;168;168;170;168;166 08:39:14 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;65;66;67;65;65;66;63;65;66;64 08:39:14 INFO - PROCESS | 1649 | __end_tp_report 08:39:14 INFO - PROCESS | 1649 | __start_cc_report 08:39:14 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2173 08:39:14 INFO - PROCESS | 1649 | __end_cc_report 08:39:14 INFO - PROCESS | 1649 | __startTimestamp1487608754567__endTimestamp 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | ------- Summary: start ------- 08:39:14 INFO - PROCESS | 1649 | Number of tests: 14 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:1.20 (1.1%) stddev-sans-first:0.67 08:39:14 INFO - PROCESS | 1649 | Values: 117.0 115.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 113.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:111.50 stddev:13.67 (12.3%) stddev-sans-first:11.64 08:39:14 INFO - PROCESS | 1649 | Values: 141.0 111.0 109.0 142.0 112.0 110.0 110.0 107.0 127.0 109.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:193.70 Median:185.50 stddev:24.28 (13.1%) stddev-sans-first:25.59 08:39:14 INFO - PROCESS | 1649 | Values: 186.0 188.0 261.0 201.0 182.0 183.0 184.0 183.0 185.0 184.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:63.70 Median:61.50 stddev:11.87 (19.3%) stddev-sans-first:10.58 08:39:14 INFO - PROCESS | 1649 | Values: 82.0 59.0 58.0 86.0 60.0 67.0 57.0 58.0 63.0 47.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:75.50 stddev:13.65 (18.1%) stddev-sans-first:14.19 08:39:14 INFO - PROCESS | 1649 | Values: 87.0 71.0 86.0 71.0 68.0 69.0 81.0 68.0 80.0 112.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.00 stddev:3.29 (3.7%) stddev-sans-first:3.48 08:39:14 INFO - PROCESS | 1649 | Values: 88.0 88.0 88.0 84.0 90.0 84.0 94.0 84.0 88.0 84.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 08:39:14 INFO - PROCESS | 1649 | Values: 93.0 94.0 94.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:1.16 (1.3%) stddev-sans-first:1.22 08:39:14 INFO - PROCESS | 1649 | Values: 86.0 86.0 86.0 87.0 84.0 87.0 85.0 85.0 87.0 84.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.17 (2.1%) stddev-sans-first:1.24 08:39:14 INFO - PROCESS | 1649 | Values: 56.0 54.0 54.0 54.0 56.0 56.0 56.0 57.0 57.0 56.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:70.00 stddev:3.30 (4.7%) stddev-sans-first:2.69 08:39:14 INFO - PROCESS | 1649 | Values: 63.0 71.0 74.0 72.0 72.0 69.0 68.0 67.0 66.0 68.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.50 stddev:3.84 (4.5%) stddev-sans-first:4.06 08:39:14 INFO - PROCESS | 1649 | Values: 84.0 95.0 82.0 86.0 85.0 83.0 83.0 82.0 87.0 84.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:139.50 stddev:18.40 (13.2%) stddev-sans-first:19.15 08:39:14 INFO - PROCESS | 1649 | Values: 138.0 138.0 148.0 138.0 137.0 138.0 139.0 140.0 182.0 183.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:169.00 stddev:9.78 (5.8%) stddev-sans-first:1.32 08:39:14 INFO - PROCESS | 1649 | Values: 199.0 170.0 167.0 169.0 169.0 168.0 168.0 170.0 168.0 166.0 08:39:14 INFO - PROCESS | 1649 | 08:39:14 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.14 (1.7%) stddev-sans-first:1.20 08:39:14 INFO - PROCESS | 1649 | Values: 65.0 66.0 67.0 65.0 65.0 66.0 63.0 65.0 66.0 64.0 08:39:14 INFO - PROCESS | 1649 | -------- Summary: end -------- 08:39:14 INFO - PROCESS | 1649 | 08:39:15 INFO - TEST-INFO | 1649: exit 0 08:39:15 INFO - TEST-OK | kraken | took 59217ms 08:39:15 INFO - SUITE-END | took 1179s 08:39:15 INFO - Completed test suite (00:19:39) 08:39:15 INFO - javascript benchmark 08:39:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3365.1418888183516, 3367.9727683056667, 3371.359441706074, 3389.864405423783, 3431.9875636687175, 5353.491418315259, 5676.744546495407, 5679.0, 5719.370869204384, 5723.141528770687, 5667.971660141693, 5727.856803579913, 5743.310802703671, 5744.138379243115, 5754.1944127822135, 5165.767540460679, 5214.296070030554, 5240.266362709223, 5246.921296180561, 5286.392064912546, 5098.0, 5187.507186817246, 5310.336207974004, 5310.6017048721305, 5315.388730296027, 4384.561543845606, 5180.1452760294505, 5258.7370631468275, 5271.736413179326, 5282.894342113155, 5256.632035757499, 5263.815766448156, 5273.683578985273, 5275.736213189363, 5287.339082614692, 5146.150885103991, 5233.21501774733, 5250.501202385767, 5285.497877701612, 5286.81496147633, 5567.0, 5575.996320662279, 5603.439656034364, 5706.828795136153, 5723.427657234285, 6136.194560805258, 6189.597676151081, 6217.813465596039, 6262.530310226751, 6293.622382657055, 6223.315435302113, 6305.716242769041, 6306.400891915307, 6311.08489269058, 6338.080978258126, 5724.656520608777, 5773.480386765169, 5785.27684039495, 5801.767929282823, 5812.215350927655, 5188.22176673502, 6292.1505596743855, 6324.209473815773, 6326.841828954313, 6343.016832390987, 6139.4001448443105, 6146.78486252979, 6155.169052177988, 6168.444839964424, 6193.628382297076, 6241.18864547615, 6246.063090536456, 6290.24517057956, 6306.558540902184, 6319.0, 6117.663528505975, 6129.706382575503, 6137.591499645514, 6259.78090766821, 6268.561200715906, 6158.445739883432, 6173.41352571505, 6189.50483961282, 6197.380261973857, 6212.099245609361, 5011.223260394645, 5016.6237532184505, 5034.546890779848, 5042.6470147090085, 5051.797928082909, 3807.9619203807606, 4433.334999749999, 4455.5989960903025, 4478.328250762346, 4482.193205223091, 5622.32532096151, 5666.0, 5667.489925906688, 5776.046952252831, 5784.1902133701315, 6143.389059649631, 6168.568200225941, 6210.658413787195, 6224.564280500412, 6323.241211054703, 5640.85897852557, 5717.742701578439, 5724.799632012943, 5772.797952071742, 5774.2782152230975, 5394.3796463406425, 5414.945850541523, 5429.511343979061, 5470.316210473691, 5491.505764481216, 6296.433321001132, 6351.079093531504, 6352.523560732963, 6367.363263673596, 6371.108044873628, 5170.37955445349, 6134.8039827316215, 6247.750089996349, 6272.560920735505, 6350.618962862243, 6356.11014457967, 6376.043593461018, 6378.425941665272, 6379.393957574209, 6381.0, 6252.1559589456665, 6252.218472690914, 6270.592411493239, 6278.4035516625845, 6288.6855657217875, 6112.10835914862, 6128.295246046761, 6156.415140561639, 6190.628562286277, 6208.4722798562625, 6107.6640784757265, 6114.692773002257, 6121.056693971993, 6134.589663226485, 6141.731496609813, 5901.439363260483, 6110.285381942539, 6118.314626315956, 6119.441623354662, 6127.220070483952, 5803.216565763737, 5854.385289544536, 5897.882042359043, 5919.112133180058, 5952.375000624872, 6097.390260973867, 6119.41115851624, 6119.837693858789, 6133.738055536083, 6148.262208535004, 4697.318888761179, 5838.948989181818, 5941.22764040672, 5947.643141411356, 5968.22413086296], "value": 5691.076784342677, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.98623041308764, 493.11978119057477, 508.9363230847528, 516.9457206993266, 539.919012148178, 38230.61769382306, 40389.0, 40399.79800101003, 40419.797901010454, 40420.59579404205, 42064.78967605158, 42651.14697706044, 42705.57294427055, 42751.0, 42764.0, 8488.151184881493, 8713.825723485526, 9198.034206408347, 9383.624655013791, 9397.201237894787, 10666.733331666732, 11468.827967580452, 11532.538698452094, 11660.416979151008, 11667.24162929411, 11441.141914356414, 11505.42472876357, 11534.01960833326, 11539.307641541493, 11548.480318385651, 8472.788180295542, 8682.305415566803, 11267.323960562393, 11407.714807129805, 11474.25417347874, 10985.01134897855, 11271.154663400195, 11271.887281127165, 11297.887021129765, 11319.924607162306, 41105.588944110474, 41270.38094428586, 41315.58684413177, 41326.96682582959, 41371.37942930858, 3874.147687508772, 3936.2521120987208, 3938.330483817758, 3951.7036222283446, 3970.5433875104445, 26500.0, 29634.407311853643, 29716.70283297161, 29768.851155744083, 31319.53020704691, 3014.9095527134223, 3200.3279311344413, 3270.084376374619, 3358.5589162096967, 3413.812240326781, 468347.0, 477955.0, 481886.9999999965, 482731.0, 482751.0, 60150.79698406095, 61059.0, 61557.69221153955, 61633.38366616366, 61713.69143154255, 66571.66714166495, 66717.66641166763, 66750.32747707711, 66859.66570167118, 66964.33035669678, 16012.439564615182, 16228.918855405647, 16289.837101628833, 16540.586485337964, 16585.25366358517, 11488.310701357945, 11760.411979401168, 11776.11679124069, 12706.682332941566, 12785.0, 17999.871350725316, 21081.472963176042, 21651.891740541196, 21658.675119873216, 21661.0, 8633.654653813777, 8861.24679402245, 8865.778355541033, 8892.555372231363, 8898.86651700225, 846.327169899931, 872.829798189347, 879.5250564695122, 887.054670213562, 916.9679061232958, 28861.56707649387, 29989.70010299869, 30150.69849301523, 30690.53964190539, 31004.53493197604, 999.5102399824179, 1017.5522769981185, 1022.2231104360591, 1031.1544533482622, 1068.2522234435926, 13847.653808654662, 14326.355314010894, 14519.564413067414, 14592.562223133324, 14681.77977330341, 627810.0, 632366.0, 635294.0, 636142.0, 637310.0, 51743.0, 51910.96178076417, 52076.0, 52132.0, 52152.739236303576, 1340.3968214303407, 1375.7936309553647, 1379.186280094749, 1387.5629176809273, 1402.3479082226609, 27460.588091178248, 28663.713362866103, 29052.854735726185, 29446.411071778017, 29451.410971780017, 45465.77267113643, 46131.3080303789, 46204.0, 46255.84360391017, 46283.76858115688, 559528.0, 563211.0, 563750.0, 564615.0, 564941.0, 23116.653250200925, 23655.763442365354, 23688.763112369346, 25972.870135649202, 26319.868400657873, 41442.1711565773, 41663.166736665706, 42132.57867421286, 42403.575964239964, 44004.77997609991, 33415.0, 33611.15972100717, 34583.4812477808, 36042.63957360393, 36051.63948360483, 34780.82609586936, 35107.0, 35134.82432587923, 36222.09444763902, 36271.0, 34511.30977380489, 35181.47227791534, 35200.29599408049, 35210.0, 35340.64659353373, 28097.0, 29912.70087299099, 30233.848830756586, 30577.847110764305, 30589.74921692661, 18993.525161871064, 22634.434139145993, 23331.18340858062, 23819.523609527365, 23861.164859229844], "value": 19849.680460063842, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.45151690666876, 398.94813674222354, 402.9576894426087, 405.64100770817817, 425.2749062847845, 20793.376198714042, 20824.687629685566, 21147.365579032616, 21352.35942921713, 21533.0, 18679.066046697677, 21511.354659360244, 21656.783432165674, 22200.0, 22436.32691019272, 4800.351952486413, 5855.560832937525, 5856.385079566648, 5863.736131874055, 5866.706664666771, 5128.384593848725, 5721.799737009205, 5819.388964158745, 6626.1386019817355, 6705.1953765548205, 6707.798766037026, 6728.83177920551, 6731.1922569291755, 6732.83167920801, 6734.956081807303, 6369.554131210817, 6473.4463728705, 6530.706118224692, 6542.0, 6560.179977502812, 5132.769025393866, 5397.082495975694, 5767.279090113736, 5775.047117225653, 5785.913211301791, 13401.86598134016, 13584.932075339659, 13591.592252232449, 13594.0, 22791.658125128135, 2523.2430270918653, 2597.2078516052597, 2626.5534859074005, 2668.5730283154794, 2677.2771351734923, 9878.753031174278, 9911.80176396468, 9915.40507569541, 10349.395843644248, 10402.791944161074, 1714.5027941896835, 1763.7707098077296, 1787.3744189533688, 1800.6038671492252, 1801.9369322073796, 96020.0, 139793.0, 140202.0, 142290.0, 143389.2830535851, 11742.589009384801, 11880.702982425335, 11902.523899043941, 11959.940200298943, 12072.577459788865, 15592.298346574431, 15602.531924042298, 15918.283677234553, 16070.11614361198, 16105.0, 8681.262092722189, 8838.823223535494, 8854.070322616033, 8859.867101993475, 8916.331275154389, 7680.001599791991, 8383.622736976851, 8600.139986001475, 8647.697330593524, 8721.433106848035, 4082.857100001486, 4611.976940115345, 4826.831060912851, 4830.2513110467935, 4854.781534830941, 1972.8125828046313, 2001.5396458814264, 2015.2644284836222, 2016.8184863362367, 2019.697045443166, 990.8662330585423, 1009.8586197932295, 1011.2718842433436, 1011.4993078426226, 1037.2998226197287, 17670.823291767174, 21550.89224553867, 22595.20916767905, 22616.982235799427, 22758.65862012071, 1034.2966782587912, 1040.0691381213771, 1045.6601604478424, 1063.3991794636006, 1069.1233188785122, 10799.622013229498, 11566.770768269831, 11697.824532632018, 11717.648470545897, 11795.938365547141, 683249.0, 695695.0, 702097.0, 712677.0, 714009.0, 96336.73811202249, 97728.0, 120453.79546204426, 134276.0, 163227.1838640823, 970.5005766091406, 987.7382493639192, 1011.185995273797, 1012.9898701013043, 1015.5379302417382, 19788.017427031657, 20862.956852157637, 20892.47768805792, 20919.37241882746, 20928.16287348489, 47734.522654774395, 61113.0, 61860.690696546226, 62237.377626223155, 63902.041469377065, 74818.38135665226, 87534.0, 91128.08871911195, 91408.0, 92845.53577232071, 8337.66649334044, 8460.873086903825, 8486.236238738544, 8780.692675756318, 8994.820103598022, 9389.643277302644, 11297.0, 13680.042397032112, 13939.024268301122, 13951.930240348733, 11572.421378931189, 11622.70943226426, 11713.41432928333, 11804.468798904241, 11869.525218991144, 9434.669786557437, 11527.538898443969, 11669.941650291694, 11817.350045747222, 11829.408529573659, 11666.358350290477, 11710.0, 11754.23597466162, 11778.76442471163, 12013.399330033639, 8560.357973152162, 8565.400421970651, 8610.827783444422, 8736.25741811953, 8748.737537873874, 7481.962590187014, 7784.41616878725, 7910.881336780068, 9832.213422926292, 11355.545778169111], "value": 9852.106304106508, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.219985108116, 1450.7243623711495, 1463.1001933810705, 1472.1902953375647, 1474.1744623011111, 8126.959365203174, 8544.829103417927, 8550.315974722023, 8553.230209281164, 8567.95716021419, 7490.850182996337, 7713.768586942387, 8127.065387480441, 8378.832423351545, 8378.99452065753, 2320.5242925200378, 2357.929262122139, 2362.645603159531, 2365.2549446924163, 2368.46709490365, 2376.120835290945, 2393.9521209575796, 2409.5662780699467, 2411.7347091819975, 2414.8309618326725, 2212.0, 2235.7093577834858, 2247.1011595361906, 2278.305116939333, 2279.042802023146, 1971.822535971755, 2320.6751054852334, 2344.6600242964673, 2349.9060037598474, 2351.200591798788, 2267.2971378872603, 2318.2002209237785, 2319.130326127702, 2325.6976593042964, 2332.8833558322017, 8429.915700842974, 8496.150384961516, 8507.276881465083, 8521.914780852174, 8524.616392262364, 5060.51925067118, 5221.903400285944, 5221.921671174935, 5223.869403264911, 5232.764525596357, 3314.5691060162026, 3419.1110311319235, 3538.5930617979006, 3589.5513060867393, 3598.982005089958, 1252.3362617812575, 1256.8625394018427, 1722.6726921884801, 1772.0076757015984, 1844.5019844641872, 10509.421981790922, 10910.127189824794, 11002.614908478245, 11146.164037697205, 11171.106311495061, 4410.713303635253, 4527.071950250191, 4566.840160594364, 4568.840090596813, 4570.154521413549, 7894.250046245597, 8235.341172706168, 8750.124987501325, 8866.689665861664, 8874.86687699685, 5149.433562308143, 5161.2516185152945, 5166.844994650167, 5167.0957582422925, 5169.069567477815, 4607.470140933769, 4735.100330937111, 4803.303520989507, 4835.323054772335, 4843.806247750121, 3606.1886075632774, 3746.119661879456, 3845.0964023454467, 3869.342211823997, 3872.244912242142, 1186.7092562322287, 1191.684203686024, 1198.5565340823778, 1200.0699457920182, 1200.6218041317131, 769.926856948589, 849.6728759427541, 888.8977767556685, 899.7435730816686, 915.3180880244261, 5345.305110335709, 5419.864503387447, 5615.3823079462045, 5775.768969241183, 5791.073428251544, 950.296780382512, 959.2421986630624, 985.113397941858, 991.9057689519484, 1017.765913839821, 3579.94630080549, 3624.2932628137787, 3730.1420673245307, 3768.2275133597545, 3838.7504812187117, 9943.651972180938, 10157.339772914736, 10188.847167292497, 10207.7448063799, 10230.6419275325, 9581.089796469325, 9988.600455981825, 10038.397696138256, 10098.242631802645, 10108.29241953071, 7777.0, 7997.640106195236, 8015.7595272141925, 8021.0, 8041.396895232764, 5294.311739473844, 5455.890882182413, 5506.421825708243, 5679.74441150141, 5880.676562789087, 9003.369764116711, 9205.0, 9389.10803473669, 9435.57539910692, 9549.90450095518, 9473.384230025027, 9543.809123817346, 9583.952080239555, 9618.615255389986, 9722.659706910506, 7040.859182816417, 7297.0, 7303.817404564928, 7459.477836551389, 7486.139094004259, 8162.979627546557, 8210.712625058095, 8225.424220304521, 8228.547429891414, 8236.629351679068, 7117.786466406016, 7288.234735352924, 7312.451566132668, 7403.481756277009, 7464.925350746423, 7086.716531338895, 7164.570125792469, 7188.209296977224, 7188.245234250328, 7313.0, 6345.587536810092, 6489.9026514603265, 6498.122753428227, 6503.414692677682, 6506.3818937200895, 4435.0, 4624.248844185351, 4739.59713424349, 4776.976115119541, 4794.616430685467, 4907.4847141051105, 4988.6757360771435, 5089.262057001788, 5089.312942752681, 5106.872328191825], "value": 4468.989101019397, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.47116143009737, 350.63008526005063, 356.4528448831043, 361.84440690503084, 375.5362127772201, 4092.427060211569, 5003.222566961943, 5149.485051494853, 5224.45143259958, 5246.671496015783, 4608.838690645828, 4967.975160124194, 5022.82420115296, 5260.790018295795, 5266.3153790007245, 4106.9794651026705, 4121.216968775923, 4122.216778812031, 4130.917381652365, 4131.7520948743095, 3158.5578019077348, 3673.8978306507943, 3764.4917936078555, 3970.749213997596, 4112.938305925413, 3575.9284814303696, 4079.530853951789, 4103.507579090498, 4106.558809577307, 4119.691023173259, 4102.856400025999, 4110.383442483621, 4116.300228961084, 4121.340585506305, 4133.689973252018, 2900.0999000999, 2912.8348660535744, 3525.982370088133, 3584.551931008624, 3668.779873207616, 4415.747968536038, 5067.201143594008, 5080.171138390177, 5084.0934649506435, 5101.744912754384, 4356.0, 4445.73325600465, 4730.209176585831, 4737.478877323491, 4741.668083234141, 4687.507811679793, 5309.141800369878, 5518.633633483612, 5576.386597474275, 5610.887782244373, 4019.095703466726, 4042.0, 4046.615571520701, 4051.412545180962, 4062.431259623655, 5228.379202447253, 5303.946960530384, 5417.972910135463, 5853.32686741026, 5890.823275301748, 3541.769784963969, 3593.1017245688577, 3798.981005094957, 4031.173609410064, 4110.506739191256, 3427.783136986334, 3753.9061523462133, 3936.5751795937717, 3943.684505239574, 3948.506436695413, 4381.255186618218, 4428.468583769968, 4473.807834161237, 4490.034642551867, 4529.365888775574, 4806.014766972762, 5510.448955104457, 5627.6948134677, 5633.57748168889, 5643.435656434323, 1252.812078188279, 1258.3267951645826, 1282.3331867428885, 1289.9806502902463, 1301.563976068009, 820.5651004967377, 855.2644725536034, 858.9312854971587, 862.6887131559994, 866.5450638414883, 4444.400005999213, 4474.843380481668, 4637.652176086807, 4739.715617062919, 4759.668232237378, 5054.519820617035, 5213.530782229617, 5440.564754819684, 5453.863653408696, 5495.670259784346, 4188.434561334181, 4508.233600287959, 4982.377202849644, 4993.450720420751, 5288.814891478857, 2434.6713193718974, 2454.631805229194, 2586.1207189555266, 2810.400379648817, 2811.943761124766, 5526.198701188386, 5545.3622833374675, 5556.38864729224, 5575.0, 5583.738585872728, 4404.691671583022, 5061.595072394273, 5387.326584176978, 5403.702796346239, 5844.59087863854, 4804.25534042224, 5897.321807992136, 5927.911081333869, 5942.524598032147, 5945.316288626776, 5307.283516725192, 5673.234113394804, 5696.373398926197, 5763.9135412968, 5765.538756899354, 4926.891449423851, 5096.847094587169, 5337.519623233772, 5488.835334939959, 5601.131824567198, 5756.459777236885, 5820.700823174907, 5829.688320128107, 5835.9708201458725, 5858.150568167677, 3487.319972605419, 3906.7851268180525, 4052.5542190359624, 4208.074223670787, 4213.662906967374, 4961.875953101201, 5261.0, 5391.948570028807, 5580.916286255629, 5645.576581756302, 5395.974764794676, 5513.5037846594, 5515.338159420895, 5555.777768889199, 5632.380438151718, 5512.944870551243, 5516.558675305886, 5521.723913804213, 5530.529904958124, 5545.066778546916, 5142.9742851287, 5466.7699767551985, 5477.397486276586, 5507.917381239365, 5511.8425130723, 5533.3083364579425, 5596.776128954796, 5612.298462692163, 5612.550995920398, 5627.380988091225, 4679.3448917150945, 5199.896002080013, 5379.865503362447, 5417.593680473901, 5441.945580544144], "value": 4045.711656061569, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.0513670587765, 701.7508784381541, 701.8420855307556, 807.8182408957986, 827.1686954610616, 14417.207053612061, 15271.0, 15758.606034849134, 15767.132807695572, 15772.526824195264, 12199.390030498484, 14192.858071419283, 14352.210628415432, 14559.636009099779, 14617.853821461782, 835.1523203947997, 851.9318454523655, 868.0148031983713, 881.4667126388539, 888.2361169394316, 702.732961474639, 726.7129483853874, 730.4010711216804, 890.9955450222773, 896.3008853094564, 896.6323807239033, 925.9259259259277, 935.368626177331, 940.9482478463682, 941.5386460634274, 927.4898805656895, 929.0616477357917, 929.972100836976, 931.2596485793777, 932.3054324528202, 540.6891037653326, 559.6530151306216, 696.4428457234243, 698.5075521757149, 699.4439420660588, 12260.632181034494, 12480.875191248062, 12515.687107822378, 12540.122191446602, 15658.982166159163, 14374.209418482083, 14439.494617688331, 14461.566153015427, 14478.131312121306, 15155.545333640008, 10934.01323015597, 11392.772144557146, 11532.654020379403, 11712.590059347967, 12103.91064804163, 3676.0, 3725.292194483067, 3728.8694895678523, 3882.9223415531815, 3888.1640447303967, 112763.0, 114087.0, 117012.41493792561, 117151.4142429291, 118076.22885656722, 10751.40867252293, 10907.890921090846, 11316.377599231957, 11639.883601164049, 11720.0, 23264.0, 23277.3016809496, 23337.18319858797, 23762.0, 23879.403014924766, 7502.099748030271, 7700.0, 7717.382609391235, 7733.033370828646, 8023.1575684553445, 4160.521540022936, 4162.0, 4252.936205956913, 4318.589733975267, 4406.1187762447635, 3604.8377822998027, 3669.321175582526, 3676.8713095041544, 3677.4667673187773, 3700.833462494194, 630.095812509051, 639.6034458635676, 642.9421352078242, 653.6143675231541, 663.9834004149839, 543.9265699130646, 554.2932760730101, 651.6741629185407, 673.6732684647942, 707.3987110955646, 9589.376690515093, 10093.596256149673, 10097.545610447547, 10244.070127191368, 10365.896341036643, 570.3298624116646, 580.1819434597197, 591.5563327504372, 637.8692368064536, 715.3669002932443, 4512.932306015412, 4885.120678277873, 4927.088488629615, 4977.875553111201, 4987.102321582078, 92355.0, 94393.0, 103140.0, 106621.46689266503, 109249.0, 78315.21684783194, 94361.0, 95627.0, 95826.52086739521, 96047.0, 63573.68213158997, 73642.0, 73825.6308718453, 76432.0, 77256.2274377249, 10722.24944253926, 10834.02493775564, 11055.613053543088, 11182.88817111851, 11194.888051119384, 47942.041159175926, 51281.99999999851, 51952.0, 52347.0, 52537.474625254785, 66567.0, 68758.0, 69119.0, 70293.64853175702, 70729.29270707433, 12387.101925130373, 12420.316882571546, 12528.49886004586, 12973.027022973503, 13016.023798215361, 13454.572557203626, 13564.86435135636, 14314.856851431352, 14713.33789979432, 15073.020253683475, 12683.23900565969, 13333.466661333438, 13488.797668035184, 13503.32483375847, 13526.391312391163, 12827.358632068546, 13172.631484464244, 13177.407016684463, 13183.868161318263, 13471.528496502968, 12213.45039473208, 12981.675458113245, 13033.739325213632, 13147.93426032902, 13158.736825263633, 10224.691235553615, 10841.232815524218, 10854.29447085937, 10977.725556860823, 11032.889671103187, 8616.827663446822, 9944.403335799876, 10168.389896606228, 10433.63482278147, 10640.787184256425], "value": 7462.638286344113, "unit": "score"}], "name": "dromaeo_css", "value": 7290.716429642859, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 111.0, 109.0, 142.0, 112.0, 110.0, 110.0, 107.0, 127.0, 109.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 188.0, 261.0, 201.0, 182.0, 183.0, 184.0, 183.0, 185.0, 184.0], "value": 193.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 86.0, 60.0, 67.0, 57.0, 58.0, 63.0, 47.0], "value": 63.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 86.0, 71.0, 68.0, 69.0, 81.0, 68.0, 80.0, 112.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 84.0, 90.0, 84.0, 94.0, 84.0, 88.0, 84.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 87.0, 84.0, 87.0, 85.0, 85.0, 87.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 54.0, 56.0, 56.0, 56.0, 57.0, 57.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 74.0, 72.0, 72.0, 69.0, 68.0, 67.0, 66.0, 68.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 95.0, 82.0, 86.0, 85.0, 83.0, 83.0, 82.0, 87.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 148.0, 138.0, 137.0, 138.0, 139.0, 140.0, 182.0, 183.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 170.0, 167.0, 169.0, 169.0, 168.0, 168.0, 170.0, 168.0, 166.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 65.0, 65.0, 66.0, 63.0, 65.0, 66.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1429.8, "alertThreshold": 2.0}]} 08:39:15 INFO - Return code: 0 08:39:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:39:15 ERROR - # TBPL SUCCESS # 08:39:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:39:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:39:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:39:15 INFO - 2017-02-20 08:39:15.870 screenresolution[1653:9988] starting screenresolution argv=screenresolution get 08:39:15 INFO - 2017-02-20 08:39:15.872 screenresolution[1653:9988] Display 0: 1600x1200x32@60 08:39:15 INFO - 2017-02-20 08:39:15.878 screenresolution[1654:9991] starting screenresolution argv=screenresolution list 08:39:15 INFO - Available Modes on Display 0 08:39:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:39:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:39:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:39:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:39:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:39:16 INFO - Intel Iris: 08:39:16 INFO - Chipset Model: Intel Iris 08:39:16 INFO - Type: GPU 08:39:16 INFO - Bus: Built-In 08:39:16 INFO - VRAM (Dynamic, Max): 1536 MB 08:39:16 INFO - Vendor: Intel (0x8086) 08:39:16 INFO - Device ID: 0x0a2e 08:39:16 INFO - Revision ID: 0x0009 08:39:16 INFO - Displays: 08:39:16 INFO - Display: 08:39:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:39:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:39:16 INFO - Display Serial Number: 1600x1200 60 08:39:16 INFO - Main Display: Yes 08:39:16 INFO - Mirror: Off 08:39:16 INFO - Online: Yes 08:39:16 INFO - Rotation: Supported 08:39:16 INFO - Return code: 0 08:39:16 INFO - Running post-action listener: _resource_record_post_action 08:39:16 INFO - [mozharness: 2017-02-20 16:39:16.122467Z] Finished run-tests step (success) 08:39:16 INFO - Running post-run listener: _resource_record_post_run 08:39:16 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 37426176; Write bytes: 508675072; Read time: 235; Write time: 1595 08:39:16 INFO - TinderboxPrint: CPU usage
53.6% 08:39:16 INFO - TinderboxPrint: I/O read bytes / time
37,426,176 / 235 08:39:16 INFO - TinderboxPrint: I/O write bytes / time
508,675,072 / 1,595 08:39:16 INFO - TinderboxPrint: CPU idle
2,229.9 (46.4%) 08:39:16 INFO - TinderboxPrint: CPU system
953.7 (19.9%) 08:39:16 INFO - TinderboxPrint: CPU user
1,618.1 (33.7%) 08:39:16 INFO - TinderboxPrint: Swap in / out
245,325,824 / 0 08:39:16 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209029632; Write bytes: 211179520; Read time: 15974; Write time: 463 08:39:16 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 33883136; Write bytes: 295906304; Read time: 211; Write time: 1126 08:39:16 INFO - Running post-run listener: _upload_blobber_files 08:39:16 INFO - Blob upload gear active. 08:39:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:39:16 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 08:39:16 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:39:16 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:39:16 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:39:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:18 INFO - (blobuploader) - INFO - Done attempting. 08:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:19 INFO - (blobuploader) - INFO - Done attempting. 08:39:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:39:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:20 INFO - (blobuploader) - INFO - Done attempting. 08:39:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:39:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:22 INFO - (blobuploader) - INFO - Done attempting. 08:39:22 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:22 INFO - Return code: 0 08:39:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:39:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed20bff0a1a8d472e7d8cb90020711cced9f6428a2617cf4ac69e77779bd5d6b68e25ba435994b408d4e64ab915dba2700645e86a48a84824d1b4ace85b9f0d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1497d369f35e48b50aeac1e95f8074b3f5fe4e6829d35b0d0ec7f819b9e6a473d8966a00560150c5c113e376cb1de393c4803e2e494d517666f8629947f201cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e235ad3e3853265906ebab74112bde5aa4068d03ca3172a68e747b55dc23f1bc7c8976b4b3e43e28f1cee32ad3217a02c6f16e57f9abd3dec86f9706aebb7c31", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b587300c8c927e3b62365e67988dbc88d6dbc5eb6bf67fcb551806f464870796171e474e4edb6aef10e046670d97c366db0e8fbfb6c94f804a41b16c3c295ea"} 08:39:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:39:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:39:22 INFO - Contents: 08:39:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed20bff0a1a8d472e7d8cb90020711cced9f6428a2617cf4ac69e77779bd5d6b68e25ba435994b408d4e64ab915dba2700645e86a48a84824d1b4ace85b9f0d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1497d369f35e48b50aeac1e95f8074b3f5fe4e6829d35b0d0ec7f819b9e6a473d8966a00560150c5c113e376cb1de393c4803e2e494d517666f8629947f201cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e235ad3e3853265906ebab74112bde5aa4068d03ca3172a68e747b55dc23f1bc7c8976b4b3e43e28f1cee32ad3217a02c6f16e57f9abd3dec86f9706aebb7c31", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b587300c8c927e3b62365e67988dbc88d6dbc5eb6bf67fcb551806f464870796171e474e4edb6aef10e046670d97c366db0e8fbfb6c94f804a41b16c3c295ea"} 08:39:22 INFO - Running post-run listener: copy_logs_to_upload_dir 08:39:22 INFO - Copying logs to upload dir... 08:39:22 INFO - mkdir: /builds/slave/test/build/upload/logs 08:39:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.259660 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-20 08:39:22.518702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-20 08:39:22.522091) ========= 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.yt3jpYjCQT/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.kTBopoDs1I/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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-Aurora/sha512/ed20bff0a1a8d472e7d8cb90020711cced9f6428a2617cf4ac69e77779bd5d6b68e25ba435994b408d4e64ab915dba2700645e86a48a84824d1b4ace85b9f0d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1497d369f35e48b50aeac1e95f8074b3f5fe4e6829d35b0d0ec7f819b9e6a473d8966a00560150c5c113e376cb1de393c4803e2e494d517666f8629947f201cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e235ad3e3853265906ebab74112bde5aa4068d03ca3172a68e747b55dc23f1bc7c8976b4b3e43e28f1cee32ad3217a02c6f16e57f9abd3dec86f9706aebb7c31", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b587300c8c927e3b62365e67988dbc88d6dbc5eb6bf67fcb551806f464870796171e474e4edb6aef10e046670d97c366db0e8fbfb6c94f804a41b16c3c295ea"} build_url:https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011012 build_url: 'https://queue.taskcluster.net/v1/task/YnmrkAtIRgCTaL6DIuxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed20bff0a1a8d472e7d8cb90020711cced9f6428a2617cf4ac69e77779bd5d6b68e25ba435994b408d4e64ab915dba2700645e86a48a84824d1b4ace85b9f0d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1497d369f35e48b50aeac1e95f8074b3f5fe4e6829d35b0d0ec7f819b9e6a473d8966a00560150c5c113e376cb1de393c4803e2e494d517666f8629947f201cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e235ad3e3853265906ebab74112bde5aa4068d03ca3172a68e747b55dc23f1bc7c8976b4b3e43e28f1cee32ad3217a02c6f16e57f9abd3dec86f9706aebb7c31", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b587300c8c927e3b62365e67988dbc88d6dbc5eb6bf67fcb551806f464870796171e474e4edb6aef10e046670d97c366db0e8fbfb6c94f804a41b16c3c295ea"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-20 08:39:22.561085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:39:22.561436) ========= 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.yt3jpYjCQT/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.kTBopoDs1I/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.005017 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:39:22.609192) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-20 08:39:22.609501) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-20 08:39:22.609790) ========= ========= Total master_lag: 0.60 =========