builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0104 starttime: 1478873846.89 results: success (0) buildid: 20161111040720 builduid: 70ab3b11237e4afab3f30e96a30ffc3b revision: 38e66a6513746a40d38783481dca39483c908d76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:26.892856) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:26.893334) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:26.893622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:26.922742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:26.923071) ========= 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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-11 06:17:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.9M=0.001s 2016-11-11 06:17:27 (21.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.491195 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:27.440165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:27.440514) ========= 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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.019726 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:27.587086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-11 06:17:27.590471) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 38e66a6513746a40d38783481dca39483c908d76 --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 38e66a6513746a40d38783481dca39483c908d76 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QyRJUqgrrT/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.Vg7UCsxuty/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-11 06:17:27,670 truncating revision to first 12 chars 2016-11-11 06:17:27,670 Setting DEBUG logging. 2016-11-11 06:17:27,670 attempt 1/10 2016-11-11 06:17:27,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/38e66a651374?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 06:17:28,703 unpacking tar archive at: mozilla-aurora-38e66a651374/testing/mozharness/ program finished with exit code 0 elapsedTime=1.317944 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-11 06:17:28.931052) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:28.934389) ========= script_repo_revision: 38e66a6513746a40d38783481dca39483c908d76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:28.934787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:28.935057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 06:17:28.953360) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-11 06:17:28.953663) ========= /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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:17:29 INFO - MultiFileLogger online at 20161111 06:17:29 in /builds/slave/test 06:17:29 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 06:17:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:17:29 INFO - {'append_to_log': False, 06:17:29 INFO - 'base_work_dir': '/builds/slave/test', 06:17:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:17:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:17:29 INFO - 'branch': 'Mozilla-Aurora', 06:17:29 INFO - 'buildbot_json_path': 'buildprops.json', 06:17:29 INFO - 'config_files': ('talos/mac_config.py',), 06:17:29 INFO - 'default_actions': ('clobber', 06:17:29 INFO - 'read-buildbot-config', 06:17:29 INFO - 'download-and-extract', 06:17:29 INFO - 'populate-webroot', 06:17:29 INFO - 'create-virtualenv', 06:17:29 INFO - 'install', 06:17:29 INFO - 'run-tests'), 06:17:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:17:29 INFO - 'download_minidump_stackwalk': True, 06:17:29 INFO - 'download_symbols': 'ondemand', 06:17:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:17:29 INFO - 'tooltool.py': '/tools/tooltool.py', 06:17:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:17:29 INFO - '/tools/misc-python/virtualenv.py')}, 06:17:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:17:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:17:29 INFO - 'installer_path': 'installer.exe', 06:17:29 INFO - 'log_level': 'info', 06:17:29 INFO - 'log_name': 'talos', 06:17:29 INFO - 'log_to_console': True, 06:17:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:17:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:17:29 INFO - 'opt_config_files': (), 06:17:29 INFO - 'pip_index': False, 06:17:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:17:29 INFO - 'cmd': ('bash', 06:17:29 INFO - '-c', 06:17:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:17:29 INFO - 'enabled': True, 06:17:29 INFO - 'halt_on_failure': False, 06:17:29 INFO - 'name': 'check_screen_resolution'},), 06:17:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:17:29 INFO - 'cmd': ('bash', 06:17:29 INFO - '-c', 06:17:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:17:29 INFO - 'enabled': True, 06:17:29 INFO - 'halt_on_failure': False, 06:17:29 INFO - 'name': 'check_screen_resolution'},), 06:17:29 INFO - 'run_cmd_checks_enabled': True, 06:17:29 INFO - 'sps_profile': False, 06:17:29 INFO - 'sps_profile_interval': 0, 06:17:29 INFO - 'suite': 'dromaeojs', 06:17:29 INFO - 'system_bits': '32', 06:17:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:17:29 INFO - 'title': 't-yosemite-r7-0104', 06:17:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:17:29 INFO - 'use_talos_json': True, 06:17:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:17:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:17:29 INFO - 'work_dir': 'build'} 06:17:29 INFO - [mozharness: 2016-11-11 14:17:29.158115Z] Running clobber step. 06:17:29 INFO - Running pre-action listener: _resource_record_pre_action 06:17:29 INFO - Running main action method: clobber 06:17:29 INFO - rmtree: /builds/slave/test/build 06:17:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:17:29 INFO - Running post-action listener: _resource_record_post_action 06:17:29 INFO - [mozharness: 2016-11-11 14:17:29.801046Z] Finished clobber step (success) 06:17:29 INFO - [mozharness: 2016-11-11 14:17:29.801215Z] Running read-buildbot-config step. 06:17:29 INFO - Running pre-action listener: _resource_record_pre_action 06:17:29 INFO - Running main action method: read_buildbot_config 06:17:29 INFO - Using buildbot properties: 06:17:29 INFO - { 06:17:29 INFO - "project": "", 06:17:29 INFO - "product": "firefox", 06:17:29 INFO - "script_repo_revision": "production", 06:17:29 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:17:29 INFO - "repository": "", 06:17:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:17:29 INFO - "buildid": "20161111040720", 06:17:29 INFO - "pgo_build": "False", 06:17:29 INFO - "basedir": "/builds/slave/test", 06:17:29 INFO - "buildnumber": 119, 06:17:29 INFO - "slavename": "t-yosemite-r7-0104", 06:17:29 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 06:17:29 INFO - "platform": "yosemite_r7", 06:17:29 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:17:29 INFO - "branch": "mozilla-aurora", 06:17:29 INFO - "repo_path": "releases/mozilla-aurora", 06:17:29 INFO - "revision": "38e66a6513746a40d38783481dca39483c908d76", 06:17:29 INFO - "stage_platform": "macosx64", 06:17:29 INFO - "builduid": "70ab3b11237e4afab3f30e96a30ffc3b", 06:17:29 INFO - "slavebuilddir": "test" 06:17:29 INFO - } 06:17:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 06:17:29 INFO - Running post-action listener: _resource_record_post_action 06:17:29 INFO - [mozharness: 2016-11-11 14:17:29.804486Z] Finished read-buildbot-config step (success) 06:17:29 INFO - [mozharness: 2016-11-11 14:17:29.804626Z] Running download-and-extract step. 06:17:29 INFO - Running pre-action listener: _resource_record_pre_action 06:17:29 INFO - Running main action method: download_and_extract 06:17:29 INFO - mkdir: /builds/slave/test/build/tests 06:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:29 INFO - trying https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 06:17:29 INFO - Downloading https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 06:17:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 06:17:30 INFO - Downloaded 1199 bytes. 06:17:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 06:17:30 INFO - Using the following test package requirements: 06:17:30 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:17:30 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:17:30 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 06:17:30 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:17:30 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 06:17:30 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:17:30 INFO - u'jsshell-mac.zip'], 06:17:30 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:17:30 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 06:17:30 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:17:30 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:17:30 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 06:17:30 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:17:30 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 06:17:30 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:17:30 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 06:17:30 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:17:30 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 06:17:30 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:17:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:17:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:17:30 INFO - Fetch https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:17:31 INFO - Expected file size: 16423407 06:17:38 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:17:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:17:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:17:38 INFO - Fetch https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:17:38 INFO - Expected file size: 16423407 06:17:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 06:17:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:17:45 INFO - Fetch https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 06:17:46 INFO - Expected file size: 14414089 06:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:47 INFO - trying https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:17:47 INFO - Downloading https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 06:17:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 06:17:50 INFO - Downloaded 115556163 bytes. 06:17:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:17:50 INFO - mkdir: /builds/slave/test/properties 06:17:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:17:50 INFO - Writing to file /builds/slave/test/properties/build_url 06:17:50 INFO - Contents: 06:17:50 INFO - build_url:https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:17:51 INFO - Running post-action listener: _resource_record_post_action 06:17:51 INFO - Running post-action listener: set_extra_try_arguments 06:17:51 INFO - [mozharness: 2016-11-11 14:17:51.112687Z] Finished download-and-extract step (success) 06:17:51 INFO - [mozharness: 2016-11-11 14:17:51.112821Z] Running populate-webroot step. 06:17:51 INFO - Running pre-action listener: _resource_record_pre_action 06:17:51 INFO - Running main action method: populate_webroot 06:17:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:17:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:17:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:17:51 INFO - '--tppagecycles', 06:17:51 INFO - '7'], 06:17:51 INFO - 'tests': ['tsvgm']}}, 06:17:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:17:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:17:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:17:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:17:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:17:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:17:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:51 INFO - 'talos_options': ['--disable-e10s'], 06:17:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:17:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:17:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:51 INFO - 'talos_options': ['--disable-e10s'], 06:17:51 INFO - 'tests': ['damp', 'tps']}, 06:17:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:51 INFO - 'tests': ['damp', 'tps']}, 06:17:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:17:51 INFO - 'tests': ['dromaeo_dom']}, 06:17:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:17:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:17:51 INFO - 'tests': ['basic_compositor_video']}, 06:17:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:17:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:17:51 INFO - 'tests': ['a11yr', 06:17:51 INFO - 'ts_paint', 06:17:51 INFO - 'tpaint', 06:17:51 INFO - 'sessionrestore', 06:17:51 INFO - 'sessionrestore_no_auto_restore', 06:17:51 INFO - 'tabpaint']}, 06:17:51 INFO - 'other-e10s': {'tests': ['a11yr', 06:17:51 INFO - 'ts_paint', 06:17:51 INFO - 'tpaint', 06:17:51 INFO - 'sessionrestore', 06:17:51 INFO - 'sessionrestore_no_auto_restore', 06:17:51 INFO - 'tabpaint']}, 06:17:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:17:51 INFO - 'ts_paint', 06:17:51 INFO - 'tpaint', 06:17:51 INFO - 'sessionrestore', 06:17:51 INFO - 'sessionrestore_no_auto_restore', 06:17:51 INFO - 'tabpaint']}, 06:17:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:17:51 INFO - 'ts_paint', 06:17:51 INFO - 'tpaint', 06:17:51 INFO - 'sessionrestore', 06:17:51 INFO - 'sessionrestore_no_auto_restore', 06:17:51 INFO - 'tabpaint']}, 06:17:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:17:51 INFO - 'tests': ['a11yr', 06:17:51 INFO - 'ts_paint', 06:17:51 INFO - 'tpaint', 06:17:51 INFO - 'sessionrestore', 06:17:51 INFO - 'sessionrestore_no_auto_restore', 06:17:51 INFO - 'tabpaint']}, 06:17:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:17:51 INFO - 'tests': ['a11yr', 06:17:51 INFO - 'ts_paint', 06:17:51 INFO - 'tpaint', 06:17:51 INFO - 'sessionrestore', 06:17:51 INFO - 'sessionrestore_no_auto_restore', 06:17:51 INFO - 'tabpaint']}, 06:17:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:17:51 INFO - 'tests': ['tsvgx', 06:17:51 INFO - 'tsvgr_opacity', 06:17:51 INFO - 'tart', 06:17:51 INFO - 'tscrollx', 06:17:51 INFO - 'cart']}, 06:17:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:17:51 INFO - 'tsvgr_opacity', 06:17:51 INFO - 'tart', 06:17:51 INFO - 'tscrollx', 06:17:51 INFO - 'cart']}, 06:17:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:51 INFO - 'talos_options': ['--disable-e10s'], 06:17:51 INFO - 'tests': ['tp5o']}, 06:17:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:51 INFO - 'tests': ['tp5o']}, 06:17:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:51 INFO - 'talos_options': ['--disable-e10s', 06:17:51 INFO - '--xperf_path', 06:17:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:17:51 INFO - 'tests': ['tp5n']}, 06:17:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:51 INFO - 'talos_options': ['--xperf_path', 06:17:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:17:51 INFO - 'tests': ['tp5n']}}, 06:17:51 INFO - 'talos.zip': {'path': '', 06:17:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:17:51 INFO - Running post-action listener: _resource_record_post_action 06:17:51 INFO - [mozharness: 2016-11-11 14:17:51.132143Z] Finished populate-webroot step (success) 06:17:51 INFO - [mozharness: 2016-11-11 14:17:51.132270Z] Running create-virtualenv step. 06:17:51 INFO - Running pre-action listener: _resource_record_pre_action 06:17:51 INFO - Running main action method: create_virtualenv 06:17:51 INFO - Creating virtualenv /builds/slave/test/build/venv 06:17:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:17:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:17:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:17:51 INFO - Using real prefix '/tools/python27' 06:17:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:17:51 INFO - Installing distribute.............................................................................................................................................................................................done. 06:17:54 INFO - Installing pip.................done. 06:17:54 INFO - Return code: 0 06:17:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:17: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')]} 06:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17: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')]} 06:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f23d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f2daf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0dbd30>, '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 0x10ef41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3b20>, '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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17: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', 'pip>=1.5'] in /builds/slave/test/build 06:17: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 pip>=1.5 06:17:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyRJUqgrrT/Render', 06:17:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:54 INFO - 'HOME': '/Users/cltbld', 06:17:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:54 INFO - 'LOGNAME': 'cltbld', 06:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:54 INFO - 'MOZ_NO_REMOTE': '1', 06:17:54 INFO - 'NO_EM_RESTART': '1', 06:17:54 INFO - 'PAGER': '/bin/cat', 06:17:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:54 INFO - 'PWD': '/builds/slave/test', 06:17:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:54 INFO - 'SHELL': '/bin/bash', 06:17:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vg7UCsxuty/Listeners', 06:17:54 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 06:17:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:54 INFO - 'USER': 'cltbld', 06:17:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:54 INFO - 'XPC_FLAGS': '0x0', 06:17:54 INFO - 'XPC_SERVICE_NAME': '0', 06:17:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:17:55 INFO - Cleaning up... 06:17:55 INFO - Return code: 0 06:17:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:55 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 0x10f2c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f23d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f2daf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0dbd30>, '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 0x10ef41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3b20>, '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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:17:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyRJUqgrrT/Render', 06:17:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:55 INFO - 'HOME': '/Users/cltbld', 06:17:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:55 INFO - 'LOGNAME': 'cltbld', 06:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:55 INFO - 'MOZ_NO_REMOTE': '1', 06:17:55 INFO - 'NO_EM_RESTART': '1', 06:17:55 INFO - 'PAGER': '/bin/cat', 06:17:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:55 INFO - 'PWD': '/builds/slave/test', 06:17:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:55 INFO - 'SHELL': '/bin/bash', 06:17:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vg7UCsxuty/Listeners', 06:17:55 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 06:17:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:55 INFO - 'USER': 'cltbld', 06:17:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:55 INFO - 'XPC_FLAGS': '0x0', 06:17:55 INFO - 'XPC_SERVICE_NAME': '0', 06:17:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:55 INFO - Downloading/unpacking psutil>=3.1.1 06:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:17:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:17:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:17:58 INFO - Installing collected packages: psutil 06:17:58 INFO - Running setup.py install for psutil 06:17:58 INFO - building 'psutil._psutil_osx' extension 06:17:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:17:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:17:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:17:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:17:59 INFO - building 'psutil._psutil_posix' extension 06:17:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:17:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:17:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:17:59 INFO - ^ 06:17:59 INFO - 1 warning generated. 06:17:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:17:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:17:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:17:59 INFO - Successfully installed psutil 06:17:59 INFO - Cleaning up... 06:17:59 INFO - Return code: 0 06:17:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:59 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 0x10f2c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f23d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f2daf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0dbd30>, '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 0x10ef41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3b20>, '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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:17:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyRJUqgrrT/Render', 06:17:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:59 INFO - 'HOME': '/Users/cltbld', 06:17:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:59 INFO - 'LOGNAME': 'cltbld', 06:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:59 INFO - 'MOZ_NO_REMOTE': '1', 06:17:59 INFO - 'NO_EM_RESTART': '1', 06:17:59 INFO - 'PAGER': '/bin/cat', 06:17:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:59 INFO - 'PWD': '/builds/slave/test', 06:17:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:59 INFO - 'SHELL': '/bin/bash', 06:17:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vg7UCsxuty/Listeners', 06:17:59 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 06:17:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:59 INFO - 'USER': 'cltbld', 06:17:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:59 INFO - 'XPC_FLAGS': '0x0', 06:17:59 INFO - 'XPC_SERVICE_NAME': '0', 06:17:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:18:02 INFO - Installing collected packages: mozsystemmonitor 06:18:02 INFO - Running setup.py install for mozsystemmonitor 06:18:02 INFO - Successfully installed mozsystemmonitor 06:18:02 INFO - Cleaning up... 06:18:02 INFO - Return code: 0 06:18:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f23d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f2daf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0dbd30>, '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 0x10ef41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3b20>, '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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:18:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyRJUqgrrT/Render', 06:18:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:02 INFO - 'HOME': '/Users/cltbld', 06:18:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:02 INFO - 'LOGNAME': 'cltbld', 06:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:02 INFO - 'MOZ_NO_REMOTE': '1', 06:18:02 INFO - 'NO_EM_RESTART': '1', 06:18:02 INFO - 'PAGER': '/bin/cat', 06:18:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:02 INFO - 'PWD': '/builds/slave/test', 06:18:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:02 INFO - 'SHELL': '/bin/bash', 06:18:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vg7UCsxuty/Listeners', 06:18:02 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 06:18:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:02 INFO - 'USER': 'cltbld', 06:18:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:02 INFO - 'XPC_FLAGS': '0x0', 06:18:02 INFO - 'XPC_SERVICE_NAME': '0', 06:18:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:03 INFO - Downloading/unpacking jsonschema==2.5.1 06:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:18:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:05 INFO - Downloading functools32-3.2.3-2.tar.gz 06:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:18:06 INFO - warning: no files found matching '*.txt' 06:18:06 INFO - no previously-included directories found matching 'build' 06:18:06 INFO - no previously-included directories found matching 'dist' 06:18:06 INFO - no previously-included directories found matching '.git*' 06:18:06 INFO - Installing collected packages: jsonschema, functools32 06:18:06 INFO - Running setup.py install for functools32 06:18:06 INFO - warning: no files found matching '*.txt' 06:18:06 INFO - no previously-included directories found matching 'build' 06:18:06 INFO - no previously-included directories found matching 'dist' 06:18:06 INFO - no previously-included directories found matching '.git*' 06:18:06 INFO - Successfully installed jsonschema functools32 06:18:06 INFO - Cleaning up... 06:18:06 INFO - Return code: 0 06:18:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f2c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f23d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f2daf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0dbd30>, '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 0x10ef41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3b20>, '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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:18:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyRJUqgrrT/Render', 06:18:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:06 INFO - 'HOME': '/Users/cltbld', 06:18:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:06 INFO - 'LOGNAME': 'cltbld', 06:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:06 INFO - 'MOZ_NO_REMOTE': '1', 06:18:06 INFO - 'NO_EM_RESTART': '1', 06:18:06 INFO - 'PAGER': '/bin/cat', 06:18:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:06 INFO - 'PWD': '/builds/slave/test', 06:18:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:06 INFO - 'SHELL': '/bin/bash', 06:18:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vg7UCsxuty/Listeners', 06:18:06 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 06:18:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:06 INFO - 'USER': 'cltbld', 06:18:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:06 INFO - 'XPC_FLAGS': '0x0', 06:18:06 INFO - 'XPC_SERVICE_NAME': '0', 06:18:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:18:06 INFO - Cleaning up... 06:18:06 INFO - Return code: 0 06:18:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f2c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f23d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f2daf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0dbd30>, '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 0x10ef41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3b20>, '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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:18:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyRJUqgrrT/Render', 06:18:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:06 INFO - 'HOME': '/Users/cltbld', 06:18:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:06 INFO - 'LOGNAME': 'cltbld', 06:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:06 INFO - 'MOZ_NO_REMOTE': '1', 06:18:06 INFO - 'NO_EM_RESTART': '1', 06:18:06 INFO - 'PAGER': '/bin/cat', 06:18:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:06 INFO - 'PWD': '/builds/slave/test', 06:18:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:06 INFO - 'SHELL': '/bin/bash', 06:18:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vg7UCsxuty/Listeners', 06:18:06 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 06:18:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:06 INFO - 'USER': 'cltbld', 06:18:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:06 INFO - 'XPC_FLAGS': '0x0', 06:18:06 INFO - 'XPC_SERVICE_NAME': '0', 06:18:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:06 INFO - Downloading/unpacking blobuploader==1.2.4 06:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:09 INFO - Downloading blobuploader-1.2.4.tar.gz 06:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:18:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:18:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:10 INFO - Downloading docopt-0.6.1.tar.gz 06:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:18:10 INFO - Installing collected packages: blobuploader, requests, docopt 06:18:10 INFO - Running setup.py install for blobuploader 06:18:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:18:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:18:10 INFO - Running setup.py install for requests 06:18:11 INFO - Running setup.py install for docopt 06:18:11 INFO - Successfully installed blobuploader requests docopt 06:18:11 INFO - Cleaning up... 06:18:11 INFO - Return code: 0 06:18:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:11 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 0x10f2c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f23d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f2daf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0dbd30>, '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 0x10ef41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3b20>, '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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:18:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyRJUqgrrT/Render', 06:18:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:11 INFO - 'HOME': '/Users/cltbld', 06:18:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:11 INFO - 'LOGNAME': 'cltbld', 06:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:11 INFO - 'MOZ_NO_REMOTE': '1', 06:18:11 INFO - 'NO_EM_RESTART': '1', 06:18:11 INFO - 'PAGER': '/bin/cat', 06:18:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:11 INFO - 'PWD': '/builds/slave/test', 06:18:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:11 INFO - 'SHELL': '/bin/bash', 06:18:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vg7UCsxuty/Listeners', 06:18:11 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 06:18:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:11 INFO - 'USER': 'cltbld', 06:18:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:11 INFO - 'XPC_FLAGS': '0x0', 06:18:11 INFO - 'XPC_SERVICE_NAME': '0', 06:18:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:11 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-VUkoCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:12 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-4btxcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:12 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-281jqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:12 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-5HXhQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:12 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Pvmnvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:12 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-47p1bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:12 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-OlpZqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:12 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-zEJbVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:12 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-qQhR23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:12 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-iPgH5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:12 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-6RZ1eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-jJsCFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-DGsKnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-YeZUZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-TkMrJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-bhRc4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-rcv0R1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:18:13 INFO - Running setup.py install for manifestparser 06:18:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:18:13 INFO - Running setup.py install for mozcrash 06:18:13 INFO - Running setup.py install for mozdebug 06:18:14 INFO - Running setup.py install for mozdevice 06:18:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:18:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:18:14 INFO - Running setup.py install for mozfile 06:18:14 INFO - Running setup.py install for mozhttpd 06:18:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:18:14 INFO - Running setup.py install for mozinfo 06:18:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:18:14 INFO - Running setup.py install for mozInstall 06:18:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:18:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:18:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:18:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:18:14 INFO - Running setup.py install for mozleak 06:18:15 INFO - Running setup.py install for mozlog 06:18:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:18:15 INFO - Running setup.py install for moznetwork 06:18:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:18:15 INFO - Running setup.py install for mozprocess 06:18:15 INFO - Running setup.py install for mozprofile 06:18:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:18:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:18:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:18:15 INFO - Running setup.py install for mozrunner 06:18:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:18:15 INFO - Running setup.py install for mozscreenshot 06:18:16 INFO - Running setup.py install for moztest 06:18:16 INFO - Running setup.py install for mozversion 06:18:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:18:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:18:16 INFO - Cleaning up... 06:18:16 INFO - Return code: 0 06:18:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:16 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 0x10f2c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f23d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f2daf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0dbd30>, '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 0x10ef41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3b20>, '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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:18:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyRJUqgrrT/Render', 06:18:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:16 INFO - 'HOME': '/Users/cltbld', 06:18:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:16 INFO - 'LOGNAME': 'cltbld', 06:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:16 INFO - 'MOZ_NO_REMOTE': '1', 06:18:16 INFO - 'NO_EM_RESTART': '1', 06:18:16 INFO - 'PAGER': '/bin/cat', 06:18:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:16 INFO - 'PWD': '/builds/slave/test', 06:18:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:16 INFO - 'SHELL': '/bin/bash', 06:18:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vg7UCsxuty/Listeners', 06:18:16 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 06:18:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:16 INFO - 'USER': 'cltbld', 06:18:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:16 INFO - 'XPC_FLAGS': '0x0', 06:18:16 INFO - 'XPC_SERVICE_NAME': '0', 06:18:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Z7xoPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-aMWtJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-XmtOGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-SehQmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-9EiKnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-W5qyc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-fGPbPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-PGstLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-uNS6Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-c2iooN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-4xQI2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-SUl3ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-nk9QYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-nWvxhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-SxsGKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-tdFMFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-BFwt9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:18:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:20 INFO - Downloading blessings-1.6.tar.gz 06:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:18:21 INFO - Installing collected packages: blessings 06:18:21 INFO - Running setup.py install for blessings 06:18:21 INFO - Successfully installed blessings 06:18:21 INFO - Cleaning up... 06:18:21 INFO - Return code: 0 06:18:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:18:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:21 INFO - Reading from file tmpfile_stdout 06:18:21 INFO - Current package versions: 06:18:21 INFO - blessings == 1.6 06:18:21 INFO - blobuploader == 1.2.4 06:18:21 INFO - docopt == 0.6.1 06:18:21 INFO - functools32 == 3.2.3-2 06:18:21 INFO - jsonschema == 2.5.1 06:18:21 INFO - manifestparser == 1.1 06:18:21 INFO - mozInstall == 1.12 06:18:21 INFO - mozcrash == 0.17 06:18:21 INFO - mozdebug == 0.1 06:18:21 INFO - mozdevice == 0.48 06:18:21 INFO - mozfile == 1.2 06:18:21 INFO - mozhttpd == 0.7 06:18:21 INFO - mozinfo == 0.9 06:18:21 INFO - mozleak == 0.1 06:18:21 INFO - mozlog == 3.4 06:18:21 INFO - moznetwork == 0.27 06:18:21 INFO - mozprocess == 0.23 06:18:21 INFO - mozprofile == 0.28 06:18:21 INFO - mozrunner == 6.12 06:18:21 INFO - mozscreenshot == 0.1 06:18:21 INFO - mozsystemmonitor == 0.3 06:18:21 INFO - moztest == 0.7 06:18:21 INFO - mozversion == 1.4 06:18:21 INFO - psutil == 3.1.1 06:18:21 INFO - requests == 1.2.3 06:18:21 INFO - wsgiref == 0.1.2 06:18:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f23d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f2daf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0dbd30>, '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 0x10ef41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3b20>, '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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyRJUqgrrT/Render', 06:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:21 INFO - 'HOME': '/Users/cltbld', 06:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:21 INFO - 'LOGNAME': 'cltbld', 06:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:21 INFO - 'MOZ_NO_REMOTE': '1', 06:18:21 INFO - 'NO_EM_RESTART': '1', 06:18:21 INFO - 'PAGER': '/bin/cat', 06:18:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:21 INFO - 'PWD': '/builds/slave/test', 06:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:21 INFO - 'SHELL': '/bin/bash', 06:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vg7UCsxuty/Listeners', 06:18:21 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 06:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:21 INFO - 'USER': 'cltbld', 06:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:21 INFO - 'XPC_FLAGS': '0x0', 06:18:21 INFO - 'XPC_SERVICE_NAME': '0', 06:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:18:21 INFO - Cleaning up... 06:18:21 INFO - Return code: 0 06:18:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:21 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 0x10f2c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f23d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f2daf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0dbd30>, '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 0x10ef41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3b20>, '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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyRJUqgrrT/Render', 06:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:21 INFO - 'HOME': '/Users/cltbld', 06:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:21 INFO - 'LOGNAME': 'cltbld', 06:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:21 INFO - 'MOZ_NO_REMOTE': '1', 06:18:21 INFO - 'NO_EM_RESTART': '1', 06:18:21 INFO - 'PAGER': '/bin/cat', 06:18:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:21 INFO - 'PWD': '/builds/slave/test', 06:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:21 INFO - 'SHELL': '/bin/bash', 06:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vg7UCsxuty/Listeners', 06:18:21 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 06:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:21 INFO - 'USER': 'cltbld', 06:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:21 INFO - 'XPC_FLAGS': '0x0', 06:18:21 INFO - 'XPC_SERVICE_NAME': '0', 06:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:18:22 INFO - Cleaning up... 06:18:22 INFO - Return code: 0 06:18:22 INFO - Running post-action listener: _resource_record_post_action 06:18:22 INFO - Running post-action listener: _start_resource_monitoring 06:18:22 INFO - Starting resource monitoring. 06:18:22 INFO - [mozharness: 2016-11-11 14:18:22.191352Z] Finished create-virtualenv step (success) 06:18:22 INFO - [mozharness: 2016-11-11 14:18:22.192375Z] Running install step. 06:18:22 INFO - Running pre-action listener: _resource_record_pre_action 06:18:22 INFO - Running main action method: install 06:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:22 INFO - Reading from file tmpfile_stdout 06:18:22 INFO - Detecting whether we're running mozinstall >=1.0... 06:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:18:22 INFO - Reading from file tmpfile_stdout 06:18:22 INFO - Output received: 06:18:22 INFO - Usage: mozinstall [options] installer 06:18:22 INFO - Options: 06:18:22 INFO - -h, --help show this help message and exit 06:18:22 INFO - -d DEST, --destination=DEST 06:18:22 INFO - Directory to install application into. [default: 06:18:22 INFO - "/builds/slave/test"] 06:18:22 INFO - --app=APP Application being installed. [default: firefox] 06:18:22 INFO - mkdir: /builds/slave/test/build/application 06:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:18:55 INFO - Reading from file tmpfile_stdout 06:18:55 INFO - Output received: 06:18:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:18:55 INFO - Running post-action listener: _resource_record_post_action 06:18:55 INFO - [mozharness: 2016-11-11 14:18:55.034778Z] Finished install step (success) 06:18:55 INFO - [mozharness: 2016-11-11 14:18:55.034933Z] Running run-tests step. 06:18:55 INFO - Running pre-action listener: _resource_record_pre_action 06:18:55 INFO - Running main action method: run_tests 06:18:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:18:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:18:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:18:55 INFO - 2016-11-11 06:18:55.050 screenresolution[7015:120046] starting screenresolution argv=screenresolution get 06:18:55 INFO - 2016-11-11 06:18:55.053 screenresolution[7015:120046] Display 0: 1600x1200x32@60 06:18:55 INFO - 2016-11-11 06:18:55.059 screenresolution[7016:120048] starting screenresolution argv=screenresolution list 06:18:55 INFO - Available Modes on Display 0 06:18:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:18:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:18:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:18:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:18:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:18:55 INFO - Intel Iris: 06:18:55 INFO - Chipset Model: Intel Iris 06:18:55 INFO - Type: GPU 06:18:55 INFO - Bus: Built-In 06:18:55 INFO - VRAM (Dynamic, Max): 1536 MB 06:18:55 INFO - Vendor: Intel (0x8086) 06:18:55 INFO - Device ID: 0x0a2e 06:18:55 INFO - Revision ID: 0x0009 06:18:55 INFO - Displays: 06:18:55 INFO - Display: 06:18:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:18:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:18:55 INFO - Display Serial Number: 1600x1200 60 06:18:55 INFO - Main Display: Yes 06:18:55 INFO - Mirror: Off 06:18:55 INFO - Online: Yes 06:18:55 INFO - Rotation: Supported 06:18:55 INFO - Return code: 0 06:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:18:55 INFO - Python 2.7.3 06:18:55 INFO - Return code: 0 06:18:55 INFO - grabbing minidump binary from tooltool 06:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:55 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 0x10f0dbd30>, '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 0x10ef41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:18:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:18:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:18:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:18:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:18:55 INFO - Return code: 0 06:18:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:18:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:18:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:18:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:18:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:18:55 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/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:18:55 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/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0104 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:18:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyRJUqgrrT/Render', 06:18:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:55 INFO - 'HOME': '/Users/cltbld', 06:18:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:55 INFO - 'LOGNAME': 'cltbld', 06:18:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:18:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:55 INFO - 'MOZ_NO_REMOTE': '1', 06:18:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:18:55 INFO - 'NO_EM_RESTART': '1', 06:18:55 INFO - 'PAGER': '/bin/cat', 06:18:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:55 INFO - 'PWD': '/builds/slave/test', 06:18:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:18:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:55 INFO - 'SHELL': '/bin/bash', 06:18:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vg7UCsxuty/Listeners', 06:18:55 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 06:18:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:55 INFO - 'USER': 'cltbld', 06:18:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:55 INFO - 'XPC_FLAGS': '0x0', 06:18:55 INFO - 'XPC_SERVICE_NAME': '0', 06:18:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:55 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/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:18:55 INFO - mozversion application_buildid: 20161111040720 06:18:55 INFO - mozversion application_changeset: 38e66a6513746a40d38783481dca39483c908d76 06:18:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:18:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:18:55 INFO - mozversion application_name: Firefox 06:18:55 INFO - mozversion application_remotingname: firefox-dev 06:18:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:18:55 INFO - mozversion application_vendor: Mozilla 06:18:55 INFO - mozversion application_version: 51.0a2 06:18:55 INFO - mozversion platform_buildid: 20161111040720 06:18:55 INFO - mozversion platform_changeset: 38e66a6513746a40d38783481dca39483c908d76 06:18:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:18:55 INFO - mozversion platform_version: 51.0a2 06:18:55 INFO - using testdate: 1478873935 06:18:55 INFO - actual date: 1478873935 06:18:55 INFO - starting webserver on 'localhost:57800' 06:18:55 INFO - SUITE-START | Running 2 tests 06:18:55 INFO - TEST-START | dromaeo_css 06:18:55 INFO - operating with platform_type : mac_ 06:18:55 INFO - Initialising browser for dromaeo_css test... 06:18:55 INFO - TEST-INFO | started process 7026 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpgB5dNa/profile http://localhost:57800/getInfo.html) 06:18:58 INFO - PROCESS | 7026 | __metrics Screen width/height:1600/1200 06:18:58 INFO - PROCESS | 7026 | colorDepth:24 06:18:58 INFO - PROCESS | 7026 | Browser inner width/height: 1024/689 06:18:58 INFO - PROCESS | 7026 | __metrics 06:18:58 INFO - PROCESS | 7026 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:18:58 INFO - PROCESS | 7026 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:18:59 INFO - TEST-INFO | 7026: exit 0 06:18:59 INFO - Browser initialized. 06:18:59 INFO - Running cycle 1/1 for dromaeo_css test... 06:18:59 INFO - TEST-INFO | started process 7028 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpgB5dNa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:11 INFO - PROCESS | 7028 | RSS: Main: 220205056 06:19:11 INFO - PROCESS | 7028 | 06:20:02 INFO - PROCESS | 7028 | 1478874002577 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:22:14 INFO - PROCESS | 7028 | Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57800/tests/dromaeo/cssquery-ext.html) 06:22:16 INFO - PROCESS | 7028 | RSS: Main: 353546240 06:22:16 INFO - PROCESS | 7028 | 06:25:19 INFO - PROCESS | 7028 | Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-ext.html (next: http://localhost:57800/tests/dromaeo/cssquery-jquery.html) 06:25:19 INFO - PROCESS | 7028 | RSS: Main: 353394688 06:25:19 INFO - PROCESS | 7028 | 06:28:21 INFO - PROCESS | 7028 | Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57800/tests/dromaeo/cssquery-mootools.html) 06:28:22 INFO - PROCESS | 7028 | RSS: Main: 315502592 06:28:22 INFO - PROCESS | 7028 | 06:31:24 INFO - PROCESS | 7028 | Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57800/tests/dromaeo/cssquery-prototype.html) 06:31:25 INFO - PROCESS | 7028 | RSS: Main: 321617920 06:31:25 INFO - PROCESS | 7028 | 06:34:28 INFO - PROCESS | 7028 | Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57800/tests/dromaeo/cssquery-yui.html) 06:34:29 INFO - PROCESS | 7028 | RSS: Main: 307953664 06:34:29 INFO - PROCESS | 7028 | 06:37:32 INFO - PROCESS | 7028 | Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-yui.html (next: http://localhost:57800/tests/dromaeo/cssquery-dojo.html) 06:37:32 INFO - PROCESS | 7028 | RSS: Main: 429715456 06:37:32 INFO - PROCESS | 7028 | 06:37:32 INFO - PROCESS | 7028 | __start_tp_report 06:37:32 INFO - PROCESS | 7028 | _x_x_mozilla_page_load 06:37:32 INFO - PROCESS | 7028 | _x_x_mozilla_page_load_details 06:37:32 INFO - PROCESS | 7028 | |i|pagename|runs| 06:37:32 INFO - PROCESS | 7028 | |0;dojo.html;3291.1772056985756;3294.983525082375;3323;3349.279904820463;3353.3796247694163;5632.605717599769;5640.520555752761;5682.488576028157;5694.316681998166;5769.653820770752;5594.13290939904;5691.317041954961;5703.657780533171;5705.144228365747;5762.164486149506;5151.71665558395;5171.379434467869;5172.896542069157;5222.033923724123;5228.163493840986;5121.692698438087;5127.820526281581;5158.406783219922;5273.604479664022;5342.706151161685;5206.947930520684;5227.980543793961;5230.163173892178;5232.555232805216;5242.711650859202;5210.036143313461;5228.843134705965;5239.423663397023;5252.894942101156;5292.682439053669;5141.177411614124;5225;5252.842414727565;5260.526552610245;5299.867503312409;5555.083411237181;5603.60774745768;5615.634983726045;5690;5698.40166782486;6104.206453161105;6150;6156.7537298508005;6197.101420294077;6217.191765070557;6209.5032397408095;6272.5922815016875;6288.213973253343;6295.96852015737;6299.811005669837;5592.832215033555;5692.117721753135;5744.982243326271;5745.971270143665;5792;6244.188255526843;6282.591631543935;6305.274893387227;6307.369263073748;6356.237251529846;6130.540209484307;6149.754009839646;6155.35368786271;6158.445739883432;6166.290876549254;6135.509159267337;6192.411720886508;6251.499880009588;6285.308616052231;6293.748250069946;5941.881162376728;5950.851228719317;5996.280446346466;6060.787872424444;6090.421409966046;6164.568480206342;6186.659733714689;6188.164597779332;6192.0711893215475;6192.59748116371;4863.756812159378;4905.607551395879;4915.238138088602;4918.114739346952;4927.77824997876;3769.6230376962635;4299.720518166309;4324.394584758136;4327.805248763813;4413.7351758894565;5755.62588431759;5789.421057894177;5849.444302791228;5856.590038697335;5860.120981852671;6247.219097612799;6294.559380843297;6308.085327627468;6317.652529110943;6329.177206963157;5765.336986246635;5770.24986751728;5774.653520788766;5797.159411885253;5822.621529600562;5257.158854583248;5270;5309.840704778863;5318.9202161967605;5331.546818520469;6246.46905013079;6272.435480806749;6285.96857015712;6301.62190268567;6310.684465776692;6254.093156492374;6259.530535209787;6268.561200715906;6272.686365681789;6284.685765711604;6135.539834512519;6229.2524897012645;6285.717142728497;6320.241571011508;6328.525360598066;6005.819825405245;6101.450869421773;6110.419510146529;6138.051223665275;6147.170132032118;6235.158253635701;6245.718942647501;6246.219222597176;6258.530610204344;6270.9372906270355;5959.880802384015;6015.165374560801;6026.668533230714;6051.606645568024;6107.389261074035;5061.544460998528;5885.558583106199;5974.462298392991;5985.5810093294795;6008.309044459943;4886.438059623189;5949.791757288474;5961.731722072604;5986.191864098291;5990.6705131218205;6059.484943779652;6085.878282434415;6117.235345581802;6120.020796672511;6147.016477363601;5744.856378590569;5851.093080572518;5855.853603659943;5890.4698577128265;5946.5540084494705 06:37:32 INFO - PROCESS | 7028 | |1;ext.html;455.410243734364;466.9136209801187;480.8100800183925;506.6326912988082;526.8419474157753;30780.692193078063;40243.396349054754;41505.58494415055;41527;44470.33294500585;43333.7833310833;43824;43831.68504944849;43948.901277468;44001.55998440015;9830.606775728962;10001.299909006373;10011.14905233056;10019.699409017705;10053.145482633985;9832.754181145492;9935.205183585333;9948.403095814274;9971.10260076593;9982.9500852496;7924.3660507159575;9109.68116115936;9919.156871665917;9994.150497207746;9999.10008099271;9854.458004809732;9929.255305852017;9945.502724863727;9992.80014399708;10019.549120289605;9886.406815591088;9963.601455941754;9973.501324933724;9978.750531236705;10001.799964000753;41523.792381038205;41867.371989420186;41889.1622167558;41907.79046104781;41938;3372.4435468147726;3692.5568931728367;3972.483577134983;4048.291548978917;4084.7140700151003;29678.258043549085;30680.386392272252;31245.375092498023;31841.363172736415;32080.83959580187;3240.692134247243;3253.5282384054417;3268.6731326867125;3299;3299.3566254580364;513583;515155;516213;517900;518075.9999999962;59238.40761592415;59633.105503417486;59645.70177149173;59810.10284845731;59905;34693.47959780605;35414.82292588521;62233.37766622366;62312.688436558434;62392.37607623866;16574.337026518806;17293.13534323279;17369.089400166224;17411;17424.041677707846;13155.736885262433;13270.800937985938;13271.800922986164;13278.136921100098;13311.66720831987;19403.02984850752;19403.611927761365;19417.32039378643;19421.708674369896;19460.22159113648;6905.482088843357;7803.492772969739;7950.3242224410415;8010.639521221559;8047.539557990121;731.4404480572366;841.1630427724454;890.701614958983;914.5701520285455;1060.9204309676804;29077.854610726812;29916.850415747784;30121.246968825515;30773;30930.381392372477;1047.1570385839473;1054.3726482742757;1068.4283908109123;1090.3566895531674;1129.9999500442168;15651.530454086396;17055.658886822195;17108.315667373165;17125.97244165354;17262.05058721757;660036;666664;667195;667231;667777;59905.502362441286;60054.39945600488;60452;60505.69747151236;60706.39293607096;1253.4798058805675;1286.5432771366031;1374.17549470321;1397.4270549075034;1403.3404299978993;27388.863055684593;28612;29407.823687052278;31168.37663246677;31775.841120794248;50868;51499;51517.48482515127;51525;51554.48445515497;603206;609596;610057;611472;611511;25424;26614.334641634116;26653;26655.600165997137;26693.466130677665;45785;45978;45997.54002459932;46088;46411.83970400632;37798.144986571046;38401.2319753609;39099.80450097731;39969.60030399659;40298.395524067746;37386.8130659345;37796.24407511889;39036;39755.40366894441;39855;36152.096197595274;36297.818510908335;36504.634953651184;36518.63481365152;36604.633953661185;32352.191195220308;34159.07170675404;34643.30713385668;34721.65278347184;34811.825940870134;23252.186173483846;24020.39949001289;25631.871840640677;25826.302828685577;26478 06:37:32 INFO - PROCESS | 7028 | |2;jquery.html;352.32705532433056;363.57824923089214;368.5393258426965;387.144410852017;400.91781184857086;14994.40022399104;15178.620534486643;16277.83722162778;20642;20916.790832091676;19731;19987;20530.794692053074;20794.792052079476;21028.843413612245;4693.20215563355;5914.260717410334;6017.428344307305;6186.721597528122;6201.782937597185;6065.332813390523;6096.786612468564;6167.04410816322;6167.074938759177;6180.598261113036;5915.112733090028;5931.466168044875;5940.584159108864;6108.236470441195;6113.991191453405;5861.384554621767;5905.084711869667;5996.130561068642;6017.69911504423;6026.276846778393;4982.651214414992;5162.432132465426;5223.059849227137;5231.816886408996;5237.711925844077;26003.089891853884;26114;26156.86921565399;26222;26534.867325663246;2228.5097278598682;2251.268337790225;2333;2774.128045867178;2871.8369060530517;12393.132480726354;12491.875081249253;15035.248237588186;15272.770908436383;16330.02019878811;1847.5011746828416;1849.214084014302;1878.0421984787856;1901.7147427885789;1913.3685883658359;109267.90732092736;113742.43128784386;115975;129629;132650.99999999904;11443.14176436754;11467.426628668532;11629.825552616718;11663.125265605113;11776.646700598996;14660.633484162769;14671.92664036673;14709.264536773118;14716.632084197981;14722.116672999655;8748.912510874938;8851.557422128868;8865.556722163867;8894.155055269739;9011;8837.718530812996;8936.151065648754;8989.955050224708;9095.36332456735;9115.772105697411;3982.8008599569907;4279.786010699452;4439.933400998988;4480.910381792346;4563.247064234431;1609.5090997245952;1881.9717704234447;1922.5770330527262;1945.747052883116;1947.47418197086;814.3281792521194;890.6526454682679;913.4421428535949;985.9359141655913;1023.6417253961203;18931.242750289835;21225.68161477579;21243;21297.23135992311;21391.57216855654;923.8983711791698;954.856771484283;969.60730903984;977.0624383733565;1015.3451024089569;8278;10093.596256149673;10180.185585153169;10426.739331516772;10857.022867941923;588652;606383;607089;611329;616282;88881.4568156149;128003.71996280104;137152;139688.30155849157;143932;937.8311903857372;958.1711819276416;964.5563041001218;970.2771435280761;971.2958105373689;15634.687306254038;16078.59803504875;17617.854839435397;19733.901330493256;19742.605147897248;50381.74809126078;54072.72963635156;58008;59581;61049.08426373519;86587;87870.68193976968;88114.11885881059;88253.55873220593;88681.55659221663;7089.964550177217;7989.2809647132035;7994.320482759031;8215.76763485482;8329.042160151661;10691.625793097204;13247.66880827987;13252.337383130613;13450.327483625975;13577.59267221985;11294.322340659259;11313.264637798517;11693.064554835422;11851.407429628656;11873.050155987674;11189.43347931274;11214.439278036229;11349.092072634334;11591.014763744839;11752.58865939688;10331.793364132825;10441.738956525844;11033.227674062739;11374.431278435879;11572.537098515964;7242.601656908921;7596.202398748052;7605.543667379975;7663.540187588763;7716.614169291401;10348.793024139324;11408.258463199865;11563.42182890869;11617.709557261136;11635.360055197045 06:37:32 INFO - PROCESS | 7028 | |3;mootools.html;1323.3118778235319;1506.7815166800817;1675.3298680527787;1890.4517689869938;1931.449536881988;8488.61801218945;9075.682351117712;9096.363254572174;9098.772530686736;9110.772230694236;6931;7885.645145968431;8164.387670924675;8621.396502244845;8865.778355541115;2366.195493532203;2410.529946660402;2410.9758902411013;2414.082648593541;2421.9273421797375;2374.95250094998;2398.4723360860585;2416.637504374349;2420.092465325503;2420.4311986683115;2093.7068810366486;2157.4498502881743;2187.223535644847;2323.9883800581056;2391.485830546432;2387.3912152401113;2402.1712509184476;2406.482606239667;2413.0347860855622;2413.903443862261;2367.195153647768;2404.4589967257402;2405.5910495215853;2407.542566912281;2410.240774156135;8997.280217582578;9063.728088157366;9071.228945539637;9079.818403631956;9094.363394562382;5324.733763311819;5383.407825139231;5462.644928079662;5472.781088756445;5482.150266708627;3540.929181416383;3621.728370372233;3741.289155060557;3744.7753134811996;3755.1363186467265;1077.978440431195;1086.0768346905147;1092.049916572579;1114.5876025870398;1120.6077872744556;9995.400275983464;11812.114091443176;11974.580889668907;11975.760484790255;11997.820032699516;4634.2585186370015;4648.86053418398;4869.756512174377;4875.146849301429;4879.585235254972;10180.98190180976;10193.745156371002;10194.592216311414;10197.439140847324;10202.132818710492;5428.321459817523;5430.5927055471;5431.266778984866;5435.048866448435;5437.184422336682;4784.68899521537;4923.75381230937;4968.677035992649;4972.5276098770555;4987.750612469362;3262.314913868114;3766.717496187742;3816.9121800286784;3826.4642949987024;3854.7494412863075;1137.3517095255625;1138.0952143046297;1153.2388623508612;1158.0851127609262;1173.906087512997;610.404855266112;747.1146691170871;747.3535391885979;801.3148757812103;895.1540793949786;5733.0540460823495;5741.167530708024;5913.201717768132;6021.819345419644;6260.780872669435;803.7186984555476;907.863820426928;926.402470406584;946.8295706772709;955.0640372435053;3730.3887278904876;3883.650471457526;3916.9020774480296;3976.980115099406;4019.91960160801;10429.68710938673;10576.735581610368;10714.46427678613;10716.464176791129;10719.946400267949;10364.948175259226;10600.04599586041;10609.204309676805;10619.734506637396;10821.080208182393;8182.427230093956;8416;8431.57842107892;8433.493990360597;8441.324694024463;5532.474414930575;5567.498925096599;5569.693666848362;5727.8568035799435;5746.9712651436475;9553.23574114083;9584.616615335308;9596.328257021942;9612.615495380107;9632.518374081408;8945.865812012955;8998.865017024618;9477.336586438883;9493.620255189991;9785;7476.476646634901;7565.2812982766545;7634.160242373224;7757.92242077572;7759.107702614272;8201;8254.42219044685;8270.007599087907;8275.54484503358;8278.172182781673;7484.775456736306;7601.3918886487845;7626.9618651906385;7740.690372385042;7756.263155000266;7338.70645174187;7434.665440055102;7463.514871533333;7479.476436649382;7537.472376933562;6995.895061573979;7003.509754317352;7003.789886303419;7010.158780946319;7072.752453664097;4821.927671085006;4946.876328091683;4956.553910148104;4961.627877909099;5067.290579318825;4934.7285899275885;5001.724905130252;5040.773165207648;5098.974505127599;5110.897782044264 06:37:32 INFO - PROCESS | 7028 | |4;prototype.html;253.77794429873862;277.6626398925306;298.4091498832312;300.05632286459087;312.2178941750914;4340.652747780178;5096.884792810979;5312.362516498021;5337.9199312010305;5400.918986215205;5077.238414237866;5131.538161565459;5199.272101905736;5218.956208758244;5257.764425360037;3643.599204087548;3932.9577661919616;4065.288574499451;4070.3487442009286;4091.6112969267947;3358.4122778513783;3539.7168226541944;3644.719752222994;3701.576615943948;3729.7948612826285;3128.530720391948;3778.5465744110747;3977.4090363854402;3986.70099742519;4039.6364327210545;3939.9212015759667;3968.3849003404516;3988.262171498282;3988.5612582615745;4036.495438070241;2873.5833304170988;3484.61669216386;3485.5817301923676;3491.2668339648703;3492.7904325740537;4743.857684269477;5072.974635126838;5108.514691104339;5141.974290128563;5143.562797162245;4201.873943781691;4245.896067022565;4581.244094724367;4589.472210695746;4605.815767369301;4812.783424745895;5564.221009058735;5572.080606699889;5578.44215578443;5638;3302.669733026678;3526.4181410067563;3754.9812250938844;3836.8848934532007;3862.6909847212155;5014.323066386028;5755.330998966015;5840.299164100293;5903.970480147572;5945.038137414643;3255.5930508686415;3880.864169754045;3892.2410130024373;3901.1027463683513;3901.2782635212575;3504.7196224301993;3535.4343305071066;3832.494747455687;3935.8032098394965;3943.901402464904;3804;4544.500104988449;4564.931526027112;4577.588017078412;4581.327815347374;4655.557722016403;4683.953160468352;5563.5271001964475;5582.106862901916;5645.633033852787;1249.4627310256676;1290.8773666501854;1291.12203701482;1292.2504947130642;1311.206719934445;850.4812064640564;864.7967727584013;897.5467388968659;900.9189172974463;903.1645727701981;5211.609129315317;5257.369115706063;5267.841964741064;5306.09796334624;5327;4465.843695470643;5425.945740542623;5744.310682718101;5784.59507834456;5787.189793428924;4655.952410707564;4729.483343407038;5092.745362731848;5099.59203263738;5126.462401111474;2657.2958166086005;2959.5708622250086;3015.4722923488303;3016;3036.832974186441;5202.479752024768;5669.688167150846;5900.911486327708;5964.224650795456;6006.579539432285;5766.221560089334;5872.911906321408;5937.584369094208;5950.672713000827;5971.701414929236;4986.725730084808;5097.949020509822;5570.415106413769;5928.258967629046;5964.493018093511;5501.78960628661;5804;5805.76776928935;5813.447722466359;5843.766249349978;4714.999999999863;4999.350084488993;5647.322321321303;5652.7738890443925;5659.745311460912;4657.69724967876;4745.217039188496;5356.491133342326;5580.693061881636;5908.438698323653;3043.599944025773;3506.965445193623;3511.894643160709;3808.733388662878;3809.504764380613;4934.679245849008;5187.455317191791;5634.830955071355;5646.661200327829;5654.067078932095;4358.3244597087505;4922.926156107733;5043.949560504348;5483.039158854174;5559.388467268516;4591.9540804591525;4852.379714954027;5520.227168196376;5536.695481748381;5552.806146678484;5186.325777648882;5224.981128679871;5315.734213289397;5362;5362.624616276823;4693.319468677091;4837.790552361909;4893.559579637849;5414.512693857571;5577.96807590597;4577.382053422745;4780.880477988078;5199;5318.441563635763;5455.863603409946 06:37:32 INFO - PROCESS | 7028 | |5;yui.html;711.7046425733321;758.0183662157506;779.3336697123959;788.992110078899;826.80983373824;15132.470363537279;15942.681146377066;16500.174991250435;16506.50480485586;16941;14759.92620036901;15149.242537873117;15157.242137893116;15181.696366072672;15193.164375959317;667.622793121887;687.0998991321385;829.3613917283703;840.2395831772255;840.9621567029499;678.5826716569298;825.7770401991459;848.4442690038035;853.2917678327004;860.6471346747835;897.6229983406952;900.594732370436;901.0223907060814;901.6438506789814;903.5346796399859;897.3539051882634;897.9102089791033;898.1018981018981;898.9730308090735;899.1143723432414;518.541091134345;537.3390729402856;639.9648019358933;655.701655746639;661.0711949710665;15095.773563396559;15144.242787860563;15160.772588411182;15168.848311516855;15190.924045379812;12612.369381530887;13229.140105893086;14002.29988500581;14078.788818167735;14137.363818628186;11218.551257949672;11287.830682539769;11577.479013444416;11789.528418863236;11905.940470297679;4428.512863585003;4633.305004249356;4647.37260469839;4791.544803243686;4793.3049707792525;85874.57062714708;110131.44934275358;111497.44251278773;115293;116510;10066;10081.69754907354;10609.893901061045;11005.504752286166;11117.332960022424;20944.581108377748;20946.162153513687;20978.2657606983;20981.370558882954;21007.15971361159;7874.448788584744;8026.5986700664735;8218.21926916942;8266.297364724065;8392.538410387366;3341.5823022122236;4507.752073635916;4515.14212299662;4519.276915693474;4572.039871626929;3645.434957581579;3804.600516945736;3811.5807261201244;3815.73289869712;3817.3701339279264;679.67035987546;681.877262092828;683.5522732610149;695.4401706626113;702.3292755418563;503.70029832249753;537.979369231527;543.2611648158502;571.6227289988587;620.1534904854841;8442;9307.72076837696;9402.858461034653;9436.386634868712;9640.084192001748;639.9328070552525;662.8044726805604;672.9795723899665;680.9071440338186;686.6566716641679;4301.612854843079;4432.911341773147;4612.838550650711;4643.117807616542;4643.791029403685;124661.37669311595;153486;157450;160362;178488;80573;82695.17304826874;104523;123081;136317.63682363048;106908.46545767221;109496.35755463675;113865;114047;117638;9156.496392698466;9821.116099551075;9828.508574571386;9845;9884.308098433328;61020.69489652523;61662;63421;63863.29435409215;65428;95035.52482237545;96811;97110;100286.9799114055;101701.49149254503;12554.246745195318;12669;12837.743245135232;13130.540431085248;13441.327933603476;14010.229437381042;14399.280035998368;14719.264036797904;14778;15610.853004982859;10774.569017239222;14009.43962241499;14179.503717370255;14721.484748033767;14723.484678036217;13230.867691322963;13696.564450043878;14216.431342746175;14395.136291822524;14834.77747833805;12507.56223532172;13770.586882393543;13953.790693139814;13979.580612581638;14118.788218176942;11017.504212310305;11200.38397888124;11457.59898403552;11563.6530904073;12539.623811285675;10793.892061079288;11451.599194028502;11584.362860042442;11604;11756.647300580997 06:37:32 INFO - PROCESS | 7028 | __end_tp_report 06:37:32 INFO - PROCESS | 7028 | __start_cc_report 06:37:32 INFO - PROCESS | 7028 | _x_x_mozilla_cycle_collect,1282 06:37:32 INFO - PROCESS | 7028 | __end_cc_report 06:37:32 INFO - PROCESS | 7028 | __startTimestamp1478875052884__endTimestamp 06:37:32 INFO - PROCESS | 7028 | 06:37:32 INFO - PROCESS | 7028 | ------- Summary: start ------- 06:37:32 INFO - PROCESS | 7028 | Number of tests: 6 06:37:32 INFO - PROCESS | 7028 | 06:37:32 INFO - PROCESS | 7028 | [#0] dojo.html Cycles:165 Average:5711.99 Median:5941.88 stddev:654.53 (11.0%) stddev-sans-first:628.39 06:37:32 INFO - PROCESS | 7028 | Values: 3291.2 3295.0 3323.0 3349.3 3353.4 5632.6 5640.5 5682.5 5694.3 5769.7 5594.1 5691.3 5703.7 5705.1 5762.2 5151.7 5171.4 5172.9 5222.0 5228.2 5121.7 5127.8 5158.4 5273.6 5342.7 5206.9 5228.0 5230.2 5232.6 5242.7 5210.0 5228.8 5239.4 5252.9 5292.7 5141.2 5225.0 5252.8 5260.5 5299.9 5555.1 5603.6 5615.6 5690.0 5698.4 6104.2 6150.0 6156.8 6197.1 6217.2 6209.5 6272.6 6288.2 6296.0 6299.8 5592.8 5692.1 5745.0 5746.0 5792.0 6244.2 6282.6 6305.3 6307.4 6356.2 6130.5 6149.8 6155.4 6158.4 6166.3 6135.5 6192.4 6251.5 6285.3 6293.7 5941.9 5950.9 5996.3 6060.8 6090.4 6164.6 6186.7 6188.2 6192.1 6192.6 4863.8 4905.6 4915.2 4918.1 4927.8 3769.6 4299.7 4324.4 4327.8 4413.7 5755.6 5789.4 5849.4 5856.6 5860.1 6247.2 6294.6 6308.1 6317.7 6329.2 5765.3 5770.2 5774.7 5797.2 5822.6 5257.2 5270.0 5309.8 5318.9 5331.5 6246.5 6272.4 6286.0 6301.6 6310.7 6254.1 6259.5 6268.6 6272.7 6284.7 6135.5 6229.3 6285.7 6320.2 6328.5 6005.8 6101.5 6110.4 6138.1 6147.2 6235.2 6245.7 6246.2 6258.5 6270.9 5959.9 6015.2 6026.7 6051.6 6107.4 5061.5 5885.6 5974.5 5985.6 6008.3 4886.4 5949.8 5961.7 5986.2 5990.7 6059.5 6085.9 6117.2 6120.0 6147.0 5744.9 5851.1 5855.9 5890.5 5946.6 06:37:32 INFO - PROCESS | 7028 | 06:37:32 INFO - PROCESS | 7028 | [#1] ext.html Cycles:180 Average:72519.33 Median:39912.30 stddev:160556.00 (402.3%) stddev-sans-first:160915.23 06:37:32 INFO - PROCESS | 7028 | Values: 455.4 466.9 480.8 506.6 526.8 30780.7 40243.4 41505.6 41527.0 44470.3 43333.8 43824.0 43831.7 43948.9 44001.6 9830.6 10001.3 10011.1 10019.7 10053.1 9832.8 9935.2 9948.4 9971.1 9983.0 7924.4 9109.7 9919.2 9994.2 9999.1 9854.5 9929.3 9945.5 9992.8 10019.5 9886.4 9963.6 9973.5 9978.8 10001.8 41523.8 41867.4 41889.2 41907.8 41938.0 3372.4 3692.6 3972.5 4048.3 4084.7 29678.3 30680.4 31245.4 31841.4 32080.8 3240.7 3253.5 3268.7 3299.0 3299.4 513583.0 515155.0 516213.0 517900.0 518076.0 59238.4 59633.1 59645.7 59810.1 59905.0 34693.5 35414.8 62233.4 62312.7 62392.4 16574.3 17293.1 17369.1 17411.0 17424.0 13155.7 13270.8 13271.8 13278.1 13311.7 19403.0 19403.6 19417.3 19421.7 19460.2 6905.5 7803.5 7950.3 8010.6 8047.5 731.4 841.2 890.7 914.6 1060.9 29077.9 29916.9 30121.2 30773.0 30930.4 1047.2 1054.4 1068.4 1090.4 1130.0 15651.5 17055.7 17108.3 17126.0 17262.1 660036.0 666664.0 667195.0 667231.0 667777.0 59905.5 60054.4 60452.0 60505.7 60706.4 1253.5 1286.5 1374.2 1397.4 1403.3 27388.9 28612.0 29407.8 31168.4 31775.8 50868.0 51499.0 51517.5 51525.0 51554.5 603206.0 609596.0 610057.0 611472.0 611511.0 25424.0 26614.3 26653.0 26655.6 26693.5 45785.0 45978.0 45997.5 46088.0 46411.8 37798.1 38401.2 39099.8 39969.6 40298.4 37386.8 37796.2 39036.0 39755.4 39855.0 36152.1 36297.8 36504.6 36518.6 36604.6 32352.2 34159.1 34643.3 34721.7 34811.8 23252.2 24020.4 25631.9 25826.3 26478.0 06:37:32 INFO - PROCESS | 7028 | 06:37:32 INFO - PROCESS | 7028 | [#2] jquery.html Cycles:180 Average:35721.85 Median:26189.43 stddev:101314.72 (386.9%) stddev-sans-first:101564.12 06:37:32 INFO - PROCESS | 7028 | Values: 352.3 363.6 368.5 387.1 400.9 14994.4 15178.6 16277.8 20642.0 20916.8 19731.0 19987.0 20530.8 20794.8 21028.8 4693.2 5914.3 6017.4 6186.7 6201.8 6065.3 6096.8 6167.0 6167.1 6180.6 5915.1 5931.5 5940.6 6108.2 6114.0 5861.4 5905.1 5996.1 6017.7 6026.3 4982.7 5162.4 5223.1 5231.8 5237.7 26003.1 26114.0 26156.9 26222.0 26534.9 2228.5 2251.3 2333.0 2774.1 2871.8 12393.1 12491.9 15035.2 15272.8 16330.0 1847.5 1849.2 1878.0 1901.7 1913.4 109267.9 113742.4 115975.0 129629.0 132651.0 11443.1 11467.4 11629.8 11663.1 11776.6 14660.6 14671.9 14709.3 14716.6 14722.1 8748.9 8851.6 8865.6 8894.2 9011.0 8837.7 8936.2 8990.0 9095.4 9115.8 3982.8 4279.8 4439.9 4480.9 4563.2 1609.5 1882.0 1922.6 1945.7 1947.5 814.3 890.7 913.4 985.9 1023.6 18931.2 21225.7 21243.0 21297.2 21391.6 923.9 954.9 969.6 977.1 1015.3 8278.0 10093.6 10180.2 10426.7 10857.0 588652.0 606383.0 607089.0 611329.0 616282.0 88881.5 128003.7 137152.0 139688.3 143932.0 937.8 958.2 964.6 970.3 971.3 15634.7 16078.6 17617.9 19733.9 19742.6 50381.7 54072.7 58008.0 59581.0 61049.1 86587.0 87870.7 88114.1 88253.6 88681.6 7090.0 7989.3 7994.3 8215.8 8329.0 10691.6 13247.7 13252.3 13450.3 13577.6 11294.3 11313.3 11693.1 11851.4 11873.1 11189.4 11214.4 11349.1 11591.0 11752.6 10331.8 10441.7 11033.2 11374.4 11572.5 7242.6 7596.2 7605.5 7663.5 7716.6 10348.8 11408.3 11563.4 11617.7 11635.4 06:37:32 INFO - PROCESS | 7028 | 06:37:32 INFO - PROCESS | 7028 | [#3] mootools.html Cycles:180 Average:5701.91 Median:5054.03 stddev:3177.53 (62.9%) stddev-sans-first:3169.40 06:37:32 INFO - PROCESS | 7028 | Values: 1323.3 1506.8 1675.3 1890.5 1931.4 8488.6 9075.7 9096.4 9098.8 9110.8 6931.0 7885.6 8164.4 8621.4 8865.8 2366.2 2410.5 2411.0 2414.1 2421.9 2375.0 2398.5 2416.6 2420.1 2420.4 2093.7 2157.4 2187.2 2324.0 2391.5 2387.4 2402.2 2406.5 2413.0 2413.9 2367.2 2404.5 2405.6 2407.5 2410.2 8997.3 9063.7 9071.2 9079.8 9094.4 5324.7 5383.4 5462.6 5472.8 5482.2 3540.9 3621.7 3741.3 3744.8 3755.1 1078.0 1086.1 1092.0 1114.6 1120.6 9995.4 11812.1 11974.6 11975.8 11997.8 4634.3 4648.9 4869.8 4875.1 4879.6 10181.0 10193.7 10194.6 10197.4 10202.1 5428.3 5430.6 5431.3 5435.0 5437.2 4784.7 4923.8 4968.7 4972.5 4987.8 3262.3 3766.7 3816.9 3826.5 3854.7 1137.4 1138.1 1153.2 1158.1 1173.9 610.4 747.1 747.4 801.3 895.2 5733.1 5741.2 5913.2 6021.8 6260.8 803.7 907.9 926.4 946.8 955.1 3730.4 3883.7 3916.9 3977.0 4019.9 10429.7 10576.7 10714.5 10716.5 10719.9 10364.9 10600.0 10609.2 10619.7 10821.1 8182.4 8416.0 8431.6 8433.5 8441.3 5532.5 5567.5 5569.7 5727.9 5747.0 9553.2 9584.6 9596.3 9612.6 9632.5 8945.9 8998.9 9477.3 9493.6 9785.0 7476.5 7565.3 7634.2 7757.9 7759.1 8201.0 8254.4 8270.0 8275.5 8278.2 7484.8 7601.4 7627.0 7740.7 7756.3 7338.7 7434.7 7463.5 7479.5 7537.5 6995.9 7003.5 7003.8 7010.2 7072.8 4821.9 4946.9 4956.6 4961.6 5067.3 4934.7 5001.7 5040.8 5099.0 5110.9 06:37:32 INFO - PROCESS | 7028 | 06:37:32 INFO - PROCESS | 7028 | [#4] prototype.html Cycles:180 Average:4433.59 Median:4960.70 stddev:1379.50 (27.8%) stddev-sans-first:1347.22 06:37:32 INFO - PROCESS | 7028 | Values: 253.8 277.7 298.4 300.1 312.2 4340.7 5096.9 5312.4 5337.9 5400.9 5077.2 5131.5 5199.3 5219.0 5257.8 3643.6 3933.0 4065.3 4070.3 4091.6 3358.4 3539.7 3644.7 3701.6 3729.8 3128.5 3778.5 3977.4 3986.7 4039.6 3939.9 3968.4 3988.3 3988.6 4036.5 2873.6 3484.6 3485.6 3491.3 3492.8 4743.9 5073.0 5108.5 5142.0 5143.6 4201.9 4245.9 4581.2 4589.5 4605.8 4812.8 5564.2 5572.1 5578.4 5638.0 3302.7 3526.4 3755.0 3836.9 3862.7 5014.3 5755.3 5840.3 5904.0 5945.0 3255.6 3880.9 3892.2 3901.1 3901.3 3504.7 3535.4 3832.5 3935.8 3943.9 3804.0 4544.5 4564.9 4577.6 4581.3 4655.6 4684.0 5563.5 5582.1 5645.6 1249.5 1290.9 1291.1 1292.3 1311.2 850.5 864.8 897.5 900.9 903.2 5211.6 5257.4 5267.8 5306.1 5327.0 4465.8 5425.9 5744.3 5784.6 5787.2 4656.0 4729.5 5092.7 5099.6 5126.5 2657.3 2959.6 3015.5 3016.0 3036.8 5202.5 5669.7 5900.9 5964.2 6006.6 5766.2 5872.9 5937.6 5950.7 5971.7 4986.7 5097.9 5570.4 5928.3 5964.5 5501.8 5804.0 5805.8 5813.4 5843.8 4715.0 4999.4 5647.3 5652.8 5659.7 4657.7 4745.2 5356.5 5580.7 5908.4 3043.6 3507.0 3511.9 3808.7 3809.5 4934.7 5187.5 5634.8 5646.7 5654.1 4358.3 4922.9 5043.9 5483.0 5559.4 4592.0 4852.4 5520.2 5536.7 5552.8 5186.3 5225.0 5315.7 5362.0 5362.6 4693.3 4837.8 4893.6 5414.5 5578.0 4577.4 4780.9 5199.0 5318.4 5455.9 06:37:32 INFO - PROCESS | 7028 | 06:37:32 INFO - PROCESS | 7028 | [#5] yui.html Cycles:180 Average:24669.24 Median:3725.02 stddev:39251.97 (1053.7%) stddev-sans-first:39320.86 06:37:32 INFO - PROCESS | 7028 | Values: 711.7 758.0 779.3 789.0 826.8 15132.5 15942.7 16500.2 16506.5 16941.0 14759.9 15149.2 15157.2 15181.7 15193.2 667.6 687.1 829.4 840.2 841.0 678.6 825.8 848.4 853.3 860.6 897.6 900.6 901.0 901.6 903.5 897.4 897.9 898.1 899.0 899.1 518.5 537.3 640.0 655.7 661.1 15095.8 15144.2 15160.8 15168.8 15190.9 12612.4 13229.1 14002.3 14078.8 14137.4 11218.6 11287.8 11577.5 11789.5 11905.9 4428.5 4633.3 4647.4 4791.5 4793.3 85874.6 110131.4 111497.4 115293.0 116510.0 10066.0 10081.7 10609.9 11005.5 11117.3 20944.6 20946.2 20978.3 20981.4 21007.2 7874.4 8026.6 8218.2 8266.3 8392.5 3341.6 4507.8 4515.1 4519.3 4572.0 3645.4 3804.6 3811.6 3815.7 3817.4 679.7 681.9 683.6 695.4 702.3 503.7 538.0 543.3 571.6 620.2 8442.0 9307.7 9402.9 9436.4 9640.1 639.9 662.8 673.0 680.9 686.7 4301.6 4432.9 4612.8 4643.1 4643.8 124661.4 153486.0 157450.0 160362.0 178488.0 80573.0 82695.2 104523.0 123081.0 136317.6 106908.5 109496.4 113865.0 114047.0 117638.0 9156.5 9821.1 9828.5 9845.0 9884.3 61020.7 61662.0 63421.0 63863.3 65428.0 95035.5 96811.0 97110.0 100287.0 101701.5 12554.2 12669.0 12837.7 13130.5 13441.3 14010.2 14399.3 14719.3 14778.0 15610.9 10774.6 14009.4 14179.5 14721.5 14723.5 13230.9 13696.6 14216.4 14395.1 14834.8 12507.6 13770.6 13953.8 13979.6 14118.8 11017.5 11200.4 11457.6 11563.7 12539.6 10793.9 11451.6 11584.4 11604.0 11756.6 06:37:32 INFO - PROCESS | 7028 | -------- Summary: end -------- 06:37:32 INFO - PROCESS | 7028 | 06:37:33 INFO - TEST-INFO | 7028: exit 0 06:37:33 INFO - TEST-OK | dromaeo_css | took 1117884ms 06:37:33 INFO - TEST-START | kraken 06:37:33 INFO - operating with platform_type : mac_ 06:37:33 INFO - Initialising browser for kraken test... 06:37:33 INFO - TEST-INFO | started process 7032 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpONLabD/profile http://localhost:57800/getInfo.html) 06:37:36 INFO - PROCESS | 7032 | __metrics Screen width/height:1600/1200 06:37:36 INFO - PROCESS | 7032 | colorDepth:24 06:37:36 INFO - PROCESS | 7032 | Browser inner width/height: 1024/689 06:37:36 INFO - PROCESS | 7032 | __metrics 06:37:36 INFO - PROCESS | 7032 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:37:36 INFO - PROCESS | 7032 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:37:37 INFO - TEST-INFO | 7032: exit 0 06:37:37 INFO - Browser initialized. 06:37:37 INFO - Running cycle 1/1 for kraken test... 06:37:37 INFO - TEST-INFO | started process 7033 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpONLabD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:49 INFO - PROCESS | 7033 | RSS: Main: 220266496 06:37:49 INFO - PROCESS | 7033 | 06:37:52 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57800/tests/kraken/driver.html?testName=audio-beat-detection) 06:37:52 INFO - PROCESS | 7033 | RSS: Main: 271564800 06:37:52 INFO - PROCESS | 7033 | 06:37:55 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57800/tests/kraken/driver.html?testName=audio-dft) 06:37:56 INFO - PROCESS | 7033 | RSS: Main: 281882624 06:37:56 INFO - PROCESS | 7033 | 06:37:59 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57800/tests/kraken/driver.html?testName=audio-fft) 06:37:59 INFO - PROCESS | 7033 | RSS: Main: 376684544 06:37:59 INFO - PROCESS | 7033 | 06:38:02 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57800/tests/kraken/driver.html?testName=audio-oscillator) 06:38:02 INFO - PROCESS | 7033 | RSS: Main: 280834048 06:38:02 INFO - PROCESS | 7033 | 06:38:04 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57800/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:38:05 INFO - PROCESS | 7033 | RSS: Main: 281149440 06:38:05 INFO - PROCESS | 7033 | 06:38:08 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57800/tests/kraken/driver.html?testName=imaging-darkroom) 06:38:08 INFO - PROCESS | 7033 | RSS: Main: 318324736 06:38:08 INFO - PROCESS | 7033 | 06:38:11 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57800/tests/kraken/driver.html?testName=imaging-desaturate) 06:38:12 INFO - PROCESS | 7033 | RSS: Main: 317034496 06:38:12 INFO - PROCESS | 7033 | 06:38:15 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57800/tests/kraken/driver.html?testName=json-parse-financial) 06:38:15 INFO - PROCESS | 7033 | RSS: Main: 315154432 06:38:15 INFO - PROCESS | 7033 | 06:38:17 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57800/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:38:17 INFO - PROCESS | 7033 | RSS: Main: 291221504 06:38:17 INFO - PROCESS | 7033 | 06:38:19 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:38:20 INFO - PROCESS | 7033 | RSS: Main: 296689664 06:38:20 INFO - PROCESS | 7033 | 06:38:22 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:38:23 INFO - PROCESS | 7033 | RSS: Main: 306724864 06:38:23 INFO - PROCESS | 7033 | 06:38:26 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:38:27 INFO - PROCESS | 7033 | RSS: Main: 309645312 06:38:27 INFO - PROCESS | 7033 | 06:38:29 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:38:30 INFO - PROCESS | 7033 | RSS: Main: 309960704 06:38:30 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57800/tests/kraken/driver.html?testName=ai-astar) 06:38:32 INFO - PROCESS | 7033 | RSS: Main: 353333248 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | __start_tp_report 06:38:32 INFO - PROCESS | 7033 | _x_x_mozilla_page_load 06:38:32 INFO - PROCESS | 7033 | _x_x_mozilla_page_load_details 06:38:32 INFO - PROCESS | 7033 | |i|pagename|runs| 06:38:32 INFO - PROCESS | 7033 | |0;ai-astar;114;137;165;130;113;119;113;120;166;155 06:38:32 INFO - PROCESS | 7033 | |1;audio-beat-detection;146;135;110;142;112;109;109;109;142;107 06:38:32 INFO - PROCESS | 7033 | |2;audio-dft;185;184;186;184;184;185;185;185;186;185 06:38:32 INFO - PROCESS | 7033 | |3;audio-fft;85;60;59;93;79;84;82;70;84;58 06:38:32 INFO - PROCESS | 7033 | |4;audio-oscillator;87;73;96;69;68;69;92;67;68;90 06:38:32 INFO - PROCESS | 7033 | |5;imaging-gaussian-blur;89;85;88;84;87;85;95;85;87;83 06:38:32 INFO - PROCESS | 7033 | |6;imaging-darkroom;96;95;96;96;98;96;101;146;162;97 06:38:32 INFO - PROCESS | 7033 | |7;imaging-desaturate;84;95;128;87;84;84;96;132;86;84 06:38:32 INFO - PROCESS | 7033 | |8;json-parse-financial;56;54;53;52;55;56;57;56;56;55 06:38:32 INFO - PROCESS | 7033 | |9;json-stringify-tinderbox;67;71;72;83;77;75;70;72;73;72 06:38:32 INFO - PROCESS | 7033 | |10;stanford-crypto-aes;87;83;84;85;86;86;86;84;90;90 06:38:32 INFO - PROCESS | 7033 | |11;stanford-crypto-ccm;152;153;128;155;153;157;137;142;176;140 06:38:32 INFO - PROCESS | 7033 | |12;stanford-crypto-pbkdf2;167;167;164;168;169;168;170;228;205;168 06:38:32 INFO - PROCESS | 7033 | |13;stanford-crypto-sha256-iterative;68;76;88;89;86;89;66;68;67;67 06:38:32 INFO - PROCESS | 7033 | __end_tp_report 06:38:32 INFO - PROCESS | 7033 | __start_cc_report 06:38:32 INFO - PROCESS | 7033 | _x_x_mozilla_cycle_collect,1948 06:38:32 INFO - PROCESS | 7033 | __end_cc_report 06:38:32 INFO - PROCESS | 7033 | __startTimestamp1478875112739__endTimestamp 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | ------- Summary: start ------- 06:38:32 INFO - PROCESS | 7033 | Number of tests: 14 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#0] ai-astar Cycles:10 Average:133.20 Median:133.50 stddev:21.47 (16.1%) stddev-sans-first:21.62 06:38:32 INFO - PROCESS | 7033 | Values: 114.0 137.0 165.0 130.0 113.0 119.0 113.0 120.0 166.0 155.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:123.50 stddev:16.74 (13.6%) stddev-sans-first:15.36 06:38:32 INFO - PROCESS | 7033 | Values: 146.0 135.0 110.0 142.0 112.0 109.0 109.0 109.0 142.0 107.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:0.74 (0.4%) stddev-sans-first:0.78 06:38:32 INFO - PROCESS | 7033 | Values: 185.0 184.0 186.0 184.0 184.0 185.0 185.0 185.0 186.0 185.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#3] audio-fft Cycles:10 Average:75.40 Median:83.00 stddev:12.67 (15.3%) stddev-sans-first:12.95 06:38:32 INFO - PROCESS | 7033 | Values: 85.0 60.0 59.0 93.0 79.0 84.0 82.0 70.0 84.0 58.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:80.00 stddev:11.80 (14.7%) stddev-sans-first:12.05 06:38:32 INFO - PROCESS | 7033 | Values: 87.0 73.0 96.0 69.0 68.0 69.0 92.0 67.0 68.0 90.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.00 stddev:3.43 (3.9%) stddev-sans-first:3.54 06:38:32 INFO - PROCESS | 7033 | Values: 89.0 85.0 88.0 84.0 87.0 85.0 95.0 85.0 87.0 83.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#6] imaging-darkroom Cycles:10 Average:108.30 Median:96.00 stddev:24.44 (25.5%) stddev-sans-first:25.51 06:38:32 INFO - PROCESS | 7033 | Values: 96.0 95.0 96.0 96.0 98.0 96.0 101.0 146.0 162.0 97.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:85.00 stddev:18.49 (21.8%) stddev-sans-first:19.10 06:38:32 INFO - PROCESS | 7033 | Values: 84.0 95.0 128.0 87.0 84.0 84.0 96.0 132.0 86.0 84.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:1.56 (2.8%) stddev-sans-first:1.62 06:38:32 INFO - PROCESS | 7033 | Values: 56.0 54.0 53.0 52.0 55.0 56.0 57.0 56.0 56.0 55.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:72.50 stddev:4.37 (6.0%) stddev-sans-first:4.01 06:38:32 INFO - PROCESS | 7033 | Values: 67.0 71.0 72.0 83.0 77.0 75.0 70.0 72.0 73.0 72.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:2.38 (2.8%) stddev-sans-first:2.50 06:38:32 INFO - PROCESS | 7033 | Values: 87.0 83.0 84.0 85.0 86.0 86.0 86.0 84.0 90.0 90.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:153.00 stddev:13.27 (8.7%) stddev-sans-first:14.04 06:38:32 INFO - PROCESS | 7033 | Values: 152.0 153.0 128.0 155.0 153.0 157.0 137.0 142.0 176.0 140.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:168.50 stddev:21.37 (12.7%) stddev-sans-first:22.33 06:38:32 INFO - PROCESS | 7033 | Values: 167.0 167.0 164.0 168.0 169.0 168.0 170.0 228.0 205.0 168.0 06:38:32 INFO - PROCESS | 7033 | 06:38:32 INFO - PROCESS | 7033 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:81.00 stddev:10.38 (12.8%) stddev-sans-first:10.56 06:38:32 INFO - PROCESS | 7033 | Values: 68.0 76.0 88.0 89.0 86.0 89.0 66.0 68.0 67.0 67.0 06:38:32 INFO - PROCESS | 7033 | -------- Summary: end -------- 06:38:32 INFO - PROCESS | 7033 | 06:38:33 INFO - TEST-INFO | 7033: exit 0 06:38:33 INFO - TEST-OK | kraken | took 60068ms 06:38:33 INFO - SUITE-END | took 1177s 06:38:33 INFO - Completed test suite (00:19:38) 06:38:33 INFO - javascript benchmark 06:38:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.1772056985756, 3294.983525082375, 3323.0, 3349.279904820463, 3353.3796247694163, 5632.605717599769, 5640.520555752761, 5682.488576028157, 5694.316681998166, 5769.653820770752, 5594.13290939904, 5691.317041954961, 5703.657780533171, 5705.144228365747, 5762.164486149506, 5151.71665558395, 5171.379434467869, 5172.896542069157, 5222.033923724123, 5228.163493840986, 5121.692698438087, 5127.820526281581, 5158.406783219922, 5273.604479664022, 5342.706151161685, 5206.947930520684, 5227.980543793961, 5230.163173892178, 5232.555232805216, 5242.711650859202, 5210.036143313461, 5228.843134705965, 5239.423663397023, 5252.894942101156, 5292.682439053669, 5141.177411614124, 5225.0, 5252.842414727565, 5260.526552610245, 5299.867503312409, 5555.083411237181, 5603.60774745768, 5615.634983726045, 5690.0, 5698.40166782486, 6104.206453161105, 6150.0, 6156.7537298508005, 6197.101420294077, 6217.191765070557, 6209.5032397408095, 6272.5922815016875, 6288.213973253343, 6295.96852015737, 6299.811005669837, 5592.832215033555, 5692.117721753135, 5744.982243326271, 5745.971270143665, 5792.0, 6244.188255526843, 6282.591631543935, 6305.274893387227, 6307.369263073748, 6356.237251529846, 6130.540209484307, 6149.754009839646, 6155.35368786271, 6158.445739883432, 6166.290876549254, 6135.509159267337, 6192.411720886508, 6251.499880009588, 6285.308616052231, 6293.748250069946, 5941.881162376728, 5950.851228719317, 5996.280446346466, 6060.787872424444, 6090.421409966046, 6164.568480206342, 6186.659733714689, 6188.164597779332, 6192.0711893215475, 6192.59748116371, 4863.756812159378, 4905.607551395879, 4915.238138088602, 4918.114739346952, 4927.77824997876, 3769.6230376962635, 4299.720518166309, 4324.394584758136, 4327.805248763813, 4413.7351758894565, 5755.62588431759, 5789.421057894177, 5849.444302791228, 5856.590038697335, 5860.120981852671, 6247.219097612799, 6294.559380843297, 6308.085327627468, 6317.652529110943, 6329.177206963157, 5765.336986246635, 5770.24986751728, 5774.653520788766, 5797.159411885253, 5822.621529600562, 5257.158854583248, 5270.0, 5309.840704778863, 5318.9202161967605, 5331.546818520469, 6246.46905013079, 6272.435480806749, 6285.96857015712, 6301.62190268567, 6310.684465776692, 6254.093156492374, 6259.530535209787, 6268.561200715906, 6272.686365681789, 6284.685765711604, 6135.539834512519, 6229.2524897012645, 6285.717142728497, 6320.241571011508, 6328.525360598066, 6005.819825405245, 6101.450869421773, 6110.419510146529, 6138.051223665275, 6147.170132032118, 6235.158253635701, 6245.718942647501, 6246.219222597176, 6258.530610204344, 6270.9372906270355, 5959.880802384015, 6015.165374560801, 6026.668533230714, 6051.606645568024, 6107.389261074035, 5061.544460998528, 5885.558583106199, 5974.462298392991, 5985.5810093294795, 6008.309044459943, 4886.438059623189, 5949.791757288474, 5961.731722072604, 5986.191864098291, 5990.6705131218205, 6059.484943779652, 6085.878282434415, 6117.235345581802, 6120.020796672511, 6147.016477363601, 5744.856378590569, 5851.093080572518, 5855.853603659943, 5890.4698577128265, 5946.5540084494705], "value": 5668.678610530002, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.410243734364, 466.9136209801187, 480.8100800183925, 506.6326912988082, 526.8419474157753, 30780.692193078063, 40243.396349054754, 41505.58494415055, 41527.0, 44470.33294500585, 43333.7833310833, 43824.0, 43831.68504944849, 43948.901277468, 44001.55998440015, 9830.606775728962, 10001.299909006373, 10011.14905233056, 10019.699409017705, 10053.145482633985, 9832.754181145492, 9935.205183585333, 9948.403095814274, 9971.10260076593, 9982.9500852496, 7924.3660507159575, 9109.68116115936, 9919.156871665917, 9994.150497207746, 9999.10008099271, 9854.458004809732, 9929.255305852017, 9945.502724863727, 9992.80014399708, 10019.549120289605, 9886.406815591088, 9963.601455941754, 9973.501324933724, 9978.750531236705, 10001.799964000753, 41523.792381038205, 41867.371989420186, 41889.1622167558, 41907.79046104781, 41938.0, 3372.4435468147726, 3692.5568931728367, 3972.483577134983, 4048.291548978917, 4084.7140700151003, 29678.258043549085, 30680.386392272252, 31245.375092498023, 31841.363172736415, 32080.83959580187, 3240.692134247243, 3253.5282384054417, 3268.6731326867125, 3299.0, 3299.3566254580364, 513583.0, 515155.0, 516213.0, 517900.0, 518075.9999999962, 59238.40761592415, 59633.105503417486, 59645.70177149173, 59810.10284845731, 59905.0, 34693.47959780605, 35414.82292588521, 62233.37766622366, 62312.688436558434, 62392.37607623866, 16574.337026518806, 17293.13534323279, 17369.089400166224, 17411.0, 17424.041677707846, 13155.736885262433, 13270.800937985938, 13271.800922986164, 13278.136921100098, 13311.66720831987, 19403.02984850752, 19403.611927761365, 19417.32039378643, 19421.708674369896, 19460.22159113648, 6905.482088843357, 7803.492772969739, 7950.3242224410415, 8010.639521221559, 8047.539557990121, 731.4404480572366, 841.1630427724454, 890.701614958983, 914.5701520285455, 1060.9204309676804, 29077.854610726812, 29916.850415747784, 30121.246968825515, 30773.0, 30930.381392372477, 1047.1570385839473, 1054.3726482742757, 1068.4283908109123, 1090.3566895531674, 1129.9999500442168, 15651.530454086396, 17055.658886822195, 17108.315667373165, 17125.97244165354, 17262.05058721757, 660036.0, 666664.0, 667195.0, 667231.0, 667777.0, 59905.502362441286, 60054.39945600488, 60452.0, 60505.69747151236, 60706.39293607096, 1253.4798058805675, 1286.5432771366031, 1374.17549470321, 1397.4270549075034, 1403.3404299978993, 27388.863055684593, 28612.0, 29407.823687052278, 31168.37663246677, 31775.841120794248, 50868.0, 51499.0, 51517.48482515127, 51525.0, 51554.48445515497, 603206.0, 609596.0, 610057.0, 611472.0, 611511.0, 25424.0, 26614.334641634116, 26653.0, 26655.600165997137, 26693.466130677665, 45785.0, 45978.0, 45997.54002459932, 46088.0, 46411.83970400632, 37798.144986571046, 38401.2319753609, 39099.80450097731, 39969.60030399659, 40298.395524067746, 37386.8130659345, 37796.24407511889, 39036.0, 39755.40366894441, 39855.0, 36152.096197595274, 36297.818510908335, 36504.634953651184, 36518.63481365152, 36604.633953661185, 32352.191195220308, 34159.07170675404, 34643.30713385668, 34721.65278347184, 34811.825940870134, 23252.186173483846, 24020.39949001289, 25631.871840640677, 25826.302828685577, 26478.0], "value": 20194.812856641594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.32705532433056, 363.57824923089214, 368.5393258426965, 387.144410852017, 400.91781184857086, 14994.40022399104, 15178.620534486643, 16277.83722162778, 20642.0, 20916.790832091676, 19731.0, 19987.0, 20530.794692053074, 20794.792052079476, 21028.843413612245, 4693.20215563355, 5914.260717410334, 6017.428344307305, 6186.721597528122, 6201.782937597185, 6065.332813390523, 6096.786612468564, 6167.04410816322, 6167.074938759177, 6180.598261113036, 5915.112733090028, 5931.466168044875, 5940.584159108864, 6108.236470441195, 6113.991191453405, 5861.384554621767, 5905.084711869667, 5996.130561068642, 6017.69911504423, 6026.276846778393, 4982.651214414992, 5162.432132465426, 5223.059849227137, 5231.816886408996, 5237.711925844077, 26003.089891853884, 26114.0, 26156.86921565399, 26222.0, 26534.867325663246, 2228.5097278598682, 2251.268337790225, 2333.0, 2774.128045867178, 2871.8369060530517, 12393.132480726354, 12491.875081249253, 15035.248237588186, 15272.770908436383, 16330.02019878811, 1847.5011746828416, 1849.214084014302, 1878.0421984787856, 1901.7147427885789, 1913.3685883658359, 109267.90732092736, 113742.43128784386, 115975.0, 129629.0, 132650.99999999904, 11443.14176436754, 11467.426628668532, 11629.825552616718, 11663.125265605113, 11776.646700598996, 14660.633484162769, 14671.92664036673, 14709.264536773118, 14716.632084197981, 14722.116672999655, 8748.912510874938, 8851.557422128868, 8865.556722163867, 8894.155055269739, 9011.0, 8837.718530812996, 8936.151065648754, 8989.955050224708, 9095.36332456735, 9115.772105697411, 3982.8008599569907, 4279.786010699452, 4439.933400998988, 4480.910381792346, 4563.247064234431, 1609.5090997245952, 1881.9717704234447, 1922.5770330527262, 1945.747052883116, 1947.47418197086, 814.3281792521194, 890.6526454682679, 913.4421428535949, 985.9359141655913, 1023.6417253961203, 18931.242750289835, 21225.68161477579, 21243.0, 21297.23135992311, 21391.57216855654, 923.8983711791698, 954.856771484283, 969.60730903984, 977.0624383733565, 1015.3451024089569, 8278.0, 10093.596256149673, 10180.185585153169, 10426.739331516772, 10857.022867941923, 588652.0, 606383.0, 607089.0, 611329.0, 616282.0, 88881.4568156149, 128003.71996280104, 137152.0, 139688.30155849157, 143932.0, 937.8311903857372, 958.1711819276416, 964.5563041001218, 970.2771435280761, 971.2958105373689, 15634.687306254038, 16078.59803504875, 17617.854839435397, 19733.901330493256, 19742.605147897248, 50381.74809126078, 54072.72963635156, 58008.0, 59581.0, 61049.08426373519, 86587.0, 87870.68193976968, 88114.11885881059, 88253.55873220593, 88681.55659221663, 7089.964550177217, 7989.2809647132035, 7994.320482759031, 8215.76763485482, 8329.042160151661, 10691.625793097204, 13247.66880827987, 13252.337383130613, 13450.327483625975, 13577.59267221985, 11294.322340659259, 11313.264637798517, 11693.064554835422, 11851.407429628656, 11873.050155987674, 11189.43347931274, 11214.439278036229, 11349.092072634334, 11591.014763744839, 11752.58865939688, 10331.793364132825, 10441.738956525844, 11033.227674062739, 11374.431278435879, 11572.537098515964, 7242.601656908921, 7596.202398748052, 7605.543667379975, 7663.540187588763, 7716.614169291401, 10348.793024139324, 11408.258463199865, 11563.42182890869, 11617.709557261136, 11635.360055197045], "value": 9687.880501453541, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.3118778235319, 1506.7815166800817, 1675.3298680527787, 1890.4517689869938, 1931.449536881988, 8488.61801218945, 9075.682351117712, 9096.363254572174, 9098.772530686736, 9110.772230694236, 6931.0, 7885.645145968431, 8164.387670924675, 8621.396502244845, 8865.778355541115, 2366.195493532203, 2410.529946660402, 2410.9758902411013, 2414.082648593541, 2421.9273421797375, 2374.95250094998, 2398.4723360860585, 2416.637504374349, 2420.092465325503, 2420.4311986683115, 2093.7068810366486, 2157.4498502881743, 2187.223535644847, 2323.9883800581056, 2391.485830546432, 2387.3912152401113, 2402.1712509184476, 2406.482606239667, 2413.0347860855622, 2413.903443862261, 2367.195153647768, 2404.4589967257402, 2405.5910495215853, 2407.542566912281, 2410.240774156135, 8997.280217582578, 9063.728088157366, 9071.228945539637, 9079.818403631956, 9094.363394562382, 5324.733763311819, 5383.407825139231, 5462.644928079662, 5472.781088756445, 5482.150266708627, 3540.929181416383, 3621.728370372233, 3741.289155060557, 3744.7753134811996, 3755.1363186467265, 1077.978440431195, 1086.0768346905147, 1092.049916572579, 1114.5876025870398, 1120.6077872744556, 9995.400275983464, 11812.114091443176, 11974.580889668907, 11975.760484790255, 11997.820032699516, 4634.2585186370015, 4648.86053418398, 4869.756512174377, 4875.146849301429, 4879.585235254972, 10180.98190180976, 10193.745156371002, 10194.592216311414, 10197.439140847324, 10202.132818710492, 5428.321459817523, 5430.5927055471, 5431.266778984866, 5435.048866448435, 5437.184422336682, 4784.68899521537, 4923.75381230937, 4968.677035992649, 4972.5276098770555, 4987.750612469362, 3262.314913868114, 3766.717496187742, 3816.9121800286784, 3826.4642949987024, 3854.7494412863075, 1137.3517095255625, 1138.0952143046297, 1153.2388623508612, 1158.0851127609262, 1173.906087512997, 610.404855266112, 747.1146691170871, 747.3535391885979, 801.3148757812103, 895.1540793949786, 5733.0540460823495, 5741.167530708024, 5913.201717768132, 6021.819345419644, 6260.780872669435, 803.7186984555476, 907.863820426928, 926.402470406584, 946.8295706772709, 955.0640372435053, 3730.3887278904876, 3883.650471457526, 3916.9020774480296, 3976.980115099406, 4019.91960160801, 10429.68710938673, 10576.735581610368, 10714.46427678613, 10716.464176791129, 10719.946400267949, 10364.948175259226, 10600.04599586041, 10609.204309676805, 10619.734506637396, 10821.080208182393, 8182.427230093956, 8416.0, 8431.57842107892, 8433.493990360597, 8441.324694024463, 5532.474414930575, 5567.498925096599, 5569.693666848362, 5727.8568035799435, 5746.9712651436475, 9553.23574114083, 9584.616615335308, 9596.328257021942, 9612.615495380107, 9632.518374081408, 8945.865812012955, 8998.865017024618, 9477.336586438883, 9493.620255189991, 9785.0, 7476.476646634901, 7565.2812982766545, 7634.160242373224, 7757.92242077572, 7759.107702614272, 8201.0, 8254.42219044685, 8270.007599087907, 8275.54484503358, 8278.172182781673, 7484.775456736306, 7601.3918886487845, 7626.9618651906385, 7740.690372385042, 7756.263155000266, 7338.70645174187, 7434.665440055102, 7463.514871533333, 7479.476436649382, 7537.472376933562, 6995.895061573979, 7003.509754317352, 7003.789886303419, 7010.158780946319, 7072.752453664097, 4821.927671085006, 4946.876328091683, 4956.553910148104, 4961.627877909099, 5067.290579318825, 4934.7285899275885, 5001.724905130252, 5040.773165207648, 5098.974505127599, 5110.897782044264], "value": 4565.952700958154, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [253.77794429873862, 277.6626398925306, 298.4091498832312, 300.05632286459087, 312.2178941750914, 4340.652747780178, 5096.884792810979, 5312.362516498021, 5337.9199312010305, 5400.918986215205, 5077.238414237866, 5131.538161565459, 5199.272101905736, 5218.956208758244, 5257.764425360037, 3643.599204087548, 3932.9577661919616, 4065.288574499451, 4070.3487442009286, 4091.6112969267947, 3358.4122778513783, 3539.7168226541944, 3644.719752222994, 3701.576615943948, 3729.7948612826285, 3128.530720391948, 3778.5465744110747, 3977.4090363854402, 3986.70099742519, 4039.6364327210545, 3939.9212015759667, 3968.3849003404516, 3988.262171498282, 3988.5612582615745, 4036.495438070241, 2873.5833304170988, 3484.61669216386, 3485.5817301923676, 3491.2668339648703, 3492.7904325740537, 4743.857684269477, 5072.974635126838, 5108.514691104339, 5141.974290128563, 5143.562797162245, 4201.873943781691, 4245.896067022565, 4581.244094724367, 4589.472210695746, 4605.815767369301, 4812.783424745895, 5564.221009058735, 5572.080606699889, 5578.44215578443, 5638.0, 3302.669733026678, 3526.4181410067563, 3754.9812250938844, 3836.8848934532007, 3862.6909847212155, 5014.323066386028, 5755.330998966015, 5840.299164100293, 5903.970480147572, 5945.038137414643, 3255.5930508686415, 3880.864169754045, 3892.2410130024373, 3901.1027463683513, 3901.2782635212575, 3504.7196224301993, 3535.4343305071066, 3832.494747455687, 3935.8032098394965, 3943.901402464904, 3804.0, 4544.500104988449, 4564.931526027112, 4577.588017078412, 4581.327815347374, 4655.557722016403, 4683.953160468352, 5563.5271001964475, 5582.106862901916, 5645.633033852787, 1249.4627310256676, 1290.8773666501854, 1291.12203701482, 1292.2504947130642, 1311.206719934445, 850.4812064640564, 864.7967727584013, 897.5467388968659, 900.9189172974463, 903.1645727701981, 5211.609129315317, 5257.369115706063, 5267.841964741064, 5306.09796334624, 5327.0, 4465.843695470643, 5425.945740542623, 5744.310682718101, 5784.59507834456, 5787.189793428924, 4655.952410707564, 4729.483343407038, 5092.745362731848, 5099.59203263738, 5126.462401111474, 2657.2958166086005, 2959.5708622250086, 3015.4722923488303, 3016.0, 3036.832974186441, 5202.479752024768, 5669.688167150846, 5900.911486327708, 5964.224650795456, 6006.579539432285, 5766.221560089334, 5872.911906321408, 5937.584369094208, 5950.672713000827, 5971.701414929236, 4986.725730084808, 5097.949020509822, 5570.415106413769, 5928.258967629046, 5964.493018093511, 5501.78960628661, 5804.0, 5805.76776928935, 5813.447722466359, 5843.766249349978, 4714.999999999863, 4999.350084488993, 5647.322321321303, 5652.7738890443925, 5659.745311460912, 4657.69724967876, 4745.217039188496, 5356.491133342326, 5580.693061881636, 5908.438698323653, 3043.599944025773, 3506.965445193623, 3511.894643160709, 3808.733388662878, 3809.504764380613, 4934.679245849008, 5187.455317191791, 5634.830955071355, 5646.661200327829, 5654.067078932095, 4358.3244597087505, 4922.926156107733, 5043.949560504348, 5483.039158854174, 5559.388467268516, 4591.9540804591525, 4852.379714954027, 5520.227168196376, 5536.695481748381, 5552.806146678484, 5186.325777648882, 5224.981128679871, 5315.734213289397, 5362.0, 5362.624616276823, 4693.319468677091, 4837.790552361909, 4893.559579637849, 5414.512693857571, 5577.96807590597, 4577.382053422745, 4780.880477988078, 5199.0, 5318.441563635763, 5455.863603409946], "value": 3994.073992645865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.7046425733321, 758.0183662157506, 779.3336697123959, 788.992110078899, 826.80983373824, 15132.470363537279, 15942.681146377066, 16500.174991250435, 16506.50480485586, 16941.0, 14759.92620036901, 15149.242537873117, 15157.242137893116, 15181.696366072672, 15193.164375959317, 667.622793121887, 687.0998991321385, 829.3613917283703, 840.2395831772255, 840.9621567029499, 678.5826716569298, 825.7770401991459, 848.4442690038035, 853.2917678327004, 860.6471346747835, 897.6229983406952, 900.594732370436, 901.0223907060814, 901.6438506789814, 903.5346796399859, 897.3539051882634, 897.9102089791033, 898.1018981018981, 898.9730308090735, 899.1143723432414, 518.541091134345, 537.3390729402856, 639.9648019358933, 655.701655746639, 661.0711949710665, 15095.773563396559, 15144.242787860563, 15160.772588411182, 15168.848311516855, 15190.924045379812, 12612.369381530887, 13229.140105893086, 14002.29988500581, 14078.788818167735, 14137.363818628186, 11218.551257949672, 11287.830682539769, 11577.479013444416, 11789.528418863236, 11905.940470297679, 4428.512863585003, 4633.305004249356, 4647.37260469839, 4791.544803243686, 4793.3049707792525, 85874.57062714708, 110131.44934275358, 111497.44251278773, 115293.0, 116510.0, 10066.0, 10081.69754907354, 10609.893901061045, 11005.504752286166, 11117.332960022424, 20944.581108377748, 20946.162153513687, 20978.2657606983, 20981.370558882954, 21007.15971361159, 7874.448788584744, 8026.5986700664735, 8218.21926916942, 8266.297364724065, 8392.538410387366, 3341.5823022122236, 4507.752073635916, 4515.14212299662, 4519.276915693474, 4572.039871626929, 3645.434957581579, 3804.600516945736, 3811.5807261201244, 3815.73289869712, 3817.3701339279264, 679.67035987546, 681.877262092828, 683.5522732610149, 695.4401706626113, 702.3292755418563, 503.70029832249753, 537.979369231527, 543.2611648158502, 571.6227289988587, 620.1534904854841, 8442.0, 9307.72076837696, 9402.858461034653, 9436.386634868712, 9640.084192001748, 639.9328070552525, 662.8044726805604, 672.9795723899665, 680.9071440338186, 686.6566716641679, 4301.612854843079, 4432.911341773147, 4612.838550650711, 4643.117807616542, 4643.791029403685, 124661.37669311595, 153486.0, 157450.0, 160362.0, 178488.0, 80573.0, 82695.17304826874, 104523.0, 123081.0, 136317.63682363048, 106908.46545767221, 109496.35755463675, 113865.0, 114047.0, 117638.0, 9156.496392698466, 9821.116099551075, 9828.508574571386, 9845.0, 9884.308098433328, 61020.69489652523, 61662.0, 63421.0, 63863.29435409215, 65428.0, 95035.52482237545, 96811.0, 97110.0, 100286.9799114055, 101701.49149254503, 12554.246745195318, 12669.0, 12837.743245135232, 13130.540431085248, 13441.327933603476, 14010.229437381042, 14399.280035998368, 14719.264036797904, 14778.0, 15610.853004982859, 10774.569017239222, 14009.43962241499, 14179.503717370255, 14721.484748033767, 14723.484678036217, 13230.867691322963, 13696.564450043878, 14216.431342746175, 14395.136291822524, 14834.77747833805, 12507.56223532172, 13770.586882393543, 13953.790693139814, 13979.580612581638, 14118.788218176942, 11017.504212310305, 11200.38397888124, 11457.59898403552, 11563.6530904073, 12539.623811285675, 10793.892061079288, 11451.599194028502, 11584.362860042442, 11604.0, 11756.647300580997], "value": 7845.148132876729, "unit": "score"}], "name": "dromaeo_css", "value": 7357.967254962683, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 137.0, 165.0, 130.0, 113.0, 119.0, 113.0, 120.0, 166.0, 155.0], "value": 133.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 135.0, 110.0, 142.0, 112.0, 109.0, 109.0, 109.0, 142.0, 107.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 186.0, 184.0, 184.0, 185.0, 185.0, 185.0, 186.0, 185.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 60.0, 59.0, 93.0, 79.0, 84.0, 82.0, 70.0, 84.0, 58.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 73.0, 96.0, 69.0, 68.0, 69.0, 92.0, 67.0, 68.0, 90.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 84.0, 87.0, 85.0, 95.0, 85.0, 87.0, 83.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 98.0, 96.0, 101.0, 146.0, 162.0, 97.0], "value": 108.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 95.0, 128.0, 87.0, 84.0, 84.0, 96.0, 132.0, 86.0, 84.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 52.0, 55.0, 56.0, 57.0, 56.0, 56.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 72.0, 83.0, 77.0, 75.0, 70.0, 72.0, 73.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 84.0, 85.0, 86.0, 86.0, 86.0, 84.0, 90.0, 90.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 128.0, 155.0, 153.0, 157.0, 137.0, 142.0, 176.0, 140.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 164.0, 168.0, 169.0, 168.0, 170.0, 228.0, 205.0, 168.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 88.0, 89.0, 86.0, 89.0, 66.0, 68.0, 67.0, 67.0], "value": 76.4, "unit": "score"}], "name": "kraken", "value": 1502.0, "alertThreshold": 2.0}]} 06:38:34 INFO - Return code: 0 06:38:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:38:34 INFO - # TBPL SUCCESS # 06:38:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:38:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:38:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:38:34 INFO - 2016-11-11 06:38:34.081 screenresolution[7037:122310] starting screenresolution argv=screenresolution get 06:38:34 INFO - 2016-11-11 06:38:34.084 screenresolution[7037:122310] Display 0: 1600x1200x32@60 06:38:34 INFO - 2016-11-11 06:38:34.090 screenresolution[7038:122313] starting screenresolution argv=screenresolution list 06:38:34 INFO - Available Modes on Display 0 06:38:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:38:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:38:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:38:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:38:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:38:34 INFO - Intel Iris: 06:38:34 INFO - Chipset Model: Intel Iris 06:38:34 INFO - Type: GPU 06:38:34 INFO - Bus: Built-In 06:38:34 INFO - VRAM (Dynamic, Max): 1536 MB 06:38:34 INFO - Vendor: Intel (0x8086) 06:38:34 INFO - Device ID: 0x0a2e 06:38:34 INFO - Revision ID: 0x0009 06:38:34 INFO - Displays: 06:38:34 INFO - Display: 06:38:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:38:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:38:34 INFO - Display Serial Number: 1600x1200 60 06:38:34 INFO - Main Display: Yes 06:38:34 INFO - Mirror: Off 06:38:34 INFO - Online: Yes 06:38:34 INFO - Rotation: Supported 06:38:34 INFO - Return code: 0 06:38:34 INFO - Running post-action listener: _resource_record_post_action 06:38:34 INFO - [mozharness: 2016-11-11 14:38:34.324144Z] Finished run-tests step (success) 06:38:34 INFO - Running post-run listener: _resource_record_post_run 06:38:34 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 1118208; Write bytes: 665001984; Read time: 7; Write time: 1957 06:38:34 INFO - TinderboxPrint: CPU usage
53.2% 06:38:34 INFO - TinderboxPrint: I/O read bytes / time
1,118,208 / 7 06:38:34 INFO - TinderboxPrint: I/O write bytes / time
665,001,984 / 1,957 06:38:34 INFO - TinderboxPrint: CPU idle
2,269.3 (46.8%) 06:38:34 INFO - TinderboxPrint: CPU system
973.0 (20.1%) 06:38:34 INFO - TinderboxPrint: CPU user
1,603.3 (33.1%) 06:38:34 INFO - TinderboxPrint: Swap in / out
364,126,208 / 0 06:38:34 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355473920; Write bytes: 356460544; Read time: 27574; Write time: 765 06:38:34 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 1118208; Write bytes: 298379264; Read time: 7; Write time: 1160 06:38:34 INFO - Running post-run listener: _upload_blobber_files 06:38:34 INFO - Blob upload gear active. 06:38:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:38:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:38:34 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'] 06:38:34 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 06:38:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:38:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:38:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:38:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:36 INFO - (blobuploader) - INFO - Done attempting. 06:38:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:38:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:38:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:37 INFO - (blobuploader) - INFO - Done attempting. 06:38:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:38:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:38:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:39 INFO - (blobuploader) - INFO - Done attempting. 06:38:39 INFO - (blobuploader) - INFO - Iteration through files over. 06:38:39 INFO - Return code: 0 06:38:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:38:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:38:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f3662b9a1c20475f903565e5b4dd47c5c53bd4b72be3aefaf612e1b4071dc4aa961c8f579d2a575b3c1e8cd7f27a4303ba2bdcd10d061a553798465e4b0e5e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/729e30d7f381f5dc3995940b3c6e171eb22307cc9bd5277a96daa84fccca4833446d8cb7ff85b5bf2f8ee8ea165c584a5dec55d740a6eec8981dd3234e4e9c32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8c8bfc883cdd6d27413bb29f36bdd08f310fdb5f4106e44378b9f4a535b0d04ab07fdc4e45b655c2adb17ef547b4622f6d1196b9832f0285758cedf5db0a2cd"} 06:38:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:38:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:38:39 INFO - Contents: 06:38:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f3662b9a1c20475f903565e5b4dd47c5c53bd4b72be3aefaf612e1b4071dc4aa961c8f579d2a575b3c1e8cd7f27a4303ba2bdcd10d061a553798465e4b0e5e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/729e30d7f381f5dc3995940b3c6e171eb22307cc9bd5277a96daa84fccca4833446d8cb7ff85b5bf2f8ee8ea165c584a5dec55d740a6eec8981dd3234e4e9c32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8c8bfc883cdd6d27413bb29f36bdd08f310fdb5f4106e44378b9f4a535b0d04ab07fdc4e45b655c2adb17ef547b4622f6d1196b9832f0285758cedf5db0a2cd"} 06:38:39 INFO - Running post-run listener: copy_logs_to_upload_dir 06:38:39 INFO - Copying logs to upload dir... 06:38:39 INFO - mkdir: /builds/slave/test/build/upload/logs 06:38:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.424163 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-11 06:38:39.434411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 06:38:39.437596) ========= 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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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/3f3662b9a1c20475f903565e5b4dd47c5c53bd4b72be3aefaf612e1b4071dc4aa961c8f579d2a575b3c1e8cd7f27a4303ba2bdcd10d061a553798465e4b0e5e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/729e30d7f381f5dc3995940b3c6e171eb22307cc9bd5277a96daa84fccca4833446d8cb7ff85b5bf2f8ee8ea165c584a5dec55d740a6eec8981dd3234e4e9c32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8c8bfc883cdd6d27413bb29f36bdd08f310fdb5f4106e44378b9f4a535b0d04ab07fdc4e45b655c2adb17ef547b4622f6d1196b9832f0285758cedf5db0a2cd"} build_url:https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/DhyRGAdbTnm0uqlyBg-K0g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f3662b9a1c20475f903565e5b4dd47c5c53bd4b72be3aefaf612e1b4071dc4aa961c8f579d2a575b3c1e8cd7f27a4303ba2bdcd10d061a553798465e4b0e5e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/729e30d7f381f5dc3995940b3c6e171eb22307cc9bd5277a96daa84fccca4833446d8cb7ff85b5bf2f8ee8ea165c584a5dec55d740a6eec8981dd3234e4e9c32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8c8bfc883cdd6d27413bb29f36bdd08f310fdb5f4106e44378b9f4a535b0d04ab07fdc4e45b655c2adb17ef547b4622f6d1196b9832f0285758cedf5db0a2cd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 06:38:39.470270) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:38:39.470645) ========= 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.QyRJUqgrrT/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.Vg7UCsxuty/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.005643 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:38:39.526340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 06:38:39.526714) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 06:38:39.527102) ========= ========= Total master_lag: 0.30 =========