builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0173 starttime: 1479049576.12 results: success (0) buildid: 20161113060520 builduid: fc74d1a1b63c48eca579c6292d84655e revision: 7cb90cec7f297457e088106ba9f6cc58ab5b51be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:16.122536) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:16.123011) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:16.123304) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:16.147853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:16.148176) ========= 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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-13 07:06:16-- 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% 76.4M=0s 2016-11-13 07:06:16 (76.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.189697 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:16.363377) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:16.363700) ========= 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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.028939 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:16.413943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-13 07:06:16.414296) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7cb90cec7f297457e088106ba9f6cc58ab5b51be --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7cb90cec7f297457e088106ba9f6cc58ab5b51be --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OMK2d4F5GW/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.9yyUX6lIGv/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-13 07:06:16,401 truncating revision to first 12 chars 2016-11-13 07:06:16,401 Setting DEBUG logging. 2016-11-13 07:06:16,401 attempt 1/10 2016-11-13 07:06:16,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7cb90cec7f29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-13 07:06:17,731 unpacking tar archive at: mozilla-aurora-7cb90cec7f29/testing/mozharness/ program finished with exit code 0 elapsedTime=1.589340 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-13 07:06:18.031654) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:18.031967) ========= script_repo_revision: 7cb90cec7f297457e088106ba9f6cc58ab5b51be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:18.032364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:18.032650) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 07:06:18.051442) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-13 07:06:18.051723) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OMK2d4F5GW/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.9yyUX6lIGv/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 07:06:18 INFO - MultiFileLogger online at 20161113 07:06:18 in /builds/slave/test 07:06:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:06:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:06:18 INFO - {'append_to_log': False, 07:06:18 INFO - 'base_work_dir': '/builds/slave/test', 07:06:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:06:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:06:18 INFO - 'branch': 'Mozilla-Aurora', 07:06:18 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:18 INFO - 'config_files': ('talos/mac_config.py',), 07:06:18 INFO - 'default_actions': ('clobber', 07:06:18 INFO - 'read-buildbot-config', 07:06:18 INFO - 'download-and-extract', 07:06:18 INFO - 'populate-webroot', 07:06:18 INFO - 'create-virtualenv', 07:06:18 INFO - 'install', 07:06:18 INFO - 'run-tests'), 07:06:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:18 INFO - 'download_minidump_stackwalk': True, 07:06:18 INFO - 'download_symbols': 'ondemand', 07:06:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:18 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:18 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:18 INFO - 'installer_path': 'installer.exe', 07:06:18 INFO - 'log_level': 'info', 07:06:18 INFO - 'log_name': 'talos', 07:06:18 INFO - 'log_to_console': True, 07:06:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:06:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:06:18 INFO - 'opt_config_files': (), 07:06:18 INFO - 'pip_index': False, 07:06:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:06:18 INFO - 'cmd': ('bash', 07:06:18 INFO - '-c', 07:06:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:06:18 INFO - 'enabled': True, 07:06:18 INFO - 'halt_on_failure': False, 07:06:18 INFO - 'name': 'check_screen_resolution'},), 07:06:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:06:18 INFO - 'cmd': ('bash', 07:06:18 INFO - '-c', 07:06:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:06:18 INFO - 'enabled': True, 07:06:18 INFO - 'halt_on_failure': False, 07:06:18 INFO - 'name': 'check_screen_resolution'},), 07:06:18 INFO - 'run_cmd_checks_enabled': True, 07:06:18 INFO - 'sps_profile': False, 07:06:18 INFO - 'sps_profile_interval': 0, 07:06:18 INFO - 'suite': 'dromaeojs', 07:06:18 INFO - 'system_bits': '32', 07:06:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:18 INFO - 'title': 't-yosemite-r7-0173', 07:06:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:18 INFO - 'use_talos_json': True, 07:06:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:06:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:18 INFO - 'work_dir': 'build'} 07:06:18 INFO - [mozharness: 2016-11-13 15:06:18.160055Z] Running clobber step. 07:06:18 INFO - Running pre-action listener: _resource_record_pre_action 07:06:18 INFO - Running main action method: clobber 07:06:18 INFO - rmtree: /builds/slave/test/build 07:06:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:06:20 INFO - Running post-action listener: _resource_record_post_action 07:06:20 INFO - [mozharness: 2016-11-13 15:06:20.282467Z] Finished clobber step (success) 07:06:20 INFO - [mozharness: 2016-11-13 15:06:20.282583Z] Running read-buildbot-config step. 07:06:20 INFO - Running pre-action listener: _resource_record_pre_action 07:06:20 INFO - Running main action method: read_buildbot_config 07:06:20 INFO - Using buildbot properties: 07:06:20 INFO - { 07:06:20 INFO - "project": "", 07:06:20 INFO - "product": "firefox", 07:06:20 INFO - "script_repo_revision": "production", 07:06:20 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:06:20 INFO - "repository": "", 07:06:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:06:20 INFO - "buildid": "20161113060520", 07:06:20 INFO - "pgo_build": "False", 07:06:20 INFO - "basedir": "/builds/slave/test", 07:06:20 INFO - "buildnumber": 122, 07:06:20 INFO - "slavename": "t-yosemite-r7-0173", 07:06:20 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:06:20 INFO - "platform": "yosemite_r7", 07:06:20 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:06:20 INFO - "branch": "mozilla-aurora", 07:06:20 INFO - "repo_path": "releases/mozilla-aurora", 07:06:20 INFO - "revision": "7cb90cec7f297457e088106ba9f6cc58ab5b51be", 07:06:20 INFO - "stage_platform": "macosx64", 07:06:20 INFO - "builduid": "fc74d1a1b63c48eca579c6292d84655e", 07:06:20 INFO - "slavebuilddir": "test" 07:06:20 INFO - } 07:06:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:06:20 INFO - Running post-action listener: _resource_record_post_action 07:06:20 INFO - [mozharness: 2016-11-13 15:06:20.285422Z] Finished read-buildbot-config step (success) 07:06:20 INFO - [mozharness: 2016-11-13 15:06:20.285521Z] Running download-and-extract step. 07:06:20 INFO - Running pre-action listener: _resource_record_pre_action 07:06:20 INFO - Running main action method: download_and_extract 07:06:20 INFO - mkdir: /builds/slave/test/build/tests 07:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:20 INFO - trying https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:06:20 INFO - Downloading https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 07:06:21 INFO - Downloaded 1199 bytes. 07:06:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:06:21 INFO - Using the following test package requirements: 07:06:21 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:06:21 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:06:21 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:06:21 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:06:21 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:06:21 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:06:21 INFO - u'jsshell-mac.zip'], 07:06:21 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:06:21 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:06:21 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:06:21 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:06:21 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:06:21 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:06:21 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:06:21 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:06:21 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:06:21 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:06:21 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:06:21 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:06:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:06:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:06:21 INFO - Fetch https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:06:22 INFO - Expected file size: 16423732 07:06:29 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:06:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:06:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:06:29 INFO - Fetch https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:06:29 INFO - Expected file size: 16423732 07:06:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:06:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:06:36 INFO - Fetch https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:06:37 INFO - Expected file size: 14414089 07:06:38 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')]} 07:06:38 INFO - trying https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:06:38 INFO - Downloading https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 07:06:43 INFO - Downloaded 115557517 bytes. 07:06:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:06:43 INFO - mkdir: /builds/slave/test/properties 07:06:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:43 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:43 INFO - Contents: 07:06:43 INFO - build_url:https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:06:43 INFO - Running post-action listener: _resource_record_post_action 07:06:43 INFO - Running post-action listener: set_extra_try_arguments 07:06:43 INFO - [mozharness: 2016-11-13 15:06:43.722280Z] Finished download-and-extract step (success) 07:06:43 INFO - [mozharness: 2016-11-13 15:06:43.722405Z] Running populate-webroot step. 07:06:43 INFO - Running pre-action listener: _resource_record_pre_action 07:06:43 INFO - Running main action method: populate_webroot 07:06:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:43 INFO - '--tppagecycles', 07:06:43 INFO - '7'], 07:06:43 INFO - 'tests': ['tsvgm']}}, 07:06:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:06:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:06:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:06:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:43 INFO - 'talos_options': ['--disable-e10s'], 07:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:43 INFO - 'talos_options': ['--disable-e10s'], 07:06:43 INFO - 'tests': ['damp', 'tps']}, 07:06:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:43 INFO - 'tests': ['damp', 'tps']}, 07:06:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:06:43 INFO - 'tests': ['dromaeo_dom']}, 07:06:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:06:43 INFO - 'tests': ['basic_compositor_video']}, 07:06:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:06:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:06:43 INFO - 'tests': ['a11yr', 07:06:43 INFO - 'ts_paint', 07:06:43 INFO - 'tpaint', 07:06:43 INFO - 'sessionrestore', 07:06:43 INFO - 'sessionrestore_no_auto_restore', 07:06:43 INFO - 'tabpaint']}, 07:06:43 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:43 INFO - 'ts_paint', 07:06:43 INFO - 'tpaint', 07:06:43 INFO - 'sessionrestore', 07:06:43 INFO - 'sessionrestore_no_auto_restore', 07:06:43 INFO - 'tabpaint']}, 07:06:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:06:43 INFO - 'ts_paint', 07:06:43 INFO - 'tpaint', 07:06:43 INFO - 'sessionrestore', 07:06:43 INFO - 'sessionrestore_no_auto_restore', 07:06:43 INFO - 'tabpaint']}, 07:06:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:06:43 INFO - 'ts_paint', 07:06:43 INFO - 'tpaint', 07:06:43 INFO - 'sessionrestore', 07:06:43 INFO - 'sessionrestore_no_auto_restore', 07:06:43 INFO - 'tabpaint']}, 07:06:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:06:43 INFO - 'tests': ['a11yr', 07:06:43 INFO - 'ts_paint', 07:06:43 INFO - 'tpaint', 07:06:43 INFO - 'sessionrestore', 07:06:43 INFO - 'sessionrestore_no_auto_restore', 07:06:43 INFO - 'tabpaint']}, 07:06:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:06:43 INFO - 'tests': ['a11yr', 07:06:43 INFO - 'ts_paint', 07:06:43 INFO - 'tpaint', 07:06:43 INFO - 'sessionrestore', 07:06:43 INFO - 'sessionrestore_no_auto_restore', 07:06:43 INFO - 'tabpaint']}, 07:06:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:06:43 INFO - 'tests': ['tsvgx', 07:06:43 INFO - 'tsvgr_opacity', 07:06:43 INFO - 'tart', 07:06:43 INFO - 'tscrollx', 07:06:43 INFO - 'cart']}, 07:06:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:43 INFO - 'tsvgr_opacity', 07:06:43 INFO - 'tart', 07:06:43 INFO - 'tscrollx', 07:06:43 INFO - 'cart']}, 07:06:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:43 INFO - 'talos_options': ['--disable-e10s'], 07:06:43 INFO - 'tests': ['tp5o']}, 07:06:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:43 INFO - 'tests': ['tp5o']}, 07:06:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:43 INFO - 'talos_options': ['--disable-e10s', 07:06:43 INFO - '--xperf_path', 07:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:43 INFO - 'tests': ['tp5n']}, 07:06:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:43 INFO - 'talos_options': ['--xperf_path', 07:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:43 INFO - 'tests': ['tp5n']}}, 07:06:43 INFO - 'talos.zip': {'path': '', 07:06:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:43 INFO - Running post-action listener: _resource_record_post_action 07:06:43 INFO - [mozharness: 2016-11-13 15:06:43.741284Z] Finished populate-webroot step (success) 07:06:43 INFO - [mozharness: 2016-11-13 15:06:43.741388Z] Running create-virtualenv step. 07:06:43 INFO - Running pre-action listener: _resource_record_pre_action 07:06:43 INFO - Running main action method: create_virtualenv 07:06:43 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:43 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 07:06:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:43 INFO - Using real prefix '/tools/python27' 07:06:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:44 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:47 INFO - Installing pip.................done. 07:06:47 INFO - Return code: 0 07:06:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebd7b250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a955d30>, '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 0x10a7bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94db20>, '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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 07:06: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', 'pip>=1.5'] in /builds/slave/test/build 07:06: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 pip>=1.5 07:06:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMK2d4F5GW/Render', 07:06:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:47 INFO - 'HOME': '/Users/cltbld', 07:06:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:47 INFO - 'LOGNAME': 'cltbld', 07:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:47 INFO - 'MOZ_NO_REMOTE': '1', 07:06:47 INFO - 'NO_EM_RESTART': '1', 07:06:47 INFO - 'PAGER': '/bin/cat', 07:06:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:47 INFO - 'PWD': '/builds/slave/test', 07:06:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:47 INFO - 'SHELL': '/bin/bash', 07:06:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yyUX6lIGv/Listeners', 07:06:47 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 07:06:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:47 INFO - 'USER': 'cltbld', 07:06:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:47 INFO - 'XPC_FLAGS': '0x0', 07:06:47 INFO - 'XPC_SERVICE_NAME': '0', 07:06:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:47 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 07:06:47 INFO - Cleaning up... 07:06:47 INFO - Return code: 0 07:06:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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', '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 0x10ab41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebd7b250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a955d30>, '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 0x10a7bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94db20>, '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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 07:06: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:06: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 psutil>=3.1.1 07:06:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMK2d4F5GW/Render', 07:06:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:47 INFO - 'HOME': '/Users/cltbld', 07:06:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:47 INFO - 'LOGNAME': 'cltbld', 07:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:47 INFO - 'MOZ_NO_REMOTE': '1', 07:06:47 INFO - 'NO_EM_RESTART': '1', 07:06:47 INFO - 'PAGER': '/bin/cat', 07:06:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:47 INFO - 'PWD': '/builds/slave/test', 07:06:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:47 INFO - 'SHELL': '/bin/bash', 07:06:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yyUX6lIGv/Listeners', 07:06:47 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 07:06:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:47 INFO - 'USER': 'cltbld', 07:06:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:47 INFO - 'XPC_FLAGS': '0x0', 07:06:47 INFO - 'XPC_SERVICE_NAME': '0', 07:06:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:48 INFO - Downloading/unpacking psutil>=3.1.1 07:06:48 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 07:06:48 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 07:06:48 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 07:06:48 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 07:06:48 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 07:06:48 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 07:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:51 INFO - Installing collected packages: psutil 07:06:51 INFO - Running setup.py install for psutil 07:06:51 INFO - building 'psutil._psutil_osx' extension 07:06:51 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 07:06:52 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 07:06:52 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 07:06:52 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 07:06:52 INFO - building 'psutil._psutil_posix' extension 07:06:52 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 07:06:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:06:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:06:52 INFO - ^ 07:06:52 INFO - 1 warning generated. 07:06:52 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 07:06:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:52 INFO - Successfully installed psutil 07:06:52 INFO - Cleaning up... 07:06:52 INFO - Return code: 0 07:06:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:52 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 0x10ab41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebd7b250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a955d30>, '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 0x10a7bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94db20>, '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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 07:06:52 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 07:06:52 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 07:06:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMK2d4F5GW/Render', 07:06:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:52 INFO - 'HOME': '/Users/cltbld', 07:06:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:52 INFO - 'LOGNAME': 'cltbld', 07:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:52 INFO - 'MOZ_NO_REMOTE': '1', 07:06:52 INFO - 'NO_EM_RESTART': '1', 07:06:52 INFO - 'PAGER': '/bin/cat', 07:06:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:52 INFO - 'PWD': '/builds/slave/test', 07:06:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:52 INFO - 'SHELL': '/bin/bash', 07:06:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yyUX6lIGv/Listeners', 07:06:52 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 07:06:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:52 INFO - 'USER': 'cltbld', 07:06:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:52 INFO - 'XPC_FLAGS': '0x0', 07:06:52 INFO - 'XPC_SERVICE_NAME': '0', 07:06:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06:53 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 07:06:53 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 07:06:53 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 07:06:53 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 07:06:53 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 07:06:53 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 07:06:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:55 INFO - Installing collected packages: mozsystemmonitor 07:06:55 INFO - Running setup.py install for mozsystemmonitor 07:06:55 INFO - Successfully installed mozsystemmonitor 07:06:55 INFO - Cleaning up... 07:06:55 INFO - Return code: 0 07:06:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ab41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebd7b250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a955d30>, '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 0x10a7bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94db20>, '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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 07:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:06:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMK2d4F5GW/Render', 07:06:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:55 INFO - 'HOME': '/Users/cltbld', 07:06:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:55 INFO - 'LOGNAME': 'cltbld', 07:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:55 INFO - 'MOZ_NO_REMOTE': '1', 07:06:55 INFO - 'NO_EM_RESTART': '1', 07:06:55 INFO - 'PAGER': '/bin/cat', 07:06:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:55 INFO - 'PWD': '/builds/slave/test', 07:06:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:55 INFO - 'SHELL': '/bin/bash', 07:06:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yyUX6lIGv/Listeners', 07:06:55 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 07:06:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:55 INFO - 'USER': 'cltbld', 07:06:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:55 INFO - 'XPC_FLAGS': '0x0', 07:06:55 INFO - 'XPC_SERVICE_NAME': '0', 07:06:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:56 INFO - Downloading/unpacking jsonschema==2.5.1 07:06:56 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 07:06:56 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 07:06:56 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 07:06:56 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 07:06:56 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 07:06:56 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 07:06:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:59 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:59 INFO - warning: no files found matching '*.txt' 07:06:59 INFO - no previously-included directories found matching 'build' 07:06:59 INFO - no previously-included directories found matching 'dist' 07:06:59 INFO - no previously-included directories found matching '.git*' 07:06:59 INFO - Installing collected packages: jsonschema, functools32 07:06:59 INFO - Running setup.py install for functools32 07:06:59 INFO - warning: no files found matching '*.txt' 07:06:59 INFO - no previously-included directories found matching 'build' 07:06:59 INFO - no previously-included directories found matching 'dist' 07:06:59 INFO - no previously-included directories found matching '.git*' 07:06:59 INFO - Successfully installed jsonschema functools32 07:06:59 INFO - Cleaning up... 07:06:59 INFO - Return code: 0 07:06:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ab41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebd7b250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a955d30>, '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 0x10a7bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94db20>, '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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 07:06:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:06:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMK2d4F5GW/Render', 07:06:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:59 INFO - 'HOME': '/Users/cltbld', 07:06:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:59 INFO - 'LOGNAME': 'cltbld', 07:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:59 INFO - 'MOZ_NO_REMOTE': '1', 07:06:59 INFO - 'NO_EM_RESTART': '1', 07:06:59 INFO - 'PAGER': '/bin/cat', 07:06:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:59 INFO - 'PWD': '/builds/slave/test', 07:06:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:59 INFO - 'SHELL': '/bin/bash', 07:06:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yyUX6lIGv/Listeners', 07:06:59 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 07:06:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:59 INFO - 'USER': 'cltbld', 07:06:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:59 INFO - 'XPC_FLAGS': '0x0', 07:06:59 INFO - 'XPC_SERVICE_NAME': '0', 07:06:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:59 INFO - Cleaning up... 07:06:59 INFO - Return code: 0 07:06:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ab41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebd7b250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a955d30>, '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 0x10a7bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94db20>, '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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 07:06:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:06:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMK2d4F5GW/Render', 07:06:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:59 INFO - 'HOME': '/Users/cltbld', 07:06:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:59 INFO - 'LOGNAME': 'cltbld', 07:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:59 INFO - 'MOZ_NO_REMOTE': '1', 07:06:59 INFO - 'NO_EM_RESTART': '1', 07:06:59 INFO - 'PAGER': '/bin/cat', 07:06:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:59 INFO - 'PWD': '/builds/slave/test', 07:06:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:59 INFO - 'SHELL': '/bin/bash', 07:06:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yyUX6lIGv/Listeners', 07:06:59 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 07:06:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:59 INFO - 'USER': 'cltbld', 07:06:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:59 INFO - 'XPC_FLAGS': '0x0', 07:06:59 INFO - 'XPC_SERVICE_NAME': '0', 07:06:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:07:00 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 07:07:00 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 07:07:00 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 07:07:00 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 07:07:00 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 07:07:00 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 07:07:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:07:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:07:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:03 INFO - Downloading docopt-0.6.1.tar.gz 07:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:07:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:07:03 INFO - Running setup.py install for blobuploader 07:07:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:07:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:07:03 INFO - Running setup.py install for requests 07:07:04 INFO - Running setup.py install for docopt 07:07:04 INFO - Successfully installed blobuploader requests docopt 07:07:04 INFO - Cleaning up... 07:07:04 INFO - Return code: 0 07:07:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:04 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')]} 07:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:04 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')]} 07:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebd7b250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a955d30>, '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 0x10a7bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94db20>, '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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 07:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:07:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMK2d4F5GW/Render', 07:07:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:04 INFO - 'HOME': '/Users/cltbld', 07:07:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:04 INFO - 'LOGNAME': 'cltbld', 07:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:04 INFO - 'MOZ_NO_REMOTE': '1', 07:07:04 INFO - 'NO_EM_RESTART': '1', 07:07:04 INFO - 'PAGER': '/bin/cat', 07:07:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:04 INFO - 'PWD': '/builds/slave/test', 07:07:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:04 INFO - 'SHELL': '/bin/bash', 07:07:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yyUX6lIGv/Listeners', 07:07:04 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 07:07:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:04 INFO - 'USER': 'cltbld', 07:07:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:04 INFO - 'XPC_FLAGS': '0x0', 07:07:04 INFO - 'XPC_SERVICE_NAME': '0', 07:07:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:07:04 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-bQuUwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:07:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-YPi4Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:07:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-CcwviA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:07:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-reQY7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:07:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-APJ1EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:07:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-7_I8A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:07:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-661WUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:07:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-4hO8H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:07:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-SWTDm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:07:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-VOCCNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:07:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-RMcLsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:07:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Z3jTG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:07:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-sgnB0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:07:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-7VopFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-BIyt9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:07:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Tm9bRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:07:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-_na0zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:07:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:07:06 INFO - Running setup.py install for manifestparser 07:07:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:07:06 INFO - Running setup.py install for mozcrash 07:07:06 INFO - Running setup.py install for mozdebug 07:07:07 INFO - Running setup.py install for mozdevice 07:07:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:07:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:07:07 INFO - Running setup.py install for mozfile 07:07:07 INFO - Running setup.py install for mozhttpd 07:07:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:07:07 INFO - Running setup.py install for mozinfo 07:07:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:07:07 INFO - Running setup.py install for mozInstall 07:07:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:07:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:07:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:07:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:07:07 INFO - Running setup.py install for mozleak 07:07:07 INFO - Running setup.py install for mozlog 07:07:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:07:08 INFO - Running setup.py install for moznetwork 07:07:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:07:08 INFO - Running setup.py install for mozprocess 07:07:08 INFO - Running setup.py install for mozprofile 07:07:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:07:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:07:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:07:08 INFO - Running setup.py install for mozrunner 07:07:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:07:08 INFO - Running setup.py install for mozscreenshot 07:07:08 INFO - Running setup.py install for moztest 07:07:09 INFO - Running setup.py install for mozversion 07:07:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:07:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:07:09 INFO - Cleaning up... 07:07:09 INFO - Return code: 0 07:07:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebd7b250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a955d30>, '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 0x10a7bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94db20>, '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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 07:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:07:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMK2d4F5GW/Render', 07:07:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:09 INFO - 'HOME': '/Users/cltbld', 07:07:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:09 INFO - 'LOGNAME': 'cltbld', 07:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:09 INFO - 'MOZ_NO_REMOTE': '1', 07:07:09 INFO - 'NO_EM_RESTART': '1', 07:07:09 INFO - 'PAGER': '/bin/cat', 07:07:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:09 INFO - 'PWD': '/builds/slave/test', 07:07:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:09 INFO - 'SHELL': '/bin/bash', 07:07:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yyUX6lIGv/Listeners', 07:07:09 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 07:07:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:09 INFO - 'USER': 'cltbld', 07:07:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:09 INFO - 'XPC_FLAGS': '0x0', 07:07:09 INFO - 'XPC_SERVICE_NAME': '0', 07:07:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:07:09 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-XoYxm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:07:09 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-P5rv2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:07:09 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-gOW3Hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:07:09 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Cq27CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:07:09 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-zJcQm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:07:10 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-4cQqGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:07:10 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-fwhKq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:07:10 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-fgOB0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:07:10 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Qhlnte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:07:10 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-IADCia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:07:10 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-zkfR4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:07:10 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-KpdAlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:07:10 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-NbN51w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:07:10 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-4CAaSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:11 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-gXuMpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:07:11 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-qV3mAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:07:11 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Wv3_eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:07:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:13 INFO - Downloading blessings-1.6.tar.gz 07:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:07:13 INFO - Installing collected packages: blessings 07:07:13 INFO - Running setup.py install for blessings 07:07:14 INFO - Successfully installed blessings 07:07:14 INFO - Cleaning up... 07:07:14 INFO - Return code: 0 07:07:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:07:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:07:14 INFO - Reading from file tmpfile_stdout 07:07:14 INFO - Current package versions: 07:07:14 INFO - blessings == 1.6 07:07:14 INFO - blobuploader == 1.2.4 07:07:14 INFO - docopt == 0.6.1 07:07:14 INFO - functools32 == 3.2.3-2 07:07:14 INFO - jsonschema == 2.5.1 07:07:14 INFO - manifestparser == 1.1 07:07:14 INFO - mozInstall == 1.12 07:07:14 INFO - mozcrash == 0.17 07:07:14 INFO - mozdebug == 0.1 07:07:14 INFO - mozdevice == 0.48 07:07:14 INFO - mozfile == 1.2 07:07:14 INFO - mozhttpd == 0.7 07:07:14 INFO - mozinfo == 0.9 07:07:14 INFO - mozleak == 0.1 07:07:14 INFO - mozlog == 3.4 07:07:14 INFO - moznetwork == 0.27 07:07:14 INFO - mozprocess == 0.23 07:07:14 INFO - mozprofile == 0.28 07:07:14 INFO - mozrunner == 6.12 07:07:14 INFO - mozscreenshot == 0.1 07:07:14 INFO - mozsystemmonitor == 0.3 07:07:14 INFO - moztest == 0.7 07:07:14 INFO - mozversion == 1.4 07:07:14 INFO - psutil == 3.1.1 07:07:14 INFO - requests == 1.2.3 07:07:14 INFO - wsgiref == 0.1.2 07:07:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebd7b250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a955d30>, '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 0x10a7bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94db20>, '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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 07:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:07:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMK2d4F5GW/Render', 07:07:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:14 INFO - 'HOME': '/Users/cltbld', 07:07:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:14 INFO - 'LOGNAME': 'cltbld', 07:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:14 INFO - 'MOZ_NO_REMOTE': '1', 07:07:14 INFO - 'NO_EM_RESTART': '1', 07:07:14 INFO - 'PAGER': '/bin/cat', 07:07:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:14 INFO - 'PWD': '/builds/slave/test', 07:07:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:14 INFO - 'SHELL': '/bin/bash', 07:07:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yyUX6lIGv/Listeners', 07:07:14 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 07:07:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:14 INFO - 'USER': 'cltbld', 07:07:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:14 INFO - 'XPC_FLAGS': '0x0', 07:07:14 INFO - 'XPC_SERVICE_NAME': '0', 07:07:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:14 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)) 07:07:14 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)) 07:07:14 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)) 07:07:14 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)) 07:07:14 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)) 07:07:14 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)) 07:07:14 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)) 07:07:14 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)) 07:07:14 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)) 07:07:14 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)) 07:07:14 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)) 07:07:14 INFO - Cleaning up... 07:07:14 INFO - Return code: 0 07:07:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:14 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 0x10ab41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebd7b250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a955d30>, '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 0x10a7bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94db20>, '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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 07:07:14 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 07:07:14 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 07:07:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMK2d4F5GW/Render', 07:07:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:14 INFO - 'HOME': '/Users/cltbld', 07:07:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:14 INFO - 'LOGNAME': 'cltbld', 07:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:14 INFO - 'MOZ_NO_REMOTE': '1', 07:07:14 INFO - 'NO_EM_RESTART': '1', 07:07:14 INFO - 'PAGER': '/bin/cat', 07:07:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:14 INFO - 'PWD': '/builds/slave/test', 07:07:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:14 INFO - 'SHELL': '/bin/bash', 07:07:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yyUX6lIGv/Listeners', 07:07:14 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 07:07:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:14 INFO - 'USER': 'cltbld', 07:07:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:14 INFO - 'XPC_FLAGS': '0x0', 07:07:14 INFO - 'XPC_SERVICE_NAME': '0', 07:07:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:07:15 INFO - Cleaning up... 07:07:15 INFO - Return code: 0 07:07:15 INFO - Running post-action listener: _resource_record_post_action 07:07:15 INFO - Running post-action listener: _start_resource_monitoring 07:07:15 INFO - Starting resource monitoring. 07:07:15 INFO - [mozharness: 2016-11-13 15:07:15.048813Z] Finished create-virtualenv step (success) 07:07:15 INFO - [mozharness: 2016-11-13 15:07:15.049809Z] Running install step. 07:07:15 INFO - Running pre-action listener: _resource_record_pre_action 07:07:15 INFO - Running main action method: install 07:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:07:15 INFO - Reading from file tmpfile_stdout 07:07:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:07:15 INFO - Reading from file tmpfile_stdout 07:07:15 INFO - Output received: 07:07:15 INFO - Usage: mozinstall [options] installer 07:07:15 INFO - Options: 07:07:15 INFO - -h, --help show this help message and exit 07:07:15 INFO - -d DEST, --destination=DEST 07:07:15 INFO - Directory to install application into. [default: 07:07:15 INFO - "/builds/slave/test"] 07:07:15 INFO - --app=APP Application being installed. [default: firefox] 07:07:15 INFO - mkdir: /builds/slave/test/build/application 07:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:07:47 INFO - Reading from file tmpfile_stdout 07:07:47 INFO - Output received: 07:07:47 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:07:47 INFO - Running post-action listener: _resource_record_post_action 07:07:47 INFO - [mozharness: 2016-11-13 15:07:47.874052Z] Finished install step (success) 07:07:47 INFO - [mozharness: 2016-11-13 15:07:47.874192Z] Running run-tests step. 07:07:47 INFO - Running pre-action listener: _resource_record_pre_action 07:07:47 INFO - Running main action method: run_tests 07:07:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:07:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:07:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:07:47 INFO - 2016-11-13 07:07:47.888 screenresolution[1648:7960] starting screenresolution argv=screenresolution get 07:07:47 INFO - 2016-11-13 07:07:47.891 screenresolution[1648:7960] Display 0: 1600x1200x32@60 07:07:47 INFO - 2016-11-13 07:07:47.897 screenresolution[1649:7963] starting screenresolution argv=screenresolution list 07:07:47 INFO - Available Modes on Display 0 07:07:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:07:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:07:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:07:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:07:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:07:48 INFO - Intel Iris: 07:07:48 INFO - Chipset Model: Intel Iris 07:07:48 INFO - Type: GPU 07:07:48 INFO - Bus: Built-In 07:07:48 INFO - VRAM (Dynamic, Max): 1536 MB 07:07:48 INFO - Vendor: Intel (0x8086) 07:07:48 INFO - Device ID: 0x0a2e 07:07:48 INFO - Revision ID: 0x0009 07:07:48 INFO - Displays: 07:07:48 INFO - Display: 07:07:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:07:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:07:48 INFO - Display Serial Number: 1600x1200 60 07:07:48 INFO - Main Display: Yes 07:07:48 INFO - Mirror: Off 07:07:48 INFO - Online: Yes 07:07:48 INFO - Rotation: Supported 07:07:48 INFO - Return code: 0 07:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:07:48 INFO - Python 2.7.3 07:07:48 INFO - Return code: 0 07:07:48 INFO - grabbing minidump binary from tooltool 07:07:48 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')]} 07:07:48 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 0x10a955d30>, '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 0x10a7bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a94db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:07:48 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 07:07:48 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 07:07:48 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 07:07:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:48 INFO - Return code: 0 07:07:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:07:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:07:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:07:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:07:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 07:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0173 --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 07:07:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMK2d4F5GW/Render', 07:07:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:48 INFO - 'HOME': '/Users/cltbld', 07:07:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:48 INFO - 'LOGNAME': 'cltbld', 07:07:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:07:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:48 INFO - 'MOZ_NO_REMOTE': '1', 07:07:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:07:48 INFO - 'NO_EM_RESTART': '1', 07:07:48 INFO - 'PAGER': '/bin/cat', 07:07:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:48 INFO - 'PWD': '/builds/slave/test', 07:07:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:07:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:48 INFO - 'SHELL': '/bin/bash', 07:07:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yyUX6lIGv/Listeners', 07:07:48 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 07:07:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:48 INFO - 'USER': 'cltbld', 07:07:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:48 INFO - 'XPC_FLAGS': '0x0', 07:07:48 INFO - 'XPC_SERVICE_NAME': '0', 07:07:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 07:07:48 INFO - mozversion application_buildid: 20161113060520 07:07:48 INFO - mozversion application_changeset: 7cb90cec7f297457e088106ba9f6cc58ab5b51be 07:07:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:07:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:48 INFO - mozversion application_name: Firefox 07:07:48 INFO - mozversion application_remotingname: firefox-dev 07:07:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:07:48 INFO - mozversion application_vendor: Mozilla 07:07:48 INFO - mozversion application_version: 51.0a2 07:07:48 INFO - mozversion platform_buildid: 20161113060520 07:07:48 INFO - mozversion platform_changeset: 7cb90cec7f297457e088106ba9f6cc58ab5b51be 07:07:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:07:48 INFO - mozversion platform_version: 51.0a2 07:07:48 INFO - using testdate: 1479049668 07:07:48 INFO - actual date: 1479049668 07:07:48 INFO - starting webserver on 'localhost:49271' 07:07:48 INFO - SUITE-START | Running 2 tests 07:07:48 INFO - TEST-START | dromaeo_css 07:07:48 INFO - operating with platform_type : mac_ 07:07:48 INFO - Initialising browser for dromaeo_css test... 07:07:48 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpnB8fdn/profile http://localhost:49271/getInfo.html) 07:07:51 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 07:07:51 INFO - PROCESS | 1659 | colorDepth:24 07:07:51 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 07:07:51 INFO - PROCESS | 1659 | __metrics 07:07:51 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:07:51 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:07:52 INFO - TEST-INFO | 1659: exit 0 07:07:52 INFO - Browser initialized. 07:07:52 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:52 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpnB8fdn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:03 INFO - PROCESS | 1662 | RSS: Main: 219648000 07:08:03 INFO - PROCESS | 1662 | 07:08:54 INFO - PROCESS | 1662 | 1479049734950 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:11:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 07:11:09 INFO - PROCESS | 1662 | RSS: Main: 308355072 07:11:09 INFO - PROCESS | 1662 | 07:14:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 07:14:13 INFO - PROCESS | 1662 | RSS: Main: 349552640 07:14:13 INFO - PROCESS | 1662 | 07:17:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 07:17:16 INFO - PROCESS | 1662 | RSS: Main: 346664960 07:17:16 INFO - PROCESS | 1662 | 07:20:18 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 07:20:18 INFO - PROCESS | 1662 | RSS: Main: 317976576 07:20:18 INFO - PROCESS | 1662 | 07:23:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 07:23:23 INFO - PROCESS | 1662 | RSS: Main: 306298880 07:23:23 INFO - PROCESS | 1662 | 07:26:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 07:26:26 INFO - PROCESS | 1662 | RSS: Main: 403030016 07:26:26 INFO - PROCESS | 1662 | 07:26:26 INFO - PROCESS | 1662 | __start_tp_report 07:26:26 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 07:26:26 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 07:26:26 INFO - PROCESS | 1662 | |i|pagename|runs| 07:26:26 INFO - PROCESS | 1662 | |0;dojo.html;3295.307985323082;3296.8681252749893;3337.5994880614317;3357.9496307555405;3358.2779702363987;5591.524720398766;5657.066584013633;5676.744546495407;5677.318721753395;5694.202811606373;5594.356648985368;5669.489745922866;5698.0883058710615;5713.085906255;5713.257276554053;5085;5145.099607568679;5151.536361727443;5187.481251874801;5241.764120614582;5116.1814109742445;5144.356955380577;5272.472752724716;5282.920756188661;5345.33183352081;5214.66104703195;5251.76367063483;5256.973715131419;5263.605229607776;5271.051210782058;4311.805968731414;5231.738413079369;5237.869053273661;5245.291885595434;5246.685198888079;5081.745912704387;5203.19350500673;5203.60972927032;5211.530962213381;5237.47625237477;5721.141828725683;5721.4850663440075;5721.6853073080965;5725.627834190765;5729.28383952006;6116.9059639085835;6117.204763380777;6117.834553513639;6131.560175786049;6135.601185922946;6161.137440758297;6200.193974783295;6233.688315584202;6238.844028899269;6275.560710750249;5750.971245143789;5752.395998420147;5755.65466072037;5762.855928601776;5789.189513468118;6185.969070154621;6257.186565746424;6262.561620686508;6310.968445157745;6333.429991300805;5958.553108516879;6031.788887389008;6104.816855494342;6144.446999770043;6145.26256849172;6219.47134493564;6249;6252.843678907972;6254.186955695731;6268.749250030039;5996.790112346047;6024.969875150597;6183.196184496077;6211.006239001828;6221.47117495018;6109.617229398918;6137;6144.692765361803;6161.983272760034;6222.688865556704;4917.385326834145;4920.532549407801;4920.72935988524;4924.901501969941;4958.479359667255;4342.088161486124;4471.128130014616;4475.373447717322;4481.462224533012;4487.214737420938;4827.444843842933;5614.663120212718;5697.914531282034;5701.173329867146;5701.600887937888;6253.874922501524;6262.780802671885;6266.342034086355;6271.059341098871;6281.905771413432;5777.682227477445;5794.072948328248;5806.419358064244;5814.622049566765;5848.970755146197;5211.739413029409;5330.466953304638;5387.218853266333;5395.298611180521;5405.864768398602;6229.626222426487;6301.558890877594;6307.936920630735;6322.209723784527;6329.303776584664;6268.216472940882;6274.654893980693;6274.8431289216305;6279.466245369194;6286.214223222098;6260.852210358211;6306.085617585516;6308.463780578702;6324.1146239527425;6326.051092336186;5984.670843103671;6048.60684055535;6055.576109672281;6061.36355682647;6088.147659327787;6218.595791273553;6223.222097237845;6226.688665566613;6245.6252624842655;6245.906311405423;5933.080372542263;6008.54935879802;6021.976264035037;6043.516518678583;6087.2999605044215;5860.531157507475;5915.378885217162;6031.517478601613;6055.878882422238;6060.212172417558;5759.9136012959;5780.5953583248765;5836.416358364129;5856.4143585641095;5897.203877476486;5880.852978675567;5957.017092179742;5998.7300571473515;6012.939870601413;6031.728572214349;5782.45066718661;5808.738606762621;5845.386234445492;5864.06175011996;5993.550483713651 07:26:26 INFO - PROCESS | 1662 | |1;ext.html;492.4705941113304;515.5488947171225;523.4922125538227;533.7144627624219;554.0359773993252;39141;42226.155476890446;42303.15393692124;42303.36544951824;42320.9419764506;42523;43029.7848510757;43081.569184308224;43154.784226078904;43189.92025199372;8457.873131903027;8877.112288771135;9058.682946096887;9814.116729494326;9982.950085249564;8982.775430614221;9087.273018158532;9088.909110908906;11139.832902506469;11627.186096973215;12409.751804963895;12488.93755531221;12494.687632809162;12497.812532812015;12535.749285014293;12097.697557561043;12146.939265303705;12405.503779848796;12500.187487813308;12506.49974001048;8877.644894204224;9108.59011344491;11889.583864564698;12008.63974080779;12320.01439884816;42875.35686964667;42967.785161073996;43013.56986430127;43161;43170.56829431728;3412.3185095437584;3424.366492198951;3469.392856250146;3513.841877115536;3748.0817199785956;30567.541486877715;31416.90040848559;32399.51400728991;32412.513812292833;33022.83488582566;3149.6062992125985;3175.2061984503875;3236.3203727217315;3265.804051756902;3345.2640419107756;479335;480177;480833.9999999965;481150;482364;61507.76984460286;61914.38085619176;61952.07071893925;62051.689741551;62069.379306207265;63056.36943630505;65303.428759986346;65456.67271663611;65570.67214663896;65596.3600909981;16858.24137913797;17128.143592820557;17133.22900469482;17151.228194731266;17152.05663688484;13267.938564914784;13326.33368331599;13328.933685305152;13332.266725330006;13356.799648005288;15222.934394592272;15560.766588501181;15564.377424903103;17184.680068190635;17452;6928.501106940963;6987.965060174768;7011.89482157768;7252.927470725331;7476.364509016795;832.4672209785742;895.4537731983485;1015.4970643447739;1058.5659879449388;1072.7639919217759;30304.696953030627;30512.389752205276;30635.2341191472;30888;30942.845285773426;902.9683961061331;1041.1358572384902;1135.6479491357707;1149.6378640728144;1184.248002518407;15686.607834803994;15852.682946341009;15930.044197348196;16064.598385040468;16181.029138251743;186813.06593467217;188085;188182;188806;189528;51577;52817;58438.7078064607;59616;59722.10416843751;1343.8118663386938;1367.6375760423496;1384.8268966379203;1385.1688986607955;1388.4585011845388;30394.240143996576;32165.678343216267;32367.190820229684;32810.67189328172;32962.50556241706;52655.73672131615;53238;53310.46689533055;53315.46684533105;53323.733381334394;597051;598436;599529;600520;601099;40327.798361008005;41004.79497602493;41688.3746743793;41914.79042604767;41926.37110443407;39422.80288598654;44264.11471770611;47958.5204147968;48193;48808.51191488039;38781;39337.606623933396;40330.79834600808;40551.797241014785;41544.58455415407;39730;39936.00159996023;40094.799526002185;40627.390589140596;41835;39110;39284.41073383844;39513;39572.2085558293;39581.208375832895;32914;33972.83013584916;34324.14189645279;35794.463083053255;35828.462573061945;20307.69538456895;22091.447713807283;25794.484110318062;26379;26833 07:26:26 INFO - PROCESS | 1662 | |2;jquery.html;358.346018516208;376.5989221479125;377.54128733588703;386.80852977776004;410.8192395346048;14956.850431495695;15372.84627153728;16853;20372.69440958383;20952.26667066653;20082.598348033032;20674.689879651778;20692.48268793281;20804;20987.580248395025;4414.470263568376;5260.132078207092;5521.420250873661;5522.22688823565;5527.032769265383;3908.472356231901;4142.523609784868;5478.205660179272;5490.423505531901;5537.418571050042;4032.959670403288;5819.30168379795;6095.81712548622;6096.939030609704;6134.662593557353;5857.824265272048;6070.939290607082;6103.084537319393;6117.908231376533;6137.110119032737;5923.881522369572;5927.911081333784;5930.762769489215;5933.110033494967;5934.258217722785;16776.916115419346;25830.612540811904;25976.87011564949;26042.82807273658;26195;2467.395488105408;2492.2149522900227;2561.679790026247;2702.4324891772753;2803.8924624773304;9650.469224192666;9883.209343252522;10121.987801219893;10365.17078633715;10366.222533310032;1874.6625607390665;1875.6530041942285;1941.7864034956144;1994.5013746563359;1999.980000199994;112672;119327.2100918487;131619.99999999904;132395;132884;11190.440477976068;11423.543058277575;11499.655010349703;11514.36670983104;11774.352410617326;14747.92626036863;14748.336324865406;14750.114993100233;14766.261686915612;14788.334524946404;8408.285295749929;8653;8654.264387527131;8793;8801.955990220007;8629.01532647482;8679.088695686989;8682.175193356621;8854.026057133839;8857.424267422597;4417.580329868657;4473.306637471197;4488.147252022105;4545.477270113913;4581.289900065495;1754.105565988729;1818.8902205059283;1835.4860639021094;1853.9629207415776;1934.6227485640447;710.8342318597504;813.5322189740923;924.8104138651561;969.9272554558436;982.3712823792779;15512;21866.671999920014;21915;22038;22038.669419958394;914.977125571866;922.2990527199242;962.4658314635304;993.1558175550869;1020.6223697232072;10715.517801698943;11186.489823873835;11324.094072474183;11333.886661133283;11347.546098156146;552408;552554;554094;607416;624286;120753;122183.55632887293;132695;134111.65888341187;136370;434.68702534175344;436.7663300134413;452.16575418353085;454.69308216953425;461.4808340616739;10908.400037997986;10910.781784364426;11189.04893084097;11239.100871930063;11579.88420115788;56771;57494.7125264371;58882.41117588769;58973.705131475785;60067.89762358296;81547.18452815633;82345;84857;85677;86569.56715216384;7654.770356889302;8101.675932962851;8138.104808470945;8360.331173506227;8594.699185528476;10212.234082443994;11797.52809887595;12086.91217790403;13214.867851321364;13718.245496497788;11440.771184576428;11571.594994175164;11683.532658693557;11772.764544709229;11892.583759568373;11301.15241356885;11514.36670983104;11611.477483513094;11882.227655202385;12008.579699710468;11536.538538458368;11586.304821710724;11887.346195958959;11942.044636429238;11997.40012999364;7690;8122.796930076795;8303.169683031649;8380.622871970654;8740.125987401208;8168.714095006646;11041.227114102257;11115.666530004113;11466.31202127875;11516.94241528787 07:26:26 INFO - PROCESS | 1662 | |3;mootools.html;1385.3211926156184;1544.5984044148518;1746.9475915722526;1865.4590168851034;1952.6485232658133;8281.75154745358;8816.118388161196;8824.823503529926;8826.558672066396;8833.425827321227;7748.41886858485;8018.639161237744;8034.357251419887;8385.496870187793;8597.527136007517;2347.812175025998;2380.143148466551;2380.7262164851004;2381.7022872140983;2382.28531440568;2343.8359314847967;2348.9412764680933;2388.95222095558;2389.4623709665275;2390.175389490623;2075.740532433446;2152.1499007891875;2153.493928926709;2154.0845140815168;2158.190678495564;2275.3742720751843;2351.576716191085;2360.480694247263;2364.337985364101;2364.9527009459885;2351.6354964980455;2362.11420717231;2366.219147681261;2371.7628237176145;2378.774016468433;8701.956490217572;8765.123487651248;8779.47323160606;8779.78050548735;8796.560171991376;5177.171652535614;5235.6073294502685;5290.206469029637;5314.309139811839;5331.013762453958;2865.355295058616;3361.3949489092197;3519.577650681909;3520.6655367740022;3531.982340088309;874.540866045325;1025.6307729217476;1027.865248648327;1045.984310235347;1067.7044354637515;11497.770044599145;11508.482118304613;11517.942410287895;11519.596814111466;11523.020543253833;4000.5599384067727;4481.462224533077;4700.670953033255;4720.032393359353;4822.590079843182;9836.655717050013;9844.950775246078;9851.605935762633;9859.654912078186;9868.851967220497;5283.550898173621;5292.708901010405;5295.576353891679;5297.205419187153;5305.336832895888;4639.9768001160455;4801.68789028712;4831.033793241366;4847.3698419205275;4854.660173787801;3857.3442514772555;3861.8841434757;3864.1305706215876;3946.8223929923224;4021.2560676274984;1281.116029939339;1284.293638498822;1288.5232463988384;1300.5383089003458;1301.7461594988886;625.9906101408483;745.4483682075333;756.2664215710862;786.4023342259809;911.9694744938178;5574.804881829116;5581.944180558224;5642.294713160855;5753.798617048383;6027.698615069229;886.8536691445839;916.7753900294471;925.2597921662643;949.6486300068881;974.1427543761445;3713.827321884876;3900.31744444721;3930.744501607386;3958.4853968984426;3998.4602078719;10060.295779295378;10468.162546996222;10478.580856765797;10581.84127238092;10591.311564748266;9171.58727857248;10509.737256568495;10547.367157970546;10552.997465240944;10569.207309451822;7838.176991415933;8130.83738325242;8152.551609661526;8182.83634327322;8192.631331590093;5426.186072089218;5728.140778883201;5753.741081651419;5991.400859913973;5992.161097446448;9688.32181747271;9850.310478266452;9875.802483950138;9891.55488003056;9913.256505761952;9466.621335146518;9786.461744604116;9912.75218119524;9935.503224838585;10058;7402.851942961218;7578.658960346687;7587.620618968919;7602.277783610548;7602.771916842504;8024.719134830253;8141.9185808141165;8222.876656850032;8242.134575869688;8246.134155913544;5382.542483888757;7090.5036647436245;7249.05762250904;7306.7077316906725;7308.59802710856;7037.824054398681;7150.570965742072;7266.091738532684;7333.413326933939;7391.2978267064545;6909.343612356818;6945.583265004116;7019.789406317818;7027.543209691354;7037.929620703932;4863.513648635108;4940.333055037524;4941.382327209099;4955.959248557843;4963.057019166491;4853.344798452164;4862.708237505761;4874.95125048745;5005.224190250517;5032 07:26:26 INFO - PROCESS | 1662 | |4;prototype.html;287.11568369422184;303.1814101924803;306.1977618639166;317.1895806215121;320.7594304271796;5279.313689220396;5379.300690910186;5470.507654311111;5530.198121272418;5559.193262189784;4628.4677262114865;5230.424653288144;5287.68273903566;5310.840674779763;5323.44103869093;3535.3661522165958;3547.71618270539;4140.710150289481;4147.294959856817;4156.044109854735;3998.5001874765653;4137.9172416551655;4138.6482149017365;4155.667546596265;4155.709100362976;3886.2227554489073;3904.960950390488;4105.651019663333;4140.730852494593;4141.855035073773;3373.325334932999;3860.3823388257883;4070.9389359159486;4116.526599441073;4119.876403707864;3245.896395225611;3294.258791771856;3562.412201986669;3562.5215535552975;3577.910552236189;4279.486461624625;4416.4258646375765;5378.892422151535;5408.35099788024;5433.169615421119;4583.808209865426;4660.970369259974;4661.953380466186;4674.602658773974;4734.147853386389;5417.158166223464;5510.724463776835;5730.793644446876;5771.394003629601;5833.045929613542;3528.858845646171;3912.1979994101425;3920.451136840816;3921.4706014687936;3940.625640564142;5633.549316054706;5932.525397968152;6023.216981792339;6025.457708806229;6032.698365081728;3388.203772113551;3773.603771603997;3932.193900250442;3949.921001579952;3950.4074388841327;4019.738716983387;4032.0927791246736;4037.6366127048705;4041.2523683118716;4043.5754245804355;3939.0940083780893;4070.715049946475;4079.73481723687;4700.8952896069395;4762.238041913277;4824.903501929942;5321.5476684482255;5803.883922321615;5856.326522449887;5865.824025279248;1186.8931796138215;1290.2129700882454;1332.9933350333185;1354.6410201296665;1369.869862363074;809.6478032056075;818.8485130250923;889.7997950461095;916.6516723644972;921.8661046912201;4534.6372290216705;4694.694844835075;4937.604991600663;5374.731263436813;5394.73026348681;4912.828051018198;5711.628744131618;5879.764809407661;5888.351261646746;5906.995810712189;4688.882777930511;4841.636877234151;5190.987757387349;5340.359156901119;5406.675599464044;2790.748832605075;2801.341684704093;2929.1359049080575;3050.8254322086154;3095.3654500827274;5054.646174767731;5735.0250457422335;5759.769609215668;5913.420126498184;5936.456521304492;4995.952468993911;5169.767360468788;5384.326959130109;5665.980123577713;5991.55063370249;5351.822599028207;5770.538356931519;5847.970745159159;6056.788012419544;6074.90887636677;4881.9511804881495;5390.865228369165;5522.37687098625;5914.792982245773;6009.669468179292;5905;5912.167228159113;5930.673812940329;5975.43233392827;5980.491658209101;5781.94218057814;5970.9701451492465;6095.908561371672;6182.258129024546;6194.194754681863;3275.7051865332232;3949.3483575210917;3958.7426817256787;4015.0966032642423;4020.8793736187963;5061.544460998381;6070;6080.513558915188;6100.675132052953;6105.756499232991;4915.582175515121;5763.394843541536;5787.6816775076095;5887.911681324869;5891.263592050994;5597.580181486486;5738.254026976633;5794.4794014603785;5800.50695690871;5852.824415267549;4459.977700111479;5229.6339256251695;5594.552435805207;5638.3366906761785;5704.743286552032;4494.258447356149;5246.76389562463;5625.437456254342;5745.97127014379;5802.912956305574;5212.374515058217;5359;5655.802046928337;5694.715264236855;5694.971525142348 07:26:26 INFO - PROCESS | 1662 | |5;yui.html;686.9622170780607;703.3423748794874;771.6450432800912;800.9759707208782;821.0762891746784;15602.765958510618;15933.601659958507;16655.916720416397;16677.583060423494;16696.916515417404;14949;14976.625584360369;15033.323500442479;15034.323455444504;15038.924805375986;704.4610872682402;717.6375930155265;730.087390761548;860.8235311761106;863.740877736678;882.9117088291151;888.3159966825541;907.1744712311797;910.0535443139128;914.6432891172448;958.0706714486971;958.851378036402;965.8792650918635;967.1778987860333;967.5887747707231;739.7521830186894;748.8801791713299;958.8801399824987;964.2189826240767;967.4050458967685;568.0740393159166;569.223010590541;571.223136534313;675.8715843989626;689.9724011039552;15319.387224511007;15320.157391343471;15332.15673137977;15361.15513646749;15363.462278820187;13943.930280348533;14279.143251404948;14317.928410357985;14381.496647617389;14403.135811851322;11279.548818047268;11992.280463172237;12233.531976162918;12757.744845103047;12807.231566106064;4629.837955671569;4640.86077417678;4658.138244424792;4821.397325334333;4853.272009198613;104287.95712042859;120831;124241;124723;126172;11618.302901825917;11660.242084264495;11734.94132529349;11850.703732406586;12018.819717704242;23240;23904.760952390603;24037.278881633578;24165;24269.271921842374;8073.7577872663915;8231.941247396699;8301.086880443147;8519.446235994641;8562.143785621513;4472.843450479218;4473.597376236155;4526.8189272428735;4533.229351010336;4581.518940511199;3684.1894783147663;3776.3013842439236;3808.257389808961;3816;3816.2939856126704;682.8600136971909;686.3513979289623;687.7145984416411;700.2052670219236;706.6148948822904;561.7865211219793;615.8922188616974;620.8075496596069;665.5740326191242;675.9594424334556;8625.439346442461;8955.776105597412;9603.615855365708;9729.221662267144;9747.610095596097;494.46844642009984;501.35055666855635;588.2793577867078;635.4947816485904;637.8915584350672;4194.119234960632;4428.756418396954;4438.689291749546;4567.657425693086;4738.834140805125;93868.12263754824;101584;136980;169045;170374;130579;135937;141995.19026453645;143197.56802431843;147979;96897.51551242199;115283;119964.40017799856;120807.18789218168;125089;9023;9119.498427586546;9170.358074934691;9205.907940920504;9243.491607961627;68582.65708671424;69177;69642.65178674074;70051;71018.64490677514;99039;103706;107901.92098078919;109686;111136;11596.130290228099;11610.535578576762;11626.767464650491;11732.296062236293;11748;12288.815667764811;12316.568920087753;12363.32001739913;12486.500539978299;12870.420831062438;12887.742245155232;13414.664633384244;14166.43334266659;14223.146611203361;14428.062175958528;11705.941470292593;11807;13245.602631921058;13944;15301.234938252821;13791;14025.859741402455;14241.64395890111;14344.282785860874;14516.637084072983;11487.770244594894;11522.13583981188;11966.64100076999;12047.277163370225;12185;9699.854502182332;11703.76592468129;11772.293662379941;11896.286222826311;11915.16593838423 07:26:26 INFO - PROCESS | 1662 | __end_tp_report 07:26:26 INFO - PROCESS | 1662 | __start_cc_report 07:26:26 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1716 07:26:26 INFO - PROCESS | 1662 | __end_cc_report 07:26:26 INFO - PROCESS | 1662 | __startTimestamp1479050786397__endTimestamp 07:26:26 INFO - PROCESS | 1662 | 07:26:26 INFO - PROCESS | 1662 | ------- Summary: start ------- 07:26:26 INFO - PROCESS | 1662 | Number of tests: 6 07:26:26 INFO - PROCESS | 1662 | 07:26:26 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5709.07 Median:5860.53 stddev:638.18 (10.9%) stddev-sans-first:611.40 07:26:26 INFO - PROCESS | 1662 | Values: 3295.3 3296.9 3337.6 3357.9 3358.3 5591.5 5657.1 5676.7 5677.3 5694.2 5594.4 5669.5 5698.1 5713.1 5713.3 5085.0 5145.1 5151.5 5187.5 5241.8 5116.2 5144.4 5272.5 5282.9 5345.3 5214.7 5251.8 5257.0 5263.6 5271.1 4311.8 5231.7 5237.9 5245.3 5246.7 5081.7 5203.2 5203.6 5211.5 5237.5 5721.1 5721.5 5721.7 5725.6 5729.3 6116.9 6117.2 6117.8 6131.6 6135.6 6161.1 6200.2 6233.7 6238.8 6275.6 5751.0 5752.4 5755.7 5762.9 5789.2 6186.0 6257.2 6262.6 6311.0 6333.4 5958.6 6031.8 6104.8 6144.4 6145.3 6219.5 6249.0 6252.8 6254.2 6268.7 5996.8 6025.0 6183.2 6211.0 6221.5 6109.6 6137.0 6144.7 6162.0 6222.7 4917.4 4920.5 4920.7 4924.9 4958.5 4342.1 4471.1 4475.4 4481.5 4487.2 4827.4 5614.7 5697.9 5701.2 5701.6 6253.9 6262.8 6266.3 6271.1 6281.9 5777.7 5794.1 5806.4 5814.6 5849.0 5211.7 5330.5 5387.2 5395.3 5405.9 6229.6 6301.6 6307.9 6322.2 6329.3 6268.2 6274.7 6274.8 6279.5 6286.2 6260.9 6306.1 6308.5 6324.1 6326.1 5984.7 6048.6 6055.6 6061.4 6088.1 6218.6 6223.2 6226.7 6245.6 6245.9 5933.1 6008.5 6022.0 6043.5 6087.3 5860.5 5915.4 6031.5 6055.9 6060.2 5759.9 5780.6 5836.4 5856.4 5897.2 5880.9 5957.0 5998.7 6012.9 6031.7 5782.5 5808.7 5845.4 5864.1 5993.6 07:26:26 INFO - PROCESS | 1662 | 07:26:26 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:59125.34 Median:39311.01 stddev:122193.88 (310.8%) stddev-sans-first:122457.37 07:26:26 INFO - PROCESS | 1662 | Values: 492.5 515.5 523.5 533.7 554.0 39141.0 42226.2 42303.2 42303.4 42320.9 42523.0 43029.8 43081.6 43154.8 43189.9 8457.9 8877.1 9058.7 9814.1 9983.0 8982.8 9087.3 9088.9 11139.8 11627.2 12409.8 12488.9 12494.7 12497.8 12535.7 12097.7 12146.9 12405.5 12500.2 12506.5 8877.6 9108.6 11889.6 12008.6 12320.0 42875.4 42967.8 43013.6 43161.0 43170.6 3412.3 3424.4 3469.4 3513.8 3748.1 30567.5 31416.9 32399.5 32412.5 33022.8 3149.6 3175.2 3236.3 3265.8 3345.3 479335.0 480177.0 480834.0 481150.0 482364.0 61507.8 61914.4 61952.1 62051.7 62069.4 63056.4 65303.4 65456.7 65570.7 65596.4 16858.2 17128.1 17133.2 17151.2 17152.1 13267.9 13326.3 13328.9 13332.3 13356.8 15222.9 15560.8 15564.4 17184.7 17452.0 6928.5 6988.0 7011.9 7252.9 7476.4 832.5 895.5 1015.5 1058.6 1072.8 30304.7 30512.4 30635.2 30888.0 30942.8 903.0 1041.1 1135.6 1149.6 1184.2 15686.6 15852.7 15930.0 16064.6 16181.0 186813.1 188085.0 188182.0 188806.0 189528.0 51577.0 52817.0 58438.7 59616.0 59722.1 1343.8 1367.6 1384.8 1385.2 1388.5 30394.2 32165.7 32367.2 32810.7 32962.5 52655.7 53238.0 53310.5 53315.5 53323.7 597051.0 598436.0 599529.0 600520.0 601099.0 40327.8 41004.8 41688.4 41914.8 41926.4 39422.8 44264.1 47958.5 48193.0 48808.5 38781.0 39337.6 40330.8 40551.8 41544.6 39730.0 39936.0 40094.8 40627.4 41835.0 39110.0 39284.4 39513.0 39572.2 39581.2 32914.0 33972.8 34324.1 35794.5 35828.5 20307.7 22091.4 25794.5 26379.0 26833.0 07:26:26 INFO - PROCESS | 1662 | 07:26:26 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:34744.38 Median:14448.72 stddev:97245.79 (673.0%) stddev-sans-first:97484.31 07:26:26 INFO - PROCESS | 1662 | Values: 358.3 376.6 377.5 386.8 410.8 14956.9 15372.8 16853.0 20372.7 20952.3 20082.6 20674.7 20692.5 20804.0 20987.6 4414.5 5260.1 5521.4 5522.2 5527.0 3908.5 4142.5 5478.2 5490.4 5537.4 4033.0 5819.3 6095.8 6096.9 6134.7 5857.8 6070.9 6103.1 6117.9 6137.1 5923.9 5927.9 5930.8 5933.1 5934.3 16776.9 25830.6 25976.9 26042.8 26195.0 2467.4 2492.2 2561.7 2702.4 2803.9 9650.5 9883.2 10122.0 10365.2 10366.2 1874.7 1875.7 1941.8 1994.5 2000.0 112672.0 119327.2 131620.0 132395.0 132884.0 11190.4 11423.5 11499.7 11514.4 11774.4 14747.9 14748.3 14750.1 14766.3 14788.3 8408.3 8653.0 8654.3 8793.0 8802.0 8629.0 8679.1 8682.2 8854.0 8857.4 4417.6 4473.3 4488.1 4545.5 4581.3 1754.1 1818.9 1835.5 1854.0 1934.6 710.8 813.5 924.8 969.9 982.4 15512.0 21866.7 21915.0 22038.0 22038.7 915.0 922.3 962.5 993.2 1020.6 10715.5 11186.5 11324.1 11333.9 11347.5 552408.0 552554.0 554094.0 607416.0 624286.0 120753.0 122183.6 132695.0 134111.7 136370.0 434.7 436.8 452.2 454.7 461.5 10908.4 10910.8 11189.0 11239.1 11579.9 56771.0 57494.7 58882.4 58973.7 60067.9 81547.2 82345.0 84857.0 85677.0 86569.6 7654.8 8101.7 8138.1 8360.3 8594.7 10212.2 11797.5 12086.9 13214.9 13718.2 11440.8 11571.6 11683.5 11772.8 11892.6 11301.2 11514.4 11611.5 11882.2 12008.6 11536.5 11586.3 11887.3 11942.0 11997.4 7690.0 8122.8 8303.2 8380.6 8740.1 8168.7 11041.2 11115.7 11466.3 11516.9 07:26:26 INFO - PROCESS | 1662 | 07:26:26 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5611.78 Median:5259.58 stddev:3137.30 (59.6%) stddev-sans-first:3130.02 07:26:26 INFO - PROCESS | 1662 | Values: 1385.3 1544.6 1746.9 1865.5 1952.6 8281.8 8816.1 8824.8 8826.6 8833.4 7748.4 8018.6 8034.4 8385.5 8597.5 2347.8 2380.1 2380.7 2381.7 2382.3 2343.8 2348.9 2389.0 2389.5 2390.2 2075.7 2152.1 2153.5 2154.1 2158.2 2275.4 2351.6 2360.5 2364.3 2365.0 2351.6 2362.1 2366.2 2371.8 2378.8 8702.0 8765.1 8779.5 8779.8 8796.6 5177.2 5235.6 5290.2 5314.3 5331.0 2865.4 3361.4 3519.6 3520.7 3532.0 874.5 1025.6 1027.9 1046.0 1067.7 11497.8 11508.5 11517.9 11519.6 11523.0 4000.6 4481.5 4700.7 4720.0 4822.6 9836.7 9845.0 9851.6 9859.7 9868.9 5283.6 5292.7 5295.6 5297.2 5305.3 4640.0 4801.7 4831.0 4847.4 4854.7 3857.3 3861.9 3864.1 3946.8 4021.3 1281.1 1284.3 1288.5 1300.5 1301.7 626.0 745.4 756.3 786.4 912.0 5574.8 5581.9 5642.3 5753.8 6027.7 886.9 916.8 925.3 949.6 974.1 3713.8 3900.3 3930.7 3958.5 3998.5 10060.3 10468.2 10478.6 10581.8 10591.3 9171.6 10509.7 10547.4 10553.0 10569.2 7838.2 8130.8 8152.6 8182.8 8192.6 5426.2 5728.1 5753.7 5991.4 5992.2 9688.3 9850.3 9875.8 9891.6 9913.3 9466.6 9786.5 9912.8 9935.5 10058.0 7402.9 7578.7 7587.6 7602.3 7602.8 8024.7 8141.9 8222.9 8242.1 8246.1 5382.5 7090.5 7249.1 7306.7 7308.6 7037.8 7150.6 7266.1 7333.4 7391.3 6909.3 6945.6 7019.8 7027.5 7037.9 4863.5 4940.3 4941.4 4956.0 4963.1 4853.3 4862.7 4875.0 5005.2 5032.0 07:26:26 INFO - PROCESS | 1662 | 07:26:26 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4604.55 Median:5230.03 stddev:1441.08 (27.6%) stddev-sans-first:1408.22 07:26:26 INFO - PROCESS | 1662 | Values: 287.1 303.2 306.2 317.2 320.8 5279.3 5379.3 5470.5 5530.2 5559.2 4628.5 5230.4 5287.7 5310.8 5323.4 3535.4 3547.7 4140.7 4147.3 4156.0 3998.5 4137.9 4138.6 4155.7 4155.7 3886.2 3905.0 4105.7 4140.7 4141.9 3373.3 3860.4 4070.9 4116.5 4119.9 3245.9 3294.3 3562.4 3562.5 3577.9 4279.5 4416.4 5378.9 5408.4 5433.2 4583.8 4661.0 4662.0 4674.6 4734.1 5417.2 5510.7 5730.8 5771.4 5833.0 3528.9 3912.2 3920.5 3921.5 3940.6 5633.5 5932.5 6023.2 6025.5 6032.7 3388.2 3773.6 3932.2 3949.9 3950.4 4019.7 4032.1 4037.6 4041.3 4043.6 3939.1 4070.7 4079.7 4700.9 4762.2 4824.9 5321.5 5803.9 5856.3 5865.8 1186.9 1290.2 1333.0 1354.6 1369.9 809.6 818.8 889.8 916.7 921.9 4534.6 4694.7 4937.6 5374.7 5394.7 4912.8 5711.6 5879.8 5888.4 5907.0 4688.9 4841.6 5191.0 5340.4 5406.7 2790.7 2801.3 2929.1 3050.8 3095.4 5054.6 5735.0 5759.8 5913.4 5936.5 4996.0 5169.8 5384.3 5666.0 5991.6 5351.8 5770.5 5848.0 6056.8 6074.9 4882.0 5390.9 5522.4 5914.8 6009.7 5905.0 5912.2 5930.7 5975.4 5980.5 5781.9 5971.0 6095.9 6182.3 6194.2 3275.7 3949.3 3958.7 4015.1 4020.9 5061.5 6070.0 6080.5 6100.7 6105.8 4915.6 5763.4 5787.7 5887.9 5891.3 5597.6 5738.3 5794.5 5800.5 5852.8 4460.0 5229.6 5594.6 5638.3 5704.7 4494.3 5246.8 5625.4 5746.0 5802.9 5212.4 5359.0 5655.8 5694.7 5695.0 07:26:26 INFO - PROCESS | 1662 | 07:26:26 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:25957.30 Median:13976.73 stddev:41556.07 (297.3%) stddev-sans-first:41629.33 07:26:26 INFO - PROCESS | 1662 | Values: 687.0 703.3 771.6 801.0 821.1 15602.8 15933.6 16655.9 16677.6 16696.9 14949.0 14976.6 15033.3 15034.3 15038.9 704.5 717.6 730.1 860.8 863.7 882.9 888.3 907.2 910.1 914.6 958.1 958.9 965.9 967.2 967.6 739.8 748.9 958.9 964.2 967.4 568.1 569.2 571.2 675.9 690.0 15319.4 15320.2 15332.2 15361.2 15363.5 13943.9 14279.1 14317.9 14381.5 14403.1 11279.5 11992.3 12233.5 12757.7 12807.2 4629.8 4640.9 4658.1 4821.4 4853.3 104288.0 120831.0 124241.0 124723.0 126172.0 11618.3 11660.2 11734.9 11850.7 12018.8 23240.0 23904.8 24037.3 24165.0 24269.3 8073.8 8231.9 8301.1 8519.4 8562.1 4472.8 4473.6 4526.8 4533.2 4581.5 3684.2 3776.3 3808.3 3816.0 3816.3 682.9 686.4 687.7 700.2 706.6 561.8 615.9 620.8 665.6 676.0 8625.4 8955.8 9603.6 9729.2 9747.6 494.5 501.4 588.3 635.5 637.9 4194.1 4428.8 4438.7 4567.7 4738.8 93868.1 101584.0 136980.0 169045.0 170374.0 130579.0 135937.0 141995.2 143197.6 147979.0 96897.5 115283.0 119964.4 120807.2 125089.0 9023.0 9119.5 9170.4 9205.9 9243.5 68582.7 69177.0 69642.7 70051.0 71018.6 99039.0 103706.0 107901.9 109686.0 111136.0 11596.1 11610.5 11626.8 11732.3 11748.0 12288.8 12316.6 12363.3 12486.5 12870.4 12887.7 13414.7 14166.4 14223.1 14428.1 11705.9 11807.0 13245.6 13944.0 15301.2 13791.0 14025.9 14241.6 14344.3 14516.6 11487.8 11522.1 11966.6 12047.3 12185.0 9699.9 11703.8 11772.3 11896.3 11915.2 07:26:26 INFO - PROCESS | 1662 | -------- Summary: end -------- 07:26:26 INFO - PROCESS | 1662 | 07:26:26 INFO - TEST-INFO | 1662: exit 0 07:26:26 INFO - TEST-OK | dromaeo_css | took 1118509ms 07:26:26 INFO - TEST-START | kraken 07:26:26 INFO - operating with platform_type : mac_ 07:26:26 INFO - Initialising browser for kraken test... 07:26:27 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpZni91R/profile http://localhost:49271/getInfo.html) 07:26:29 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 07:26:29 INFO - PROCESS | 1667 | colorDepth:24 07:26:29 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 07:26:29 INFO - PROCESS | 1667 | __metrics 07:26:29 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:26:29 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:26:30 INFO - TEST-INFO | 1667: exit 0 07:26:30 INFO - Browser initialized. 07:26:30 INFO - Running cycle 1/1 for kraken test... 07:26:30 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpZni91R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:42 INFO - PROCESS | 1668 | RSS: Main: 219979776 07:26:42 INFO - PROCESS | 1668 | 07:26:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 07:26:45 INFO - PROCESS | 1668 | RSS: Main: 271536128 07:26:45 INFO - PROCESS | 1668 | 07:26:48 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 07:26:48 INFO - PROCESS | 1668 | RSS: Main: 282619904 07:26:48 INFO - PROCESS | 1668 | 07:26:52 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 07:26:52 INFO - PROCESS | 1668 | RSS: Main: 377315328 07:26:52 INFO - PROCESS | 1668 | 07:26:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 07:26:55 INFO - PROCESS | 1668 | RSS: Main: 280735744 07:26:55 INFO - PROCESS | 1668 | 07:26:57 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:57 INFO - PROCESS | 1668 | RSS: Main: 281509888 07:26:57 INFO - PROCESS | 1668 | 07:27:00 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 07:27:01 INFO - PROCESS | 1668 | RSS: Main: 319135744 07:27:01 INFO - PROCESS | 1668 | 07:27:04 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 07:27:04 INFO - PROCESS | 1668 | RSS: Main: 319832064 07:27:04 INFO - PROCESS | 1668 | 07:27:07 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 07:27:08 INFO - PROCESS | 1668 | RSS: Main: 318439424 07:27:08 INFO - PROCESS | 1668 | 07:27:09 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:27:10 INFO - PROCESS | 1668 | RSS: Main: 291594240 07:27:10 INFO - PROCESS | 1668 | 07:27:12 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:27:12 INFO - PROCESS | 1668 | RSS: Main: 296566784 07:27:12 INFO - PROCESS | 1668 | 07:27:15 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:27:15 INFO - PROCESS | 1668 | RSS: Main: 303869952 07:27:15 INFO - PROCESS | 1668 | 07:27:18 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:27:19 INFO - PROCESS | 1668 | RSS: Main: 311701504 07:27:19 INFO - PROCESS | 1668 | 07:27:22 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:27:22 INFO - PROCESS | 1668 | RSS: Main: 311533568 07:27:22 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 07:27:24 INFO - PROCESS | 1668 | RSS: Main: 355336192 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | __start_tp_report 07:27:24 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 07:27:24 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 07:27:24 INFO - PROCESS | 1668 | |i|pagename|runs| 07:27:24 INFO - PROCESS | 1668 | |0;ai-astar;115;113;114;113;113;123;167;157;111;113 07:27:24 INFO - PROCESS | 1668 | |1;audio-beat-detection;143;107;112;151;110;111;110;105;138;108 07:27:24 INFO - PROCESS | 1668 | |2;audio-dft;182;183;182;182;184;183;181;182;182;182 07:27:24 INFO - PROCESS | 1668 | |3;audio-fft;81;59;59;88;61;68;58;60;82;56 07:27:24 INFO - PROCESS | 1668 | |4;audio-oscillator;86;70;94;69;68;70;94;68;69;90 07:27:24 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;117;131;97;85;86;86;87;84;88;84 07:27:24 INFO - PROCESS | 1668 | |6;imaging-darkroom;94;96;95;95;95;95;95;95;95;94 07:27:24 INFO - PROCESS | 1668 | |7;imaging-desaturate;86;97;141;87;84;84;84;87;85;85 07:27:24 INFO - PROCESS | 1668 | |8;json-parse-financial;57;53;54;54;55;58;57;57;56;56 07:27:24 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;66;69;72;76;74;69;70;71;70;71 07:27:24 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;82;83;84;80;83;81;81;82;83;90 07:27:24 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;137;136;138;134;135;136;140;137;170;136 07:27:24 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;160;161;163;161;162;161;163;168;162;159 07:27:24 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;68;66;68;67;64;66;66;65;65;68 07:27:24 INFO - PROCESS | 1668 | __end_tp_report 07:27:24 INFO - PROCESS | 1668 | __start_cc_report 07:27:24 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1961 07:27:24 INFO - PROCESS | 1668 | __end_cc_report 07:27:24 INFO - PROCESS | 1668 | __startTimestamp1479050844591__endTimestamp 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | ------- Summary: start ------- 07:27:24 INFO - PROCESS | 1668 | Number of tests: 14 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:123.90 Median:114.50 stddev:20.47 (17.9%) stddev-sans-first:21.46 07:27:24 INFO - PROCESS | 1668 | Values: 115.0 113.0 114.0 113.0 113.0 123.0 167.0 157.0 111.0 113.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:111.50 stddev:17.30 (15.5%) stddev-sans-first:16.13 07:27:24 INFO - PROCESS | 1668 | Values: 143.0 107.0 112.0 151.0 110.0 111.0 110.0 105.0 138.0 108.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:182.30 Median:182.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 07:27:24 INFO - PROCESS | 1668 | Values: 182.0 183.0 182.0 182.0 184.0 183.0 181.0 182.0 182.0 182.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:67.20 Median:64.50 stddev:11.91 (18.5%) stddev-sans-first:11.54 07:27:24 INFO - PROCESS | 1668 | Values: 81.0 59.0 59.0 88.0 61.0 68.0 58.0 60.0 82.0 56.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:11.59 (14.9%) stddev-sans-first:11.91 07:27:24 INFO - PROCESS | 1668 | Values: 86.0 70.0 94.0 69.0 68.0 70.0 94.0 68.0 69.0 90.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:86.00 stddev:16.32 (19.0%) stddev-sans-first:15.15 07:27:24 INFO - PROCESS | 1668 | Values: 117.0 131.0 97.0 85.0 86.0 86.0 87.0 84.0 88.0 84.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 07:27:24 INFO - PROCESS | 1668 | Values: 94.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:92.00 Median:85.50 stddev:17.64 (20.6%) stddev-sans-first:18.58 07:27:24 INFO - PROCESS | 1668 | Values: 86.0 97.0 141.0 87.0 84.0 84.0 84.0 87.0 85.0 85.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.50 stddev:1.64 (2.9%) stddev-sans-first:1.67 07:27:24 INFO - PROCESS | 1668 | Values: 57.0 53.0 54.0 54.0 55.0 58.0 57.0 57.0 56.0 56.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:2.78 (3.9%) stddev-sans-first:2.35 07:27:24 INFO - PROCESS | 1668 | Values: 66.0 69.0 72.0 76.0 74.0 69.0 70.0 71.0 70.0 71.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:2.77 (3.3%) stddev-sans-first:2.92 07:27:24 INFO - PROCESS | 1668 | Values: 82.0 83.0 84.0 80.0 83.0 81.0 81.0 82.0 83.0 90.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:137.00 stddev:10.70 (7.8%) stddev-sans-first:11.30 07:27:24 INFO - PROCESS | 1668 | Values: 137.0 136.0 138.0 134.0 135.0 136.0 140.0 137.0 170.0 136.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.00 stddev:2.45 (1.5%) stddev-sans-first:2.49 07:27:24 INFO - PROCESS | 1668 | Values: 160.0 161.0 163.0 161.0 162.0 161.0 163.0 168.0 162.0 159.0 07:27:24 INFO - PROCESS | 1668 | 07:27:24 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.42 (2.1%) stddev-sans-first:1.36 07:27:24 INFO - PROCESS | 1668 | Values: 68.0 66.0 68.0 67.0 64.0 66.0 66.0 65.0 65.0 68.0 07:27:24 INFO - PROCESS | 1668 | -------- Summary: end -------- 07:27:24 INFO - PROCESS | 1668 | 07:27:25 INFO - TEST-INFO | 1668: exit 0 07:27:25 INFO - TEST-OK | kraken | took 58477ms 07:27:25 INFO - SUITE-END | took 1176s 07:27:25 INFO - Completed test suite (00:19:37) 07:27:25 INFO - javascript benchmark 07:27:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.307985323082, 3296.8681252749893, 3337.5994880614317, 3357.9496307555405, 3358.2779702363987, 5591.524720398766, 5657.066584013633, 5676.744546495407, 5677.318721753395, 5694.202811606373, 5594.356648985368, 5669.489745922866, 5698.0883058710615, 5713.085906255, 5713.257276554053, 5085.0, 5145.099607568679, 5151.536361727443, 5187.481251874801, 5241.764120614582, 5116.1814109742445, 5144.356955380577, 5272.472752724716, 5282.920756188661, 5345.33183352081, 5214.66104703195, 5251.76367063483, 5256.973715131419, 5263.605229607776, 5271.051210782058, 4311.805968731414, 5231.738413079369, 5237.869053273661, 5245.291885595434, 5246.685198888079, 5081.745912704387, 5203.19350500673, 5203.60972927032, 5211.530962213381, 5237.47625237477, 5721.141828725683, 5721.4850663440075, 5721.6853073080965, 5725.627834190765, 5729.28383952006, 6116.9059639085835, 6117.204763380777, 6117.834553513639, 6131.560175786049, 6135.601185922946, 6161.137440758297, 6200.193974783295, 6233.688315584202, 6238.844028899269, 6275.560710750249, 5750.971245143789, 5752.395998420147, 5755.65466072037, 5762.855928601776, 5789.189513468118, 6185.969070154621, 6257.186565746424, 6262.561620686508, 6310.968445157745, 6333.429991300805, 5958.553108516879, 6031.788887389008, 6104.816855494342, 6144.446999770043, 6145.26256849172, 6219.47134493564, 6249.0, 6252.843678907972, 6254.186955695731, 6268.749250030039, 5996.790112346047, 6024.969875150597, 6183.196184496077, 6211.006239001828, 6221.47117495018, 6109.617229398918, 6137.0, 6144.692765361803, 6161.983272760034, 6222.688865556704, 4917.385326834145, 4920.532549407801, 4920.72935988524, 4924.901501969941, 4958.479359667255, 4342.088161486124, 4471.128130014616, 4475.373447717322, 4481.462224533012, 4487.214737420938, 4827.444843842933, 5614.663120212718, 5697.914531282034, 5701.173329867146, 5701.600887937888, 6253.874922501524, 6262.780802671885, 6266.342034086355, 6271.059341098871, 6281.905771413432, 5777.682227477445, 5794.072948328248, 5806.419358064244, 5814.622049566765, 5848.970755146197, 5211.739413029409, 5330.466953304638, 5387.218853266333, 5395.298611180521, 5405.864768398602, 6229.626222426487, 6301.558890877594, 6307.936920630735, 6322.209723784527, 6329.303776584664, 6268.216472940882, 6274.654893980693, 6274.8431289216305, 6279.466245369194, 6286.214223222098, 6260.852210358211, 6306.085617585516, 6308.463780578702, 6324.1146239527425, 6326.051092336186, 5984.670843103671, 6048.60684055535, 6055.576109672281, 6061.36355682647, 6088.147659327787, 6218.595791273553, 6223.222097237845, 6226.688665566613, 6245.6252624842655, 6245.906311405423, 5933.080372542263, 6008.54935879802, 6021.976264035037, 6043.516518678583, 6087.2999605044215, 5860.531157507475, 5915.378885217162, 6031.517478601613, 6055.878882422238, 6060.212172417558, 5759.9136012959, 5780.5953583248765, 5836.416358364129, 5856.4143585641095, 5897.203877476486, 5880.852978675567, 5957.017092179742, 5998.7300571473515, 6012.939870601413, 6031.728572214349, 5782.45066718661, 5808.738606762621, 5845.386234445492, 5864.06175011996, 5993.550483713651], "value": 5667.811512460328, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.4705941113304, 515.5488947171225, 523.4922125538227, 533.7144627624219, 554.0359773993252, 39141.0, 42226.155476890446, 42303.15393692124, 42303.36544951824, 42320.9419764506, 42523.0, 43029.7848510757, 43081.569184308224, 43154.784226078904, 43189.92025199372, 8457.873131903027, 8877.112288771135, 9058.682946096887, 9814.116729494326, 9982.950085249564, 8982.775430614221, 9087.273018158532, 9088.909110908906, 11139.832902506469, 11627.186096973215, 12409.751804963895, 12488.93755531221, 12494.687632809162, 12497.812532812015, 12535.749285014293, 12097.697557561043, 12146.939265303705, 12405.503779848796, 12500.187487813308, 12506.49974001048, 8877.644894204224, 9108.59011344491, 11889.583864564698, 12008.63974080779, 12320.01439884816, 42875.35686964667, 42967.785161073996, 43013.56986430127, 43161.0, 43170.56829431728, 3412.3185095437584, 3424.366492198951, 3469.392856250146, 3513.841877115536, 3748.0817199785956, 30567.541486877715, 31416.90040848559, 32399.51400728991, 32412.513812292833, 33022.83488582566, 3149.6062992125985, 3175.2061984503875, 3236.3203727217315, 3265.804051756902, 3345.2640419107756, 479335.0, 480177.0, 480833.9999999965, 481150.0, 482364.0, 61507.76984460286, 61914.38085619176, 61952.07071893925, 62051.689741551, 62069.379306207265, 63056.36943630505, 65303.428759986346, 65456.67271663611, 65570.67214663896, 65596.3600909981, 16858.24137913797, 17128.143592820557, 17133.22900469482, 17151.228194731266, 17152.05663688484, 13267.938564914784, 13326.33368331599, 13328.933685305152, 13332.266725330006, 13356.799648005288, 15222.934394592272, 15560.766588501181, 15564.377424903103, 17184.680068190635, 17452.0, 6928.501106940963, 6987.965060174768, 7011.89482157768, 7252.927470725331, 7476.364509016795, 832.4672209785742, 895.4537731983485, 1015.4970643447739, 1058.5659879449388, 1072.7639919217759, 30304.696953030627, 30512.389752205276, 30635.2341191472, 30888.0, 30942.845285773426, 902.9683961061331, 1041.1358572384902, 1135.6479491357707, 1149.6378640728144, 1184.248002518407, 15686.607834803994, 15852.682946341009, 15930.044197348196, 16064.598385040468, 16181.029138251743, 186813.06593467217, 188085.0, 188182.0, 188806.0, 189528.0, 51577.0, 52817.0, 58438.7078064607, 59616.0, 59722.10416843751, 1343.8118663386938, 1367.6375760423496, 1384.8268966379203, 1385.1688986607955, 1388.4585011845388, 30394.240143996576, 32165.678343216267, 32367.190820229684, 32810.67189328172, 32962.50556241706, 52655.73672131615, 53238.0, 53310.46689533055, 53315.46684533105, 53323.733381334394, 597051.0, 598436.0, 599529.0, 600520.0, 601099.0, 40327.798361008005, 41004.79497602493, 41688.3746743793, 41914.79042604767, 41926.37110443407, 39422.80288598654, 44264.11471770611, 47958.5204147968, 48193.0, 48808.51191488039, 38781.0, 39337.606623933396, 40330.79834600808, 40551.797241014785, 41544.58455415407, 39730.0, 39936.00159996023, 40094.799526002185, 40627.390589140596, 41835.0, 39110.0, 39284.41073383844, 39513.0, 39572.2085558293, 39581.208375832895, 32914.0, 33972.83013584916, 34324.14189645279, 35794.463083053255, 35828.462573061945, 20307.69538456895, 22091.447713807283, 25794.484110318062, 26379.0, 26833.0], "value": 20152.755998055978, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.346018516208, 376.5989221479125, 377.54128733588703, 386.80852977776004, 410.8192395346048, 14956.850431495695, 15372.84627153728, 16853.0, 20372.69440958383, 20952.26667066653, 20082.598348033032, 20674.689879651778, 20692.48268793281, 20804.0, 20987.580248395025, 4414.470263568376, 5260.132078207092, 5521.420250873661, 5522.22688823565, 5527.032769265383, 3908.472356231901, 4142.523609784868, 5478.205660179272, 5490.423505531901, 5537.418571050042, 4032.959670403288, 5819.30168379795, 6095.81712548622, 6096.939030609704, 6134.662593557353, 5857.824265272048, 6070.939290607082, 6103.084537319393, 6117.908231376533, 6137.110119032737, 5923.881522369572, 5927.911081333784, 5930.762769489215, 5933.110033494967, 5934.258217722785, 16776.916115419346, 25830.612540811904, 25976.87011564949, 26042.82807273658, 26195.0, 2467.395488105408, 2492.2149522900227, 2561.679790026247, 2702.4324891772753, 2803.8924624773304, 9650.469224192666, 9883.209343252522, 10121.987801219893, 10365.17078633715, 10366.222533310032, 1874.6625607390665, 1875.6530041942285, 1941.7864034956144, 1994.5013746563359, 1999.980000199994, 112672.0, 119327.2100918487, 131619.99999999904, 132395.0, 132884.0, 11190.440477976068, 11423.543058277575, 11499.655010349703, 11514.36670983104, 11774.352410617326, 14747.92626036863, 14748.336324865406, 14750.114993100233, 14766.261686915612, 14788.334524946404, 8408.285295749929, 8653.0, 8654.264387527131, 8793.0, 8801.955990220007, 8629.01532647482, 8679.088695686989, 8682.175193356621, 8854.026057133839, 8857.424267422597, 4417.580329868657, 4473.306637471197, 4488.147252022105, 4545.477270113913, 4581.289900065495, 1754.105565988729, 1818.8902205059283, 1835.4860639021094, 1853.9629207415776, 1934.6227485640447, 710.8342318597504, 813.5322189740923, 924.8104138651561, 969.9272554558436, 982.3712823792779, 15512.0, 21866.671999920014, 21915.0, 22038.0, 22038.669419958394, 914.977125571866, 922.2990527199242, 962.4658314635304, 993.1558175550869, 1020.6223697232072, 10715.517801698943, 11186.489823873835, 11324.094072474183, 11333.886661133283, 11347.546098156146, 552408.0, 552554.0, 554094.0, 607416.0, 624286.0, 120753.0, 122183.55632887293, 132695.0, 134111.65888341187, 136370.0, 434.68702534175344, 436.7663300134413, 452.16575418353085, 454.69308216953425, 461.4808340616739, 10908.400037997986, 10910.781784364426, 11189.04893084097, 11239.100871930063, 11579.88420115788, 56771.0, 57494.7125264371, 58882.41117588769, 58973.705131475785, 60067.89762358296, 81547.18452815633, 82345.0, 84857.0, 85677.0, 86569.56715216384, 7654.770356889302, 8101.675932962851, 8138.104808470945, 8360.331173506227, 8594.699185528476, 10212.234082443994, 11797.52809887595, 12086.91217790403, 13214.867851321364, 13718.245496497788, 11440.771184576428, 11571.594994175164, 11683.532658693557, 11772.764544709229, 11892.583759568373, 11301.15241356885, 11514.36670983104, 11611.477483513094, 11882.227655202385, 12008.579699710468, 11536.538538458368, 11586.304821710724, 11887.346195958959, 11942.044636429238, 11997.40012999364, 7690.0, 8122.796930076795, 8303.169683031649, 8380.622871970654, 8740.125987401208, 8168.714095006646, 11041.227114102257, 11115.666530004113, 11466.31202127875, 11516.94241528787], "value": 9252.986145350822, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.3211926156184, 1544.5984044148518, 1746.9475915722526, 1865.4590168851034, 1952.6485232658133, 8281.75154745358, 8816.118388161196, 8824.823503529926, 8826.558672066396, 8833.425827321227, 7748.41886858485, 8018.639161237744, 8034.357251419887, 8385.496870187793, 8597.527136007517, 2347.812175025998, 2380.143148466551, 2380.7262164851004, 2381.7022872140983, 2382.28531440568, 2343.8359314847967, 2348.9412764680933, 2388.95222095558, 2389.4623709665275, 2390.175389490623, 2075.740532433446, 2152.1499007891875, 2153.493928926709, 2154.0845140815168, 2158.190678495564, 2275.3742720751843, 2351.576716191085, 2360.480694247263, 2364.337985364101, 2364.9527009459885, 2351.6354964980455, 2362.11420717231, 2366.219147681261, 2371.7628237176145, 2378.774016468433, 8701.956490217572, 8765.123487651248, 8779.47323160606, 8779.78050548735, 8796.560171991376, 5177.171652535614, 5235.6073294502685, 5290.206469029637, 5314.309139811839, 5331.013762453958, 2865.355295058616, 3361.3949489092197, 3519.577650681909, 3520.6655367740022, 3531.982340088309, 874.540866045325, 1025.6307729217476, 1027.865248648327, 1045.984310235347, 1067.7044354637515, 11497.770044599145, 11508.482118304613, 11517.942410287895, 11519.596814111466, 11523.020543253833, 4000.5599384067727, 4481.462224533077, 4700.670953033255, 4720.032393359353, 4822.590079843182, 9836.655717050013, 9844.950775246078, 9851.605935762633, 9859.654912078186, 9868.851967220497, 5283.550898173621, 5292.708901010405, 5295.576353891679, 5297.205419187153, 5305.336832895888, 4639.9768001160455, 4801.68789028712, 4831.033793241366, 4847.3698419205275, 4854.660173787801, 3857.3442514772555, 3861.8841434757, 3864.1305706215876, 3946.8223929923224, 4021.2560676274984, 1281.116029939339, 1284.293638498822, 1288.5232463988384, 1300.5383089003458, 1301.7461594988886, 625.9906101408483, 745.4483682075333, 756.2664215710862, 786.4023342259809, 911.9694744938178, 5574.804881829116, 5581.944180558224, 5642.294713160855, 5753.798617048383, 6027.698615069229, 886.8536691445839, 916.7753900294471, 925.2597921662643, 949.6486300068881, 974.1427543761445, 3713.827321884876, 3900.31744444721, 3930.744501607386, 3958.4853968984426, 3998.4602078719, 10060.295779295378, 10468.162546996222, 10478.580856765797, 10581.84127238092, 10591.311564748266, 9171.58727857248, 10509.737256568495, 10547.367157970546, 10552.997465240944, 10569.207309451822, 7838.176991415933, 8130.83738325242, 8152.551609661526, 8182.83634327322, 8192.631331590093, 5426.186072089218, 5728.140778883201, 5753.741081651419, 5991.400859913973, 5992.161097446448, 9688.32181747271, 9850.310478266452, 9875.802483950138, 9891.55488003056, 9913.256505761952, 9466.621335146518, 9786.461744604116, 9912.75218119524, 9935.503224838585, 10058.0, 7402.851942961218, 7578.658960346687, 7587.620618968919, 7602.277783610548, 7602.771916842504, 8024.719134830253, 8141.9185808141165, 8222.876656850032, 8242.134575869688, 8246.134155913544, 5382.542483888757, 7090.5036647436245, 7249.05762250904, 7306.7077316906725, 7308.59802710856, 7037.824054398681, 7150.570965742072, 7266.091738532684, 7333.413326933939, 7391.2978267064545, 6909.343612356818, 6945.583265004116, 7019.789406317818, 7027.543209691354, 7037.929620703932, 4863.513648635108, 4940.333055037524, 4941.382327209099, 4955.959248557843, 4963.057019166491, 4853.344798452164, 4862.708237505761, 4874.95125048745, 5005.224190250517, 5032.0], "value": 4503.137836374022, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.11568369422184, 303.1814101924803, 306.1977618639166, 317.1895806215121, 320.7594304271796, 5279.313689220396, 5379.300690910186, 5470.507654311111, 5530.198121272418, 5559.193262189784, 4628.4677262114865, 5230.424653288144, 5287.68273903566, 5310.840674779763, 5323.44103869093, 3535.3661522165958, 3547.71618270539, 4140.710150289481, 4147.294959856817, 4156.044109854735, 3998.5001874765653, 4137.9172416551655, 4138.6482149017365, 4155.667546596265, 4155.709100362976, 3886.2227554489073, 3904.960950390488, 4105.651019663333, 4140.730852494593, 4141.855035073773, 3373.325334932999, 3860.3823388257883, 4070.9389359159486, 4116.526599441073, 4119.876403707864, 3245.896395225611, 3294.258791771856, 3562.412201986669, 3562.5215535552975, 3577.910552236189, 4279.486461624625, 4416.4258646375765, 5378.892422151535, 5408.35099788024, 5433.169615421119, 4583.808209865426, 4660.970369259974, 4661.953380466186, 4674.602658773974, 4734.147853386389, 5417.158166223464, 5510.724463776835, 5730.793644446876, 5771.394003629601, 5833.045929613542, 3528.858845646171, 3912.1979994101425, 3920.451136840816, 3921.4706014687936, 3940.625640564142, 5633.549316054706, 5932.525397968152, 6023.216981792339, 6025.457708806229, 6032.698365081728, 3388.203772113551, 3773.603771603997, 3932.193900250442, 3949.921001579952, 3950.4074388841327, 4019.738716983387, 4032.0927791246736, 4037.6366127048705, 4041.2523683118716, 4043.5754245804355, 3939.0940083780893, 4070.715049946475, 4079.73481723687, 4700.8952896069395, 4762.238041913277, 4824.903501929942, 5321.5476684482255, 5803.883922321615, 5856.326522449887, 5865.824025279248, 1186.8931796138215, 1290.2129700882454, 1332.9933350333185, 1354.6410201296665, 1369.869862363074, 809.6478032056075, 818.8485130250923, 889.7997950461095, 916.6516723644972, 921.8661046912201, 4534.6372290216705, 4694.694844835075, 4937.604991600663, 5374.731263436813, 5394.73026348681, 4912.828051018198, 5711.628744131618, 5879.764809407661, 5888.351261646746, 5906.995810712189, 4688.882777930511, 4841.636877234151, 5190.987757387349, 5340.359156901119, 5406.675599464044, 2790.748832605075, 2801.341684704093, 2929.1359049080575, 3050.8254322086154, 3095.3654500827274, 5054.646174767731, 5735.0250457422335, 5759.769609215668, 5913.420126498184, 5936.456521304492, 4995.952468993911, 5169.767360468788, 5384.326959130109, 5665.980123577713, 5991.55063370249, 5351.822599028207, 5770.538356931519, 5847.970745159159, 6056.788012419544, 6074.90887636677, 4881.9511804881495, 5390.865228369165, 5522.37687098625, 5914.792982245773, 6009.669468179292, 5905.0, 5912.167228159113, 5930.673812940329, 5975.43233392827, 5980.491658209101, 5781.94218057814, 5970.9701451492465, 6095.908561371672, 6182.258129024546, 6194.194754681863, 3275.7051865332232, 3949.3483575210917, 3958.7426817256787, 4015.0966032642423, 4020.8793736187963, 5061.544460998381, 6070.0, 6080.513558915188, 6100.675132052953, 6105.756499232991, 4915.582175515121, 5763.394843541536, 5787.6816775076095, 5887.911681324869, 5891.263592050994, 5597.580181486486, 5738.254026976633, 5794.4794014603785, 5800.50695690871, 5852.824415267549, 4459.977700111479, 5229.6339256251695, 5594.552435805207, 5638.3366906761785, 5704.743286552032, 4494.258447356149, 5246.76389562463, 5625.437456254342, 5745.97127014379, 5802.912956305574, 5212.374515058217, 5359.0, 5655.802046928337, 5694.715264236855, 5694.971525142348], "value": 4142.039836095877, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.9622170780607, 703.3423748794874, 771.6450432800912, 800.9759707208782, 821.0762891746784, 15602.765958510618, 15933.601659958507, 16655.916720416397, 16677.583060423494, 16696.916515417404, 14949.0, 14976.625584360369, 15033.323500442479, 15034.323455444504, 15038.924805375986, 704.4610872682402, 717.6375930155265, 730.087390761548, 860.8235311761106, 863.740877736678, 882.9117088291151, 888.3159966825541, 907.1744712311797, 910.0535443139128, 914.6432891172448, 958.0706714486971, 958.851378036402, 965.8792650918635, 967.1778987860333, 967.5887747707231, 739.7521830186894, 748.8801791713299, 958.8801399824987, 964.2189826240767, 967.4050458967685, 568.0740393159166, 569.223010590541, 571.223136534313, 675.8715843989626, 689.9724011039552, 15319.387224511007, 15320.157391343471, 15332.15673137977, 15361.15513646749, 15363.462278820187, 13943.930280348533, 14279.143251404948, 14317.928410357985, 14381.496647617389, 14403.135811851322, 11279.548818047268, 11992.280463172237, 12233.531976162918, 12757.744845103047, 12807.231566106064, 4629.837955671569, 4640.86077417678, 4658.138244424792, 4821.397325334333, 4853.272009198613, 104287.95712042859, 120831.0, 124241.0, 124723.0, 126172.0, 11618.302901825917, 11660.242084264495, 11734.94132529349, 11850.703732406586, 12018.819717704242, 23240.0, 23904.760952390603, 24037.278881633578, 24165.0, 24269.271921842374, 8073.7577872663915, 8231.941247396699, 8301.086880443147, 8519.446235994641, 8562.143785621513, 4472.843450479218, 4473.597376236155, 4526.8189272428735, 4533.229351010336, 4581.518940511199, 3684.1894783147663, 3776.3013842439236, 3808.257389808961, 3816.0, 3816.2939856126704, 682.8600136971909, 686.3513979289623, 687.7145984416411, 700.2052670219236, 706.6148948822904, 561.7865211219793, 615.8922188616974, 620.8075496596069, 665.5740326191242, 675.9594424334556, 8625.439346442461, 8955.776105597412, 9603.615855365708, 9729.221662267144, 9747.610095596097, 494.46844642009984, 501.35055666855635, 588.2793577867078, 635.4947816485904, 637.8915584350672, 4194.119234960632, 4428.756418396954, 4438.689291749546, 4567.657425693086, 4738.834140805125, 93868.12263754824, 101584.0, 136980.0, 169045.0, 170374.0, 130579.0, 135937.0, 141995.19026453645, 143197.56802431843, 147979.0, 96897.51551242199, 115283.0, 119964.40017799856, 120807.18789218168, 125089.0, 9023.0, 9119.498427586546, 9170.358074934691, 9205.907940920504, 9243.491607961627, 68582.65708671424, 69177.0, 69642.65178674074, 70051.0, 71018.64490677514, 99039.0, 103706.0, 107901.92098078919, 109686.0, 111136.0, 11596.130290228099, 11610.535578576762, 11626.767464650491, 11732.296062236293, 11748.0, 12288.815667764811, 12316.568920087753, 12363.32001739913, 12486.500539978299, 12870.420831062438, 12887.742245155232, 13414.664633384244, 14166.43334266659, 14223.146611203361, 14428.062175958528, 11705.941470292593, 11807.0, 13245.602631921058, 13944.0, 15301.234938252821, 13791.0, 14025.859741402455, 14241.64395890111, 14344.282785860874, 14516.637084072983, 11487.770244594894, 11522.13583981188, 11966.64100076999, 12047.277163370225, 12185.0, 9699.854502182332, 11703.76592468129, 11772.293662379941, 11896.286222826311, 11915.16593838423], "value": 7996.987579606942, "unit": "score"}], "name": "dromaeo_css", "value": 7350.02772698023, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 114.0, 113.0, 113.0, 123.0, 167.0, 157.0, 111.0, 113.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 112.0, 151.0, 110.0, 111.0, 110.0, 105.0, 138.0, 108.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 182.0, 182.0, 184.0, 183.0, 181.0, 182.0, 182.0, 182.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 88.0, 61.0, 68.0, 58.0, 60.0, 82.0, 56.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 94.0, 69.0, 68.0, 70.0, 94.0, 68.0, 69.0, 90.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 131.0, 97.0, 85.0, 86.0, 86.0, 87.0, 84.0, 88.0, 84.0], "value": 94.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 97.0, 141.0, 87.0, 84.0, 84.0, 84.0, 87.0, 85.0, 85.0], "value": 92.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 54.0, 54.0, 55.0, 58.0, 57.0, 57.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 72.0, 76.0, 74.0, 69.0, 70.0, 71.0, 70.0, 71.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 84.0, 80.0, 83.0, 81.0, 81.0, 82.0, 83.0, 90.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 138.0, 134.0, 135.0, 136.0, 140.0, 137.0, 170.0, 136.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 161.0, 162.0, 161.0, 163.0, 168.0, 162.0, 159.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 67.0, 64.0, 66.0, 66.0, 65.0, 65.0, 68.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1429.7, "alertThreshold": 2.0}]} 07:27:25 INFO - Return code: 0 07:27:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:27:25 INFO - # TBPL SUCCESS # 07:27:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:27:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:27:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:27:25 INFO - 2016-11-13 07:27:25.902 screenresolution[1672:10121] starting screenresolution argv=screenresolution get 07:27:25 INFO - 2016-11-13 07:27:25.905 screenresolution[1672:10121] Display 0: 1600x1200x32@60 07:27:25 INFO - 2016-11-13 07:27:25.911 screenresolution[1673:10124] starting screenresolution argv=screenresolution list 07:27:25 INFO - Available Modes on Display 0 07:27:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:27:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:27:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:27:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:27:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:27:26 INFO - Intel Iris: 07:27:26 INFO - Chipset Model: Intel Iris 07:27:26 INFO - Type: GPU 07:27:26 INFO - Bus: Built-In 07:27:26 INFO - VRAM (Dynamic, Max): 1536 MB 07:27:26 INFO - Vendor: Intel (0x8086) 07:27:26 INFO - Device ID: 0x0a2e 07:27:26 INFO - Revision ID: 0x0009 07:27:26 INFO - Displays: 07:27:26 INFO - Display: 07:27:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:27:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:27:26 INFO - Display Serial Number: 1600x1200 60 07:27:26 INFO - Main Display: Yes 07:27:26 INFO - Mirror: Off 07:27:26 INFO - Online: Yes 07:27:26 INFO - Rotation: Supported 07:27:26 INFO - Return code: 0 07:27:26 INFO - Running post-action listener: _resource_record_post_action 07:27:26 INFO - [mozharness: 2016-11-13 15:27:26.147729Z] Finished run-tests step (success) 07:27:26 INFO - Running post-run listener: _resource_record_post_run 07:27:26 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 33098752; Write bytes: 666550784; Read time: 310; Write time: 2168 07:27:26 INFO - TinderboxPrint: CPU usage
53.3% 07:27:26 INFO - TinderboxPrint: I/O read bytes / time
33,098,752 / 310 07:27:26 INFO - TinderboxPrint: I/O write bytes / time
666,550,784 / 2,168 07:27:26 INFO - TinderboxPrint: CPU idle
2,262.6 (46.7%) 07:27:26 INFO - TinderboxPrint: CPU system
963.5 (19.9%) 07:27:26 INFO - TinderboxPrint: CPU user
1,615.7 (33.4%) 07:27:26 INFO - TinderboxPrint: Swap in / out
392,720,384 / 0 07:27:26 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355668480; Write bytes: 357500928; Read time: 27891; Write time: 736 07:27:26 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 32152576; Write bytes: 298887680; Read time: 295; Write time: 1401 07:27:26 INFO - Running post-run listener: _upload_blobber_files 07:27:26 INFO - Blob upload gear active. 07:27:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:27:26 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 07:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:27:27 INFO - (blobuploader) - INFO - Open directory for files ... 07:27:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:27:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:27:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:28 INFO - (blobuploader) - INFO - Done attempting. 07:27:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:27:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:27:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:29 INFO - (blobuploader) - INFO - Done attempting. 07:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:27:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:31 INFO - (blobuploader) - INFO - Done attempting. 07:27:31 INFO - (blobuploader) - INFO - Iteration through files over. 07:27:31 INFO - Return code: 0 07:27:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:27:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:27:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc8392f64bde6e5e64999de53fdba9bdc1d504d936525ee3c08a23f8543838543954c4ea6657c0f7935e6954760eb368782fa5330e69e26a4900910cc68b5210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bbb50ed92cbac10cf341ac8dca7883c44a7952df83ee4e1a26b4cc921ec29dbf01cb34da6740b10d81d989656386b0c05af8295f6c70c9e7803784fd4629cee5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18675470873cbd14ea14c116b0668a07e9608d2927c388b61b33500f4f888fb6b745ca6a80cab48630df496b67b2afa4eb42d6e4e9b9e275b4cd4c7eb760b9ce"} 07:27:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:27:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:27:31 INFO - Contents: 07:27:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc8392f64bde6e5e64999de53fdba9bdc1d504d936525ee3c08a23f8543838543954c4ea6657c0f7935e6954760eb368782fa5330e69e26a4900910cc68b5210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bbb50ed92cbac10cf341ac8dca7883c44a7952df83ee4e1a26b4cc921ec29dbf01cb34da6740b10d81d989656386b0c05af8295f6c70c9e7803784fd4629cee5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18675470873cbd14ea14c116b0668a07e9608d2927c388b61b33500f4f888fb6b745ca6a80cab48630df496b67b2afa4eb42d6e4e9b9e275b4cd4c7eb760b9ce"} 07:27:31 INFO - Running post-run listener: copy_logs_to_upload_dir 07:27:31 INFO - Copying logs to upload dir... 07:27:31 INFO - mkdir: /builds/slave/test/build/upload/logs 07:27:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.890925 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-13 07:27:32.026742) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 07:27:32.029789) ========= 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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc8392f64bde6e5e64999de53fdba9bdc1d504d936525ee3c08a23f8543838543954c4ea6657c0f7935e6954760eb368782fa5330e69e26a4900910cc68b5210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bbb50ed92cbac10cf341ac8dca7883c44a7952df83ee4e1a26b4cc921ec29dbf01cb34da6740b10d81d989656386b0c05af8295f6c70c9e7803784fd4629cee5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18675470873cbd14ea14c116b0668a07e9608d2927c388b61b33500f4f888fb6b745ca6a80cab48630df496b67b2afa4eb42d6e4e9b9e275b4cd4c7eb760b9ce"} build_url:https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010870 build_url: 'https://queue.taskcluster.net/v1/task/NSTph7ujRPOwTjMAyYdv-g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc8392f64bde6e5e64999de53fdba9bdc1d504d936525ee3c08a23f8543838543954c4ea6657c0f7935e6954760eb368782fa5330e69e26a4900910cc68b5210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bbb50ed92cbac10cf341ac8dca7883c44a7952df83ee4e1a26b4cc921ec29dbf01cb34da6740b10d81d989656386b0c05af8295f6c70c9e7803784fd4629cee5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18675470873cbd14ea14c116b0668a07e9608d2927c388b61b33500f4f888fb6b745ca6a80cab48630df496b67b2afa4eb42d6e4e9b9e275b4cd4c7eb760b9ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 07:27:32.064351) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 07:27:32.064675) ========= 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.OMK2d4F5GW/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.9yyUX6lIGv/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.005333 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 07:27:32.113279) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 07:27:32.114558) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 07:27:32.114889) ========= ========= Total master_lag: 0.23 =========