builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0113 starttime: 1484858877.4 results: success (0) buildid: 20170119071129 builduid: c70f3fdf1f924acab3275675a44e0caf revision: a3978751f45108ff1ae002ecebdc0fa23fc52b84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.402591) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.402927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.403184) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.460370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.460950) ========= 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.nHhAgdYk7R/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.t1THEXZzRA/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-19 12:47:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 179M=0s 2017-01-19 12:47:58 (179 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.572636 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:58.066588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:58.067231) ========= 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.nHhAgdYk7R/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.t1THEXZzRA/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.026517 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:58.119234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 12:47:58.120005) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a3978751f45108ff1ae002ecebdc0fa23fc52b84 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a3978751f45108ff1ae002ecebdc0fa23fc52b84 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nHhAgdYk7R/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.t1THEXZzRA/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-19 12:47:58,231 truncating revision to first 12 chars 2017-01-19 12:47:58,231 Setting DEBUG logging. 2017-01-19 12:47:58,231 attempt 1/10 2017-01-19 12:47:58,231 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a3978751f451?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 12:47:59,332 unpacking tar archive at: mozilla-central-a3978751f451/testing/mozharness/ program finished with exit code 0 elapsedTime=1.375226 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 12:47:59.532459) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:59.532790) ========= script_repo_revision: a3978751f45108ff1ae002ecebdc0fa23fc52b84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:59.533199) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:59.533509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:59.559858) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-01-19 12:47:59.560275) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nHhAgdYk7R/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.t1THEXZzRA/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 12:47:59 INFO - MultiFileLogger online at 20170119 12:47:59 in /builds/slave/test 12:47:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:47:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:47:59 INFO - {'append_to_log': False, 12:47:59 INFO - 'base_work_dir': '/builds/slave/test', 12:47:59 INFO - 'blob_upload_branch': 'Firefox', 12:47:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:47:59 INFO - 'branch': 'Firefox', 12:47:59 INFO - 'buildbot_json_path': 'buildprops.json', 12:47:59 INFO - 'config_files': ('talos/mac_config.py',), 12:47:59 INFO - 'default_actions': ('clobber', 12:47:59 INFO - 'read-buildbot-config', 12:47:59 INFO - 'download-and-extract', 12:47:59 INFO - 'populate-webroot', 12:47:59 INFO - 'create-virtualenv', 12:47:59 INFO - 'install', 12:47:59 INFO - 'run-tests'), 12:47:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:47:59 INFO - 'download_minidump_stackwalk': True, 12:47:59 INFO - 'download_symbols': 'ondemand', 12:47:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:47:59 INFO - 'tooltool.py': '/tools/tooltool.py', 12:47:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:47:59 INFO - '/tools/misc-python/virtualenv.py')}, 12:47:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:47:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:47:59 INFO - 'installer_path': 'installer.exe', 12:47:59 INFO - 'log_level': 'info', 12:47:59 INFO - 'log_name': 'talos', 12:47:59 INFO - 'log_to_console': True, 12:47:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:47:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:47:59 INFO - 'opt_config_files': (), 12:47:59 INFO - 'pip_index': False, 12:47:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:59 INFO - 'cmd': ('bash', 12:47:59 INFO - '-c', 12:47:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:59 INFO - 'enabled': True, 12:47:59 INFO - 'halt_on_failure': False, 12:47:59 INFO - 'name': 'check_screen_resolution'},), 12:47:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:59 INFO - 'cmd': ('bash', 12:47:59 INFO - '-c', 12:47:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:59 INFO - 'enabled': True, 12:47:59 INFO - 'halt_on_failure': False, 12:47:59 INFO - 'name': 'check_screen_resolution'},), 12:47:59 INFO - 'run_cmd_checks_enabled': True, 12:47:59 INFO - 'sps_profile': False, 12:47:59 INFO - 'sps_profile_interval': 0, 12:47:59 INFO - 'suite': 'dromaeojs', 12:47:59 INFO - 'system_bits': '32', 12:47:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:47:59 INFO - 'title': 't-yosemite-r7-0113', 12:47:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:47:59 INFO - 'use_talos_json': True, 12:47:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:47:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:47:59 INFO - 'work_dir': 'build'} 12:47:59 INFO - [mozharness: 2017-01-19 20:47:59.782163Z] Running clobber step. 12:47:59 INFO - Running pre-action listener: _resource_record_pre_action 12:47:59 INFO - Running main action method: clobber 12:47:59 INFO - rmtree: /builds/slave/test/build 12:47:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:48:02 INFO - Running post-action listener: _resource_record_post_action 12:48:02 INFO - [mozharness: 2017-01-19 20:48:02.212592Z] Finished clobber step (success) 12:48:02 INFO - [mozharness: 2017-01-19 20:48:02.212702Z] Running read-buildbot-config step. 12:48:02 INFO - Running pre-action listener: _resource_record_pre_action 12:48:02 INFO - Running main action method: read_buildbot_config 12:48:02 INFO - Using buildbot properties: 12:48:02 INFO - { 12:48:02 INFO - "project": "", 12:48:02 INFO - "product": "firefox", 12:48:02 INFO - "script_repo_revision": "production", 12:48:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:48:02 INFO - "repository": "", 12:48:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:48:02 INFO - "buildid": "20170119071129", 12:48:02 INFO - "pgo_build": "False", 12:48:02 INFO - "basedir": "/builds/slave/test", 12:48:02 INFO - "buildnumber": 119, 12:48:02 INFO - "slavename": "t-yosemite-r7-0113", 12:48:02 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:48:02 INFO - "platform": "yosemite_r7", 12:48:02 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:48:02 INFO - "branch": "mozilla-central", 12:48:02 INFO - "repo_path": "mozilla-central", 12:48:02 INFO - "revision": "a3978751f45108ff1ae002ecebdc0fa23fc52b84", 12:48:02 INFO - "stage_platform": "macosx64", 12:48:02 INFO - "builduid": "c70f3fdf1f924acab3275675a44e0caf", 12:48:02 INFO - "slavebuilddir": "test" 12:48:02 INFO - } 12:48:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 12:48:02 INFO - Running post-action listener: _resource_record_post_action 12:48:02 INFO - [mozharness: 2017-01-19 20:48:02.215829Z] Finished read-buildbot-config step (success) 12:48:02 INFO - [mozharness: 2017-01-19 20:48:02.215932Z] Running download-and-extract step. 12:48:02 INFO - Running pre-action listener: _resource_record_pre_action 12:48:02 INFO - Running main action method: download_and_extract 12:48:02 INFO - mkdir: /builds/slave/test/build/tests 12:48: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')]} 12:48:02 INFO - trying https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 12:48:02 INFO - Downloading https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 12:48:03 INFO - Downloaded 1199 bytes. 12:48:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:48:03 INFO - Using the following test package requirements: 12:48:03 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:48:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 12:48:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 12:48:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'jsshell-mac.zip'], 12:48:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 12:48:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:48:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 12:48:03 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 12:48:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 12:48:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 12:48:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:48:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:48:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:48:03 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:48:05 INFO - Expected file size: 16340629 12:48:05 INFO - Obtained file size: 16340629 12:48:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:48:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:48:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:48:12 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:48:15 INFO - Expected file size: 16340629 12:48:15 INFO - Obtained file size: 16340629 12:48:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 12:48:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:48:21 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 12:48:24 INFO - Expected file size: 14403463 12:48:24 INFO - Obtained file size: 14403463 12:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:24 INFO - trying https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:48:24 INFO - Downloading https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 12:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 12:48:28 INFO - Downloaded 69915509 bytes. 12:48:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:48:28 INFO - mkdir: /builds/slave/test/properties 12:48:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:48:28 INFO - Writing to file /builds/slave/test/properties/build_url 12:48:28 INFO - Contents: 12:48:28 INFO - build_url:https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:48:29 INFO - Running post-action listener: _resource_record_post_action 12:48:29 INFO - Running post-action listener: set_extra_try_arguments 12:48:29 INFO - [mozharness: 2017-01-19 20:48:29.580030Z] Finished download-and-extract step (success) 12:48:29 INFO - [mozharness: 2017-01-19 20:48:29.580155Z] Running populate-webroot step. 12:48:29 INFO - Running pre-action listener: _resource_record_pre_action 12:48:29 INFO - Running main action method: populate_webroot 12:48:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:48:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:48:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:48:29 INFO - '--tppagecycles', 12:48:29 INFO - '7'], 12:48:29 INFO - 'tests': ['tsvgm']}}, 12:48:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:48:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:48:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:48:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:48:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:48:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:48:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'talos_options': ['--disable-e10s'], 12:48:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'talos_options': ['--disable-e10s'], 12:48:29 INFO - 'tests': ['damp', 'tps']}, 12:48:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'tests': ['damp', 'tps']}, 12:48:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:48:29 INFO - 'tests': ['dromaeo_dom']}, 12:48:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:48:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:48:29 INFO - 'tests': ['basic_compositor_video']}, 12:48:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:48:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:48:29 INFO - 'tests': ['a11yr', 12:48:29 INFO - 'ts_paint', 12:48:29 INFO - 'tpaint', 12:48:29 INFO - 'sessionrestore', 12:48:29 INFO - 'sessionrestore_no_auto_restore', 12:48:29 INFO - 'tabpaint']}, 12:48:29 INFO - 'other-e10s': {'tests': ['a11yr', 12:48:29 INFO - 'ts_paint', 12:48:29 INFO - 'tpaint', 12:48:29 INFO - 'sessionrestore', 12:48:29 INFO - 'sessionrestore_no_auto_restore', 12:48:29 INFO - 'tabpaint']}, 12:48:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:48:29 INFO - 'ts_paint', 12:48:29 INFO - 'tpaint', 12:48:29 INFO - 'sessionrestore', 12:48:29 INFO - 'sessionrestore_no_auto_restore', 12:48:29 INFO - 'tabpaint']}, 12:48:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:48:29 INFO - 'ts_paint', 12:48:29 INFO - 'tpaint', 12:48:29 INFO - 'sessionrestore', 12:48:29 INFO - 'sessionrestore_no_auto_restore', 12:48:29 INFO - 'tabpaint']}, 12:48:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:48:29 INFO - 'tests': ['a11yr', 12:48:29 INFO - 'ts_paint', 12:48:29 INFO - 'tpaint', 12:48:29 INFO - 'sessionrestore', 12:48:29 INFO - 'sessionrestore_no_auto_restore', 12:48:29 INFO - 'tabpaint']}, 12:48:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:48:29 INFO - 'tests': ['a11yr', 12:48:29 INFO - 'ts_paint', 12:48:29 INFO - 'tpaint', 12:48:29 INFO - 'sessionrestore', 12:48:29 INFO - 'sessionrestore_no_auto_restore', 12:48:29 INFO - 'tabpaint']}, 12:48:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:48:29 INFO - 'tests': ['tsvgx', 12:48:29 INFO - 'tsvgr_opacity', 12:48:29 INFO - 'tart', 12:48:29 INFO - 'tscrollx', 12:48:29 INFO - 'cart', 12:48:29 INFO - 'tsvg_static']}, 12:48:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:48:29 INFO - 'tsvgr_opacity', 12:48:29 INFO - 'tart', 12:48:29 INFO - 'tscrollx', 12:48:29 INFO - 'cart', 12:48:29 INFO - 'tsvg_static']}, 12:48:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'talos_options': ['--disable-e10s'], 12:48:29 INFO - 'tests': ['tp5o']}, 12:48:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:48:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'talos_options': ['--disable-e10s', 12:48:29 INFO - '--xperf_path', 12:48:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:29 INFO - 'tests': ['tp5n']}, 12:48:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'talos_options': ['--xperf_path', 12:48:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:29 INFO - 'tests': ['tp5n']}}, 12:48:29 INFO - 'talos.zip': {'path': '', 12:48:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:48:29 INFO - Running post-action listener: _resource_record_post_action 12:48:29 INFO - [mozharness: 2017-01-19 20:48:29.599421Z] Finished populate-webroot step (success) 12:48:29 INFO - [mozharness: 2017-01-19 20:48:29.599533Z] Running create-virtualenv step. 12:48:29 INFO - Running pre-action listener: _resource_record_pre_action 12:48:29 INFO - Running main action method: create_virtualenv 12:48:29 INFO - Creating virtualenv /builds/slave/test/build/venv 12:48:29 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 12:48:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:48:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:48:29 INFO - Using real prefix '/tools/python27' 12:48:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:48:30 INFO - Installing distribute.............................................................................................................................................................................................done. 12:48:33 INFO - Installing pip.................done. 12:48:33 INFO - Return code: 0 12:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:48:33 INFO - Reading from file tmpfile_stdout 12:48:33 INFO - Output received: 12:48:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:48:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:48:33 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')]} 12:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:33 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')]} 12:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:33 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 0x10fcf1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a2cac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10facfd30>, '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 0x10f9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fac4be8>, '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.nHhAgdYk7R/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.t1THEXZzRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 12:48:33 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 12:48:33 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 12:48:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHhAgdYk7R/Render', 12:48:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:33 INFO - 'HOME': '/Users/cltbld', 12:48:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:33 INFO - 'LOGNAME': 'cltbld', 12:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:33 INFO - 'MOZ_NO_REMOTE': '1', 12:48:33 INFO - 'NO_EM_RESTART': '1', 12:48:33 INFO - 'PAGER': '/bin/cat', 12:48:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:33 INFO - 'PWD': '/builds/slave/test', 12:48:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:33 INFO - 'SHELL': '/bin/bash', 12:48:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t1THEXZzRA/Listeners', 12:48:33 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 12:48:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:33 INFO - 'USER': 'cltbld', 12:48:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:33 INFO - 'XPC_FLAGS': '0x0', 12:48:33 INFO - 'XPC_SERVICE_NAME': '0', 12:48:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:33 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 12:48:33 INFO - Cleaning up... 12:48:33 INFO - Return code: 0 12:48:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:48:33 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')]} 12:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:33 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')]} 12:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:33 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 0x10fcf1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a2cac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10facfd30>, '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 0x10f9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fac4be8>, '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.nHhAgdYk7R/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.t1THEXZzRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 12:48:33 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 12:48:33 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 12:48:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHhAgdYk7R/Render', 12:48:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:33 INFO - 'HOME': '/Users/cltbld', 12:48:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:33 INFO - 'LOGNAME': 'cltbld', 12:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:33 INFO - 'MOZ_NO_REMOTE': '1', 12:48:33 INFO - 'NO_EM_RESTART': '1', 12:48:33 INFO - 'PAGER': '/bin/cat', 12:48:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:33 INFO - 'PWD': '/builds/slave/test', 12:48:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:33 INFO - 'SHELL': '/bin/bash', 12:48:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t1THEXZzRA/Listeners', 12:48:33 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 12:48:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:33 INFO - 'USER': 'cltbld', 12:48:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:33 INFO - 'XPC_FLAGS': '0x0', 12:48:33 INFO - 'XPC_SERVICE_NAME': '0', 12:48:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:34 INFO - Downloading/unpacking psutil>=3.1.1 12:48:34 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 12:48:34 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 12:48:34 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 12:48:34 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 12:48:34 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 12:48:34 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 12:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:48:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:38 INFO - Installing collected packages: psutil 12:48:38 INFO - Running setup.py install for psutil 12:48:38 INFO - building 'psutil._psutil_osx' extension 12:48:38 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 12:48:39 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 12:48:39 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 12:48:39 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 12:48:39 INFO - building 'psutil._psutil_posix' extension 12:48:39 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 12:48:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:48:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:48:39 INFO - ^ 12:48:39 INFO - 1 warning generated. 12:48:39 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 12:48:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:40 INFO - Successfully installed psutil 12:48:40 INFO - Cleaning up... 12:48:40 INFO - Return code: 0 12:48:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:48:40 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')]} 12:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:40 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')]} 12:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:40 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 0x10fcf1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a2cac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10facfd30>, '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 0x10f9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fac4be8>, '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.nHhAgdYk7R/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.t1THEXZzRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 12:48:40 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 12:48:40 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 12:48:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHhAgdYk7R/Render', 12:48:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:40 INFO - 'HOME': '/Users/cltbld', 12:48:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:40 INFO - 'LOGNAME': 'cltbld', 12:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:40 INFO - 'MOZ_NO_REMOTE': '1', 12:48:40 INFO - 'NO_EM_RESTART': '1', 12:48:40 INFO - 'PAGER': '/bin/cat', 12:48:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:40 INFO - 'PWD': '/builds/slave/test', 12:48:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:40 INFO - 'SHELL': '/bin/bash', 12:48:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t1THEXZzRA/Listeners', 12:48:40 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 12:48:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:40 INFO - 'USER': 'cltbld', 12:48:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:40 INFO - 'XPC_FLAGS': '0x0', 12:48:40 INFO - 'XPC_SERVICE_NAME': '0', 12:48:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:48:40 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 12:48:40 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 12:48:40 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 12:48:40 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 12:48:40 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 12:48:40 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 12:48:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:48:43 INFO - Installing collected packages: mozsystemmonitor 12:48:43 INFO - Running setup.py install for mozsystemmonitor 12:48:43 INFO - Successfully installed mozsystemmonitor 12:48:43 INFO - Cleaning up... 12:48:43 INFO - Return code: 0 12:48:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:43 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 0x10fcf1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a2cac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10facfd30>, '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 0x10f9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fac4be8>, '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.nHhAgdYk7R/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.t1THEXZzRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 12:48:43 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 12:48:43 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 12:48:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHhAgdYk7R/Render', 12:48:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:43 INFO - 'HOME': '/Users/cltbld', 12:48:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:43 INFO - 'LOGNAME': 'cltbld', 12:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:43 INFO - 'MOZ_NO_REMOTE': '1', 12:48:43 INFO - 'NO_EM_RESTART': '1', 12:48:43 INFO - 'PAGER': '/bin/cat', 12:48:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:43 INFO - 'PWD': '/builds/slave/test', 12:48:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:43 INFO - 'SHELL': '/bin/bash', 12:48:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t1THEXZzRA/Listeners', 12:48:43 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 12:48:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:43 INFO - 'USER': 'cltbld', 12:48:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:43 INFO - 'XPC_FLAGS': '0x0', 12:48:43 INFO - 'XPC_SERVICE_NAME': '0', 12:48:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:43 INFO - Downloading/unpacking jsonschema==2.5.1 12:48:43 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 12:48:43 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 12:48:43 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 12:48:43 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 12:48:43 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 12:48:43 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 12:48:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:48:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:46 INFO - Downloading functools32-3.2.3-2.tar.gz 12:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:48:46 INFO - warning: no files found matching '*.txt' 12:48:46 INFO - no previously-included directories found matching 'build' 12:48:46 INFO - no previously-included directories found matching 'dist' 12:48:46 INFO - no previously-included directories found matching '.git*' 12:48:46 INFO - Installing collected packages: jsonschema, functools32 12:48:46 INFO - Running setup.py install for functools32 12:48:46 INFO - warning: no files found matching '*.txt' 12:48:46 INFO - no previously-included directories found matching 'build' 12:48:46 INFO - no previously-included directories found matching 'dist' 12:48:46 INFO - no previously-included directories found matching '.git*' 12:48:46 INFO - Successfully installed jsonschema functools32 12:48:46 INFO - Cleaning up... 12:48:46 INFO - Return code: 0 12:48:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:47 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 0x10fcf1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a2cac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10facfd30>, '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 0x10f9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fac4be8>, '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.nHhAgdYk7R/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.t1THEXZzRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 12:48:47 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 12:48:47 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 12:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHhAgdYk7R/Render', 12:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:47 INFO - 'HOME': '/Users/cltbld', 12:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:47 INFO - 'LOGNAME': 'cltbld', 12:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:47 INFO - 'MOZ_NO_REMOTE': '1', 12:48:47 INFO - 'NO_EM_RESTART': '1', 12:48:47 INFO - 'PAGER': '/bin/cat', 12:48:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:47 INFO - 'PWD': '/builds/slave/test', 12:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:47 INFO - 'SHELL': '/bin/bash', 12:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t1THEXZzRA/Listeners', 12:48:47 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 12:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:47 INFO - 'USER': 'cltbld', 12:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:47 INFO - 'XPC_FLAGS': '0x0', 12:48:47 INFO - 'XPC_SERVICE_NAME': '0', 12:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:48:47 INFO - Cleaning up... 12:48:47 INFO - Return code: 0 12:48:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:47 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 0x10fcf1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a2cac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10facfd30>, '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 0x10f9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fac4be8>, '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.nHhAgdYk7R/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.t1THEXZzRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 12:48:47 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 12:48:47 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 12:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHhAgdYk7R/Render', 12:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:47 INFO - 'HOME': '/Users/cltbld', 12:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:47 INFO - 'LOGNAME': 'cltbld', 12:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:47 INFO - 'MOZ_NO_REMOTE': '1', 12:48:47 INFO - 'NO_EM_RESTART': '1', 12:48:47 INFO - 'PAGER': '/bin/cat', 12:48:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:47 INFO - 'PWD': '/builds/slave/test', 12:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:47 INFO - 'SHELL': '/bin/bash', 12:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t1THEXZzRA/Listeners', 12:48:47 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 12:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:47 INFO - 'USER': 'cltbld', 12:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:47 INFO - 'XPC_FLAGS': '0x0', 12:48:47 INFO - 'XPC_SERVICE_NAME': '0', 12:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:47 INFO - Downloading/unpacking blobuploader==1.2.4 12:48:47 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 12:48:47 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 12:48:47 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 12:48:47 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 12:48:47 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 12:48:47 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 12:48:50 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:48:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:48:50 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 12:48:50 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 12:48:50 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 12:48:50 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 12:48:50 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 12:48:50 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 12:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:48:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:48:50 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 12:48:50 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 12:48:50 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 12:48:50 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 12:48:50 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 12:48:50 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 12:48:51 INFO - Downloading docopt-0.6.1.tar.gz 12:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:48:51 INFO - Installing collected packages: blobuploader, requests, docopt 12:48:51 INFO - Running setup.py install for blobuploader 12:48:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:48:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:48:51 INFO - Running setup.py install for requests 12:48:52 INFO - Running setup.py install for docopt 12:48:52 INFO - Successfully installed blobuploader requests docopt 12:48:52 INFO - Cleaning up... 12:48:52 INFO - Return code: 0 12:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:52 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')]} 12:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:52 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')]} 12:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:52 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 0x10fcf1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a2cac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10facfd30>, '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 0x10f9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fac4be8>, '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.nHhAgdYk7R/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.t1THEXZzRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 12:48:52 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 12:48:52 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 12:48:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHhAgdYk7R/Render', 12:48:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:52 INFO - 'HOME': '/Users/cltbld', 12:48:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:52 INFO - 'LOGNAME': 'cltbld', 12:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:52 INFO - 'MOZ_NO_REMOTE': '1', 12:48:52 INFO - 'NO_EM_RESTART': '1', 12:48:52 INFO - 'PAGER': '/bin/cat', 12:48:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:52 INFO - 'PWD': '/builds/slave/test', 12:48:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:52 INFO - 'SHELL': '/bin/bash', 12:48:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t1THEXZzRA/Listeners', 12:48:52 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 12:48:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:52 INFO - 'USER': 'cltbld', 12:48:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:52 INFO - 'XPC_FLAGS': '0x0', 12:48:52 INFO - 'XPC_SERVICE_NAME': '0', 12:48:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:52 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-yeZAK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:52 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-3Afq09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:52 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-v6VHXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:52 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-7cpkTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:53 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-qhBecS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:53 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-0FBg9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:53 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-NoYRin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:53 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-CWPD2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:53 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-ZjGiZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:53 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-Fy94Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:53 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-FUXxEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:53 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-OOpXqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:53 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-Am9894-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:54 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-dUZpMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:54 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-rREExf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:54 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-PZ4aYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:54 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-D0D6VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:48:54 INFO - Running setup.py install for manifestparser 12:48:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:48:54 INFO - Running setup.py install for mozcrash 12:48:54 INFO - Running setup.py install for mozdebug 12:48:54 INFO - Running setup.py install for mozdevice 12:48:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:48:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:48:55 INFO - Running setup.py install for mozfile 12:48:55 INFO - Running setup.py install for mozhttpd 12:48:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:48:55 INFO - Running setup.py install for mozinfo 12:48:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:48:55 INFO - Running setup.py install for mozInstall 12:48:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:48:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:48:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:48:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:48:55 INFO - Running setup.py install for mozleak 12:48:55 INFO - Running setup.py install for mozlog 12:48:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:48:55 INFO - Running setup.py install for moznetwork 12:48:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:48:56 INFO - Running setup.py install for mozprocess 12:48:56 INFO - Running setup.py install for mozprofile 12:48:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:48:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:48:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:48:56 INFO - Running setup.py install for mozrunner 12:48:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:48:56 INFO - Running setup.py install for mozscreenshot 12:48:56 INFO - Running setup.py install for moztest 12:48:56 INFO - Running setup.py install for mozversion 12:48:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:48:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:48:56 INFO - Cleaning up... 12:48:56 INFO - Return code: 0 12:48:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:56 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')]} 12:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:56 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')]} 12:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:56 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 0x10fcf1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a2cac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10facfd30>, '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 0x10f9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fac4be8>, '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.nHhAgdYk7R/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.t1THEXZzRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 12:48:56 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 12:48:56 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 12:48:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHhAgdYk7R/Render', 12:48:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:56 INFO - 'HOME': '/Users/cltbld', 12:48:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:56 INFO - 'LOGNAME': 'cltbld', 12:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:56 INFO - 'MOZ_NO_REMOTE': '1', 12:48:56 INFO - 'NO_EM_RESTART': '1', 12:48:56 INFO - 'PAGER': '/bin/cat', 12:48:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:56 INFO - 'PWD': '/builds/slave/test', 12:48:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:56 INFO - 'SHELL': '/bin/bash', 12:48:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t1THEXZzRA/Listeners', 12:48:56 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 12:48:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:56 INFO - 'USER': 'cltbld', 12:48:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:56 INFO - 'XPC_FLAGS': '0x0', 12:48:56 INFO - 'XPC_SERVICE_NAME': '0', 12:48:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:57 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-WbiFWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:57 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)) 12:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:57 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-o8XJUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:57 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-oiqSp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:57 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)) 12:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:57 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-vZuLPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:57 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-SV_Y5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:57 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)) 12:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:57 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-lleKjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:57 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)) 12:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:57 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-khSyv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:57 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)) 12:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:57 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-ctm23i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:58 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)) 12:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:58 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-XuhBJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:58 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)) 12:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:58 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-XnGN3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:58 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)) 12:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:58 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-XNeEMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:58 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)) 12:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:58 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-xlqAe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:58 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-WzKRL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:58 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)) 12:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:58 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-XsLeuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:58 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-gs9Osl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:58 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)) 12:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:58 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-eDdEZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:58 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-WC6DiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:58 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)) 12:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:48:58 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)) 12:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:48:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:49:01 INFO - Downloading blessings-1.6.tar.gz 12:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:49:01 INFO - Installing collected packages: blessings 12:49:01 INFO - Running setup.py install for blessings 12:49:01 INFO - Successfully installed blessings 12:49:01 INFO - Cleaning up... 12:49:02 INFO - Return code: 0 12:49:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:49:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:49:02 INFO - Reading from file tmpfile_stdout 12:49:02 INFO - Current package versions: 12:49:02 INFO - blessings == 1.6 12:49:02 INFO - blobuploader == 1.2.4 12:49:02 INFO - docopt == 0.6.1 12:49:02 INFO - functools32 == 3.2.3-2 12:49:02 INFO - jsonschema == 2.5.1 12:49:02 INFO - manifestparser == 1.1 12:49:02 INFO - mozInstall == 1.12 12:49:02 INFO - mozcrash == 1.0 12:49:02 INFO - mozdebug == 0.1 12:49:02 INFO - mozdevice == 0.49 12:49:02 INFO - mozfile == 1.2 12:49:02 INFO - mozhttpd == 0.7 12:49:02 INFO - mozinfo == 0.9 12:49:02 INFO - mozleak == 0.1 12:49:02 INFO - mozlog == 3.4 12:49:02 INFO - moznetwork == 0.27 12:49:02 INFO - mozprocess == 0.24 12:49:02 INFO - mozprofile == 0.28 12:49:02 INFO - mozrunner == 6.13 12:49:02 INFO - mozscreenshot == 0.1 12:49:02 INFO - mozsystemmonitor == 0.3 12:49:02 INFO - moztest == 0.8 12:49:02 INFO - mozversion == 1.4 12:49:02 INFO - psutil == 3.1.1 12:49:02 INFO - requests == 1.2.3 12:49:02 INFO - wsgiref == 0.1.2 12:49:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:49: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')]} 12:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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')]} 12:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:02 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 0x10fcf1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a2cac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10facfd30>, '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 0x10f9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fac4be8>, '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.nHhAgdYk7R/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.t1THEXZzRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 12:49:02 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 12:49:02 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 12:49:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHhAgdYk7R/Render', 12:49:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:49:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:49:02 INFO - 'HOME': '/Users/cltbld', 12:49:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:49:02 INFO - 'LOGNAME': 'cltbld', 12:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:02 INFO - 'MOZ_NO_REMOTE': '1', 12:49:02 INFO - 'NO_EM_RESTART': '1', 12:49:02 INFO - 'PAGER': '/bin/cat', 12:49:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:02 INFO - 'PWD': '/builds/slave/test', 12:49:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:49:02 INFO - 'SHELL': '/bin/bash', 12:49:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t1THEXZzRA/Listeners', 12:49:02 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 12:49:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:49:02 INFO - 'USER': 'cltbld', 12:49:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:49:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:02 INFO - 'XPC_FLAGS': '0x0', 12:49:02 INFO - 'XPC_SERVICE_NAME': '0', 12:49:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:02 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)) 12:49:02 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)) 12:49:02 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)) 12:49:02 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)) 12:49:02 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)) 12:49:02 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)) 12:49:02 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)) 12:49:02 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)) 12:49:02 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)) 12:49:02 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)) 12:49:02 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)) 12:49:02 INFO - Cleaning up... 12:49:02 INFO - Return code: 0 12:49:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:49: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')]} 12:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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')]} 12:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a2cac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10facfd30>, '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 0x10f9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fac4be8>, '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.nHhAgdYk7R/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.t1THEXZzRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 12:49: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'] in /builds/slave/test/build 12:49: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 12:49:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHhAgdYk7R/Render', 12:49:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:49:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:49:02 INFO - 'HOME': '/Users/cltbld', 12:49:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:49:02 INFO - 'LOGNAME': 'cltbld', 12:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:02 INFO - 'MOZ_NO_REMOTE': '1', 12:49:02 INFO - 'NO_EM_RESTART': '1', 12:49:02 INFO - 'PAGER': '/bin/cat', 12:49:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:02 INFO - 'PWD': '/builds/slave/test', 12:49:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:49:02 INFO - 'SHELL': '/bin/bash', 12:49:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t1THEXZzRA/Listeners', 12:49:02 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 12:49:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:49:02 INFO - 'USER': 'cltbld', 12:49:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:49:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:02 INFO - 'XPC_FLAGS': '0x0', 12:49:02 INFO - 'XPC_SERVICE_NAME': '0', 12:49:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:49:02 INFO - Cleaning up... 12:49:02 INFO - Return code: 0 12:49:02 INFO - Running post-action listener: _resource_record_post_action 12:49:02 INFO - Running post-action listener: _start_resource_monitoring 12:49:02 INFO - Starting resource monitoring. 12:49:02 INFO - [mozharness: 2017-01-19 20:49:02.870005Z] Finished create-virtualenv step (success) 12:49:02 INFO - [mozharness: 2017-01-19 20:49:02.870936Z] Running install step. 12:49:02 INFO - Running pre-action listener: _resource_record_pre_action 12:49:02 INFO - Running main action method: install 12:49:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:49:03 INFO - Reading from file tmpfile_stdout 12:49:03 INFO - Detecting whether we're running mozinstall >=1.0... 12:49:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:49:03 INFO - Reading from file tmpfile_stdout 12:49:03 INFO - Output received: 12:49:03 INFO - Usage: mozinstall [options] installer 12:49:03 INFO - Options: 12:49:03 INFO - -h, --help show this help message and exit 12:49:03 INFO - -d DEST, --destination=DEST 12:49:03 INFO - Directory to install application into. [default: 12:49:03 INFO - "/builds/slave/test"] 12:49:03 INFO - --app=APP Application being installed. [default: firefox] 12:49:03 INFO - mkdir: /builds/slave/test/build/application 12:49:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:49:25 INFO - Reading from file tmpfile_stdout 12:49:25 INFO - Output received: 12:49:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:49:25 INFO - Running post-action listener: _resource_record_post_action 12:49:25 INFO - [mozharness: 2017-01-19 20:49:25.178768Z] Finished install step (success) 12:49:25 INFO - [mozharness: 2017-01-19 20:49:25.178935Z] Running run-tests step. 12:49:25 INFO - Running pre-action listener: _resource_record_pre_action 12:49:25 INFO - Running main action method: run_tests 12:49:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:49:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:49:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:49:25 INFO - 2017-01-19 12:49:25.193 screenresolution[1631:8380] starting screenresolution argv=screenresolution get 12:49:25 INFO - 2017-01-19 12:49:25.196 screenresolution[1631:8380] Display 0: 1600x1200x32@60 12:49:25 INFO - 2017-01-19 12:49:25.201 screenresolution[1632:8383] starting screenresolution argv=screenresolution list 12:49:25 INFO - Available Modes on Display 0 12:49:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:49:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:49:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:49:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:49:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:49:25 INFO - Intel Iris: 12:49:25 INFO - Chipset Model: Intel Iris 12:49:25 INFO - Type: GPU 12:49:25 INFO - Bus: Built-In 12:49:25 INFO - VRAM (Dynamic, Max): 1536 MB 12:49:25 INFO - Vendor: Intel (0x8086) 12:49:25 INFO - Device ID: 0x0a2e 12:49:25 INFO - Revision ID: 0x0009 12:49:25 INFO - Displays: 12:49:25 INFO - Display: 12:49:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:49:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:49:25 INFO - Display Serial Number: 1600x1200 60 12:49:25 INFO - Main Display: Yes 12:49:25 INFO - Mirror: Off 12:49:25 INFO - Online: Yes 12:49:25 INFO - Rotation: Supported 12:49:25 INFO - Return code: 0 12:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:49:25 INFO - Python 2.7.3 12:49:25 INFO - Return code: 0 12:49:25 INFO - grabbing minidump binary from tooltool 12:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:25 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 0x10facfd30>, '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 0x10f9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fac4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:49:25 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 12:49:25 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 12:49:25 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 12:49:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:49:25 INFO - Return code: 0 12:49:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:49:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:49:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:49:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:49:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0113', '--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 12:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0113 --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 12:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHhAgdYk7R/Render', 12:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:49:25 INFO - 'HOME': '/Users/cltbld', 12:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:49:25 INFO - 'LOGNAME': 'cltbld', 12:49:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:49:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:25 INFO - 'MOZ_NO_REMOTE': '1', 12:49:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:49:25 INFO - 'NO_EM_RESTART': '1', 12:49:25 INFO - 'PAGER': '/bin/cat', 12:49:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:25 INFO - 'PWD': '/builds/slave/test', 12:49:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:49:25 INFO - 'SHELL': '/bin/bash', 12:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t1THEXZzRA/Listeners', 12:49:25 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 12:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:49:25 INFO - 'USER': 'cltbld', 12:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:25 INFO - 'XPC_FLAGS': '0x0', 12:49:25 INFO - 'XPC_SERVICE_NAME': '0', 12:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:49:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0113', '--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 12:49:25 INFO - mozversion application_buildid: 20170119071129 12:49:25 INFO - mozversion application_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 12:49:25 INFO - mozversion application_display_name: Nightly 12:49:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:49:25 INFO - mozversion application_name: Firefox 12:49:25 INFO - mozversion application_remotingname: firefox 12:49:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:49:25 INFO - mozversion application_vendor: Mozilla 12:49:25 INFO - mozversion application_version: 53.0a1 12:49:25 INFO - mozversion platform_buildid: 20170119071129 12:49:25 INFO - mozversion platform_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 12:49:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:49:25 INFO - mozversion platform_version: 53.0a1 12:49:25 INFO - using testdate: 1484858965 12:49:25 INFO - actual date: 1484858965 12:49:25 INFO - starting webserver on 'localhost:49245' 12:49:25 INFO - SUITE-START | Running 2 tests 12:49:25 INFO - TEST-START | dromaeo_css 12:49:25 INFO - operating with platform_type : mac_ 12:49:25 INFO - Initialising browser for dromaeo_css test... 12:49:25 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmp7ZHyAr/profile http://localhost:49245/getInfo.html) 12:49:28 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 12:49:28 INFO - PROCESS | 1642 | colorDepth:24 12:49:28 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 12:49:28 INFO - PROCESS | 1642 | __metrics 12:49:28 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:49:28 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:49:29 INFO - TEST-INFO | 1642: exit 0 12:49:29 INFO - Browser initialized. 12:49:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:49:29 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmp7ZHyAr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:49:41 INFO - PROCESS | 1645 | RSS: Main: 235589632 12:49:41 INFO - PROCESS | 1645 | 12:52:44 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 12:52:46 INFO - PROCESS | 1645 | RSS: Main: 376303616 12:52:46 INFO - PROCESS | 1645 | 12:54:31 INFO - PROCESS | 1645 | ************************* 12:54:31 INFO - PROCESS | 1645 | A coding exception was thrown and uncaught in a Task. 12:54:31 INFO - PROCESS | 1645 | 12:54:31 ERROR - PROCESS | 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:54:31 INFO - PROCESS | 1645 | Full stack: 12:54:31 INFO - PROCESS | 1645 | ************************* 12:55:49 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 12:55:50 INFO - PROCESS | 1645 | RSS: Main: 369623040 12:55:50 INFO - PROCESS | 1645 | 12:58:52 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 12:58:53 INFO - PROCESS | 1645 | RSS: Main: 363716608 12:58:53 INFO - PROCESS | 1645 | 13:01:55 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 13:01:56 INFO - PROCESS | 1645 | RSS: Main: 333881344 13:01:56 INFO - PROCESS | 1645 | 13:04:59 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 13:05:00 INFO - PROCESS | 1645 | RSS: Main: 325873664 13:05:00 INFO - PROCESS | 1645 | 13:08:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 13:08:03 INFO - PROCESS | 1645 | RSS: Main: 392110080 13:08:03 INFO - PROCESS | 1645 | 13:08:03 INFO - PROCESS | 1645 | __start_tp_report 13:08:03 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 13:08:03 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 13:08:03 INFO - PROCESS | 1645 | |i|pagename|runs| 13:08:03 INFO - PROCESS | 1645 | |0;dojo.html;3310.8013519188844;3331.90004299871;3337.46600543913;3361.344537815124;3402.676745709157;5501.752421141048;5605.1592261160795;5615.298087739033;5646.604737668365;5649.0679037958735;5590.972045139769;5615.410381909902;5616.719164041802;5623.718814059291;5635.098384258519;4043.353063509839;5077.035363280974;5094.235864620299;5114.667546609477;5213.608979326546;5163.63854530183;5199.68801871887;5204.141316682742;5244.580433565325;5248.895022099556;5199.948000519984;5202.661826981234;5213.983273261715;5218.086834803913;5225.111731005719;581.1082083473755;5126.974365128151;5136.614753893473;5202.531772140525;5245.10833158364;4412.580804823537;5152.4847515248175;5178.5857131429775;5186.351706036746;5193.169092945149;4683.976580117078;5490.588205884575;5633.549316054706;5634.887302253973;5645.068563686987;6011.4289142531825;6208.689565521706;6211;6220.782272620437;6224.190855188796;6116.3053375860445;6145.477634401082;6200.038993955944;6255.530835187334;6258.4680302174365;5754.367019627837;5764.106563482625;5768.653880767168;5781.508571771446;5816.1275808628625;6241.906371404432;6274.964630835952;6279.277883043417;6295.37046295376;6305.684715764193;5867.002609556385;5909.320428150818;6017.428344307371;6025.9153352396115;6081.27024757032;6167.105769663373;6204.534659900525;6210.31686514483;6212.285587157445;6224.37756224383;6147.815565533041;6157.199564056734;6162.414570615784;6162.506999440034;6167.753289868355;5986.880262394728;6109.450149486567;6113.445900579344;6128.877422451526;6169.8457538561;4232.513260975027;4909.484504127086;4921.680090794087;4931.506849315111;4960.107180707435;4304.988327743041;4379.671524635665;4387.451568553931;4398.890027749332;4428.2914733642465;5596.804111856147;5610.607257491936;5654.321481422256;5669.092945128759;5681.488666019995;6173.888700034037;6195;6201.782937597162;6212.81361559154;6215.502759779207;5648.152777083388;5682.602217844794;5692;5699.715014249271;5732.6847023413275;5170.276161337416;5284.392294886137;5291.1798671206025;5352.2506849041165;5353.598480114007;6236.469900058546;6250.937490625036;6277.372262773686;6339.492840572835;6342.39747224013;6192.473639740672;6210.068489726577;6219.844503887439;6222.09779581949;6230.626162430269;6163.537734670007;6280.937190628035;6292.2134733158355;6316.905246421215;6340.112384266298;6009.098635204754;6057.909131362945;6073.5748497604745;6097.939020609737;6144.924638188389;6212.596181248205;6223.595466294676;6223.844403889939;6227.937720622917;6229.626222426487;5983.461488466059;5983.970080149571;6021.488173505301;6021.563234883828;6057.242844644419;5165.431802501646;5649.406812284651;5900.822975310747;5921.2006379138265;5948.643081415129;5841.795537156179;5845.795397161079;5848.473637372486;5862.530997520103;5882.1470886722045;6001.669908155093;6008.579399441997;6031.035034394476;6031.185789918305;6032.668203248863;4869.87825304356;5645.830625081254;5663.207150998781;5762.740676669476;5786.508146807569 13:08:03 INFO - PROCESS | 1645 | |1;ext.html;472.6549618778292;493.5089585862068;496.2308421945985;503.275283591628;512.4542362384062;30915.38169236617;32432.351352972957;40263.79868100663;42054.36918446218;42437.36343954843;43056.569434305646;43116;43240.13519729611;43415;43623;9255.907440925572;9462.195713364372;9465.958744538095;9468.715938521855;9476.715698529055;8452.366072544553;8681.869771953427;11175.944120279388;11446.942765286161;11470.770584588303;11352.205345625809;11418.543258269701;11424.143189260798;11442.199046066778;11444.599439019636;11271.26736762112;11332.716682082932;11346.773064538746;11350.659480215607;11366.545338186505;8334.541600211985;8552.61513231906;9308.44149351041;11235.382053987027;11256.493457794419;40998.79500602508;41255.174896502205;41450.58549414497;41574;41809.372859407136;4000.299947509174;4045.878623641266;4047.1298670785923;4061.8578349757913;4194.475690538683;30062.24844378886;30431.543526847116;31233.37533249345;31302;31407;3146.606674165729;3214.8714051437914;3296.96703032969;3320.9501857472155;3366.1416338833687;351266;351540;351740;352112.99999999744;352941;61710.69144654338;61757.38242617606;62014.689926550076;62025.689871550356;62066;64412.35587644157;64989.501049894636;65057;65119.34880651227;65401.69196616041;15513;15996.68006639884;15998.840011599968;16012.839871601134;16031.438899638457;11144.33134011962;12340;12433;12446.626601201979;12449.502019919282;11812.527498899948;14573.125612463286;14992.025518341274;16297.674046519003;16665.91667041657;7375.635507431142;7502.17476077631;7539.698412063566;7578.355839753683;7600.885986710204;873.7640836973982;884.9911500885038;889.1419779912416;917.6696389299847;927.4249965021595;27730.31138944829;30398.696013039586;32189.195270117965;34790.47814282788;34891.82554087264;959.8080383923243;1079.9352038877535;1098.522142867855;1099.71957150926;1182.2374568403332;15199.392024319124;15400.922995385175;15931.601709957113;16027.919860400623;16069.576318519119;634246;642333;646459;646911;648443;61992.69003654953;62619;62704;62857;62941;1497.1989985357782;1508.3287936868207;1510.358097808427;1541.3295216580823;1543.668111356064;29778.553321699757;30311.393772124877;30586;31027.53458698076;31166.22084447907;53716.73141634423;53724.46275537195;53749.19376209438;53885.730571346896;54199.18701219564;591287;591895;592219;592581;593308;31726.682733172373;37311.06722331963;38943.610563894;41653.375199371425;42751;34060.31879362349;41885;44181.55818441903;45764;46267.76866115648;35328.47007294944;35921.28157436889;35936;36982.26035479329;36999.44500832436;35684.821575891954;36102.63897360993;36775.89672309835;37435.62564374322;37443.06392340214;35031.29937401289;35648.4652730204;36276.81861590675;36400;36580.53677852856;31315.373692525565;32350.35299294048;32391.028269151964;32679.85620503271;32981.17547061247;23079.76920230776;24028.87985560061;24061.27816165518;24077.152312922142;24308.75691243065 13:08:03 INFO - PROCESS | 1645 | |2;jquery.html;340.58788865472786;382.74356181358485;385.9713862556288;405.62479706271694;412.0666689947268;20084;22175.11299548016;22245.332640020784;22323.665145022816;22608.20871269504;18009.459716208534;21104.261350852725;21470.89264553679;22167.44581385462;22477.100915963343;5628.43715628437;5872.060470324749;5925.229720136376;5968.522518198555;5999.400059994009;4238.97880510597;4398.846040388587;5769.480746732793;5873.353931067579;5880.529557635379;6267.4986001119805;6506.577072490273;6577.506686998494;6632.2704502504685;6657.400833924946;6410.358964103622;6598.86802263952;6620.404163625273;6653.634050127241;6686.7993960181275;5620.578456615729;5835.620684655484;5850.414958504158;5851.561132915006;5886.20536227608;20396.796032039638;26556.86721566399;26580;26960.59559106615;26983.32541686454;3118.4875335462284;3137.6391714952842;3149.7952633078776;3152.7793054486197;3166.319241363095;12863.42114604845;15707.293171807296;15843.683126337408;16272.349106035745;16340.509784706477;1821.225978958937;1858.9163487643089;1891.9054047297718;1893.1575448925234;1936.2835750772163;126517.36741316327;128564.35717821444;129056;130422.3478882609;130533.34733326368;9225.308101892386;11409.60066397672;11514.712132196762;11547.884521154681;11804.88195118055;14641.267936603128;14684.339204735812;14690.412383504754;14695.559133226021;14698.412063517553;6932.306769323028;8597.18326758957;8781.121887811169;8796.07641197678;8850.070742571937;8636.093210212963;8644.913550864536;8678.696245631372;8832.77918052041;8858.247049000778;6300.8658441480975;7139.143302803697;7240.984829644367;7249.309484070142;7266.108266493025;1745.3280487012591;1805.816020251769;1846.547595839028;1921.8846869187894;1921.9519512012032;897.7127319257775;968.2694800662065;1030.5517100061347;1036.2073014144187;1089.1559041742712;18421.078946052643;21270.46823829417;22632.020955389788;22637.547249054925;22682.546349073255;898.8719157457349;1029.8455231715302;1032.2670903658486;1057.8519007338978;1071.1002757683584;10784.514696838503;11013.449327533592;11824.645260642195;11826.526938922347;11877.465514051888;722552;725495.372523134;733349;754697;759838;162351.376486236;167544.4449977586;168467;170216;171070.14464927596;998.5157198758596;1032.2877214721818;1034.8447732839984;1063.0963680871198;1070.3684825952569;19163.425097247105;20197.990100494622;20304.390868273975;20619;20697.379078627666;53502.66243343947;55356;62303.37696622976;63570.046449304224;63823.34119905455;95257;95609;96468.55297170408;96564.51717741367;96718;8162.265396114378;8248;8475.533845638549;8654.350923680624;8774.605142768718;7868.567228802471;12607.621771346874;12959.092863499465;13286.734265314833;13627.182369057491;11288.94355528217;11430.828537571777;11623;11626.418679066182;11700.765984680089;6027.728752206249;10907.146854264916;11421.200515963803;11616.361100139573;11834.112441566745;10029;11524.769504609692;11548.48031838586;11877.643670689893;11986.46060927243;7425.554466732014;7643.388528917784;8498.065212826708;8520.190581894958;8600.913990860012;10877.347359158475;11372.251705837729;11458.197926145423;11597.130215233723;11682.70793230176 13:08:03 INFO - PROCESS | 1645 | |3;mootools.html;1410.9050584659258;1439.4314245872881;1448.3699590678052;1460.153111195506;1467.4937146684395;7210.891836622448;8036.437449378546;8461.746147615566;8473.830523389528;8488.61801218945;7385.5568665879955;7691;7692.346150577194;7768.805779855506;7769.7669069928;2093.3196711068927;2235.7876001779805;2312.6877871487304;2314.52345989791;2328.836981411302;2290.4159439342943;2316.6061769499142;2325.430269583954;2327.5810354136247;2332.3935776698013;2302.194232018797;2326.5114325991563;2327.045911176418;2329.534093181362;2331.7901388875;2281.6577513372963;2307.204014614955;2307.4462129088897;2309.6766452696634;2311.4452531392512;2267.5918334699745;2317.2816426907543;2336.719593648756;2338.1348900906605;2338.4504641409253;8373.874391884126;8417.705380311721;8440.915590844135;8455.069942306342;8460.78848028798;4999.075171093359;5152.845414637567;5156.458571849939;5162.070827251093;5170.819021334235;3305.636379998198;3443.896683099511;3450.344434557426;3465.2722928185112;3481.2515309208643;1163.2264544078262;1212;1250.2311078686632;1259.4017841525294;1263.7346157306977;10313.639022634246;10724.839127413095;10744.78510429795;10764.407957562331;10896.945515272451;4329.740215587075;4397.582229688239;4521.638268938477;4540.954590454119;4545.636349092065;8669.21977022071;8675.175858293578;8684.78288042804;8695.913040869636;8703.6518539259;5131.897362052738;5136.332276803992;5138.2806407103035;5138.486151384906;5155.02054609623;4285.400043993781;4552.840650577214;4688.695234809727;4736.905261894743;4777.187878060738;3464.133966508373;3506.1234691327168;3593.9820300898327;3708.647678470541;3713.2759111972905;1078.1751959750798;1118.697951553076;1144.5364627325946;1158.9652310430702;1161.0769438296575;662.211967758366;844.1305455380967;887.2857349833446;895.2658819767859;946.8721722567503;4644.674872758875;5009.499050095034;5608.439156084441;5630.183623374588;5981.820545383645;998.7053819123377;999.4103478947311;1004.9296549241483;1048.339546085961;1053.7997780421695;3826.2730081284467;3949.8420063197723;4027.979860100739;4043.130726893732;4148.62662360389;9942.900570994341;9967.252456065678;10147.898521014842;10153.695389138338;10155.441450720133;9914.752131196778;9955.352902061488;10079.5464204111;10105.949470252748;10109.191264698806;7648.73229436967;7816.960915195387;7872.134065252818;8028.07677117139;8046.436749427484;5370.677759334452;5645.322561292507;5687.402822703557;5716.714164291686;6094.847628809315;8995.010548839753;9043.547822608974;9146.862797058182;9160.58777355034;9308.627654893728;9184.12750788674;9374;9389.577469014048;9510.667126650535;9525.428474291564;7136.357727804315;7294.978702981481;7321.63391830417;7321.74373896911;7323.12122545298;6500.544961852814;7207.9279207207255;8045.839083218186;8093.231143041402;8178.713745018896;7307.086614173229;7426.777196684108;7501.174870764103;7519;7567.735129270449;7260.201377848538;7291.708331666674;7401.48189626721;7410;7452.850942981218;6365.299817020216;6396.9040464394;6446.7098980546925;6454.1609590752905;6481.222253329631;4987.47631498702;5024.070546948826;5032.723200224023;5073.949260507347;5173.017126745906;4291.442112525352;4917.827876024322;5011.924821127759;5086.949130508648;5145.716985565829 13:08:03 INFO - PROCESS | 1645 | |4;prototype.html;314.2254343044396;335.9109835893487;343.10278621405035;362.3785208367649;367.00358526600274;4437.911241775162;4950.208256340082;5044.016416798717;5219.556337711294;5294.867628309295;4185.958140418595;4333.523312435637;5143.434222235561;5178.5339319461245;5190.506901844328;4081.3265811141127;4086.264472394968;4088.7546747195115;4091.9181616367655;4113.547509773923;3780.8846390314784;4110.938335924963;4111.814968326433;4118.876433706993;4139.875803725893;3195.664455232202;3751.224094170308;3978.622030907059;4076.5923407659143;4106.733062350952;3628.838771593091;4045.4538637283886;4059.7970101494807;4077.55146933837;4101.2207680540605;3077.753779697619;3084.7686423518103;3383;3574.124339536804;3653.4337177737493;4340.110277393127;4805.639577031737;5083.161278389061;5112.769925353368;5180.689158650455;4700.905981880377;4710.576048155648;4713.34013238147;4714.434267887841;4754.904901901942;5463.251759436982;5483.424240454735;5490.004096272412;5502.422245664187;5530.917036244459;3543.344481270973;3558.928821423557;3883.9223215535812;4012.29784787661;4040.393940908858;4835.162638197462;5630.493255606974;5747.626404283708;5751.511121554673;5758.251427314464;3572.4641303804638;4090.629639070885;4109.623276202446;4113.8813511041835;4135.56576559463;3905.7461265017682;4065.654419374386;4215;4219;4240.236757383639;4130.256553820341;4705.411823522059;4712.976435117871;4748.548887855648;4760.928586071212;4561.521040290788;5103.958416633376;5233.39815921174;5528.838943821843;5601.80393686219;1119.7928383249125;1224.6448529926222;1318.0575888239762;1336.7059246965653;1342.812006319116;898.7124120281578;935.2471260635253;940.8004793887711;975.2149519636619;979.0111986893147;4545.954540454553;4671.439427268681;4863.975680121577;4880.097182021266;4904.828331008398;4438.866833994985;5011.57401620859;5208.619715775322;5333.839794883079;5388.326459192601;4494.887627809331;4556.11155824611;4806.711597304173;4877.707337559757;4880.707157570557;2328.5808554460023;2635.89456421741;2736.986315068412;2790.372166262575;2793.385455199853;4479.955200447954;4926.581240594518;5053.772580233898;5169.81905633301;5620.662760234399;4506.932396014063;4719.914419683423;5114.207297868837;5281.55106815925;5540.86147846299;4777.641676874248;4931.901361972812;5473.261109750133;5597.3003374578175;5602.355729091207;4508.346289787897;4641.118187544355;4773.6156514610375;5019.222020586815;5153.45888681698;4577.667017924081;5220.929709409638;5239.738013099406;5263.552448111646;5273.947260527346;5061.493850614909;5554.638948468337;5561.416051314553;5594.888102237851;5602.831915042555;3095.7059079387423;3561.7889917428197;3646.997075804175;3780.2061567070123;3903.40423618302;4392.033752574429;4550.863474095782;5309.177077552986;5321.3348331458565;5335.519803217729;4933.333999909966;5089.9745501272255;5114.5652619527755;5146.044503088802;5156.329677142097;4601.37881386022;4707.411573553306;4713.599344055794;5051.787570983011;5146.305248791366;3921.9607803921594;4228.767417792051;5004.524570165829;5014.047331007243;5222.138347172674;4378.6278166356215;5008.549230569266;5036.917062831509;5230.476952304739;5281.841544753664;4479.955200448084;4537.8411755588395;4754.786034628381;4876.317670403705;4957.4794646561595 13:08:03 INFO - PROCESS | 1645 | |5;yui.html;726.5858460677409;758.586570319176;774.7056118674902;821.57688790273;826.3884725303276;14732.042417242872;15597.532074037768;15642.139682317467;15646.765298520517;15668.373265069398;12127.878721212785;14343;14485.348159332829;14512.492062777805;14529.200893950829;689.5173378634963;712.508369225233;846.3440833354139;861;863.2317237658489;870.1820288928387;874.3005595523588;874.9475031498099;878.7978764884049;884.2395539835736;929.6281487405058;931.2456909902967;933.4026223217146;935.4013431403907;936.3398803843274;718.9712411503533;924.6440120553568;927.3879239701798;932.5011119051275;932.9673461428852;549.0391814324931;676.9120014398097;693.1681981622023;695.7390978383106;695.9512834101615;15221.467248646244;15225.238738063052;15250.542483725507;15260.923695381563;15287.464938727091;13621.455141794415;13649.522266720616;13711.862881371158;13758.93120534391;13842.723145537133;12105.394730263451;12124.757504849853;12158.817617735742;12217.266963982102;12455.190412623151;3654.177809992757;3830.80845957701;4058.9188216235807;4151.875443736692;4292.699511034229;70205;92473.68815779591;95498;96484;96535;10557.208209384327;10698.197635177237;10984.945075274733;11167.162462815322;11187.944060279646;18231.90884045571;21170.47073823136;21681.891590542262;21764.564708705737;21804.890975545022;7610.1628820829665;7682;7780.18308077655;7791.376689864797;7885.329746971457;4195.559466256061;4260.8508702195895;4269.274223382033;4295;4303;3386.6274709781906;3449.5688038995127;3477.704395126392;3530.0998245447245;3576.8748093816594;663.9004149377536;666.1805978646292;666.9566478179;677.864427114579;679.0052572980608;591.5740666719955;615.7561725314928;630.9400606942334;645.141961191614;660.5310229736845;8399.286060684788;9355.859662105075;9382.718518444457;9577.856332155023;10039.648612298535;597.1192491075716;640.478010421505;642.4474951541671;643.9871202575922;680.4828330468879;4436.6228870546365;4755.38180036593;4779.139754844162;4793.904121917542;4801.663883528189;106871;108333.83332333309;109470;109799;110381;93910;95179.52410237904;95347;96783;99285;68142;73048.63475682588;73665.6316718413;74105.14737131508;75986;7646.74421045804;9064.456132632064;9324.533773311443;9408.43549387039;9514.90485095168;49148.50851491439;50308.74845625748;50364.49635503598;51998.96002080013;52912.735436322575;44348.55651443573;55595.16607250975;67536.29854805753;68504.62990740257;70457;11185.776284474428;11414.429278535874;11572.479238434122;11627.418629068343;12016.399180041139;10466.738331541468;12046.277223366626;12176;12412.255264683787;12705.42825572833;11834;11844.881551184379;11849.229800062969;12007.81988270194;12274.509019639114;11847.703807404883;11851.585194518151;11862.762744745229;11889.881101188877;11894.821577676168;11699.766004680028;11748.29510229389;11754.412279386168;11774.116941229271;11797.233179843282;9879.95060024724;9982.901880793252;10020.549075291483;10076.546555404877;10157.39055656663;8785.516796575994;9282.58228379711;9350.812983740423;9391.718248452557;9543.618255269988 13:08:03 INFO - PROCESS | 1645 | __end_tp_report 13:08:03 INFO - PROCESS | 1645 | __start_cc_report 13:08:03 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1408 13:08:03 INFO - PROCESS | 1645 | __end_cc_report 13:08:03 INFO - PROCESS | 1645 | __startTimestamp1484860083515__endTimestamp 13:08:03 INFO - PROCESS | 1645 | 13:08:03 INFO - PROCESS | 1645 | ------- Summary: start ------- 13:08:03 INFO - PROCESS | 1645 | Number of tests: 6 13:08:03 INFO - PROCESS | 1645 | 13:08:03 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5627.44 Median:5841.80 stddev:767.84 (13.1%) stddev-sans-first:748.38 13:08:03 INFO - PROCESS | 1645 | Values: 3310.8 3331.9 3337.5 3361.3 3402.7 5501.8 5605.2 5615.3 5646.6 5649.1 5591.0 5615.4 5616.7 5623.7 5635.1 4043.4 5077.0 5094.2 5114.7 5213.6 5163.6 5199.7 5204.1 5244.6 5248.9 5199.9 5202.7 5214.0 5218.1 5225.1 581.1 5127.0 5136.6 5202.5 5245.1 4412.6 5152.5 5178.6 5186.4 5193.2 4684.0 5490.6 5633.5 5634.9 5645.1 6011.4 6208.7 6211.0 6220.8 6224.2 6116.3 6145.5 6200.0 6255.5 6258.5 5754.4 5764.1 5768.7 5781.5 5816.1 6241.9 6275.0 6279.3 6295.4 6305.7 5867.0 5909.3 6017.4 6025.9 6081.3 6167.1 6204.5 6210.3 6212.3 6224.4 6147.8 6157.2 6162.4 6162.5 6167.8 5986.9 6109.5 6113.4 6128.9 6169.8 4232.5 4909.5 4921.7 4931.5 4960.1 4305.0 4379.7 4387.5 4398.9 4428.3 5596.8 5610.6 5654.3 5669.1 5681.5 6173.9 6195.0 6201.8 6212.8 6215.5 5648.2 5682.6 5692.0 5699.7 5732.7 5170.3 5284.4 5291.2 5352.3 5353.6 6236.5 6250.9 6277.4 6339.5 6342.4 6192.5 6210.1 6219.8 6222.1 6230.6 6163.5 6280.9 6292.2 6316.9 6340.1 6009.1 6057.9 6073.6 6097.9 6144.9 6212.6 6223.6 6223.8 6227.9 6229.6 5983.5 5984.0 6021.5 6021.6 6057.2 5165.4 5649.4 5900.8 5921.2 5948.6 5841.8 5845.8 5848.5 5862.5 5882.1 6001.7 6008.6 6031.0 6031.2 6032.7 4869.9 5645.8 5663.2 5762.7 5786.5 13:08:03 INFO - PROCESS | 1645 | 13:08:03 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:67299.74 Median:36338.41 stddev:145619.92 (400.7%) stddev-sans-first:145941.98 13:08:03 INFO - PROCESS | 1645 | Values: 472.7 493.5 496.2 503.3 512.5 30915.4 32432.4 40263.8 42054.4 42437.4 43056.6 43116.0 43240.1 43415.0 43623.0 9255.9 9462.2 9466.0 9468.7 9476.7 8452.4 8681.9 11175.9 11446.9 11470.8 11352.2 11418.5 11424.1 11442.2 11444.6 11271.3 11332.7 11346.8 11350.7 11366.5 8334.5 8552.6 9308.4 11235.4 11256.5 40998.8 41255.2 41450.6 41574.0 41809.4 4000.3 4045.9 4047.1 4061.9 4194.5 30062.2 30431.5 31233.4 31302.0 31407.0 3146.6 3214.9 3297.0 3321.0 3366.1 351266.0 351540.0 351740.0 352113.0 352941.0 61710.7 61757.4 62014.7 62025.7 62066.0 64412.4 64989.5 65057.0 65119.3 65401.7 15513.0 15996.7 15998.8 16012.8 16031.4 11144.3 12340.0 12433.0 12446.6 12449.5 11812.5 14573.1 14992.0 16297.7 16665.9 7375.6 7502.2 7539.7 7578.4 7600.9 873.8 885.0 889.1 917.7 927.4 27730.3 30398.7 32189.2 34790.5 34891.8 959.8 1079.9 1098.5 1099.7 1182.2 15199.4 15400.9 15931.6 16027.9 16069.6 634246.0 642333.0 646459.0 646911.0 648443.0 61992.7 62619.0 62704.0 62857.0 62941.0 1497.2 1508.3 1510.4 1541.3 1543.7 29778.6 30311.4 30586.0 31027.5 31166.2 53716.7 53724.5 53749.2 53885.7 54199.2 591287.0 591895.0 592219.0 592581.0 593308.0 31726.7 37311.1 38943.6 41653.4 42751.0 34060.3 41885.0 44181.6 45764.0 46267.8 35328.5 35921.3 35936.0 36982.3 36999.4 35684.8 36102.6 36775.9 37435.6 37443.1 35031.3 35648.5 36276.8 36400.0 36580.5 31315.4 32350.4 32391.0 32679.9 32981.2 23079.8 24028.9 24061.3 24077.2 24308.8 13:08:03 INFO - PROCESS | 1645 | 13:08:03 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:41462.69 Median:22620.11 stddev:123584.96 (546.3%) stddev-sans-first:123893.08 13:08:03 INFO - PROCESS | 1645 | Values: 340.6 382.7 386.0 405.6 412.1 20084.0 22175.1 22245.3 22323.7 22608.2 18009.5 21104.3 21470.9 22167.4 22477.1 5628.4 5872.1 5925.2 5968.5 5999.4 4239.0 4398.8 5769.5 5873.4 5880.5 6267.5 6506.6 6577.5 6632.3 6657.4 6410.4 6598.9 6620.4 6653.6 6686.8 5620.6 5835.6 5850.4 5851.6 5886.2 20396.8 26556.9 26580.0 26960.6 26983.3 3118.5 3137.6 3149.8 3152.8 3166.3 12863.4 15707.3 15843.7 16272.3 16340.5 1821.2 1858.9 1891.9 1893.2 1936.3 126517.4 128564.4 129056.0 130422.3 130533.3 9225.3 11409.6 11514.7 11547.9 11804.9 14641.3 14684.3 14690.4 14695.6 14698.4 6932.3 8597.2 8781.1 8796.1 8850.1 8636.1 8644.9 8678.7 8832.8 8858.2 6300.9 7139.1 7241.0 7249.3 7266.1 1745.3 1805.8 1846.5 1921.9 1922.0 897.7 968.3 1030.6 1036.2 1089.2 18421.1 21270.5 22632.0 22637.5 22682.5 898.9 1029.8 1032.3 1057.9 1071.1 10784.5 11013.4 11824.6 11826.5 11877.5 722552.0 725495.4 733349.0 754697.0 759838.0 162351.4 167544.4 168467.0 170216.0 171070.1 998.5 1032.3 1034.8 1063.1 1070.4 19163.4 20198.0 20304.4 20619.0 20697.4 53502.7 55356.0 62303.4 63570.0 63823.3 95257.0 95609.0 96468.6 96564.5 96718.0 8162.3 8248.0 8475.5 8654.4 8774.6 7868.6 12607.6 12959.1 13286.7 13627.2 11288.9 11430.8 11623.0 11626.4 11700.8 6027.7 10907.1 11421.2 11616.4 11834.1 10029.0 11524.8 11548.5 11877.6 11986.5 7425.6 7643.4 8498.1 8520.2 8600.9 10877.3 11372.3 11458.2 11597.1 11682.7 13:08:03 INFO - PROCESS | 1645 | 13:08:03 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5412.55 Median:5134.11 stddev:2938.02 (57.2%) stddev-sans-first:2930.87 13:08:03 INFO - PROCESS | 1645 | Values: 1410.9 1439.4 1448.4 1460.2 1467.5 7210.9 8036.4 8461.7 8473.8 8488.6 7385.6 7691.0 7692.3 7768.8 7769.8 2093.3 2235.8 2312.7 2314.5 2328.8 2290.4 2316.6 2325.4 2327.6 2332.4 2302.2 2326.5 2327.0 2329.5 2331.8 2281.7 2307.2 2307.4 2309.7 2311.4 2267.6 2317.3 2336.7 2338.1 2338.5 8373.9 8417.7 8440.9 8455.1 8460.8 4999.1 5152.8 5156.5 5162.1 5170.8 3305.6 3443.9 3450.3 3465.3 3481.3 1163.2 1212.0 1250.2 1259.4 1263.7 10313.6 10724.8 10744.8 10764.4 10896.9 4329.7 4397.6 4521.6 4541.0 4545.6 8669.2 8675.2 8684.8 8695.9 8703.7 5131.9 5136.3 5138.3 5138.5 5155.0 4285.4 4552.8 4688.7 4736.9 4777.2 3464.1 3506.1 3594.0 3708.6 3713.3 1078.2 1118.7 1144.5 1159.0 1161.1 662.2 844.1 887.3 895.3 946.9 4644.7 5009.5 5608.4 5630.2 5981.8 998.7 999.4 1004.9 1048.3 1053.8 3826.3 3949.8 4028.0 4043.1 4148.6 9942.9 9967.3 10147.9 10153.7 10155.4 9914.8 9955.4 10079.5 10105.9 10109.2 7648.7 7817.0 7872.1 8028.1 8046.4 5370.7 5645.3 5687.4 5716.7 6094.8 8995.0 9043.5 9146.9 9160.6 9308.6 9184.1 9374.0 9389.6 9510.7 9525.4 7136.4 7295.0 7321.6 7321.7 7323.1 6500.5 7207.9 8045.8 8093.2 8178.7 7307.1 7426.8 7501.2 7519.0 7567.7 7260.2 7291.7 7401.5 7410.0 7452.9 6365.3 6396.9 6446.7 6454.2 6481.2 4987.5 5024.1 5032.7 5073.9 5173.0 4291.4 4917.8 5011.9 5086.9 5145.7 13:08:03 INFO - PROCESS | 1645 | 13:08:03 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4304.89 Median:4714.02 stddev:1252.93 (26.6%) stddev-sans-first:1220.12 13:08:03 INFO - PROCESS | 1645 | Values: 314.2 335.9 343.1 362.4 367.0 4437.9 4950.2 5044.0 5219.6 5294.9 4186.0 4333.5 5143.4 5178.5 5190.5 4081.3 4086.3 4088.8 4091.9 4113.5 3780.9 4110.9 4111.8 4118.9 4139.9 3195.7 3751.2 3978.6 4076.6 4106.7 3628.8 4045.5 4059.8 4077.6 4101.2 3077.8 3084.8 3383.0 3574.1 3653.4 4340.1 4805.6 5083.2 5112.8 5180.7 4700.9 4710.6 4713.3 4714.4 4754.9 5463.3 5483.4 5490.0 5502.4 5530.9 3543.3 3558.9 3883.9 4012.3 4040.4 4835.2 5630.5 5747.6 5751.5 5758.3 3572.5 4090.6 4109.6 4113.9 4135.6 3905.7 4065.7 4215.0 4219.0 4240.2 4130.3 4705.4 4713.0 4748.5 4760.9 4561.5 5104.0 5233.4 5528.8 5601.8 1119.8 1224.6 1318.1 1336.7 1342.8 898.7 935.2 940.8 975.2 979.0 4546.0 4671.4 4864.0 4880.1 4904.8 4438.9 5011.6 5208.6 5333.8 5388.3 4494.9 4556.1 4806.7 4877.7 4880.7 2328.6 2635.9 2737.0 2790.4 2793.4 4480.0 4926.6 5053.8 5169.8 5620.7 4506.9 4719.9 5114.2 5281.6 5540.9 4777.6 4931.9 5473.3 5597.3 5602.4 4508.3 4641.1 4773.6 5019.2 5153.5 4577.7 5220.9 5239.7 5263.6 5273.9 5061.5 5554.6 5561.4 5594.9 5602.8 3095.7 3561.8 3647.0 3780.2 3903.4 4392.0 4550.9 5309.2 5321.3 5335.5 4933.3 5090.0 5114.6 5146.0 5156.3 4601.4 4707.4 4713.6 5051.8 5146.3 3922.0 4228.8 5004.5 5014.0 5222.1 4378.6 5008.5 5036.9 5230.5 5281.8 4480.0 4537.8 4754.8 4876.3 4957.5 13:08:03 INFO - PROCESS | 1645 | 13:08:03 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:19745.95 Median:49728.63 stddev:28882.94 (58.1%) stddev-sans-first:28928.66 13:08:03 INFO - PROCESS | 1645 | Values: 726.6 758.6 774.7 821.6 826.4 14732.0 15597.5 15642.1 15646.8 15668.4 12127.9 14343.0 14485.3 14512.5 14529.2 689.5 712.5 846.3 861.0 863.2 870.2 874.3 874.9 878.8 884.2 929.6 931.2 933.4 935.4 936.3 719.0 924.6 927.4 932.5 933.0 549.0 676.9 693.2 695.7 696.0 15221.5 15225.2 15250.5 15260.9 15287.5 13621.5 13649.5 13711.9 13758.9 13842.7 12105.4 12124.8 12158.8 12217.3 12455.2 3654.2 3830.8 4058.9 4151.9 4292.7 70205.0 92473.7 95498.0 96484.0 96535.0 10557.2 10698.2 10984.9 11167.2 11187.9 18231.9 21170.5 21681.9 21764.6 21804.9 7610.2 7682.0 7780.2 7791.4 7885.3 4195.6 4260.9 4269.3 4295.0 4303.0 3386.6 3449.6 3477.7 3530.1 3576.9 663.9 666.2 667.0 677.9 679.0 591.6 615.8 630.9 645.1 660.5 8399.3 9355.9 9382.7 9577.9 10039.6 597.1 640.5 642.4 644.0 680.5 4436.6 4755.4 4779.1 4793.9 4801.7 106871.0 108333.8 109470.0 109799.0 110381.0 93910.0 95179.5 95347.0 96783.0 99285.0 68142.0 73048.6 73665.6 74105.1 75986.0 7646.7 9064.5 9324.5 9408.4 9514.9 49148.5 50308.7 50364.5 51999.0 52912.7 44348.6 55595.2 67536.3 68504.6 70457.0 11185.8 11414.4 11572.5 11627.4 12016.4 10466.7 12046.3 12176.0 12412.3 12705.4 11834.0 11844.9 11849.2 12007.8 12274.5 11847.7 11851.6 11862.8 11889.9 11894.8 11699.8 11748.3 11754.4 11774.1 11797.2 9880.0 9982.9 10020.5 10076.5 10157.4 8785.5 9282.6 9350.8 9391.7 9543.6 13:08:03 INFO - PROCESS | 1645 | -------- Summary: end -------- 13:08:03 INFO - PROCESS | 1645 | 13:08:04 INFO - TEST-INFO | 1645: exit 0 13:08:04 INFO - TEST-OK | dromaeo_css | took 1118404ms 13:08:04 INFO - TEST-START | kraken 13:08:04 INFO - operating with platform_type : mac_ 13:08:04 INFO - Initialising browser for kraken test... 13:08:04 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpWhGoVr/profile http://localhost:49245/getInfo.html) 13:08:06 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 13:08:06 INFO - PROCESS | 1651 | colorDepth:24 13:08:06 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 13:08:06 INFO - PROCESS | 1651 | __metrics 13:08:06 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:08:06 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:08:07 INFO - TEST-INFO | 1651: exit 0 13:08:07 INFO - Browser initialized. 13:08:07 INFO - Running cycle 1/1 for kraken test... 13:08:07 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpWhGoVr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:19 INFO - PROCESS | 1652 | RSS: Main: 227016704 13:08:19 INFO - PROCESS | 1652 | 13:08:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 13:08:23 INFO - PROCESS | 1652 | RSS: Main: 287895552 13:08:23 INFO - PROCESS | 1652 | 13:08:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 13:08:26 INFO - PROCESS | 1652 | RSS: Main: 288890880 13:08:26 INFO - PROCESS | 1652 | 13:08:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 13:08:30 INFO - PROCESS | 1652 | RSS: Main: 381075456 13:08:30 INFO - PROCESS | 1652 | 13:08:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 13:08:32 INFO - PROCESS | 1652 | RSS: Main: 282042368 13:08:32 INFO - PROCESS | 1652 | 13:08:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:35 INFO - PROCESS | 1652 | RSS: Main: 284499968 13:08:35 INFO - PROCESS | 1652 | 13:08:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:38 INFO - PROCESS | 1652 | RSS: Main: 326057984 13:08:38 INFO - PROCESS | 1652 | 13:08:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:42 INFO - PROCESS | 1652 | RSS: Main: 328343552 13:08:42 INFO - PROCESS | 1652 | 13:08:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 13:08:45 INFO - PROCESS | 1652 | RSS: Main: 326848512 13:08:45 INFO - PROCESS | 1652 | 13:08:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:47 INFO - PROCESS | 1652 | RSS: Main: 304017408 13:08:47 INFO - PROCESS | 1652 | 13:08:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:50 INFO - PROCESS | 1652 | RSS: Main: 306470912 13:08:50 INFO - PROCESS | 1652 | 13:08:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:53 INFO - PROCESS | 1652 | RSS: Main: 308023296 13:08:53 INFO - PROCESS | 1652 | 13:08:56 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:56 INFO - PROCESS | 1652 | RSS: Main: 328642560 13:08:56 INFO - PROCESS | 1652 | 13:08:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:09:00 INFO - PROCESS | 1652 | RSS: Main: 322498560 13:09:00 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 13:09:02 INFO - PROCESS | 1652 | RSS: Main: 365875200 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | __start_tp_report 13:09:02 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 13:09:02 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 13:09:02 INFO - PROCESS | 1652 | |i|pagename|runs| 13:09:02 INFO - PROCESS | 1652 | |0;ai-astar;109;112;112;110;111;111;111;111;111;112 13:09:02 INFO - PROCESS | 1652 | |1;audio-beat-detection;143;109;109;144;111;109;109;109;131;111 13:09:02 INFO - PROCESS | 1652 | |2;audio-dft;185;180;180;184;180;184;182;183;181;180 13:09:02 INFO - PROCESS | 1652 | |3;audio-fft;79;58;59;88;58;62;59;58;76;59 13:09:02 INFO - PROCESS | 1652 | |4;audio-oscillator;82;70;86;70;68;70;82;68;68;82 13:09:02 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;87;85;88;86;87;85;88;85;89;86 13:09:02 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;93;98;94;94;94;94;94;93;93 13:09:02 INFO - PROCESS | 1652 | |7;imaging-desaturate;86;87;86;87;87;88;85;87;86;86 13:09:02 INFO - PROCESS | 1652 | |8;json-parse-financial;57;54;53;54;55;56;55;55;55;54 13:09:02 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;68;65;80;76;73;71;70;72;71;71 13:09:02 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;91;87;86;86;87;86;85;87;101;106 13:09:02 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;140;138;138;139;142;147;137;140;179;139 13:09:02 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;175;173;170;175;171;172;172;172;177;172 13:09:02 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;67;67;68;67;67;67;66;68;67;67 13:09:02 INFO - PROCESS | 1652 | __end_tp_report 13:09:02 INFO - PROCESS | 1652 | __start_cc_report 13:09:02 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1984 13:09:02 INFO - PROCESS | 1652 | __end_cc_report 13:09:02 INFO - PROCESS | 1652 | __startTimestamp1484860142475__endTimestamp 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | ------- Summary: start ------- 13:09:02 INFO - PROCESS | 1652 | Number of tests: 14 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.94 (0.8%) stddev-sans-first:0.67 13:09:02 INFO - PROCESS | 1652 | Values: 109.0 112.0 112.0 110.0 111.0 111.0 111.0 111.0 111.0 112.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:111.00 stddev:14.80 (13.3%) stddev-sans-first:12.76 13:09:02 INFO - PROCESS | 1652 | Values: 143.0 109.0 109.0 144.0 111.0 109.0 109.0 109.0 131.0 111.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:181.90 Median:182.50 stddev:1.97 (1.1%) stddev-sans-first:1.74 13:09:02 INFO - PROCESS | 1652 | Values: 185.0 180.0 180.0 184.0 180.0 184.0 182.0 183.0 181.0 180.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.50 stddev:11.09 (18.3%) stddev-sans-first:10.65 13:09:02 INFO - PROCESS | 1652 | Values: 79.0 58.0 59.0 88.0 58.0 62.0 59.0 58.0 76.0 59.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:76.00 stddev:7.37 (9.7%) stddev-sans-first:7.31 13:09:02 INFO - PROCESS | 1652 | Values: 82.0 70.0 86.0 70.0 68.0 70.0 82.0 68.0 68.0 82.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.00 stddev:1.43 (1.6%) stddev-sans-first:1.51 13:09:02 INFO - PROCESS | 1652 | Values: 87.0 85.0 88.0 86.0 87.0 85.0 88.0 85.0 89.0 86.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:1.45 (1.5%) stddev-sans-first:1.54 13:09:02 INFO - PROCESS | 1652 | Values: 94.0 93.0 98.0 94.0 94.0 94.0 94.0 94.0 93.0 93.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 13:09:02 INFO - PROCESS | 1652 | Values: 86.0 87.0 86.0 87.0 87.0 88.0 85.0 87.0 86.0 86.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.14 (2.1%) stddev-sans-first:0.88 13:09:02 INFO - PROCESS | 1652 | Values: 57.0 54.0 53.0 54.0 55.0 56.0 55.0 55.0 55.0 54.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:71.50 stddev:4.11 (5.7%) stddev-sans-first:4.14 13:09:02 INFO - PROCESS | 1652 | Values: 68.0 65.0 80.0 76.0 73.0 71.0 70.0 72.0 71.0 71.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:86.50 stddev:7.28 (8.4%) stddev-sans-first:7.72 13:09:02 INFO - PROCESS | 1652 | Values: 91.0 87.0 86.0 86.0 87.0 86.0 85.0 87.0 101.0 106.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:140.00 stddev:12.65 (9.0%) stddev-sans-first:13.34 13:09:02 INFO - PROCESS | 1652 | Values: 140.0 138.0 138.0 139.0 142.0 147.0 137.0 140.0 179.0 139.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:172.50 stddev:2.13 (1.2%) stddev-sans-first:2.12 13:09:02 INFO - PROCESS | 1652 | Values: 175.0 173.0 170.0 175.0 171.0 172.0 172.0 172.0 177.0 172.0 13:09:02 INFO - PROCESS | 1652 | 13:09:02 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 13:09:02 INFO - PROCESS | 1652 | Values: 67.0 67.0 68.0 67.0 67.0 67.0 66.0 68.0 67.0 67.0 13:09:02 INFO - PROCESS | 1652 | -------- Summary: end -------- 13:09:02 INFO - PROCESS | 1652 | 13:09:03 INFO - TEST-INFO | 1652: exit 0 13:09:03 INFO - TEST-OK | kraken | took 59169ms 13:09:03 INFO - SUITE-END | took 1177s 13:09:03 INFO - Completed test suite (00:19:37) 13:09:03 INFO - javascript benchmark 13:09:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.8013519188844, 3331.90004299871, 3337.46600543913, 3361.344537815124, 3402.676745709157, 5501.752421141048, 5605.1592261160795, 5615.298087739033, 5646.604737668365, 5649.0679037958735, 5590.972045139769, 5615.410381909902, 5616.719164041802, 5623.718814059291, 5635.098384258519, 4043.353063509839, 5077.035363280974, 5094.235864620299, 5114.667546609477, 5213.608979326546, 5163.63854530183, 5199.68801871887, 5204.141316682742, 5244.580433565325, 5248.895022099556, 5199.948000519984, 5202.661826981234, 5213.983273261715, 5218.086834803913, 5225.111731005719, 581.1082083473755, 5126.974365128151, 5136.614753893473, 5202.531772140525, 5245.10833158364, 4412.580804823537, 5152.4847515248175, 5178.5857131429775, 5186.351706036746, 5193.169092945149, 4683.976580117078, 5490.588205884575, 5633.549316054706, 5634.887302253973, 5645.068563686987, 6011.4289142531825, 6208.689565521706, 6211.0, 6220.782272620437, 6224.190855188796, 6116.3053375860445, 6145.477634401082, 6200.038993955944, 6255.530835187334, 6258.4680302174365, 5754.367019627837, 5764.106563482625, 5768.653880767168, 5781.508571771446, 5816.1275808628625, 6241.906371404432, 6274.964630835952, 6279.277883043417, 6295.37046295376, 6305.684715764193, 5867.002609556385, 5909.320428150818, 6017.428344307371, 6025.9153352396115, 6081.27024757032, 6167.105769663373, 6204.534659900525, 6210.31686514483, 6212.285587157445, 6224.37756224383, 6147.815565533041, 6157.199564056734, 6162.414570615784, 6162.506999440034, 6167.753289868355, 5986.880262394728, 6109.450149486567, 6113.445900579344, 6128.877422451526, 6169.8457538561, 4232.513260975027, 4909.484504127086, 4921.680090794087, 4931.506849315111, 4960.107180707435, 4304.988327743041, 4379.671524635665, 4387.451568553931, 4398.890027749332, 4428.2914733642465, 5596.804111856147, 5610.607257491936, 5654.321481422256, 5669.092945128759, 5681.488666019995, 6173.888700034037, 6195.0, 6201.782937597162, 6212.81361559154, 6215.502759779207, 5648.152777083388, 5682.602217844794, 5692.0, 5699.715014249271, 5732.6847023413275, 5170.276161337416, 5284.392294886137, 5291.1798671206025, 5352.2506849041165, 5353.598480114007, 6236.469900058546, 6250.937490625036, 6277.372262773686, 6339.492840572835, 6342.39747224013, 6192.473639740672, 6210.068489726577, 6219.844503887439, 6222.09779581949, 6230.626162430269, 6163.537734670007, 6280.937190628035, 6292.2134733158355, 6316.905246421215, 6340.112384266298, 6009.098635204754, 6057.909131362945, 6073.5748497604745, 6097.939020609737, 6144.924638188389, 6212.596181248205, 6223.595466294676, 6223.844403889939, 6227.937720622917, 6229.626222426487, 5983.461488466059, 5983.970080149571, 6021.488173505301, 6021.563234883828, 6057.242844644419, 5165.431802501646, 5649.406812284651, 5900.822975310747, 5921.2006379138265, 5948.643081415129, 5841.795537156179, 5845.795397161079, 5848.473637372486, 5862.530997520103, 5882.1470886722045, 6001.669908155093, 6008.579399441997, 6031.035034394476, 6031.185789918305, 6032.668203248863, 4869.87825304356, 5645.830625081254, 5663.207150998781, 5762.740676669476, 5786.508146807569], "value": 5579.736537692005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.6549618778292, 493.5089585862068, 496.2308421945985, 503.275283591628, 512.4542362384062, 30915.38169236617, 32432.351352972957, 40263.79868100663, 42054.36918446218, 42437.36343954843, 43056.569434305646, 43116.0, 43240.13519729611, 43415.0, 43623.0, 9255.907440925572, 9462.195713364372, 9465.958744538095, 9468.715938521855, 9476.715698529055, 8452.366072544553, 8681.869771953427, 11175.944120279388, 11446.942765286161, 11470.770584588303, 11352.205345625809, 11418.543258269701, 11424.143189260798, 11442.199046066778, 11444.599439019636, 11271.26736762112, 11332.716682082932, 11346.773064538746, 11350.659480215607, 11366.545338186505, 8334.541600211985, 8552.61513231906, 9308.44149351041, 11235.382053987027, 11256.493457794419, 40998.79500602508, 41255.174896502205, 41450.58549414497, 41574.0, 41809.372859407136, 4000.299947509174, 4045.878623641266, 4047.1298670785923, 4061.8578349757913, 4194.475690538683, 30062.24844378886, 30431.543526847116, 31233.37533249345, 31302.0, 31407.0, 3146.606674165729, 3214.8714051437914, 3296.96703032969, 3320.9501857472155, 3366.1416338833687, 351266.0, 351540.0, 351740.0, 352112.99999999744, 352941.0, 61710.69144654338, 61757.38242617606, 62014.689926550076, 62025.689871550356, 62066.0, 64412.35587644157, 64989.501049894636, 65057.0, 65119.34880651227, 65401.69196616041, 15513.0, 15996.68006639884, 15998.840011599968, 16012.839871601134, 16031.438899638457, 11144.33134011962, 12340.0, 12433.0, 12446.626601201979, 12449.502019919282, 11812.527498899948, 14573.125612463286, 14992.025518341274, 16297.674046519003, 16665.91667041657, 7375.635507431142, 7502.17476077631, 7539.698412063566, 7578.355839753683, 7600.885986710204, 873.7640836973982, 884.9911500885038, 889.1419779912416, 917.6696389299847, 927.4249965021595, 27730.31138944829, 30398.696013039586, 32189.195270117965, 34790.47814282788, 34891.82554087264, 959.8080383923243, 1079.9352038877535, 1098.522142867855, 1099.71957150926, 1182.2374568403332, 15199.392024319124, 15400.922995385175, 15931.601709957113, 16027.919860400623, 16069.576318519119, 634246.0, 642333.0, 646459.0, 646911.0, 648443.0, 61992.69003654953, 62619.0, 62704.0, 62857.0, 62941.0, 1497.1989985357782, 1508.3287936868207, 1510.358097808427, 1541.3295216580823, 1543.668111356064, 29778.553321699757, 30311.393772124877, 30586.0, 31027.53458698076, 31166.22084447907, 53716.73141634423, 53724.46275537195, 53749.19376209438, 53885.730571346896, 54199.18701219564, 591287.0, 591895.0, 592219.0, 592581.0, 593308.0, 31726.682733172373, 37311.06722331963, 38943.610563894, 41653.375199371425, 42751.0, 34060.31879362349, 41885.0, 44181.55818441903, 45764.0, 46267.76866115648, 35328.47007294944, 35921.28157436889, 35936.0, 36982.26035479329, 36999.44500832436, 35684.821575891954, 36102.63897360993, 36775.89672309835, 37435.62564374322, 37443.06392340214, 35031.29937401289, 35648.4652730204, 36276.81861590675, 36400.0, 36580.53677852856, 31315.373692525565, 32350.35299294048, 32391.028269151964, 32679.85620503271, 32981.17547061247, 23079.76920230776, 24028.87985560061, 24061.27816165518, 24077.152312922142, 24308.75691243065], "value": 20157.02888717562, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.58788865472786, 382.74356181358485, 385.9713862556288, 405.62479706271694, 412.0666689947268, 20084.0, 22175.11299548016, 22245.332640020784, 22323.665145022816, 22608.20871269504, 18009.459716208534, 21104.261350852725, 21470.89264553679, 22167.44581385462, 22477.100915963343, 5628.43715628437, 5872.060470324749, 5925.229720136376, 5968.522518198555, 5999.400059994009, 4238.97880510597, 4398.846040388587, 5769.480746732793, 5873.353931067579, 5880.529557635379, 6267.4986001119805, 6506.577072490273, 6577.506686998494, 6632.2704502504685, 6657.400833924946, 6410.358964103622, 6598.86802263952, 6620.404163625273, 6653.634050127241, 6686.7993960181275, 5620.578456615729, 5835.620684655484, 5850.414958504158, 5851.561132915006, 5886.20536227608, 20396.796032039638, 26556.86721566399, 26580.0, 26960.59559106615, 26983.32541686454, 3118.4875335462284, 3137.6391714952842, 3149.7952633078776, 3152.7793054486197, 3166.319241363095, 12863.42114604845, 15707.293171807296, 15843.683126337408, 16272.349106035745, 16340.509784706477, 1821.225978958937, 1858.9163487643089, 1891.9054047297718, 1893.1575448925234, 1936.2835750772163, 126517.36741316327, 128564.35717821444, 129056.0, 130422.3478882609, 130533.34733326368, 9225.308101892386, 11409.60066397672, 11514.712132196762, 11547.884521154681, 11804.88195118055, 14641.267936603128, 14684.339204735812, 14690.412383504754, 14695.559133226021, 14698.412063517553, 6932.306769323028, 8597.18326758957, 8781.121887811169, 8796.07641197678, 8850.070742571937, 8636.093210212963, 8644.913550864536, 8678.696245631372, 8832.77918052041, 8858.247049000778, 6300.8658441480975, 7139.143302803697, 7240.984829644367, 7249.309484070142, 7266.108266493025, 1745.3280487012591, 1805.816020251769, 1846.547595839028, 1921.8846869187894, 1921.9519512012032, 897.7127319257775, 968.2694800662065, 1030.5517100061347, 1036.2073014144187, 1089.1559041742712, 18421.078946052643, 21270.46823829417, 22632.020955389788, 22637.547249054925, 22682.546349073255, 898.8719157457349, 1029.8455231715302, 1032.2670903658486, 1057.8519007338978, 1071.1002757683584, 10784.514696838503, 11013.449327533592, 11824.645260642195, 11826.526938922347, 11877.465514051888, 722552.0, 725495.372523134, 733349.0, 754697.0, 759838.0, 162351.376486236, 167544.4449977586, 168467.0, 170216.0, 171070.14464927596, 998.5157198758596, 1032.2877214721818, 1034.8447732839984, 1063.0963680871198, 1070.3684825952569, 19163.425097247105, 20197.990100494622, 20304.390868273975, 20619.0, 20697.379078627666, 53502.66243343947, 55356.0, 62303.37696622976, 63570.046449304224, 63823.34119905455, 95257.0, 95609.0, 96468.55297170408, 96564.51717741367, 96718.0, 8162.265396114378, 8248.0, 8475.533845638549, 8654.350923680624, 8774.605142768718, 7868.567228802471, 12607.621771346874, 12959.092863499465, 13286.734265314833, 13627.182369057491, 11288.94355528217, 11430.828537571777, 11623.0, 11626.418679066182, 11700.765984680089, 6027.728752206249, 10907.146854264916, 11421.200515963803, 11616.361100139573, 11834.112441566745, 10029.0, 11524.769504609692, 11548.48031838586, 11877.643670689893, 11986.46060927243, 7425.554466732014, 7643.388528917784, 8498.065212826708, 8520.190581894958, 8600.913990860012, 10877.347359158475, 11372.251705837729, 11458.197926145423, 11597.130215233723, 11682.70793230176], "value": 10320.604033384458, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.9050584659258, 1439.4314245872881, 1448.3699590678052, 1460.153111195506, 1467.4937146684395, 7210.891836622448, 8036.437449378546, 8461.746147615566, 8473.830523389528, 8488.61801218945, 7385.5568665879955, 7691.0, 7692.346150577194, 7768.805779855506, 7769.7669069928, 2093.3196711068927, 2235.7876001779805, 2312.6877871487304, 2314.52345989791, 2328.836981411302, 2290.4159439342943, 2316.6061769499142, 2325.430269583954, 2327.5810354136247, 2332.3935776698013, 2302.194232018797, 2326.5114325991563, 2327.045911176418, 2329.534093181362, 2331.7901388875, 2281.6577513372963, 2307.204014614955, 2307.4462129088897, 2309.6766452696634, 2311.4452531392512, 2267.5918334699745, 2317.2816426907543, 2336.719593648756, 2338.1348900906605, 2338.4504641409253, 8373.874391884126, 8417.705380311721, 8440.915590844135, 8455.069942306342, 8460.78848028798, 4999.075171093359, 5152.845414637567, 5156.458571849939, 5162.070827251093, 5170.819021334235, 3305.636379998198, 3443.896683099511, 3450.344434557426, 3465.2722928185112, 3481.2515309208643, 1163.2264544078262, 1212.0, 1250.2311078686632, 1259.4017841525294, 1263.7346157306977, 10313.639022634246, 10724.839127413095, 10744.78510429795, 10764.407957562331, 10896.945515272451, 4329.740215587075, 4397.582229688239, 4521.638268938477, 4540.954590454119, 4545.636349092065, 8669.21977022071, 8675.175858293578, 8684.78288042804, 8695.913040869636, 8703.6518539259, 5131.897362052738, 5136.332276803992, 5138.2806407103035, 5138.486151384906, 5155.02054609623, 4285.400043993781, 4552.840650577214, 4688.695234809727, 4736.905261894743, 4777.187878060738, 3464.133966508373, 3506.1234691327168, 3593.9820300898327, 3708.647678470541, 3713.2759111972905, 1078.1751959750798, 1118.697951553076, 1144.5364627325946, 1158.9652310430702, 1161.0769438296575, 662.211967758366, 844.1305455380967, 887.2857349833446, 895.2658819767859, 946.8721722567503, 4644.674872758875, 5009.499050095034, 5608.439156084441, 5630.183623374588, 5981.820545383645, 998.7053819123377, 999.4103478947311, 1004.9296549241483, 1048.339546085961, 1053.7997780421695, 3826.2730081284467, 3949.8420063197723, 4027.979860100739, 4043.130726893732, 4148.62662360389, 9942.900570994341, 9967.252456065678, 10147.898521014842, 10153.695389138338, 10155.441450720133, 9914.752131196778, 9955.352902061488, 10079.5464204111, 10105.949470252748, 10109.191264698806, 7648.73229436967, 7816.960915195387, 7872.134065252818, 8028.07677117139, 8046.436749427484, 5370.677759334452, 5645.322561292507, 5687.402822703557, 5716.714164291686, 6094.847628809315, 8995.010548839753, 9043.547822608974, 9146.862797058182, 9160.58777355034, 9308.627654893728, 9184.12750788674, 9374.0, 9389.577469014048, 9510.667126650535, 9525.428474291564, 7136.357727804315, 7294.978702981481, 7321.63391830417, 7321.74373896911, 7323.12122545298, 6500.544961852814, 7207.9279207207255, 8045.839083218186, 8093.231143041402, 8178.713745018896, 7307.086614173229, 7426.777196684108, 7501.174870764103, 7519.0, 7567.735129270449, 7260.201377848538, 7291.708331666674, 7401.48189626721, 7410.0, 7452.850942981218, 6365.299817020216, 6396.9040464394, 6446.7098980546925, 6454.1609590752905, 6481.222253329631, 4987.47631498702, 5024.070546948826, 5032.723200224023, 5073.949260507347, 5173.017126745906, 4291.442112525352, 4917.827876024322, 5011.924821127759, 5086.949130508648, 5145.716985565829], "value": 4403.419373819285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.2254343044396, 335.9109835893487, 343.10278621405035, 362.3785208367649, 367.00358526600274, 4437.911241775162, 4950.208256340082, 5044.016416798717, 5219.556337711294, 5294.867628309295, 4185.958140418595, 4333.523312435637, 5143.434222235561, 5178.5339319461245, 5190.506901844328, 4081.3265811141127, 4086.264472394968, 4088.7546747195115, 4091.9181616367655, 4113.547509773923, 3780.8846390314784, 4110.938335924963, 4111.814968326433, 4118.876433706993, 4139.875803725893, 3195.664455232202, 3751.224094170308, 3978.622030907059, 4076.5923407659143, 4106.733062350952, 3628.838771593091, 4045.4538637283886, 4059.7970101494807, 4077.55146933837, 4101.2207680540605, 3077.753779697619, 3084.7686423518103, 3383.0, 3574.124339536804, 3653.4337177737493, 4340.110277393127, 4805.639577031737, 5083.161278389061, 5112.769925353368, 5180.689158650455, 4700.905981880377, 4710.576048155648, 4713.34013238147, 4714.434267887841, 4754.904901901942, 5463.251759436982, 5483.424240454735, 5490.004096272412, 5502.422245664187, 5530.917036244459, 3543.344481270973, 3558.928821423557, 3883.9223215535812, 4012.29784787661, 4040.393940908858, 4835.162638197462, 5630.493255606974, 5747.626404283708, 5751.511121554673, 5758.251427314464, 3572.4641303804638, 4090.629639070885, 4109.623276202446, 4113.8813511041835, 4135.56576559463, 3905.7461265017682, 4065.654419374386, 4215.0, 4219.0, 4240.236757383639, 4130.256553820341, 4705.411823522059, 4712.976435117871, 4748.548887855648, 4760.928586071212, 4561.521040290788, 5103.958416633376, 5233.39815921174, 5528.838943821843, 5601.80393686219, 1119.7928383249125, 1224.6448529926222, 1318.0575888239762, 1336.7059246965653, 1342.812006319116, 898.7124120281578, 935.2471260635253, 940.8004793887711, 975.2149519636619, 979.0111986893147, 4545.954540454553, 4671.439427268681, 4863.975680121577, 4880.097182021266, 4904.828331008398, 4438.866833994985, 5011.57401620859, 5208.619715775322, 5333.839794883079, 5388.326459192601, 4494.887627809331, 4556.11155824611, 4806.711597304173, 4877.707337559757, 4880.707157570557, 2328.5808554460023, 2635.89456421741, 2736.986315068412, 2790.372166262575, 2793.385455199853, 4479.955200447954, 4926.581240594518, 5053.772580233898, 5169.81905633301, 5620.662760234399, 4506.932396014063, 4719.914419683423, 5114.207297868837, 5281.55106815925, 5540.86147846299, 4777.641676874248, 4931.901361972812, 5473.261109750133, 5597.3003374578175, 5602.355729091207, 4508.346289787897, 4641.118187544355, 4773.6156514610375, 5019.222020586815, 5153.45888681698, 4577.667017924081, 5220.929709409638, 5239.738013099406, 5263.552448111646, 5273.947260527346, 5061.493850614909, 5554.638948468337, 5561.416051314553, 5594.888102237851, 5602.831915042555, 3095.7059079387423, 3561.7889917428197, 3646.997075804175, 3780.2061567070123, 3903.40423618302, 4392.033752574429, 4550.863474095782, 5309.177077552986, 5321.3348331458565, 5335.519803217729, 4933.333999909966, 5089.9745501272255, 5114.5652619527755, 5146.044503088802, 5156.329677142097, 4601.37881386022, 4707.411573553306, 4713.599344055794, 5051.787570983011, 5146.305248791366, 3921.9607803921594, 4228.767417792051, 5004.524570165829, 5014.047331007243, 5222.138347172674, 4378.6278166356215, 5008.549230569266, 5036.917062831509, 5230.476952304739, 5281.841544753664, 4479.955200448084, 4537.8411755588395, 4754.786034628381, 4876.317670403705, 4957.4794646561595], "value": 3925.5972178080306, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.5858460677409, 758.586570319176, 774.7056118674902, 821.57688790273, 826.3884725303276, 14732.042417242872, 15597.532074037768, 15642.139682317467, 15646.765298520517, 15668.373265069398, 12127.878721212785, 14343.0, 14485.348159332829, 14512.492062777805, 14529.200893950829, 689.5173378634963, 712.508369225233, 846.3440833354139, 861.0, 863.2317237658489, 870.1820288928387, 874.3005595523588, 874.9475031498099, 878.7978764884049, 884.2395539835736, 929.6281487405058, 931.2456909902967, 933.4026223217146, 935.4013431403907, 936.3398803843274, 718.9712411503533, 924.6440120553568, 927.3879239701798, 932.5011119051275, 932.9673461428852, 549.0391814324931, 676.9120014398097, 693.1681981622023, 695.7390978383106, 695.9512834101615, 15221.467248646244, 15225.238738063052, 15250.542483725507, 15260.923695381563, 15287.464938727091, 13621.455141794415, 13649.522266720616, 13711.862881371158, 13758.93120534391, 13842.723145537133, 12105.394730263451, 12124.757504849853, 12158.817617735742, 12217.266963982102, 12455.190412623151, 3654.177809992757, 3830.80845957701, 4058.9188216235807, 4151.875443736692, 4292.699511034229, 70205.0, 92473.68815779591, 95498.0, 96484.0, 96535.0, 10557.208209384327, 10698.197635177237, 10984.945075274733, 11167.162462815322, 11187.944060279646, 18231.90884045571, 21170.47073823136, 21681.891590542262, 21764.564708705737, 21804.890975545022, 7610.1628820829665, 7682.0, 7780.18308077655, 7791.376689864797, 7885.329746971457, 4195.559466256061, 4260.8508702195895, 4269.274223382033, 4295.0, 4303.0, 3386.6274709781906, 3449.5688038995127, 3477.704395126392, 3530.0998245447245, 3576.8748093816594, 663.9004149377536, 666.1805978646292, 666.9566478179, 677.864427114579, 679.0052572980608, 591.5740666719955, 615.7561725314928, 630.9400606942334, 645.141961191614, 660.5310229736845, 8399.286060684788, 9355.859662105075, 9382.718518444457, 9577.856332155023, 10039.648612298535, 597.1192491075716, 640.478010421505, 642.4474951541671, 643.9871202575922, 680.4828330468879, 4436.6228870546365, 4755.38180036593, 4779.139754844162, 4793.904121917542, 4801.663883528189, 106871.0, 108333.83332333309, 109470.0, 109799.0, 110381.0, 93910.0, 95179.52410237904, 95347.0, 96783.0, 99285.0, 68142.0, 73048.63475682588, 73665.6316718413, 74105.14737131508, 75986.0, 7646.74421045804, 9064.456132632064, 9324.533773311443, 9408.43549387039, 9514.90485095168, 49148.50851491439, 50308.74845625748, 50364.49635503598, 51998.96002080013, 52912.735436322575, 44348.55651443573, 55595.16607250975, 67536.29854805753, 68504.62990740257, 70457.0, 11185.776284474428, 11414.429278535874, 11572.479238434122, 11627.418629068343, 12016.399180041139, 10466.738331541468, 12046.277223366626, 12176.0, 12412.255264683787, 12705.42825572833, 11834.0, 11844.881551184379, 11849.229800062969, 12007.81988270194, 12274.509019639114, 11847.703807404883, 11851.585194518151, 11862.762744745229, 11889.881101188877, 11894.821577676168, 11699.766004680028, 11748.29510229389, 11754.412279386168, 11774.116941229271, 11797.233179843282, 9879.95060024724, 9982.901880793252, 10020.549075291483, 10076.546555404877, 10157.39055656663, 8785.516796575994, 9282.58228379711, 9350.812983740423, 9391.718248452557, 9543.618255269988], "value": 7234.2442083850465, "unit": "score"}], "name": "dromaeo_css", "value": 7249.603647088533, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 112.0, 110.0, 111.0, 111.0, 111.0, 111.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 109.0, 144.0, 111.0, 109.0, 109.0, 109.0, 131.0, 111.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 180.0, 180.0, 184.0, 180.0, 184.0, 182.0, 183.0, 181.0, 180.0], "value": 181.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 88.0, 58.0, 62.0, 59.0, 58.0, 76.0, 59.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 86.0, 70.0, 68.0, 70.0, 82.0, 68.0, 68.0, 82.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 86.0, 87.0, 85.0, 88.0, 85.0, 89.0, 86.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 98.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 87.0, 87.0, 88.0, 85.0, 87.0, 86.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 53.0, 54.0, 55.0, 56.0, 55.0, 55.0, 55.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 80.0, 76.0, 73.0, 71.0, 70.0, 72.0, 71.0, 71.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 86.0, 86.0, 87.0, 86.0, 85.0, 87.0, 101.0, 106.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 138.0, 139.0, 142.0, 147.0, 137.0, 140.0, 179.0, 139.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 170.0, 175.0, 171.0, 172.0, 172.0, 172.0, 177.0, 172.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 68.0, 67.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1419.4, "alertThreshold": 2.0}]} 13:09:03 INFO - Return code: 0 13:09:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:09:03 ERROR - # TBPL SUCCESS # 13:09:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:09:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:09:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:09:03 INFO - 2017-01-19 13:09:03.792 screenresolution[1656:10670] starting screenresolution argv=screenresolution get 13:09:03 INFO - 2017-01-19 13:09:03.794 screenresolution[1656:10670] Display 0: 1600x1200x32@60 13:09:03 INFO - 2017-01-19 13:09:03.800 screenresolution[1657:10673] starting screenresolution argv=screenresolution list 13:09:03 INFO - Available Modes on Display 0 13:09:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:09:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:09:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:09:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:09:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:09:04 INFO - Intel Iris: 13:09:04 INFO - Chipset Model: Intel Iris 13:09:04 INFO - Type: GPU 13:09:04 INFO - Bus: Built-In 13:09:04 INFO - VRAM (Dynamic, Max): 1536 MB 13:09:04 INFO - Vendor: Intel (0x8086) 13:09:04 INFO - Device ID: 0x0a2e 13:09:04 INFO - Revision ID: 0x0009 13:09:04 INFO - Displays: 13:09:04 INFO - Display: 13:09:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:09:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:09:04 INFO - Display Serial Number: 1600x1200 60 13:09:04 INFO - Main Display: Yes 13:09:04 INFO - Mirror: Off 13:09:04 INFO - Online: Yes 13:09:04 INFO - Rotation: Supported 13:09:04 INFO - Return code: 0 13:09:04 INFO - Running post-action listener: _resource_record_post_action 13:09:04 INFO - [mozharness: 2017-01-19 21:09:04.037141Z] Finished run-tests step (success) 13:09:04 INFO - Running post-run listener: _resource_record_post_run 13:09:04 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 33586176; Write bytes: 552129024; Read time: 319; Write time: 1638 13:09:04 INFO - TinderboxPrint: CPU usage
53.7% 13:09:04 INFO - TinderboxPrint: I/O read bytes / time
33,586,176 / 319 13:09:04 INFO - TinderboxPrint: I/O write bytes / time
552,129,024 / 1,638 13:09:04 INFO - TinderboxPrint: CPU idle
2,223.4 (46.3%) 13:09:04 INFO - TinderboxPrint: CPU system
958.0 (20.0%) 13:09:04 INFO - TinderboxPrint: CPU user
1,620.2 (33.7%) 13:09:04 INFO - TinderboxPrint: Swap in / out
280,551,424 / 0 13:09:04 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247085568; Write bytes: 239325184; Read time: 18079; Write time: 434 13:09:04 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31480832; Write bytes: 299196928; Read time: 289; Write time: 1165 13:09:04 INFO - Running post-run listener: _upload_blobber_files 13:09:04 INFO - Blob upload gear active. 13:09:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:09:04 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 13:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:09:04 INFO - (blobuploader) - INFO - Open directory for files ... 13:09:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:09:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:09:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:06 INFO - (blobuploader) - INFO - Done attempting. 13:09:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:09:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:09:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:07 INFO - (blobuploader) - INFO - Done attempting. 13:09:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:09:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:09 INFO - (blobuploader) - INFO - Done attempting. 13:09:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:09:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:09:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:11 INFO - (blobuploader) - INFO - Done attempting. 13:09:11 INFO - (blobuploader) - INFO - Iteration through files over. 13:09:11 INFO - Return code: 0 13:09:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:09:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:09:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf7fe77b519fc0086831ab3676c581b9d42abd594a11e9eae06ca8e61c89e1a061579a52ae78a065de6556a84bc576b6930dc254939a9a509850188148c5f7f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1855b63d0ccdf4a541fe12e3b0960ec38fb004b05a16417e63b762322d0d59877814bc1a68672837af23ef4dc890fd02b5b3e231b58dc6a837c88365bc0db048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e8b792d4e885259a4a241379394a885316de1a248df1dea0178e2551d4bf308a373e270ed3c4ae37ec3464067344ecd6e172dd83df62427bfc1c606da13370a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04d7dce6936bb1afe7c3ce546663c1e4fe65b18eaf6046d5fa3a175f5e3aea742ae428d3d9bebeea8f226d95ca6da2cb6adeda9dfeba9af1eee546bb7a2ba359"} 13:09:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:09:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:09:11 INFO - Contents: 13:09:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf7fe77b519fc0086831ab3676c581b9d42abd594a11e9eae06ca8e61c89e1a061579a52ae78a065de6556a84bc576b6930dc254939a9a509850188148c5f7f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1855b63d0ccdf4a541fe12e3b0960ec38fb004b05a16417e63b762322d0d59877814bc1a68672837af23ef4dc890fd02b5b3e231b58dc6a837c88365bc0db048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e8b792d4e885259a4a241379394a885316de1a248df1dea0178e2551d4bf308a373e270ed3c4ae37ec3464067344ecd6e172dd83df62427bfc1c606da13370a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04d7dce6936bb1afe7c3ce546663c1e4fe65b18eaf6046d5fa3a175f5e3aea742ae428d3d9bebeea8f226d95ca6da2cb6adeda9dfeba9af1eee546bb7a2ba359"} 13:09:11 INFO - Running post-run listener: copy_logs_to_upload_dir 13:09:11 INFO - Copying logs to upload dir... 13:09:11 INFO - mkdir: /builds/slave/test/build/upload/logs 13:09:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.694444 ========= master_lag: 6.72 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-01-19 13:09:17.972285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 13:09:17.980080) ========= 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.nHhAgdYk7R/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.t1THEXZzRA/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf7fe77b519fc0086831ab3676c581b9d42abd594a11e9eae06ca8e61c89e1a061579a52ae78a065de6556a84bc576b6930dc254939a9a509850188148c5f7f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1855b63d0ccdf4a541fe12e3b0960ec38fb004b05a16417e63b762322d0d59877814bc1a68672837af23ef4dc890fd02b5b3e231b58dc6a837c88365bc0db048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e8b792d4e885259a4a241379394a885316de1a248df1dea0178e2551d4bf308a373e270ed3c4ae37ec3464067344ecd6e172dd83df62427bfc1c606da13370a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04d7dce6936bb1afe7c3ce546663c1e4fe65b18eaf6046d5fa3a175f5e3aea742ae428d3d9bebeea8f226d95ca6da2cb6adeda9dfeba9af1eee546bb7a2ba359"} build_url:https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010979 build_url: 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf7fe77b519fc0086831ab3676c581b9d42abd594a11e9eae06ca8e61c89e1a061579a52ae78a065de6556a84bc576b6930dc254939a9a509850188148c5f7f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1855b63d0ccdf4a541fe12e3b0960ec38fb004b05a16417e63b762322d0d59877814bc1a68672837af23ef4dc890fd02b5b3e231b58dc6a837c88365bc0db048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e8b792d4e885259a4a241379394a885316de1a248df1dea0178e2551d4bf308a373e270ed3c4ae37ec3464067344ecd6e172dd83df62427bfc1c606da13370a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04d7dce6936bb1afe7c3ce546663c1e4fe65b18eaf6046d5fa3a175f5e3aea742ae428d3d9bebeea8f226d95ca6da2cb6adeda9dfeba9af1eee546bb7a2ba359"}' ========= master_lag: 0.73 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 13:09:18.721906) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 13:09:18.722221) ========= 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.nHhAgdYk7R/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.t1THEXZzRA/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.005109 ========= master_lag: 0.43 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 13:09:19.160827) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 13:09:19.161619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 13:09:19.163404) ========= ========= Total master_lag: 7.98 =========