builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0126 starttime: 1477600613.69 results: success (0) buildid: 20161027111134 builduid: db173525d7ab4ca297026d8e1f4beee3 revision: 52d62548a29d97d03e2e11ecd16db7602eb93ee7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:53.685354) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:53.685787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:53.686078) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:53.713024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:53.713462) ========= 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.N4unvpD8d3/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.osVG2voP3Y/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-10-27 13:36:53-- 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% 8.98M=0.001s 2016-10-27 13:36:53 (8.98 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132285 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:53.870060) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:53.870406) ========= 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.N4unvpD8d3/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.osVG2voP3Y/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.020391 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:53.919279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 13:36:53.919656) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 52d62548a29d97d03e2e11ecd16db7602eb93ee7 --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 52d62548a29d97d03e2e11ecd16db7602eb93ee7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N4unvpD8d3/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.osVG2voP3Y/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-10-27 13:36:53,993 truncating revision to first 12 chars 2016-10-27 13:36:53,994 Setting DEBUG logging. 2016-10-27 13:36:53,994 attempt 1/10 2016-10-27 13:36:53,994 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/52d62548a29d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 13:36:55,232 unpacking tar archive at: mozilla-aurora-52d62548a29d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.505838 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 13:36:55.448259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:55.448574) ========= script_repo_revision: 52d62548a29d97d03e2e11ecd16db7602eb93ee7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:55.448968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:55.449245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 13:36:55.468262) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-27 13:36:55.468599) ========= /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.N4unvpD8d3/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.osVG2voP3Y/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 13:36:55 INFO - MultiFileLogger online at 20161027 13:36:55 in /builds/slave/test 13:36:55 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 13:36:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:36:55 INFO - {'append_to_log': False, 13:36:55 INFO - 'base_work_dir': '/builds/slave/test', 13:36:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:36:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:36:55 INFO - 'branch': 'Mozilla-Aurora', 13:36:55 INFO - 'buildbot_json_path': 'buildprops.json', 13:36:55 INFO - 'config_files': ('talos/mac_config.py',), 13:36:55 INFO - 'default_actions': ('clobber', 13:36:55 INFO - 'read-buildbot-config', 13:36:55 INFO - 'download-and-extract', 13:36:55 INFO - 'populate-webroot', 13:36:55 INFO - 'create-virtualenv', 13:36:55 INFO - 'install', 13:36:55 INFO - 'run-tests'), 13:36:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:36:55 INFO - 'download_minidump_stackwalk': True, 13:36:55 INFO - 'download_symbols': 'ondemand', 13:36:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:36:55 INFO - 'tooltool.py': '/tools/tooltool.py', 13:36:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:36:55 INFO - '/tools/misc-python/virtualenv.py')}, 13:36:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:36:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:36:55 INFO - 'installer_path': 'installer.exe', 13:36:55 INFO - 'log_level': 'info', 13:36:55 INFO - 'log_name': 'talos', 13:36:55 INFO - 'log_to_console': True, 13:36:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:36:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:36:55 INFO - 'opt_config_files': (), 13:36:55 INFO - 'pip_index': False, 13:36:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:36:55 INFO - 'cmd': ('bash', 13:36:55 INFO - '-c', 13:36:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:36:55 INFO - 'enabled': True, 13:36:55 INFO - 'halt_on_failure': False, 13:36:55 INFO - 'name': 'check_screen_resolution'},), 13:36:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:36:55 INFO - 'cmd': ('bash', 13:36:55 INFO - '-c', 13:36:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:36:55 INFO - 'enabled': True, 13:36:55 INFO - 'halt_on_failure': False, 13:36:55 INFO - 'name': 'check_screen_resolution'},), 13:36:55 INFO - 'run_cmd_checks_enabled': True, 13:36:55 INFO - 'sps_profile': False, 13:36:55 INFO - 'sps_profile_interval': 0, 13:36:55 INFO - 'suite': 'dromaeojs', 13:36:55 INFO - 'system_bits': '32', 13:36:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:36:55 INFO - 'title': 't-yosemite-r7-0126', 13:36:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:36:55 INFO - 'use_talos_json': True, 13:36:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:36:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:36:55 INFO - 'work_dir': 'build'} 13:36:55 INFO - [mozharness: 2016-10-27 20:36:55.674654Z] Running clobber step. 13:36:55 INFO - Running pre-action listener: _resource_record_pre_action 13:36:55 INFO - Running main action method: clobber 13:36:55 INFO - rmtree: /builds/slave/test/build 13:36:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:36:57 INFO - Running post-action listener: _resource_record_post_action 13:36:57 INFO - [mozharness: 2016-10-27 20:36:57.179365Z] Finished clobber step (success) 13:36:57 INFO - [mozharness: 2016-10-27 20:36:57.179470Z] Running read-buildbot-config step. 13:36:57 INFO - Running pre-action listener: _resource_record_pre_action 13:36:57 INFO - Running main action method: read_buildbot_config 13:36:57 INFO - Using buildbot properties: 13:36:57 INFO - { 13:36:57 INFO - "project": "", 13:36:57 INFO - "product": "firefox", 13:36:57 INFO - "script_repo_revision": "production", 13:36:57 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:36:57 INFO - "repository": "", 13:36:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:36:57 INFO - "buildid": "20161027111134", 13:36:57 INFO - "pgo_build": "False", 13:36:57 INFO - "basedir": "/builds/slave/test", 13:36:57 INFO - "buildnumber": 62, 13:36:57 INFO - "slavename": "t-yosemite-r7-0126", 13:36:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:36:57 INFO - "platform": "yosemite_r7", 13:36:57 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:36:57 INFO - "branch": "mozilla-aurora", 13:36:57 INFO - "repo_path": "releases/mozilla-aurora", 13:36:57 INFO - "revision": "52d62548a29d97d03e2e11ecd16db7602eb93ee7", 13:36:57 INFO - "stage_platform": "macosx64", 13:36:57 INFO - "builduid": "db173525d7ab4ca297026d8e1f4beee3", 13:36:57 INFO - "slavebuilddir": "test" 13:36:57 INFO - } 13:36:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 13:36:57 INFO - Running post-action listener: _resource_record_post_action 13:36:57 INFO - [mozharness: 2016-10-27 20:36:57.185033Z] Finished read-buildbot-config step (success) 13:36:57 INFO - [mozharness: 2016-10-27 20:36:57.185202Z] Running download-and-extract step. 13:36:57 INFO - Running pre-action listener: _resource_record_pre_action 13:36:57 INFO - Running main action method: download_and_extract 13:36:57 INFO - mkdir: /builds/slave/test/build/tests 13:36:57 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')]} 13:36:57 INFO - trying https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 13:36:57 INFO - Downloading https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/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 13:36:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/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 13:36:58 INFO - Downloaded 1199 bytes. 13:36:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 13:36:58 INFO - Using the following test package requirements: 13:36:58 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 13:36:58 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:36:58 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 13:36:58 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:36:58 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 13:36:58 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:36:58 INFO - u'jsshell-mac.zip'], 13:36:58 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:36:58 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 13:36:58 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 13:36:58 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:36:58 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 13:36:58 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:36:58 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 13:36:58 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:36:58 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 13:36:58 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:36:58 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 13:36:58 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:36:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 13:36:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:36:58 INFO - Fetch https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 13:36:58 INFO - Expected file size: 16420273 13:37:05 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 13:37:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 13:37:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:37:05 INFO - Fetch https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 13:37:06 INFO - Expected file size: 16420273 13:37:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 13:37:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:37:13 INFO - Fetch https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 13:37:13 INFO - Expected file size: 14414081 13:37: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')]} 13:37:14 INFO - trying https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:37:14 INFO - Downloading https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 13:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/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 13:37:17 INFO - Downloaded 115418284 bytes. 13:37:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:37:17 INFO - mkdir: /builds/slave/test/properties 13:37:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:37:17 INFO - Writing to file /builds/slave/test/properties/build_url 13:37:17 INFO - Contents: 13:37:17 INFO - build_url:https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:37:17 INFO - Running post-action listener: _resource_record_post_action 13:37:17 INFO - Running post-action listener: set_extra_try_arguments 13:37:17 INFO - [mozharness: 2016-10-27 20:37:17.815059Z] Finished download-and-extract step (success) 13:37:17 INFO - [mozharness: 2016-10-27 20:37:17.815159Z] Running populate-webroot step. 13:37:17 INFO - Running pre-action listener: _resource_record_pre_action 13:37:17 INFO - Running main action method: populate_webroot 13:37:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:37:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:37:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:37:17 INFO - '--tppagecycles', 13:37:17 INFO - '7'], 13:37:17 INFO - 'tests': ['tsvgm']}}, 13:37:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:37:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:37:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:37:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:37:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:37:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:37:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:17 INFO - 'talos_options': ['--disable-e10s'], 13:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:37:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:37:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:17 INFO - 'talos_options': ['--disable-e10s'], 13:37:17 INFO - 'tests': ['damp', 'tps']}, 13:37:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:17 INFO - 'tests': ['damp', 'tps']}, 13:37:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:37:17 INFO - 'tests': ['dromaeo_dom']}, 13:37:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:37:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:37:17 INFO - 'tests': ['basic_compositor_video']}, 13:37:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:37:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:37:17 INFO - 'tests': ['a11yr', 13:37:17 INFO - 'ts_paint', 13:37:17 INFO - 'tpaint', 13:37:17 INFO - 'sessionrestore', 13:37:17 INFO - 'sessionrestore_no_auto_restore', 13:37:17 INFO - 'tabpaint']}, 13:37:17 INFO - 'other-e10s': {'tests': ['a11yr', 13:37:17 INFO - 'ts_paint', 13:37:17 INFO - 'tpaint', 13:37:17 INFO - 'sessionrestore', 13:37:17 INFO - 'sessionrestore_no_auto_restore', 13:37:17 INFO - 'tabpaint']}, 13:37:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:37:17 INFO - 'ts_paint', 13:37:17 INFO - 'tpaint', 13:37:17 INFO - 'sessionrestore', 13:37:17 INFO - 'sessionrestore_no_auto_restore', 13:37:17 INFO - 'tabpaint']}, 13:37:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:37:17 INFO - 'ts_paint', 13:37:17 INFO - 'tpaint', 13:37:17 INFO - 'sessionrestore', 13:37:17 INFO - 'sessionrestore_no_auto_restore', 13:37:17 INFO - 'tabpaint']}, 13:37:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:37:17 INFO - 'tests': ['a11yr', 13:37:17 INFO - 'ts_paint', 13:37:17 INFO - 'tpaint', 13:37:17 INFO - 'sessionrestore', 13:37:17 INFO - 'sessionrestore_no_auto_restore', 13:37:17 INFO - 'tabpaint']}, 13:37:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:37:17 INFO - 'tests': ['a11yr', 13:37:17 INFO - 'ts_paint', 13:37:17 INFO - 'tpaint', 13:37:17 INFO - 'sessionrestore', 13:37:17 INFO - 'sessionrestore_no_auto_restore', 13:37:17 INFO - 'tabpaint']}, 13:37:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:37:17 INFO - 'tests': ['tsvgx', 13:37:17 INFO - 'tsvgr_opacity', 13:37:17 INFO - 'tart', 13:37:17 INFO - 'tscrollx', 13:37:17 INFO - 'cart']}, 13:37:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:37:17 INFO - 'tsvgr_opacity', 13:37:17 INFO - 'tart', 13:37:17 INFO - 'tscrollx', 13:37:17 INFO - 'cart']}, 13:37:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:17 INFO - 'talos_options': ['--disable-e10s'], 13:37:17 INFO - 'tests': ['tp5o']}, 13:37:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:17 INFO - 'tests': ['tp5o']}, 13:37:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:17 INFO - 'talos_options': ['--disable-e10s', 13:37:17 INFO - '--xperf_path', 13:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:37:17 INFO - 'tests': ['tp5n']}, 13:37:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:17 INFO - 'talos_options': ['--xperf_path', 13:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:37:17 INFO - 'tests': ['tp5n']}}, 13:37:17 INFO - 'talos.zip': {'path': '', 13:37:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:37:17 INFO - Running post-action listener: _resource_record_post_action 13:37:17 INFO - [mozharness: 2016-10-27 20:37:17.833871Z] Finished populate-webroot step (success) 13:37:17 INFO - [mozharness: 2016-10-27 20:37:17.834002Z] Running create-virtualenv step. 13:37:17 INFO - Running pre-action listener: _resource_record_pre_action 13:37:17 INFO - Running main action method: create_virtualenv 13:37:17 INFO - Creating virtualenv /builds/slave/test/build/venv 13:37:17 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 13:37:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:37:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:37:17 INFO - Using real prefix '/tools/python27' 13:37:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:37:18 INFO - Installing distribute.............................................................................................................................................................................................done. 13:37:21 INFO - Installing pip.................done. 13:37:21 INFO - Return code: 0 13:37:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f7dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f752570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb590560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5f0d30>, '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 0x10f456db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e8b20>, '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.N4unvpD8d3/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.osVG2voP3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 13:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:37:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4unvpD8d3/Render', 13:37:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:37:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:37:21 INFO - 'HOME': '/Users/cltbld', 13:37:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:37:21 INFO - 'LOGNAME': 'cltbld', 13:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:21 INFO - 'MOZ_NO_REMOTE': '1', 13:37:21 INFO - 'NO_EM_RESTART': '1', 13:37:21 INFO - 'PAGER': '/bin/cat', 13:37:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:21 INFO - 'PWD': '/builds/slave/test', 13:37:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:37:21 INFO - 'SHELL': '/bin/bash', 13:37:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osVG2voP3Y/Listeners', 13:37:21 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 13:37:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:37:21 INFO - 'USER': 'cltbld', 13:37:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:37:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:21 INFO - 'XPC_FLAGS': '0x0', 13:37:21 INFO - 'XPC_SERVICE_NAME': '0', 13:37:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:21 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 13:37:21 INFO - Cleaning up... 13:37:21 INFO - Return code: 0 13:37:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f7dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f752570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb590560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5f0d30>, '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 0x10f456db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e8b20>, '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.N4unvpD8d3/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.osVG2voP3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 13:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:37:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4unvpD8d3/Render', 13:37:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:37:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:37:21 INFO - 'HOME': '/Users/cltbld', 13:37:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:37:21 INFO - 'LOGNAME': 'cltbld', 13:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:21 INFO - 'MOZ_NO_REMOTE': '1', 13:37:21 INFO - 'NO_EM_RESTART': '1', 13:37:21 INFO - 'PAGER': '/bin/cat', 13:37:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:21 INFO - 'PWD': '/builds/slave/test', 13:37:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:37:21 INFO - 'SHELL': '/bin/bash', 13:37:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osVG2voP3Y/Listeners', 13:37:21 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 13:37:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:37:21 INFO - 'USER': 'cltbld', 13:37:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:37:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:21 INFO - 'XPC_FLAGS': '0x0', 13:37:21 INFO - 'XPC_SERVICE_NAME': '0', 13:37:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:22 INFO - Downloading/unpacking psutil>=3.1.1 13:37:22 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 13:37:22 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 13:37:22 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 13:37:22 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 13:37:22 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 13:37:22 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 13:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:37:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:37:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:37:25 INFO - Installing collected packages: psutil 13:37:25 INFO - Running setup.py install for psutil 13:37:25 INFO - building 'psutil._psutil_osx' extension 13:37:25 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 13:37:25 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 13:37:25 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 13:37:25 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 13:37:25 INFO - building 'psutil._psutil_posix' extension 13:37:25 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 13:37:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:37:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:37:25 INFO - ^ 13:37:25 INFO - 1 warning generated. 13:37:25 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 13:37:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:37:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:37:25 INFO - Successfully installed psutil 13:37:25 INFO - Cleaning up... 13:37:25 INFO - Return code: 0 13:37:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:25 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 0x10f7dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f752570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb590560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5f0d30>, '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 0x10f456db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e8b20>, '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.N4unvpD8d3/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.osVG2voP3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 13:37:25 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 13:37:25 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 13:37:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4unvpD8d3/Render', 13:37:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:37:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:37:25 INFO - 'HOME': '/Users/cltbld', 13:37:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:37:25 INFO - 'LOGNAME': 'cltbld', 13:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:25 INFO - 'MOZ_NO_REMOTE': '1', 13:37:25 INFO - 'NO_EM_RESTART': '1', 13:37:25 INFO - 'PAGER': '/bin/cat', 13:37:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:25 INFO - 'PWD': '/builds/slave/test', 13:37:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:37:25 INFO - 'SHELL': '/bin/bash', 13:37:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osVG2voP3Y/Listeners', 13:37:25 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 13:37:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:37:25 INFO - 'USER': 'cltbld', 13:37:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:37:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:25 INFO - 'XPC_FLAGS': '0x0', 13:37:25 INFO - 'XPC_SERVICE_NAME': '0', 13:37:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:37:26 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 13:37:26 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 13:37:26 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 13:37:26 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 13:37:26 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 13:37:26 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 13:37:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:37:28 INFO - Installing collected packages: mozsystemmonitor 13:37:28 INFO - Running setup.py install for mozsystemmonitor 13:37:28 INFO - Successfully installed mozsystemmonitor 13:37:28 INFO - Cleaning up... 13:37:28 INFO - Return code: 0 13:37:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:37:28 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')]} 13:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:28 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')]} 13:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:29 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 0x10f7dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f752570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb590560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5f0d30>, '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 0x10f456db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e8b20>, '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.N4unvpD8d3/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.osVG2voP3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 13:37:29 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 13:37:29 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 13:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4unvpD8d3/Render', 13:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:37:29 INFO - 'HOME': '/Users/cltbld', 13:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:37:29 INFO - 'LOGNAME': 'cltbld', 13:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:29 INFO - 'MOZ_NO_REMOTE': '1', 13:37:29 INFO - 'NO_EM_RESTART': '1', 13:37:29 INFO - 'PAGER': '/bin/cat', 13:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:29 INFO - 'PWD': '/builds/slave/test', 13:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:37:29 INFO - 'SHELL': '/bin/bash', 13:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osVG2voP3Y/Listeners', 13:37:29 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 13:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:37:29 INFO - 'USER': 'cltbld', 13:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:29 INFO - 'XPC_FLAGS': '0x0', 13:37:29 INFO - 'XPC_SERVICE_NAME': '0', 13:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:29 INFO - Downloading/unpacking jsonschema==2.5.1 13:37:29 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 13:37:29 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 13:37:29 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 13:37:29 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 13:37:29 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 13:37:29 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 13:37:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:37:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:37:31 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 13:37:31 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 13:37:31 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 13:37:31 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 13:37:31 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 13:37:31 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 13:37:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:37:32 INFO - warning: no files found matching '*.txt' 13:37:32 INFO - no previously-included directories found matching 'build' 13:37:32 INFO - no previously-included directories found matching 'dist' 13:37:32 INFO - no previously-included directories found matching '.git*' 13:37:32 INFO - Installing collected packages: jsonschema, functools32 13:37:32 INFO - Running setup.py install for functools32 13:37:32 INFO - warning: no files found matching '*.txt' 13:37:32 INFO - no previously-included directories found matching 'build' 13:37:32 INFO - no previously-included directories found matching 'dist' 13:37:32 INFO - no previously-included directories found matching '.git*' 13:37:32 INFO - Successfully installed jsonschema functools32 13:37:32 INFO - Cleaning up... 13:37:32 INFO - Return code: 0 13:37:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:37:32 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')]} 13:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:32 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')]} 13:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:32 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 0x10f7dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f752570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb590560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5f0d30>, '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 0x10f456db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e8b20>, '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.N4unvpD8d3/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.osVG2voP3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 13:37:32 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 13:37:32 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 13:37:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4unvpD8d3/Render', 13:37:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:37:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:37:32 INFO - 'HOME': '/Users/cltbld', 13:37:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:37:32 INFO - 'LOGNAME': 'cltbld', 13:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:32 INFO - 'MOZ_NO_REMOTE': '1', 13:37:32 INFO - 'NO_EM_RESTART': '1', 13:37:32 INFO - 'PAGER': '/bin/cat', 13:37:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:32 INFO - 'PWD': '/builds/slave/test', 13:37:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:37:32 INFO - 'SHELL': '/bin/bash', 13:37:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osVG2voP3Y/Listeners', 13:37:32 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 13:37:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:37:32 INFO - 'USER': 'cltbld', 13:37:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:37:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:32 INFO - 'XPC_FLAGS': '0x0', 13:37:32 INFO - 'XPC_SERVICE_NAME': '0', 13:37:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:37:32 INFO - Cleaning up... 13:37:32 INFO - Return code: 0 13:37:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:37:32 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')]} 13:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:32 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')]} 13:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:32 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 0x10f7dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f752570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb590560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5f0d30>, '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 0x10f456db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e8b20>, '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.N4unvpD8d3/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.osVG2voP3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 13:37:32 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 13:37:32 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 13:37:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4unvpD8d3/Render', 13:37:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:37:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:37:32 INFO - 'HOME': '/Users/cltbld', 13:37:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:37:32 INFO - 'LOGNAME': 'cltbld', 13:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:32 INFO - 'MOZ_NO_REMOTE': '1', 13:37:32 INFO - 'NO_EM_RESTART': '1', 13:37:32 INFO - 'PAGER': '/bin/cat', 13:37:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:32 INFO - 'PWD': '/builds/slave/test', 13:37:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:37:32 INFO - 'SHELL': '/bin/bash', 13:37:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osVG2voP3Y/Listeners', 13:37:32 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 13:37:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:37:32 INFO - 'USER': 'cltbld', 13:37:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:37:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:32 INFO - 'XPC_FLAGS': '0x0', 13:37:32 INFO - 'XPC_SERVICE_NAME': '0', 13:37:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:33 INFO - Downloading/unpacking blobuploader==1.2.4 13:37:33 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 13:37:33 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 13:37:33 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 13:37:33 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 13:37:33 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 13:37:33 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 13:37:35 INFO - Downloading blobuploader-1.2.4.tar.gz 13:37:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:37:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:37:35 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 13:37:35 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 13:37:35 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 13:37:35 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 13:37:35 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 13:37:35 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 13:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:37:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:37:36 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 13:37:36 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 13:37:36 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 13:37:36 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 13:37:36 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 13:37:36 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 13:37:36 INFO - Downloading docopt-0.6.1.tar.gz 13:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:37:36 INFO - Installing collected packages: blobuploader, requests, docopt 13:37:36 INFO - Running setup.py install for blobuploader 13:37:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:37:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:37:36 INFO - Running setup.py install for requests 13:37:37 INFO - Running setup.py install for docopt 13:37:37 INFO - Successfully installed blobuploader requests docopt 13:37:37 INFO - Cleaning up... 13:37:37 INFO - Return code: 0 13:37:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:37:37 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')]} 13:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:37 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')]} 13:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:37 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 0x10f7dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f752570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb590560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5f0d30>, '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 0x10f456db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e8b20>, '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.N4unvpD8d3/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.osVG2voP3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 13:37:37 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 13:37:37 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 13:37:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4unvpD8d3/Render', 13:37:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:37:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:37:37 INFO - 'HOME': '/Users/cltbld', 13:37:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:37:37 INFO - 'LOGNAME': 'cltbld', 13:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:37 INFO - 'MOZ_NO_REMOTE': '1', 13:37:37 INFO - 'NO_EM_RESTART': '1', 13:37:37 INFO - 'PAGER': '/bin/cat', 13:37:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:37 INFO - 'PWD': '/builds/slave/test', 13:37:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:37:37 INFO - 'SHELL': '/bin/bash', 13:37:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osVG2voP3Y/Listeners', 13:37:37 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 13:37:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:37:37 INFO - 'USER': 'cltbld', 13:37:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:37:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:37 INFO - 'XPC_FLAGS': '0x0', 13:37:37 INFO - 'XPC_SERVICE_NAME': '0', 13:37:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:37:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-7ZtVq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:37:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-IOdRrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:37:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-2t22Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:37:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-WXjSjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:37:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-bSH2xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:37:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-wsaaNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:37:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-JAAh4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:37:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-9i8QaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:37:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-oXhbon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:37:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Xv7Jac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:37:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-3uLoWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:37:39 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-OozCjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:37:39 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-gIer1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:37:39 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-0f5SVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:39 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-fyuqrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:37:39 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-GVyckW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:37:39 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-D4fPTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:37:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:37:39 INFO - Running setup.py install for manifestparser 13:37:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:37:39 INFO - Running setup.py install for mozcrash 13:37:40 INFO - Running setup.py install for mozdebug 13:37:40 INFO - Running setup.py install for mozdevice 13:37:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:37:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:37:40 INFO - Running setup.py install for mozfile 13:37:40 INFO - Running setup.py install for mozhttpd 13:37:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:37:40 INFO - Running setup.py install for mozinfo 13:37:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:37:40 INFO - Running setup.py install for mozInstall 13:37:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:37:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:37:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:37:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:37:40 INFO - Running setup.py install for mozleak 13:37:41 INFO - Running setup.py install for mozlog 13:37:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:37:41 INFO - Running setup.py install for moznetwork 13:37:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:37:41 INFO - Running setup.py install for mozprocess 13:37:41 INFO - Running setup.py install for mozprofile 13:37:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:37:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:37:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:37:41 INFO - Running setup.py install for mozrunner 13:37:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:37:41 INFO - Running setup.py install for mozscreenshot 13:37:41 INFO - Running setup.py install for moztest 13:37:42 INFO - Running setup.py install for mozversion 13:37:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:37:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:37:42 INFO - Cleaning up... 13:37:42 INFO - Return code: 0 13:37:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:37:42 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')]} 13:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:42 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')]} 13:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:42 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 0x10f7dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f752570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb590560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5f0d30>, '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 0x10f456db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e8b20>, '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.N4unvpD8d3/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.osVG2voP3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 13:37:42 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 13:37:42 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 13:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4unvpD8d3/Render', 13:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:37:42 INFO - 'HOME': '/Users/cltbld', 13:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:37:42 INFO - 'LOGNAME': 'cltbld', 13:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:42 INFO - 'MOZ_NO_REMOTE': '1', 13:37:42 INFO - 'NO_EM_RESTART': '1', 13:37:42 INFO - 'PAGER': '/bin/cat', 13:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:42 INFO - 'PWD': '/builds/slave/test', 13:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:37:42 INFO - 'SHELL': '/bin/bash', 13:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osVG2voP3Y/Listeners', 13:37:42 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 13:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:37:42 INFO - 'USER': 'cltbld', 13:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:42 INFO - 'XPC_FLAGS': '0x0', 13:37:42 INFO - 'XPC_SERVICE_NAME': '0', 13:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:37:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-AUqn1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:37:42 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)) 13:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:37:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-VSFLl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:37:42 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)) 13:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:37:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-EsCyNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:37:42 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)) 13:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:37:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-LZcKRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:37:42 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)) 13:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:37:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-lTR46L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:37:43 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)) 13:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:37:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-KIFOlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:37:43 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)) 13:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:37:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-hFwvR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:37:43 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)) 13:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:37:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-YYN_TB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:37:43 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)) 13:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:37:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-rvd3vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:37:43 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)) 13:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:37:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-DaV2w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:37:43 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)) 13:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:37:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-9ZPbAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:37:43 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)) 13:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:37:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-JWGcAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:37:43 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)) 13:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:37:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Y807Aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:37:43 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)) 13:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:37:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-OiBS26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:37:44 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)) 13:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:44 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-nNCgn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:44 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)) 13:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:37:44 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-dlDr8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:37:44 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)) 13:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:37:44 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-oreUas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:37:44 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)) 13:37:44 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)) 13:37:44 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)) 13:37:44 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)) 13:37:44 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)) 13:37:44 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)) 13:37:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:37:44 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 13:37:44 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 13:37:44 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 13:37:44 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 13:37:44 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 13:37:44 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 13:37:46 INFO - Downloading blessings-1.6.tar.gz 13:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:37:47 INFO - Installing collected packages: blessings 13:37:47 INFO - Running setup.py install for blessings 13:37:47 INFO - Successfully installed blessings 13:37:47 INFO - Cleaning up... 13:37:47 INFO - Return code: 0 13:37:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:37:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:37:47 INFO - Reading from file tmpfile_stdout 13:37:47 INFO - Current package versions: 13:37:47 INFO - blessings == 1.6 13:37:47 INFO - blobuploader == 1.2.4 13:37:47 INFO - docopt == 0.6.1 13:37:47 INFO - functools32 == 3.2.3-2 13:37:47 INFO - jsonschema == 2.5.1 13:37:47 INFO - manifestparser == 1.1 13:37:47 INFO - mozInstall == 1.12 13:37:47 INFO - mozcrash == 0.17 13:37:47 INFO - mozdebug == 0.1 13:37:47 INFO - mozdevice == 0.48 13:37:47 INFO - mozfile == 1.2 13:37:47 INFO - mozhttpd == 0.7 13:37:47 INFO - mozinfo == 0.9 13:37:47 INFO - mozleak == 0.1 13:37:47 INFO - mozlog == 3.4 13:37:47 INFO - moznetwork == 0.27 13:37:47 INFO - mozprocess == 0.23 13:37:47 INFO - mozprofile == 0.28 13:37:47 INFO - mozrunner == 6.12 13:37:47 INFO - mozscreenshot == 0.1 13:37:47 INFO - mozsystemmonitor == 0.3 13:37:47 INFO - moztest == 0.7 13:37:47 INFO - mozversion == 1.4 13:37:47 INFO - psutil == 3.1.1 13:37:47 INFO - requests == 1.2.3 13:37:47 INFO - wsgiref == 0.1.2 13:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:37: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')]} 13:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37: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')]} 13:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:47 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 0x10f7dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f752570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb590560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5f0d30>, '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 0x10f456db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e8b20>, '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.N4unvpD8d3/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.osVG2voP3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 13:37:47 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 13:37:47 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 13:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4unvpD8d3/Render', 13:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:37:47 INFO - 'HOME': '/Users/cltbld', 13:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:37:47 INFO - 'LOGNAME': 'cltbld', 13:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:47 INFO - 'MOZ_NO_REMOTE': '1', 13:37:47 INFO - 'NO_EM_RESTART': '1', 13:37:47 INFO - 'PAGER': '/bin/cat', 13:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:47 INFO - 'PWD': '/builds/slave/test', 13:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:37:47 INFO - 'SHELL': '/bin/bash', 13:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osVG2voP3Y/Listeners', 13:37:47 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 13:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:37:47 INFO - 'USER': 'cltbld', 13:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:47 INFO - 'XPC_FLAGS': '0x0', 13:37:47 INFO - 'XPC_SERVICE_NAME': '0', 13:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:47 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)) 13:37:47 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)) 13:37:47 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)) 13:37:47 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)) 13:37:47 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)) 13:37:47 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)) 13:37:47 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)) 13:37:47 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)) 13:37:47 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)) 13:37:47 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)) 13:37:47 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)) 13:37:47 INFO - Cleaning up... 13:37:47 INFO - Return code: 0 13:37:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:37: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')]} 13:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37: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')]} 13:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f7dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f752570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb590560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5f0d30>, '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 0x10f456db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e8b20>, '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.N4unvpD8d3/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.osVG2voP3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 13:37: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', 'jsonschema'] in /builds/slave/test/build 13:37: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 jsonschema 13:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4unvpD8d3/Render', 13:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:37:47 INFO - 'HOME': '/Users/cltbld', 13:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:37:47 INFO - 'LOGNAME': 'cltbld', 13:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:47 INFO - 'MOZ_NO_REMOTE': '1', 13:37:47 INFO - 'NO_EM_RESTART': '1', 13:37:47 INFO - 'PAGER': '/bin/cat', 13:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:47 INFO - 'PWD': '/builds/slave/test', 13:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:37:47 INFO - 'SHELL': '/bin/bash', 13:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osVG2voP3Y/Listeners', 13:37:47 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 13:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:37:47 INFO - 'USER': 'cltbld', 13:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:47 INFO - 'XPC_FLAGS': '0x0', 13:37:47 INFO - 'XPC_SERVICE_NAME': '0', 13:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:37:48 INFO - Cleaning up... 13:37:48 INFO - Return code: 0 13:37:48 INFO - Running post-action listener: _resource_record_post_action 13:37:48 INFO - Running post-action listener: _start_resource_monitoring 13:37:48 INFO - Starting resource monitoring. 13:37:48 INFO - [mozharness: 2016-10-27 20:37:48.086696Z] Finished create-virtualenv step (success) 13:37:48 INFO - [mozharness: 2016-10-27 20:37:48.087679Z] Running install step. 13:37:48 INFO - Running pre-action listener: _resource_record_pre_action 13:37:48 INFO - Running main action method: install 13:37:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:37:48 INFO - Reading from file tmpfile_stdout 13:37:48 INFO - Detecting whether we're running mozinstall >=1.0... 13:37:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:37:48 INFO - Reading from file tmpfile_stdout 13:37:48 INFO - Output received: 13:37:48 INFO - Usage: mozinstall [options] installer 13:37:48 INFO - Options: 13:37:48 INFO - -h, --help show this help message and exit 13:37:48 INFO - -d DEST, --destination=DEST 13:37:48 INFO - Directory to install application into. [default: 13:37:48 INFO - "/builds/slave/test"] 13:37:48 INFO - --app=APP Application being installed. [default: firefox] 13:37:48 INFO - mkdir: /builds/slave/test/build/application 13:37:48 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'] 13:37:48 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 13:38:20 INFO - Reading from file tmpfile_stdout 13:38:20 INFO - Output received: 13:38:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:38:20 INFO - Running post-action listener: _resource_record_post_action 13:38:20 INFO - [mozharness: 2016-10-27 20:38:20.813256Z] Finished install step (success) 13:38:20 INFO - [mozharness: 2016-10-27 20:38:20.813426Z] Running run-tests step. 13:38:20 INFO - Running pre-action listener: _resource_record_pre_action 13:38:20 INFO - Running main action method: run_tests 13:38:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:38:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:38:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:38:20 INFO - 2016-10-27 13:38:20.827 screenresolution[1933:17132] starting screenresolution argv=screenresolution get 13:38:20 INFO - 2016-10-27 13:38:20.830 screenresolution[1933:17132] Display 0: 1600x1200x32@60 13:38:20 INFO - 2016-10-27 13:38:20.835 screenresolution[1934:17134] starting screenresolution argv=screenresolution list 13:38:20 INFO - Available Modes on Display 0 13:38:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:38:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:38:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:38:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:38:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:38:21 INFO - Intel Iris: 13:38:21 INFO - Chipset Model: Intel Iris 13:38:21 INFO - Type: GPU 13:38:21 INFO - Bus: Built-In 13:38:21 INFO - VRAM (Dynamic, Max): 1536 MB 13:38:21 INFO - Vendor: Intel (0x8086) 13:38:21 INFO - Device ID: 0x0a2e 13:38:21 INFO - Revision ID: 0x0009 13:38:21 INFO - Displays: 13:38:21 INFO - Display: 13:38:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:38:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:38:21 INFO - Display Serial Number: 1600x1200 60 13:38:21 INFO - Main Display: Yes 13:38:21 INFO - Mirror: Off 13:38:21 INFO - Online: Yes 13:38:21 INFO - Rotation: Supported 13:38:21 INFO - Return code: 0 13:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:38:21 INFO - Python 2.7.3 13:38:21 INFO - Return code: 0 13:38:21 INFO - grabbing minidump binary from tooltool 13:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:21 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 0x10f5f0d30>, '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 0x10f456db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:38:21 INFO - Return code: 0 13:38:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:38:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:38:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:38:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:38:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:38:21 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/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 13:38:21 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/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --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 13:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4unvpD8d3/Render', 13:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:21 INFO - 'HOME': '/Users/cltbld', 13:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:21 INFO - 'LOGNAME': 'cltbld', 13:38:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:38:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:21 INFO - 'MOZ_NO_REMOTE': '1', 13:38:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:38:21 INFO - 'NO_EM_RESTART': '1', 13:38:21 INFO - 'PAGER': '/bin/cat', 13:38:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:21 INFO - 'PWD': '/builds/slave/test', 13:38:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:21 INFO - 'SHELL': '/bin/bash', 13:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osVG2voP3Y/Listeners', 13:38:21 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 13:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:21 INFO - 'USER': 'cltbld', 13:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:21 INFO - 'XPC_FLAGS': '0x0', 13:38:21 INFO - 'XPC_SERVICE_NAME': '0', 13:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:21 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/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 13:38:21 INFO - mozversion application_buildid: 20161027111134 13:38:21 INFO - mozversion application_changeset: 52d62548a29d97d03e2e11ecd16db7602eb93ee7 13:38:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:38:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:38:21 INFO - mozversion application_name: Firefox 13:38:21 INFO - mozversion application_remotingname: firefox-dev 13:38:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:38:21 INFO - mozversion application_vendor: Mozilla 13:38:21 INFO - mozversion application_version: 51.0a2 13:38:21 INFO - mozversion platform_buildid: 20161027111134 13:38:21 INFO - mozversion platform_changeset: 52d62548a29d97d03e2e11ecd16db7602eb93ee7 13:38:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:38:21 INFO - mozversion platform_version: 51.0a2 13:38:21 INFO - using testdate: 1477600701 13:38:21 INFO - actual date: 1477600701 13:38:21 INFO - starting webserver on 'localhost:52881' 13:38:21 INFO - SUITE-START | Running 2 tests 13:38:21 INFO - TEST-START | dromaeo_css 13:38:21 INFO - operating with platform_type : mac_ 13:38:21 INFO - Initialising browser for dromaeo_css test... 13:38:21 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpItwgft/profile http://localhost:52881/getInfo.html) 13:38:23 INFO - PROCESS | 1944 | __metrics Screen width/height:1600/1200 13:38:23 INFO - PROCESS | 1944 | colorDepth:24 13:38:23 INFO - PROCESS | 1944 | Browser inner width/height: 1024/689 13:38:23 INFO - PROCESS | 1944 | __metrics 13:38:23 INFO - PROCESS | 1944 | 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" 13:38:23 INFO - PROCESS | 1944 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:38:24 INFO - TEST-INFO | 1944: exit 0 13:38:24 INFO - Browser initialized. 13:38:24 INFO - Running cycle 1/1 for dromaeo_css test... 13:38:24 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpItwgft/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:36 INFO - PROCESS | 1946 | RSS: Main: 219668480 13:38:36 INFO - PROCESS | 1946 | 13:39:31 INFO - PROCESS | 1946 | 1477600771913 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] 13:41:39 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:52881/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52881/tests/dromaeo/cssquery-ext.html) 13:41:40 INFO - PROCESS | 1946 | RSS: Main: 356560896 13:41:40 INFO - PROCESS | 1946 | 13:44:43 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:52881/tests/dromaeo/cssquery-ext.html (next: http://localhost:52881/tests/dromaeo/cssquery-jquery.html) 13:44:44 INFO - PROCESS | 1946 | RSS: Main: 351723520 13:44:44 INFO - PROCESS | 1946 | 13:47:46 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:52881/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52881/tests/dromaeo/cssquery-mootools.html) 13:47:47 INFO - PROCESS | 1946 | RSS: Main: 325959680 13:47:47 INFO - PROCESS | 1946 | 13:50:49 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:52881/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52881/tests/dromaeo/cssquery-prototype.html) 13:50:50 INFO - PROCESS | 1946 | RSS: Main: 322019328 13:50:50 INFO - PROCESS | 1946 | 13:53:53 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:52881/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52881/tests/dromaeo/cssquery-yui.html) 13:53:54 INFO - PROCESS | 1946 | RSS: Main: 311574528 13:53:54 INFO - PROCESS | 1946 | 13:56:57 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:52881/tests/dromaeo/cssquery-yui.html (next: http://localhost:52881/tests/dromaeo/cssquery-dojo.html) 13:56:57 INFO - PROCESS | 1946 | RSS: Main: 466833408 13:56:57 INFO - PROCESS | 1946 | 13:56:57 INFO - PROCESS | 1946 | __start_tp_report 13:56:57 INFO - PROCESS | 1946 | _x_x_mozilla_page_load 13:56:57 INFO - PROCESS | 1946 | _x_x_mozilla_page_load_details 13:56:57 INFO - PROCESS | 1946 | |i|pagename|runs| 13:56:57 INFO - PROCESS | 1946 | |0;dojo.html;3019.894303699371;3171.3974344874478;3314;3356.630770615232;3364.798112113275;5777.133429985504;5814.302283725959;5820.417958204188;5821.621594596349;5865.853353666155;5771.942280577193;5772.5670574706855;5831.2419385479825;5884.852878678035;5904.291485021803;5280.287161233232;5321.255024296602;5344.599155063366;5347.358317001946;5372.274742909696;5229.8954020919555;5241.187615919539;5250.422453530108;5410.756515956791;5416.83749487516;5341.412444631087;5346.224797404374;5348.732563371836;5352.464753524655;5359.035373632744;5283.762230699647;5327.041132596131;5361.169018802092;5380.24676545284;5394.083005889008;5159.845204643867;5266.4470230626;5274.841754747364;5347.786088556453;5392.91910621341;5954.851128721773;5999.730012149464;6004.759809607611;6005.519558435315;6011.909821352683;6097.664628445434;6145.139680444741;6147.8155655329965;6174.9073763893575;6204.13142160098;5192.662476939025;6130.092410195535;6172.166757487771;6301.8109456716375;6318.115463835067;4817.373741413594;5873.970630146822;5877.471027607493;5884.176215329857;5946.197263369476;6125.572745538934;6322.462590679844;6331.651759153291;6334.968325158345;6352.36476352361;6126.029144987373;6209.565330426917;6214.8135555933395;6243.063540468966;6257.812265632038;6291.905621415683;6304.65324407162;6306.49548036156;6306.49548036156;6324.209473815773;5941.960156972599;6098.1157732128595;6143.96928015357;6321.652309123042;6327.557071004985;6023.789167379121;6139.84650383744;6153.938460615426;6216.937830621727;6242.28213755424;4950.6782059166035;4951.70289782607;4952.653314267966;4957.380327459067;4969.155243608595;4314.525402205755;4423.093265880551;4425.645948324191;4443.688941774045;4457.175422546839;5715.599908006399;5721.771129154788;5749.626274292157;5802.564807639444;5870.471657550841;5506.697131657717;6229.3770622937345;6275.121482992385;6313.652749098752;6323.399277068671;5871.060630299132;5885.793997210077;5888.823335299948;5899.941000590025;5901.144334071536;5304.283921670525;5344.652597581145;5418.701971391612;5428.995635807389;5492.725363731797;5775.162601422854;6257.249130104235;6274.686265686697;6351.17434733491;6360.745570177326;6241.981202446774;6269.3417191196095;6273.52948528853;6278.968605157128;6300.117983482408;5438.2386465894015;6394.616323020634;6400.871982560416;6500.349965003462;6534.640594767334;4807.735574543294;5670.518005969374;6114.054067497291;6220.72006759706;6256.374362563707;6223.066540018853;6286.717097730521;6295.024271237966;6298.149749783904;6300.779472718433;4949.901001980013;6214;6237.033259844731;6243.063540468966;6255.593386429868;6000.969995149996;6133.3866613338305;6144.938550614615;6152.046432802923;6170.660613666291;5975.940240597713;6082.239720034996;6115;6119.816405507842;6132.17215675878;6166.392018440415;6172.166757487861;6189.288231853395;6193.163922870535;6210.937890621217;5925.614835035709;5954.642721436728;6072.696365181811;6072.817815465543;6100.816975490742 13:56:57 INFO - PROCESS | 1946 | |1;ext.html;460.5739690786023;472.2774155542022;525.6320575597083;532.3691425660592;554.5203399059812;30137.945171918986;38234;39219.41170882432;39300.624478143305;41256.17487650245;41641.791791041;42110.789446052724;42145;42187.57812421875;42284.15431691364;8806.955965220164;9824.950875245631;10008.199344052495;10034.347767395133;10040.548175332127;8806.823863522726;11998.940005300004;12261.693457663585;12293.569725059624;12448;12160.331181785043;12221.511139554406;12227.449764760608;12237.449314780812;12256.44845981933;12236.327002014885;12297.508099676003;12322;12327.321997290146;12327.445264963098;12155.696107597292;12184.451699673536;12193.207441516273;12195.39023048844;12226.572069977508;39880.80059599713;40098;40114.79942600268;40225.597744022474;40327.59672403268;3270.444024515838;3345.43127668297;3357.5635167428077;3382.4588065909584;3740.3641380965028;30696.69303306983;30823;30965.380692386025;31043.689563104304;31384.529232061537;2719.6736391632935;3181.427343078245;3249.3501299740146;3298.736101111929;3308.17295676081;530852;531309;531752.9999999962;532108;532796;33648.49527257093;57971;58549.414505854395;58558.70720646455;58616.413835861946;34113.31773364569;35344;35611.82194089013;35748.821255893556;35764.46353304703;14888;15036.17301048431;15056;15075.472358467401;15085.094894306376;11572.47923843429;11786.292822430682;12527.624171274876;12721.872781272068;12811.231326120462;7666.655000524878;7778.455508114378;7844.646990885424;7846;7859;3245.3671534051105;3281.868725251011;3298.538204651351;3300.8184549849507;3314.834258287124;938.6573900526396;1005.7988402319565;1008.1833714691123;1011.9494025298706;1020.5356562763925;29516.704832951826;29570.704292957227;30106.698933010826;30128.24679382989;30170.396592068035;899.2491269789799;986.1765425869336;1048.4233671480656;1078.5739632845139;1081.4808891732014;14574.271286435636;14667.339969701388;14928.25358732059;15461.226938653022;15848.44530441429;664739;670972;671873;673604;673991;55372.446275537535;55607;55875.720621396635;55955.16067258995;56005.879882402936;1261.6152073617634;1286.6075846866795;1384.2179168769612;1407.9366428510946;1410.9788353174506;29840;30201.244968875955;30627.54058689077;30654.540181896842;31287;47397;48056.5194348052;48059.75970120127;48075.5192448085;48173.75913120412;457871;458622;458911;458971;674313;39356.409653854644;40424.79787601043;41291;41296;41508;44764.32853507135;44806;44928.10143797041;45205;45338.773306133255;36383.090422739646;36655.35050922661;37708.62291377051;38732.80633596814;38823.611763882;36742.44886326654;36779.81610091932;36974.63025369712;37365.626343736214;37638;36155.81922090373;36234.4564831533;36526.45210321794;36853.49202184358;37306.25387492289;30908.53637195399;33120.834395827864;33350;33389.49915751217;33393;24634.75365246396;24761.504769904142;24835.62746558767;25360.74639253584;25368.873155634104 13:56:57 INFO - PROCESS | 1946 | |2;jquery.html;354.09881850689993;372.8713593810135;377.32467842778044;383.7428922621844;402.8972611983946;15239;15563.922180389096;17500.562485937873;20678.48303792406;20932.9533523324;20575.588488230227;21038.579228415423;21219.787802121973;21326.36020919371;21496.92515374233;4923.458419573853;5810.506106980912;5909.438603332676;6121.357257487966;6124.081387791823;5884.76460941564;6047.818565443044;6050.2134722486235;6052.425019623129;6064.241969753781;4149.792510374485;4397.38436618872;6453.096566480696;6730.394264516192;6808;5849.7660093596205;6159.722812473449;6831.385175334219;6865.931340686604;6877.2091209511045;6091.573589848713;6096.329403765582;6103.511719062464;6120.326764055951;6132.080187971796;11460.598879039277;11588;12591.118621696485;12901.548445804352;13408.664783380396;2171.1206961180746;2274.9658755118685;2308.5844547981355;2562.7309132541186;2757.352022274764;8153.918460815435;9834.754131146707;9886.159676427513;10217.2847900647;10221.233407494468;1819.5087326421924;1864.5525073982283;1864.7855496617792;1878.5961018380976;1999.6700544410155;97058;117124.63002959742;120553;127441;129417.35291323483;11307.886921130848;11493.655190344303;11569.826452603218;11587.304761714155;11784.469698863571;14675.926620367043;14680.779788303184;14682.119072855663;14688.339024743913;14711.264436778332;8374.832503349899;8593.398462107592;8594.742157735278;8752;8774.210321071134;8490.787730306793;8512.02111757156;8521.786955326043;8666.220040196287;8741.606627701769;4424.557544245614;4526.411566496335;4527.230370836965;4581.221192397234;4603.148417542765;1842.5117343903876;1894.1665667106429;1894.640018396528;1909.1313452379134;1909.1695112626053;694.9166100068024;697.5396238482679;769.6651956398985;842.7808769719794;872.7905302727427;18505.61207909412;18610.34863779761;20145.05720812364;21558.78441215599;21841.319309180843;925.3615005646083;936.5317341329335;945.952702364879;951.4909523404945;962.8122516109291;10856.565737370416;11298.37858917751;11503.482343294572;11531.596394126165;11549.36478493674;512174;544072.3981900484;561142;572333;577253;105722.4141637876;123730;129058;130988;134212;947.668316089377;977.9413235205768;988.8417853143462;989.1690979577046;990.153418826907;18026.639467210844;18768.53078673044;19113.808861911202;19140;19197.32809351666;35199.64800351964;49155.03379864765;53080.93838123139;53446.46553534415;54179.72910135424;73634.63182684267;75707.24292757001;78320.2167978313;78425.2157478418;80215;7780.688772449265;7934.087579928382;8081.393895457747;8175.959120204361;8245.175482451707;7164.319389657974;8735.868961965449;10438.63464778729;12741.681457963625;12919.935400322938;10645.89354106449;10871.34771913656;10940.617078402218;11006.724831879266;11056.668299951014;10590.629327973484;10813.945930270298;10821.404822734825;11044.834327484934;11228.831567526331;11062.668119956414;11181.869076658548;11307.095432365555;11342.149338799458;11630.302181869114;7939.047314322318;8014.599270036359;8189.836203275782;8220.3834712398;8283.917160828314;8559.529225892637;9927.453990030617;10898.182636302468;10935.617253396093;11339.773204535699 13:56:57 INFO - PROCESS | 1946 | |3;mootools.html;1503.098141115331;1518.962025949351;1730.3857130718595;1837.8713490055702;1912.1013123831804;8584.871226931593;9116.1339672731;9117.316201284897;9132.178103970642;9135.269178465724;8072.757817265477;8272.131426200252;8290.088090310077;8740.694075707352;8966.193042626162;2344.9648255276143;2402.8438151520095;2407.0131246189067;2408.084927727461;2414;2367.8579285242854;2392.820538459614;2400.4718961828457;2406.915757948472;2409.77107174819;2373.359193017884;2375.596148654733;2376.6910301660846;2391.5097405032016;2407.4823912858733;1939.224310275901;2342.3792694935855;2348.189874493297;2355.6702061711376;2356.976430235693;2353.7763912428463;2359.3865594945264;2361.8700971446565;2364.1725396111397;2365.2431222008963;8995.55022248885;8998.05520420353;9121.771955701095;9123.589438475285;9133.315001374924;5316.9734151329385;5487.42382049883;5487.5884308677005;5489.615726899118;5494.450554944514;3136.5765621641012;3352.6982571568433;3543.344481270973;3633.654802793757;3646.781193128421;1060.1836585828946;1063.8138325792954;1070.9678709638724;1088.2871719024051;1090.3566895531674;10588;11729.533808273965;12177;12178.573749918798;12185.634430967086;4071.5114186297833;4639.257718764981;4670.9766451167525;4858.708477491362;4873.31773551703;8528.445651032664;10240.590376384862;10244.334118282288;10251.7437064074;10292.279540432099;5318.175682769177;5328.120860058125;5412.134058550613;5425.159100339453;5429.619926605179;4463.24124898768;4463.910721785546;4950.282209079735;4956.504349565087;4967.552920237196;3966.1076257842333;3987.980060099681;4043.5147782265726;4062;4077.89805254871;1285.1453783234044;1293.2046791223518;1294.7216348485122;1308.1431662261234;1312.4553310376277;829.5064436660177;835.9623816928253;926.7034548944273;928.4614923344444;928.9628414863465;4947;5835.241418615553;5962.761489540457;6109.938900610937;6225.159603453566;436.38033991731817;441.8232706917259;448.5021625995143;452.4344569288389;465.8136745301906;3981.283368993551;4033.9798301008896;4104.610062044101;4111.259973204852;4149.7095203335475;10654.467276636136;10928.289661172157;11081.27971681838;11085.27945683528;11116.55533778656;10565.9471702641;10788.56845726178;10956.780864382827;10966.287191332538;10986.725331866768;8227.13615070421;8320.583970801557;8345.123762005023;8408.285295749807;8431.072582015973;5872.148538461814;6028.75884964614;6031.09533569968;6053.102078618004;6147.631142131487;9931;9993.350432221881;10208.54061567246;10274.332168409328;10278;10098.19214462856;10323.793524129325;10452.94773526158;10489.580416783243;10576.576936922746;6415.518836087219;7045.964770176116;7274.454415918933;7282.781516554512;7700.922990770021;6906.412954898688;8070.152633973583;8134.389920755849;8140.83718325642;8230;7408.444366672629;7688.538687678757;7695.769126926201;7738.2261773822165;7854.253845884632;7365.558066516026;7424.777256682308;7455.329020388191;7494.887576686463;7555.09338879338;7098.858022839618;7122.074130363019;7198.244184360567;7205.027321311556;7211.242819504087;5045.722485263345;5051.898962020812;5067.87330316745;5095.235714642833;5206.140986737298;4761.2382018876815;5026.84919452417;5082.2122571001555;5227.268182454535;5259.15853463444 13:56:57 INFO - PROCESS | 1946 | |4;prototype.html;259.2287943368479;300.8841595985545;305.30086102824527;313.1513598149016;315.0516943998564;4211.915761684764;5246.947530524693;5250.107481728101;5333.759980800864;5370.3287089113865;4219.346001369792;4542.6138778203895;4793.688410253331;5082.442290396719;5231.607629427789;3411.3347897160124;4062.6140516651017;4098.233692257729;4101.528324242706;4104.958950410502;3811.455346527728;4075.368317910714;4118.361653943629;4136.779650003241;4157.438745769313;3676.3382591133586;4044.6562042226446;4050.8987275318204;4062.370332598452;4068.7151899367054;3982.7298439889273;3988.561258261589;4005.8397664093254;4021.537523184842;4066.861278841914;3173.7778355515125;3296.3736889991064;3353.094664440587;3453.2748122894222;3522.9959461553335;4449.888752781174;5077.086124497589;5184.818531351385;5190.273361729361;5226.451222621608;4575.679702420832;4649.7907594158005;4661.930071048937;4672.6261899047995;4674.883127921795;5399.163129714901;5533.043873630333;5584.246126772874;5632;5682.045336425077;3806.7525610835205;3812.656860882506;3814.2180852925085;3824.292505886392;3828.617138286177;4661.160991021648;5859.472647461706;5903.291605007426;5911.852203694899;5972.6715030673295;3015.3516993845988;3707.570497289996;3876.573576906538;3881.4565960765517;3934.1738234970976;3602.4056030755155;3960.6435420812263;3979.8259513443604;3982.163745613396;3984.1234928315725;4014.9397759033636;4589.403377560896;4592.3720260994105;4598.494165641777;4625.121226966866;4670.789814458358;5284.701154997589;5649.802256920988;5653.4170432279025;5716.342620598602;1031.8452232165234;1313.9422764674339;1350.3923234544495;1355.2478374502048;1355.491690616019;785.6616744414397;805.4361946637378;814.7270664327517;818.5988865455884;819.6557645461448;3775.716821238418;4096.508418989681;4345.914400775485;4392.780360981938;4402.434028436976;4305.763183024964;4803.639727020418;4808.63935204861;4878.292647566083;4880.731559764176;3632.383589302735;3718.322807578539;4197.761660310216;4287.528371879091;4401.40581021558;2578.755018273261;2725.6592925884265;3054.7556195504308;3070.0022492689964;3093.8607762650736;5557.360903496069;5958.702064896825;6099.969500152471;6109.969450152721;6115.694215289218;4887.242477416006;5353.491418315254;5721.5136713379825;6022.307434644984;6112.572119951649;5300.549453296436;6091.51267898567;6106.542009349317;6116.510679145657;6190.380961903774;5193.610479213999;5413.022837439471;5851.92256748848;5902.704864756659;5930.318013428511;4595.954040459553;5314.468553144655;5692.373838877803;5782.5663075268685;5789.33422656383;5567.053600887778;6126.763731237977;6131.96934015327;6151.569390142647;6158.753649853956;3500.43992961125;3809.4666746654934;3824.5028146340796;3918;4024.295748243987;5005.924911126263;5704.971475142598;5792.739326730223;5793.8551536211935;5818;5162.527720616159;5385.676859388449;5628.268325117709;5659;5722.313322401338;4856.514348565115;5617.915731264116;5626.662400255997;5629.915551266652;5642.630095359877;4785.736784476887;5021.372328458942;5524.696141712245;5546.839870097427;5618.185363122243;5360.758765855468;5594.936961977374;5668.801591944262;5669.34802497718;5757.625754325955;4991.053489139311;5324.068288049499;5517.062099443024;5541.667499950016;5589.329280486205 13:56:57 INFO - PROCESS | 1946 | |5;yui.html;601.6600620649333;701.5510073552924;775.3177204060426;790.0756115345046;808.2402541610884;15247;16280.26738796754;16550.006999580033;16558.08930508823;16579.83420165798;15102.39590416382;15222.467213647524;15325.69348613027;15326.616834579141;15331.310091045902;832.9416940814145;845.8350621628784;849.0193826130828;851.2806678356809;853.1255463150259;666.2904007232282;682.0757873081977;684.2780866186172;826.7809030606894;838.5429940682343;894.7181637784078;898.2544488074882;900.4327273817486;900.9009009009004;900.9909900901006;888.7822483491586;889.0886840987974;891.1355984694868;891.148952750122;893.5264309915755;518.1321286844558;529.6266132376666;534.2680527677069;534.5563182558467;660.7423104989058;12711.364431778375;14915.776263356058;15521.223938803014;15575.143367114804;15711.68576628461;14744.336504857307;14985.325660345201;15094.622634434118;15139.318730657036;15354.309056092503;11444.828327575093;11678.591249306319;11717.355545444998;12105.09211809118;12229.93885030569;3781.2248489059675;3840.558335791392;3988.3818008208773;4015.819288132041;4017.97991010046;121137.39431302875;124760;124887.3755631225;125041;125047.37476312651;10068.748281293027;10978.835317470244;10990.505427255792;11370.374629395463;11651.30092194471;23954.64068038981;24391.878040610038;24420;24428.877855610608;24437.389065273153;8121.31996441173;8153.347732181412;8161.67353305873;8184.6316915738935;8186.467879587808;4361.825526978949;4492.236319825637;4493.191225579427;4518.4126063612175;4621.514740952219;3688.6864616507896;3812.4662547243406;3813.4661147438824;3815.6184381562175;3827.655511004023;598.9550783691241;610.2372034956304;616.7687117331001;651.1600035953661;665.3280187011056;653.8002764926414;660.6168422315046;669.7722774256777;678.8404724889647;706.4136766483806;8899.288056955427;9379.765505862271;9596;9686.418814871131;9749.073837985521;656.9047488114293;670.3798985937988;675.166169780321;679.1578442730978;681.3050688297908;4638.652101092432;4644.698094623838;4676.158291507493;4699.718016918928;4763.54746299101;84968;128425.3578732119;130938.69061309456;150310;167116.16441917713;117858;118044;119263.40368298104;124083.3795831033;124465.37767311286;101770.49114754378;115621.42189289;116955;118311.81688183008;118421.40789295998;6405.903911441239;8049.87925181111;8175.059868115243;8683.348748843988;8688.739337819876;50955.471335859984;62230.68884655729;63798.68100659467;64951.67524162349;66004.6699766498;82075;92385.5380723119;97235;99755.00244997747;101244.49377753065;11593.304401735923;11785.351805650771;12118.818217726917;12148.453319600816;12177.391130443266;12216.389180541115;12705.157752125706;13101.279429631462;13197.472101115847;13323.733525329246;11751.76496470083;11753;11794.764104717686;12378.566750163702;12400.069994750249;12184.237866719157;12464.626061218178;12596.118271720892;12742.362881856056;12745.362731863184;10560.894391055992;11994.400279986141;11997;12080.523492683802;12685.302308372758;9244.907550924405;9683.66107186245;9795.461249631338;9844.064813842673;10425.218108642033;9723.46520941355;10382.584696612354;10382.948085259526;10414.375137491472;10425.061744442733 13:56:57 INFO - PROCESS | 1946 | __end_tp_report 13:56:57 INFO - PROCESS | 1946 | __start_cc_report 13:56:57 INFO - PROCESS | 1946 | _x_x_mozilla_cycle_collect,1291 13:56:57 INFO - PROCESS | 1946 | __end_cc_report 13:56:57 INFO - PROCESS | 1946 | __startTimestamp1477601817565__endTimestamp 13:56:57 INFO - PROCESS | 1946 | 13:56:57 INFO - PROCESS | 1946 | ------- Summary: start ------- 13:56:57 INFO - PROCESS | 1946 | Number of tests: 6 13:56:57 INFO - PROCESS | 1946 | 13:56:57 INFO - PROCESS | 1946 | [#0] dojo.html Cycles:165 Average:5766.45 Median:5999.73 stddev:659.58 (11.0%) stddev-sans-first:625.43 13:56:57 INFO - PROCESS | 1946 | Values: 3019.9 3171.4 3314.0 3356.6 3364.8 5777.1 5814.3 5820.4 5821.6 5865.9 5771.9 5772.6 5831.2 5884.9 5904.3 5280.3 5321.3 5344.6 5347.4 5372.3 5229.9 5241.2 5250.4 5410.8 5416.8 5341.4 5346.2 5348.7 5352.5 5359.0 5283.8 5327.0 5361.2 5380.2 5394.1 5159.8 5266.4 5274.8 5347.8 5392.9 5954.9 5999.7 6004.8 6005.5 6011.9 6097.7 6145.1 6147.8 6174.9 6204.1 5192.7 6130.1 6172.2 6301.8 6318.1 4817.4 5874.0 5877.5 5884.2 5946.2 6125.6 6322.5 6331.7 6335.0 6352.4 6126.0 6209.6 6214.8 6243.1 6257.8 6291.9 6304.7 6306.5 6306.5 6324.2 5942.0 6098.1 6144.0 6321.7 6327.6 6023.8 6139.8 6153.9 6216.9 6242.3 4950.7 4951.7 4952.7 4957.4 4969.2 4314.5 4423.1 4425.6 4443.7 4457.2 5715.6 5721.8 5749.6 5802.6 5870.5 5506.7 6229.4 6275.1 6313.7 6323.4 5871.1 5885.8 5888.8 5899.9 5901.1 5304.3 5344.7 5418.7 5429.0 5492.7 5775.2 6257.2 6274.7 6351.2 6360.7 6242.0 6269.3 6273.5 6279.0 6300.1 5438.2 6394.6 6400.9 6500.3 6534.6 4807.7 5670.5 6114.1 6220.7 6256.4 6223.1 6286.7 6295.0 6298.1 6300.8 4949.9 6214.0 6237.0 6243.1 6255.6 6001.0 6133.4 6144.9 6152.0 6170.7 5975.9 6082.2 6115.0 6119.8 6132.2 6166.4 6172.2 6189.3 6193.2 6210.9 5925.6 5954.6 6072.7 6072.8 6100.8 13:56:57 INFO - PROCESS | 1946 | 13:56:57 INFO - PROCESS | 1946 | [#1] ext.html Cycles:180 Average:69033.84 Median:34728.66 stddev:153980.59 (443.4%) stddev-sans-first:154326.47 13:56:57 INFO - PROCESS | 1946 | Values: 460.6 472.3 525.6 532.4 554.5 30137.9 38234.0 39219.4 39300.6 41256.2 41641.8 42110.8 42145.0 42187.6 42284.2 8807.0 9825.0 10008.2 10034.3 10040.5 8806.8 11998.9 12261.7 12293.6 12448.0 12160.3 12221.5 12227.4 12237.4 12256.4 12236.3 12297.5 12322.0 12327.3 12327.4 12155.7 12184.5 12193.2 12195.4 12226.6 39880.8 40098.0 40114.8 40225.6 40327.6 3270.4 3345.4 3357.6 3382.5 3740.4 30696.7 30823.0 30965.4 31043.7 31384.5 2719.7 3181.4 3249.4 3298.7 3308.2 530852.0 531309.0 531753.0 532108.0 532796.0 33648.5 57971.0 58549.4 58558.7 58616.4 34113.3 35344.0 35611.8 35748.8 35764.5 14888.0 15036.2 15056.0 15075.5 15085.1 11572.5 11786.3 12527.6 12721.9 12811.2 7666.7 7778.5 7844.6 7846.0 7859.0 3245.4 3281.9 3298.5 3300.8 3314.8 938.7 1005.8 1008.2 1011.9 1020.5 29516.7 29570.7 30106.7 30128.2 30170.4 899.2 986.2 1048.4 1078.6 1081.5 14574.3 14667.3 14928.3 15461.2 15848.4 664739.0 670972.0 671873.0 673604.0 673991.0 55372.4 55607.0 55875.7 55955.2 56005.9 1261.6 1286.6 1384.2 1407.9 1411.0 29840.0 30201.2 30627.5 30654.5 31287.0 47397.0 48056.5 48059.8 48075.5 48173.8 457871.0 458622.0 458911.0 458971.0 674313.0 39356.4 40424.8 41291.0 41296.0 41508.0 44764.3 44806.0 44928.1 45205.0 45338.8 36383.1 36655.4 37708.6 38732.8 38823.6 36742.4 36779.8 36974.6 37365.6 37638.0 36155.8 36234.5 36526.5 36853.5 37306.3 30908.5 33120.8 33350.0 33389.5 33393.0 24634.8 24761.5 24835.6 25360.7 25368.9 13:56:57 INFO - PROCESS | 1946 | 13:56:57 INFO - PROCESS | 1946 | [#2] jquery.html Cycles:180 Average:33100.29 Median:380.53 stddev:92894.26 (24411.6%) stddev-sans-first:93122.31 13:56:57 INFO - PROCESS | 1946 | Values: 354.1 372.9 377.3 383.7 402.9 15239.0 15563.9 17500.6 20678.5 20933.0 20575.6 21038.6 21219.8 21326.4 21496.9 4923.5 5810.5 5909.4 6121.4 6124.1 5884.8 6047.8 6050.2 6052.4 6064.2 4149.8 4397.4 6453.1 6730.4 6808.0 5849.8 6159.7 6831.4 6865.9 6877.2 6091.6 6096.3 6103.5 6120.3 6132.1 11460.6 11588.0 12591.1 12901.5 13408.7 2171.1 2275.0 2308.6 2562.7 2757.4 8153.9 9834.8 9886.2 10217.3 10221.2 1819.5 1864.6 1864.8 1878.6 1999.7 97058.0 117124.6 120553.0 127441.0 129417.4 11307.9 11493.7 11569.8 11587.3 11784.5 14675.9 14680.8 14682.1 14688.3 14711.3 8374.8 8593.4 8594.7 8752.0 8774.2 8490.8 8512.0 8521.8 8666.2 8741.6 4424.6 4526.4 4527.2 4581.2 4603.1 1842.5 1894.2 1894.6 1909.1 1909.2 694.9 697.5 769.7 842.8 872.8 18505.6 18610.3 20145.1 21558.8 21841.3 925.4 936.5 946.0 951.5 962.8 10856.6 11298.4 11503.5 11531.6 11549.4 512174.0 544072.4 561142.0 572333.0 577253.0 105722.4 123730.0 129058.0 130988.0 134212.0 947.7 977.9 988.8 989.2 990.2 18026.6 18768.5 19113.8 19140.0 19197.3 35199.6 49155.0 53080.9 53446.5 54179.7 73634.6 75707.2 78320.2 78425.2 80215.0 7780.7 7934.1 8081.4 8176.0 8245.2 7164.3 8735.9 10438.6 12741.7 12919.9 10645.9 10871.3 10940.6 11006.7 11056.7 10590.6 10813.9 10821.4 11044.8 11228.8 11062.7 11181.9 11307.1 11342.1 11630.3 7939.0 8014.6 8189.8 8220.4 8283.9 8559.5 9927.5 10898.2 10935.6 11339.8 13:56:57 INFO - PROCESS | 1946 | 13:56:57 INFO - PROCESS | 1946 | [#3] mootools.html Cycles:180 Average:5758.25 Median:2568.40 stddev:3268.54 (127.3%) stddev-sans-first:3262.07 13:56:57 INFO - PROCESS | 1946 | Values: 1503.1 1519.0 1730.4 1837.9 1912.1 8584.9 9116.1 9117.3 9132.2 9135.3 8072.8 8272.1 8290.1 8740.7 8966.2 2345.0 2402.8 2407.0 2408.1 2414.0 2367.9 2392.8 2400.5 2406.9 2409.8 2373.4 2375.6 2376.7 2391.5 2407.5 1939.2 2342.4 2348.2 2355.7 2357.0 2353.8 2359.4 2361.9 2364.2 2365.2 8995.6 8998.1 9121.8 9123.6 9133.3 5317.0 5487.4 5487.6 5489.6 5494.5 3136.6 3352.7 3543.3 3633.7 3646.8 1060.2 1063.8 1071.0 1088.3 1090.4 10588.0 11729.5 12177.0 12178.6 12185.6 4071.5 4639.3 4671.0 4858.7 4873.3 8528.4 10240.6 10244.3 10251.7 10292.3 5318.2 5328.1 5412.1 5425.2 5429.6 4463.2 4463.9 4950.3 4956.5 4967.6 3966.1 3988.0 4043.5 4062.0 4077.9 1285.1 1293.2 1294.7 1308.1 1312.5 829.5 836.0 926.7 928.5 929.0 4947.0 5835.2 5962.8 6109.9 6225.2 436.4 441.8 448.5 452.4 465.8 3981.3 4034.0 4104.6 4111.3 4149.7 10654.5 10928.3 11081.3 11085.3 11116.6 10565.9 10788.6 10956.8 10966.3 10986.7 8227.1 8320.6 8345.1 8408.3 8431.1 5872.1 6028.8 6031.1 6053.1 6147.6 9931.0 9993.4 10208.5 10274.3 10278.0 10098.2 10323.8 10452.9 10489.6 10576.6 6415.5 7046.0 7274.5 7282.8 7700.9 6906.4 8070.2 8134.4 8140.8 8230.0 7408.4 7688.5 7695.8 7738.2 7854.3 7365.6 7424.8 7455.3 7494.9 7555.1 7098.9 7122.1 7198.2 7205.0 7211.2 5045.7 5051.9 5067.9 5095.2 5206.1 4761.2 5026.8 5082.2 5227.3 5259.2 13:56:57 INFO - PROCESS | 1946 | 13:56:57 INFO - PROCESS | 1946 | [#4] prototype.html Cycles:180 Average:4474.53 Median:4806.14 stddev:1411.50 (29.4%) stddev-sans-first:1379.55 13:56:57 INFO - PROCESS | 1946 | Values: 259.2 300.9 305.3 313.2 315.1 4211.9 5246.9 5250.1 5333.8 5370.3 4219.3 4542.6 4793.7 5082.4 5231.6 3411.3 4062.6 4098.2 4101.5 4105.0 3811.5 4075.4 4118.4 4136.8 4157.4 3676.3 4044.7 4050.9 4062.4 4068.7 3982.7 3988.6 4005.8 4021.5 4066.9 3173.8 3296.4 3353.1 3453.3 3523.0 4449.9 5077.1 5184.8 5190.3 5226.5 4575.7 4649.8 4661.9 4672.6 4674.9 5399.2 5533.0 5584.2 5632.0 5682.0 3806.8 3812.7 3814.2 3824.3 3828.6 4661.2 5859.5 5903.3 5911.9 5972.7 3015.4 3707.6 3876.6 3881.5 3934.2 3602.4 3960.6 3979.8 3982.2 3984.1 4014.9 4589.4 4592.4 4598.5 4625.1 4670.8 5284.7 5649.8 5653.4 5716.3 1031.8 1313.9 1350.4 1355.2 1355.5 785.7 805.4 814.7 818.6 819.7 3775.7 4096.5 4345.9 4392.8 4402.4 4305.8 4803.6 4808.6 4878.3 4880.7 3632.4 3718.3 4197.8 4287.5 4401.4 2578.8 2725.7 3054.8 3070.0 3093.9 5557.4 5958.7 6100.0 6110.0 6115.7 4887.2 5353.5 5721.5 6022.3 6112.6 5300.5 6091.5 6106.5 6116.5 6190.4 5193.6 5413.0 5851.9 5902.7 5930.3 4596.0 5314.5 5692.4 5782.6 5789.3 5567.1 6126.8 6132.0 6151.6 6158.8 3500.4 3809.5 3824.5 3918.0 4024.3 5005.9 5705.0 5792.7 5793.9 5818.0 5162.5 5385.7 5628.3 5659.0 5722.3 4856.5 5617.9 5626.7 5629.9 5642.6 4785.7 5021.4 5524.7 5546.8 5618.2 5360.8 5594.9 5668.8 5669.3 5757.6 4991.1 5324.1 5517.1 5541.7 5589.3 13:56:57 INFO - PROCESS | 1946 | 13:56:57 INFO - PROCESS | 1946 | [#5] yui.html Cycles:180 Average:24632.59 Median:3834.11 stddev:39333.80 (1025.9%) stddev-sans-first:39402.76 13:56:57 INFO - PROCESS | 1946 | Values: 601.7 701.6 775.3 790.1 808.2 15247.0 16280.3 16550.0 16558.1 16579.8 15102.4 15222.5 15325.7 15326.6 15331.3 832.9 845.8 849.0 851.3 853.1 666.3 682.1 684.3 826.8 838.5 894.7 898.3 900.4 900.9 901.0 888.8 889.1 891.1 891.1 893.5 518.1 529.6 534.3 534.6 660.7 12711.4 14915.8 15521.2 15575.1 15711.7 14744.3 14985.3 15094.6 15139.3 15354.3 11444.8 11678.6 11717.4 12105.1 12229.9 3781.2 3840.6 3988.4 4015.8 4018.0 121137.4 124760.0 124887.4 125041.0 125047.4 10068.7 10978.8 10990.5 11370.4 11651.3 23954.6 24391.9 24420.0 24428.9 24437.4 8121.3 8153.3 8161.7 8184.6 8186.5 4361.8 4492.2 4493.2 4518.4 4621.5 3688.7 3812.5 3813.5 3815.6 3827.7 599.0 610.2 616.8 651.2 665.3 653.8 660.6 669.8 678.8 706.4 8899.3 9379.8 9596.0 9686.4 9749.1 656.9 670.4 675.2 679.2 681.3 4638.7 4644.7 4676.2 4699.7 4763.5 84968.0 128425.4 130938.7 150310.0 167116.2 117858.0 118044.0 119263.4 124083.4 124465.4 101770.5 115621.4 116955.0 118311.8 118421.4 6405.9 8049.9 8175.1 8683.3 8688.7 50955.5 62230.7 63798.7 64951.7 66004.7 82075.0 92385.5 97235.0 99755.0 101244.5 11593.3 11785.4 12118.8 12148.5 12177.4 12216.4 12705.2 13101.3 13197.5 13323.7 11751.8 11753.0 11794.8 12378.6 12400.1 12184.2 12464.6 12596.1 12742.4 12745.4 10560.9 11994.4 11997.0 12080.5 12685.3 9244.9 9683.7 9795.5 9844.1 10425.2 9723.5 10382.6 10382.9 10414.4 10425.1 13:56:57 INFO - PROCESS | 1946 | -------- Summary: end -------- 13:56:57 INFO - PROCESS | 1946 | 13:56:58 INFO - TEST-INFO | 1946: exit 0 13:56:58 INFO - TEST-OK | dromaeo_css | took 1116788ms 13:56:58 INFO - TEST-START | kraken 13:56:58 INFO - operating with platform_type : mac_ 13:56:58 INFO - Initialising browser for kraken test... 13:56:58 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpTEQILE/profile http://localhost:52881/getInfo.html) 13:57:00 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 13:57:00 INFO - PROCESS | 1949 | colorDepth:24 13:57:00 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 13:57:00 INFO - PROCESS | 1949 | __metrics 13:57:00 INFO - PROCESS | 1949 | 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" 13:57:00 INFO - PROCESS | 1949 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:57:01 INFO - TEST-INFO | 1949: exit 0 13:57:01 INFO - Browser initialized. 13:57:01 INFO - Running cycle 1/1 for kraken test... 13:57:01 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpTEQILE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:57:13 INFO - PROCESS | 1950 | RSS: Main: 218918912 13:57:13 INFO - PROCESS | 1950 | 13:57:16 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52881/tests/kraken/driver.html?testName=audio-beat-detection) 13:57:17 INFO - PROCESS | 1950 | RSS: Main: 269258752 13:57:17 INFO - PROCESS | 1950 | 13:57:19 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52881/tests/kraken/driver.html?testName=audio-dft) 13:57:20 INFO - PROCESS | 1950 | RSS: Main: 279674880 13:57:20 INFO - PROCESS | 1950 | 13:57:23 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52881/tests/kraken/driver.html?testName=audio-fft) 13:57:24 INFO - PROCESS | 1950 | RSS: Main: 378535936 13:57:24 INFO - PROCESS | 1950 | 13:57:26 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52881/tests/kraken/driver.html?testName=audio-oscillator) 13:57:26 INFO - PROCESS | 1950 | RSS: Main: 279756800 13:57:26 INFO - PROCESS | 1950 | 13:57:28 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52881/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:57:29 INFO - PROCESS | 1950 | RSS: Main: 281190400 13:57:29 INFO - PROCESS | 1950 | 13:57:32 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52881/tests/kraken/driver.html?testName=imaging-darkroom) 13:57:32 INFO - PROCESS | 1950 | RSS: Main: 319016960 13:57:32 INFO - PROCESS | 1950 | 13:57:35 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52881/tests/kraken/driver.html?testName=imaging-desaturate) 13:57:36 INFO - PROCESS | 1950 | RSS: Main: 319574016 13:57:36 INFO - PROCESS | 1950 | 13:57:38 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52881/tests/kraken/driver.html?testName=json-parse-financial) 13:57:39 INFO - PROCESS | 1950 | RSS: Main: 317050880 13:57:39 INFO - PROCESS | 1950 | 13:57:41 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52881/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:57:41 INFO - PROCESS | 1950 | RSS: Main: 289509376 13:57:41 INFO - PROCESS | 1950 | 13:57:43 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52881/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:57:44 INFO - PROCESS | 1950 | RSS: Main: 296497152 13:57:44 INFO - PROCESS | 1950 | 13:57:46 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52881/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:57:46 INFO - PROCESS | 1950 | RSS: Main: 299470848 13:57:46 INFO - PROCESS | 1950 | 13:57:50 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:57:50 INFO - PROCESS | 1950 | RSS: Main: 310272000 13:57:50 INFO - PROCESS | 1950 | 13:57:53 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:57:54 INFO - PROCESS | 1950 | RSS: Main: 308879360 13:57:54 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52881/tests/kraken/driver.html?testName=ai-astar) 13:57:56 INFO - PROCESS | 1950 | RSS: Main: 353128448 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | __start_tp_report 13:57:56 INFO - PROCESS | 1950 | _x_x_mozilla_page_load 13:57:56 INFO - PROCESS | 1950 | _x_x_mozilla_page_load_details 13:57:56 INFO - PROCESS | 1950 | |i|pagename|runs| 13:57:56 INFO - PROCESS | 1950 | |0;ai-astar;114;115;114;116;115;114;114;113;115;114 13:57:56 INFO - PROCESS | 1950 | |1;audio-beat-detection;143;110;108;143;111;111;110;108;137;111 13:57:56 INFO - PROCESS | 1950 | |2;audio-dft;182;185;185;183;186;186;183;197;262;201 13:57:56 INFO - PROCESS | 1950 | |3;audio-fft;82;60;59;88;61;60;60;58;82;58 13:57:56 INFO - PROCESS | 1950 | |4;audio-oscillator;86;71;96;70;68;68;93;68;70;91 13:57:56 INFO - PROCESS | 1950 | |5;imaging-gaussian-blur;87;85;88;86;87;84;87;85;88;85 13:57:56 INFO - PROCESS | 1950 | |6;imaging-darkroom;93;93;93;92;93;93;94;93;92;91 13:57:56 INFO - PROCESS | 1950 | |7;imaging-desaturate;84;83;84;85;87;84;86;83;86;81 13:57:56 INFO - PROCESS | 1950 | |8;json-parse-financial;57;53;53;53;54;56;57;55;57;58 13:57:56 INFO - PROCESS | 1950 | |9;json-stringify-tinderbox;68;74;75;72;73;69;69;70;70;70 13:57:56 INFO - PROCESS | 1950 | |10;stanford-crypto-aes;98;84;82;85;82;83;80;82;82;84 13:57:56 INFO - PROCESS | 1950 | |11;stanford-crypto-ccm;139;141;156;150;150;141;142;151;162;153 13:57:56 INFO - PROCESS | 1950 | |12;stanford-crypto-pbkdf2;168;173;168;172;166;173;171;169;168;169 13:57:56 INFO - PROCESS | 1950 | |13;stanford-crypto-sha256-iterative;68;67;67;68;67;68;68;67;67;66 13:57:56 INFO - PROCESS | 1950 | __end_tp_report 13:57:56 INFO - PROCESS | 1950 | __start_cc_report 13:57:56 INFO - PROCESS | 1950 | _x_x_mozilla_cycle_collect,2066 13:57:56 INFO - PROCESS | 1950 | __end_cc_report 13:57:56 INFO - PROCESS | 1950 | __startTimestamp1477601876281__endTimestamp 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | ------- Summary: start ------- 13:57:56 INFO - PROCESS | 1950 | Number of tests: 14 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 13:57:56 INFO - PROCESS | 1950 | Values: 114.0 115.0 114.0 116.0 115.0 114.0 114.0 113.0 115.0 114.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#1] audio-beat-detection Cycles:10 Average:119.20 Median:111.00 stddev:15.17 (13.7%) stddev-sans-first:13.43 13:57:56 INFO - PROCESS | 1950 | Values: 143.0 110.0 108.0 143.0 111.0 111.0 110.0 108.0 137.0 111.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#2] audio-dft Cycles:10 Average:195.00 Median:186.00 stddev:24.38 (13.1%) stddev-sans-first:25.40 13:57:56 INFO - PROCESS | 1950 | Values: 182.0 185.0 185.0 183.0 186.0 186.0 183.0 197.0 262.0 201.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#3] audio-fft Cycles:10 Average:66.80 Median:60.50 stddev:12.02 (19.9%) stddev-sans-first:11.42 13:57:56 INFO - PROCESS | 1950 | Values: 82.0 60.0 59.0 88.0 61.0 60.0 60.0 58.0 82.0 58.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.50 stddev:11.83 (15.1%) stddev-sans-first:12.19 13:57:56 INFO - PROCESS | 1950 | Values: 86.0 71.0 96.0 70.0 68.0 68.0 93.0 68.0 70.0 91.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.00 stddev:1.40 (1.6%) stddev-sans-first:1.45 13:57:56 INFO - PROCESS | 1950 | Values: 87.0 85.0 88.0 86.0 87.0 84.0 87.0 85.0 88.0 85.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 13:57:56 INFO - PROCESS | 1950 | Values: 93.0 93.0 93.0 92.0 93.0 93.0 94.0 93.0 92.0 91.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.50 stddev:1.77 (2.1%) stddev-sans-first:1.87 13:57:56 INFO - PROCESS | 1950 | Values: 84.0 83.0 84.0 85.0 87.0 84.0 86.0 83.0 86.0 81.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.50 stddev:1.95 (3.4%) stddev-sans-first:1.96 13:57:56 INFO - PROCESS | 1950 | Values: 57.0 53.0 53.0 53.0 54.0 56.0 57.0 55.0 57.0 58.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.00 stddev:2.36 (3.3%) stddev-sans-first:2.24 13:57:56 INFO - PROCESS | 1950 | Values: 68.0 74.0 75.0 72.0 73.0 69.0 69.0 70.0 70.0 70.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.50 stddev:5.05 (6.0%) stddev-sans-first:1.50 13:57:56 INFO - PROCESS | 1950 | Values: 98.0 84.0 82.0 85.0 82.0 83.0 80.0 82.0 82.0 84.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:150.50 stddev:7.56 (5.0%) stddev-sans-first:7.20 13:57:56 INFO - PROCESS | 1950 | Values: 139.0 141.0 156.0 150.0 150.0 141.0 142.0 151.0 162.0 153.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:170.00 stddev:2.41 (1.4%) stddev-sans-first:2.47 13:57:56 INFO - PROCESS | 1950 | Values: 168.0 173.0 168.0 172.0 166.0 173.0 171.0 169.0 168.0 169.0 13:57:56 INFO - PROCESS | 1950 | 13:57:56 INFO - PROCESS | 1950 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 13:57:56 INFO - PROCESS | 1950 | Values: 68.0 67.0 67.0 68.0 67.0 68.0 68.0 67.0 67.0 66.0 13:57:56 INFO - PROCESS | 1950 | -------- Summary: end -------- 13:57:56 INFO - PROCESS | 1950 | 13:57:57 INFO - TEST-INFO | 1950: exit 0 13:57:57 INFO - TEST-OK | kraken | took 58924ms 13:57:57 INFO - SUITE-END | took 1175s 13:57:57 INFO - Completed test suite (00:19:36) 13:57:57 INFO - javascript benchmark 13:57:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3019.894303699371, 3171.3974344874478, 3314.0, 3356.630770615232, 3364.798112113275, 5777.133429985504, 5814.302283725959, 5820.417958204188, 5821.621594596349, 5865.853353666155, 5771.942280577193, 5772.5670574706855, 5831.2419385479825, 5884.852878678035, 5904.291485021803, 5280.287161233232, 5321.255024296602, 5344.599155063366, 5347.358317001946, 5372.274742909696, 5229.8954020919555, 5241.187615919539, 5250.422453530108, 5410.756515956791, 5416.83749487516, 5341.412444631087, 5346.224797404374, 5348.732563371836, 5352.464753524655, 5359.035373632744, 5283.762230699647, 5327.041132596131, 5361.169018802092, 5380.24676545284, 5394.083005889008, 5159.845204643867, 5266.4470230626, 5274.841754747364, 5347.786088556453, 5392.91910621341, 5954.851128721773, 5999.730012149464, 6004.759809607611, 6005.519558435315, 6011.909821352683, 6097.664628445434, 6145.139680444741, 6147.8155655329965, 6174.9073763893575, 6204.13142160098, 5192.662476939025, 6130.092410195535, 6172.166757487771, 6301.8109456716375, 6318.115463835067, 4817.373741413594, 5873.970630146822, 5877.471027607493, 5884.176215329857, 5946.197263369476, 6125.572745538934, 6322.462590679844, 6331.651759153291, 6334.968325158345, 6352.36476352361, 6126.029144987373, 6209.565330426917, 6214.8135555933395, 6243.063540468966, 6257.812265632038, 6291.905621415683, 6304.65324407162, 6306.49548036156, 6306.49548036156, 6324.209473815773, 5941.960156972599, 6098.1157732128595, 6143.96928015357, 6321.652309123042, 6327.557071004985, 6023.789167379121, 6139.84650383744, 6153.938460615426, 6216.937830621727, 6242.28213755424, 4950.6782059166035, 4951.70289782607, 4952.653314267966, 4957.380327459067, 4969.155243608595, 4314.525402205755, 4423.093265880551, 4425.645948324191, 4443.688941774045, 4457.175422546839, 5715.599908006399, 5721.771129154788, 5749.626274292157, 5802.564807639444, 5870.471657550841, 5506.697131657717, 6229.3770622937345, 6275.121482992385, 6313.652749098752, 6323.399277068671, 5871.060630299132, 5885.793997210077, 5888.823335299948, 5899.941000590025, 5901.144334071536, 5304.283921670525, 5344.652597581145, 5418.701971391612, 5428.995635807389, 5492.725363731797, 5775.162601422854, 6257.249130104235, 6274.686265686697, 6351.17434733491, 6360.745570177326, 6241.981202446774, 6269.3417191196095, 6273.52948528853, 6278.968605157128, 6300.117983482408, 5438.2386465894015, 6394.616323020634, 6400.871982560416, 6500.349965003462, 6534.640594767334, 4807.735574543294, 5670.518005969374, 6114.054067497291, 6220.72006759706, 6256.374362563707, 6223.066540018853, 6286.717097730521, 6295.024271237966, 6298.149749783904, 6300.779472718433, 4949.901001980013, 6214.0, 6237.033259844731, 6243.063540468966, 6255.593386429868, 6000.969995149996, 6133.3866613338305, 6144.938550614615, 6152.046432802923, 6170.660613666291, 5975.940240597713, 6082.239720034996, 6115.0, 6119.816405507842, 6132.17215675878, 6166.392018440415, 6172.166757487861, 6189.288231853395, 6193.163922870535, 6210.937890621217, 5925.614835035709, 5954.642721436728, 6072.696365181811, 6072.817815465543, 6100.816975490742], "value": 5724.413768639775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.5739690786023, 472.2774155542022, 525.6320575597083, 532.3691425660592, 554.5203399059812, 30137.945171918986, 38234.0, 39219.41170882432, 39300.624478143305, 41256.17487650245, 41641.791791041, 42110.789446052724, 42145.0, 42187.57812421875, 42284.15431691364, 8806.955965220164, 9824.950875245631, 10008.199344052495, 10034.347767395133, 10040.548175332127, 8806.823863522726, 11998.940005300004, 12261.693457663585, 12293.569725059624, 12448.0, 12160.331181785043, 12221.511139554406, 12227.449764760608, 12237.449314780812, 12256.44845981933, 12236.327002014885, 12297.508099676003, 12322.0, 12327.321997290146, 12327.445264963098, 12155.696107597292, 12184.451699673536, 12193.207441516273, 12195.39023048844, 12226.572069977508, 39880.80059599713, 40098.0, 40114.79942600268, 40225.597744022474, 40327.59672403268, 3270.444024515838, 3345.43127668297, 3357.5635167428077, 3382.4588065909584, 3740.3641380965028, 30696.69303306983, 30823.0, 30965.380692386025, 31043.689563104304, 31384.529232061537, 2719.6736391632935, 3181.427343078245, 3249.3501299740146, 3298.736101111929, 3308.17295676081, 530852.0, 531309.0, 531752.9999999962, 532108.0, 532796.0, 33648.49527257093, 57971.0, 58549.414505854395, 58558.70720646455, 58616.413835861946, 34113.31773364569, 35344.0, 35611.82194089013, 35748.821255893556, 35764.46353304703, 14888.0, 15036.17301048431, 15056.0, 15075.472358467401, 15085.094894306376, 11572.47923843429, 11786.292822430682, 12527.624171274876, 12721.872781272068, 12811.231326120462, 7666.655000524878, 7778.455508114378, 7844.646990885424, 7846.0, 7859.0, 3245.3671534051105, 3281.868725251011, 3298.538204651351, 3300.8184549849507, 3314.834258287124, 938.6573900526396, 1005.7988402319565, 1008.1833714691123, 1011.9494025298706, 1020.5356562763925, 29516.704832951826, 29570.704292957227, 30106.698933010826, 30128.24679382989, 30170.396592068035, 899.2491269789799, 986.1765425869336, 1048.4233671480656, 1078.5739632845139, 1081.4808891732014, 14574.271286435636, 14667.339969701388, 14928.25358732059, 15461.226938653022, 15848.44530441429, 664739.0, 670972.0, 671873.0, 673604.0, 673991.0, 55372.446275537535, 55607.0, 55875.720621396635, 55955.16067258995, 56005.879882402936, 1261.6152073617634, 1286.6075846866795, 1384.2179168769612, 1407.9366428510946, 1410.9788353174506, 29840.0, 30201.244968875955, 30627.54058689077, 30654.540181896842, 31287.0, 47397.0, 48056.5194348052, 48059.75970120127, 48075.5192448085, 48173.75913120412, 457871.0, 458622.0, 458911.0, 458971.0, 674313.0, 39356.409653854644, 40424.79787601043, 41291.0, 41296.0, 41508.0, 44764.32853507135, 44806.0, 44928.10143797041, 45205.0, 45338.773306133255, 36383.090422739646, 36655.35050922661, 37708.62291377051, 38732.80633596814, 38823.611763882, 36742.44886326654, 36779.81610091932, 36974.63025369712, 37365.626343736214, 37638.0, 36155.81922090373, 36234.4564831533, 36526.45210321794, 36853.49202184358, 37306.25387492289, 30908.53637195399, 33120.834395827864, 33350.0, 33389.49915751217, 33393.0, 24634.75365246396, 24761.504769904142, 24835.62746558767, 25360.74639253584, 25368.873155634104], "value": 19133.768140317407, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.09881850689993, 372.8713593810135, 377.32467842778044, 383.7428922621844, 402.8972611983946, 15239.0, 15563.922180389096, 17500.562485937873, 20678.48303792406, 20932.9533523324, 20575.588488230227, 21038.579228415423, 21219.787802121973, 21326.36020919371, 21496.92515374233, 4923.458419573853, 5810.506106980912, 5909.438603332676, 6121.357257487966, 6124.081387791823, 5884.76460941564, 6047.818565443044, 6050.2134722486235, 6052.425019623129, 6064.241969753781, 4149.792510374485, 4397.38436618872, 6453.096566480696, 6730.394264516192, 6808.0, 5849.7660093596205, 6159.722812473449, 6831.385175334219, 6865.931340686604, 6877.2091209511045, 6091.573589848713, 6096.329403765582, 6103.511719062464, 6120.326764055951, 6132.080187971796, 11460.598879039277, 11588.0, 12591.118621696485, 12901.548445804352, 13408.664783380396, 2171.1206961180746, 2274.9658755118685, 2308.5844547981355, 2562.7309132541186, 2757.352022274764, 8153.918460815435, 9834.754131146707, 9886.159676427513, 10217.2847900647, 10221.233407494468, 1819.5087326421924, 1864.5525073982283, 1864.7855496617792, 1878.5961018380976, 1999.6700544410155, 97058.0, 117124.63002959742, 120553.0, 127441.0, 129417.35291323483, 11307.886921130848, 11493.655190344303, 11569.826452603218, 11587.304761714155, 11784.469698863571, 14675.926620367043, 14680.779788303184, 14682.119072855663, 14688.339024743913, 14711.264436778332, 8374.832503349899, 8593.398462107592, 8594.742157735278, 8752.0, 8774.210321071134, 8490.787730306793, 8512.02111757156, 8521.786955326043, 8666.220040196287, 8741.606627701769, 4424.557544245614, 4526.411566496335, 4527.230370836965, 4581.221192397234, 4603.148417542765, 1842.5117343903876, 1894.1665667106429, 1894.640018396528, 1909.1313452379134, 1909.1695112626053, 694.9166100068024, 697.5396238482679, 769.6651956398985, 842.7808769719794, 872.7905302727427, 18505.61207909412, 18610.34863779761, 20145.05720812364, 21558.78441215599, 21841.319309180843, 925.3615005646083, 936.5317341329335, 945.952702364879, 951.4909523404945, 962.8122516109291, 10856.565737370416, 11298.37858917751, 11503.482343294572, 11531.596394126165, 11549.36478493674, 512174.0, 544072.3981900484, 561142.0, 572333.0, 577253.0, 105722.4141637876, 123730.0, 129058.0, 130988.0, 134212.0, 947.668316089377, 977.9413235205768, 988.8417853143462, 989.1690979577046, 990.153418826907, 18026.639467210844, 18768.53078673044, 19113.808861911202, 19140.0, 19197.32809351666, 35199.64800351964, 49155.03379864765, 53080.93838123139, 53446.46553534415, 54179.72910135424, 73634.63182684267, 75707.24292757001, 78320.2167978313, 78425.2157478418, 80215.0, 7780.688772449265, 7934.087579928382, 8081.393895457747, 8175.959120204361, 8245.175482451707, 7164.319389657974, 8735.868961965449, 10438.63464778729, 12741.681457963625, 12919.935400322938, 10645.89354106449, 10871.34771913656, 10940.617078402218, 11006.724831879266, 11056.668299951014, 10590.629327973484, 10813.945930270298, 10821.404822734825, 11044.834327484934, 11228.831567526331, 11062.668119956414, 11181.869076658548, 11307.095432365555, 11342.149338799458, 11630.302181869114, 7939.047314322318, 8014.599270036359, 8189.836203275782, 8220.3834712398, 8283.917160828314, 8559.529225892637, 9927.453990030617, 10898.182636302468, 10935.617253396093, 11339.773204535699], "value": 9249.891519622359, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1503.098141115331, 1518.962025949351, 1730.3857130718595, 1837.8713490055702, 1912.1013123831804, 8584.871226931593, 9116.1339672731, 9117.316201284897, 9132.178103970642, 9135.269178465724, 8072.757817265477, 8272.131426200252, 8290.088090310077, 8740.694075707352, 8966.193042626162, 2344.9648255276143, 2402.8438151520095, 2407.0131246189067, 2408.084927727461, 2414.0, 2367.8579285242854, 2392.820538459614, 2400.4718961828457, 2406.915757948472, 2409.77107174819, 2373.359193017884, 2375.596148654733, 2376.6910301660846, 2391.5097405032016, 2407.4823912858733, 1939.224310275901, 2342.3792694935855, 2348.189874493297, 2355.6702061711376, 2356.976430235693, 2353.7763912428463, 2359.3865594945264, 2361.8700971446565, 2364.1725396111397, 2365.2431222008963, 8995.55022248885, 8998.05520420353, 9121.771955701095, 9123.589438475285, 9133.315001374924, 5316.9734151329385, 5487.42382049883, 5487.5884308677005, 5489.615726899118, 5494.450554944514, 3136.5765621641012, 3352.6982571568433, 3543.344481270973, 3633.654802793757, 3646.781193128421, 1060.1836585828946, 1063.8138325792954, 1070.9678709638724, 1088.2871719024051, 1090.3566895531674, 10588.0, 11729.533808273965, 12177.0, 12178.573749918798, 12185.634430967086, 4071.5114186297833, 4639.257718764981, 4670.9766451167525, 4858.708477491362, 4873.31773551703, 8528.445651032664, 10240.590376384862, 10244.334118282288, 10251.7437064074, 10292.279540432099, 5318.175682769177, 5328.120860058125, 5412.134058550613, 5425.159100339453, 5429.619926605179, 4463.24124898768, 4463.910721785546, 4950.282209079735, 4956.504349565087, 4967.552920237196, 3966.1076257842333, 3987.980060099681, 4043.5147782265726, 4062.0, 4077.89805254871, 1285.1453783234044, 1293.2046791223518, 1294.7216348485122, 1308.1431662261234, 1312.4553310376277, 829.5064436660177, 835.9623816928253, 926.7034548944273, 928.4614923344444, 928.9628414863465, 4947.0, 5835.241418615553, 5962.761489540457, 6109.938900610937, 6225.159603453566, 436.38033991731817, 441.8232706917259, 448.5021625995143, 452.4344569288389, 465.8136745301906, 3981.283368993551, 4033.9798301008896, 4104.610062044101, 4111.259973204852, 4149.7095203335475, 10654.467276636136, 10928.289661172157, 11081.27971681838, 11085.27945683528, 11116.55533778656, 10565.9471702641, 10788.56845726178, 10956.780864382827, 10966.287191332538, 10986.725331866768, 8227.13615070421, 8320.583970801557, 8345.123762005023, 8408.285295749807, 8431.072582015973, 5872.148538461814, 6028.75884964614, 6031.09533569968, 6053.102078618004, 6147.631142131487, 9931.0, 9993.350432221881, 10208.54061567246, 10274.332168409328, 10278.0, 10098.19214462856, 10323.793524129325, 10452.94773526158, 10489.580416783243, 10576.576936922746, 6415.518836087219, 7045.964770176116, 7274.454415918933, 7282.781516554512, 7700.922990770021, 6906.412954898688, 8070.152633973583, 8134.389920755849, 8140.83718325642, 8230.0, 7408.444366672629, 7688.538687678757, 7695.769126926201, 7738.2261773822165, 7854.253845884632, 7365.558066516026, 7424.777256682308, 7455.329020388191, 7494.887576686463, 7555.09338879338, 7098.858022839618, 7122.074130363019, 7198.244184360567, 7205.027321311556, 7211.242819504087, 5045.722485263345, 5051.898962020812, 5067.87330316745, 5095.235714642833, 5206.140986737298, 4761.2382018876815, 5026.84919452417, 5082.2122571001555, 5227.268182454535, 5259.15853463444], "value": 4541.058583998658, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.2287943368479, 300.8841595985545, 305.30086102824527, 313.1513598149016, 315.0516943998564, 4211.915761684764, 5246.947530524693, 5250.107481728101, 5333.759980800864, 5370.3287089113865, 4219.346001369792, 4542.6138778203895, 4793.688410253331, 5082.442290396719, 5231.607629427789, 3411.3347897160124, 4062.6140516651017, 4098.233692257729, 4101.528324242706, 4104.958950410502, 3811.455346527728, 4075.368317910714, 4118.361653943629, 4136.779650003241, 4157.438745769313, 3676.3382591133586, 4044.6562042226446, 4050.8987275318204, 4062.370332598452, 4068.7151899367054, 3982.7298439889273, 3988.561258261589, 4005.8397664093254, 4021.537523184842, 4066.861278841914, 3173.7778355515125, 3296.3736889991064, 3353.094664440587, 3453.2748122894222, 3522.9959461553335, 4449.888752781174, 5077.086124497589, 5184.818531351385, 5190.273361729361, 5226.451222621608, 4575.679702420832, 4649.7907594158005, 4661.930071048937, 4672.6261899047995, 4674.883127921795, 5399.163129714901, 5533.043873630333, 5584.246126772874, 5632.0, 5682.045336425077, 3806.7525610835205, 3812.656860882506, 3814.2180852925085, 3824.292505886392, 3828.617138286177, 4661.160991021648, 5859.472647461706, 5903.291605007426, 5911.852203694899, 5972.6715030673295, 3015.3516993845988, 3707.570497289996, 3876.573576906538, 3881.4565960765517, 3934.1738234970976, 3602.4056030755155, 3960.6435420812263, 3979.8259513443604, 3982.163745613396, 3984.1234928315725, 4014.9397759033636, 4589.403377560896, 4592.3720260994105, 4598.494165641777, 4625.121226966866, 4670.789814458358, 5284.701154997589, 5649.802256920988, 5653.4170432279025, 5716.342620598602, 1031.8452232165234, 1313.9422764674339, 1350.3923234544495, 1355.2478374502048, 1355.491690616019, 785.6616744414397, 805.4361946637378, 814.7270664327517, 818.5988865455884, 819.6557645461448, 3775.716821238418, 4096.508418989681, 4345.914400775485, 4392.780360981938, 4402.434028436976, 4305.763183024964, 4803.639727020418, 4808.63935204861, 4878.292647566083, 4880.731559764176, 3632.383589302735, 3718.322807578539, 4197.761660310216, 4287.528371879091, 4401.40581021558, 2578.755018273261, 2725.6592925884265, 3054.7556195504308, 3070.0022492689964, 3093.8607762650736, 5557.360903496069, 5958.702064896825, 6099.969500152471, 6109.969450152721, 6115.694215289218, 4887.242477416006, 5353.491418315254, 5721.5136713379825, 6022.307434644984, 6112.572119951649, 5300.549453296436, 6091.51267898567, 6106.542009349317, 6116.510679145657, 6190.380961903774, 5193.610479213999, 5413.022837439471, 5851.92256748848, 5902.704864756659, 5930.318013428511, 4595.954040459553, 5314.468553144655, 5692.373838877803, 5782.5663075268685, 5789.33422656383, 5567.053600887778, 6126.763731237977, 6131.96934015327, 6151.569390142647, 6158.753649853956, 3500.43992961125, 3809.4666746654934, 3824.5028146340796, 3918.0, 4024.295748243987, 5005.924911126263, 5704.971475142598, 5792.739326730223, 5793.8551536211935, 5818.0, 5162.527720616159, 5385.676859388449, 5628.268325117709, 5659.0, 5722.313322401338, 4856.514348565115, 5617.915731264116, 5626.662400255997, 5629.915551266652, 5642.630095359877, 4785.736784476887, 5021.372328458942, 5524.696141712245, 5546.839870097427, 5618.185363122243, 5360.758765855468, 5594.936961977374, 5668.801591944262, 5669.34802497718, 5757.625754325955, 4991.053489139311, 5324.068288049499, 5517.062099443024, 5541.667499950016, 5589.329280486205], "value": 4021.179980127362, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.6600620649333, 701.5510073552924, 775.3177204060426, 790.0756115345046, 808.2402541610884, 15247.0, 16280.26738796754, 16550.006999580033, 16558.08930508823, 16579.83420165798, 15102.39590416382, 15222.467213647524, 15325.69348613027, 15326.616834579141, 15331.310091045902, 832.9416940814145, 845.8350621628784, 849.0193826130828, 851.2806678356809, 853.1255463150259, 666.2904007232282, 682.0757873081977, 684.2780866186172, 826.7809030606894, 838.5429940682343, 894.7181637784078, 898.2544488074882, 900.4327273817486, 900.9009009009004, 900.9909900901006, 888.7822483491586, 889.0886840987974, 891.1355984694868, 891.148952750122, 893.5264309915755, 518.1321286844558, 529.6266132376666, 534.2680527677069, 534.5563182558467, 660.7423104989058, 12711.364431778375, 14915.776263356058, 15521.223938803014, 15575.143367114804, 15711.68576628461, 14744.336504857307, 14985.325660345201, 15094.622634434118, 15139.318730657036, 15354.309056092503, 11444.828327575093, 11678.591249306319, 11717.355545444998, 12105.09211809118, 12229.93885030569, 3781.2248489059675, 3840.558335791392, 3988.3818008208773, 4015.819288132041, 4017.97991010046, 121137.39431302875, 124760.0, 124887.3755631225, 125041.0, 125047.37476312651, 10068.748281293027, 10978.835317470244, 10990.505427255792, 11370.374629395463, 11651.30092194471, 23954.64068038981, 24391.878040610038, 24420.0, 24428.877855610608, 24437.389065273153, 8121.31996441173, 8153.347732181412, 8161.67353305873, 8184.6316915738935, 8186.467879587808, 4361.825526978949, 4492.236319825637, 4493.191225579427, 4518.4126063612175, 4621.514740952219, 3688.6864616507896, 3812.4662547243406, 3813.4661147438824, 3815.6184381562175, 3827.655511004023, 598.9550783691241, 610.2372034956304, 616.7687117331001, 651.1600035953661, 665.3280187011056, 653.8002764926414, 660.6168422315046, 669.7722774256777, 678.8404724889647, 706.4136766483806, 8899.288056955427, 9379.765505862271, 9596.0, 9686.418814871131, 9749.073837985521, 656.9047488114293, 670.3798985937988, 675.166169780321, 679.1578442730978, 681.3050688297908, 4638.652101092432, 4644.698094623838, 4676.158291507493, 4699.718016918928, 4763.54746299101, 84968.0, 128425.3578732119, 130938.69061309456, 150310.0, 167116.16441917713, 117858.0, 118044.0, 119263.40368298104, 124083.3795831033, 124465.37767311286, 101770.49114754378, 115621.42189289, 116955.0, 118311.81688183008, 118421.40789295998, 6405.903911441239, 8049.87925181111, 8175.059868115243, 8683.348748843988, 8688.739337819876, 50955.471335859984, 62230.68884655729, 63798.68100659467, 64951.67524162349, 66004.6699766498, 82075.0, 92385.5380723119, 97235.0, 99755.00244997747, 101244.49377753065, 11593.304401735923, 11785.351805650771, 12118.818217726917, 12148.453319600816, 12177.391130443266, 12216.389180541115, 12705.157752125706, 13101.279429631462, 13197.472101115847, 13323.733525329246, 11751.76496470083, 11753.0, 11794.764104717686, 12378.566750163702, 12400.069994750249, 12184.237866719157, 12464.626061218178, 12596.118271720892, 12742.362881856056, 12745.362731863184, 10560.894391055992, 11994.400279986141, 11997.0, 12080.523492683802, 12685.302308372758, 9244.907550924405, 9683.66107186245, 9795.461249631338, 9844.064813842673, 10425.218108642033, 9723.46520941355, 10382.584696612354, 10382.948085259526, 10414.375137491472, 10425.061744442733], "value": 7677.727436576695, "unit": "score"}], "name": "dromaeo_css", "value": 7223.417883750538, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 116.0, 115.0, 114.0, 114.0, 113.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 108.0, 143.0, 111.0, 111.0, 110.0, 108.0, 137.0, 111.0], "value": 119.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 185.0, 183.0, 186.0, 186.0, 183.0, 197.0, 262.0, 201.0], "value": 195.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 59.0, 88.0, 61.0, 60.0, 60.0, 58.0, 82.0, 58.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 96.0, 70.0, 68.0, 68.0, 93.0, 68.0, 70.0, 91.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 86.0, 87.0, 84.0, 87.0, 85.0, 88.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 92.0, 93.0, 93.0, 94.0, 93.0, 92.0, 91.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 85.0, 87.0, 84.0, 86.0, 83.0, 86.0, 81.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 53.0, 54.0, 56.0, 57.0, 55.0, 57.0, 58.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 75.0, 72.0, 73.0, 69.0, 69.0, 70.0, 70.0, 70.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 84.0, 82.0, 85.0, 82.0, 83.0, 80.0, 82.0, 82.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 156.0, 150.0, 150.0, 141.0, 142.0, 151.0, 162.0, 153.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 173.0, 168.0, 172.0, 166.0, 173.0, 171.0, 169.0, 168.0, 169.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1432.7, "alertThreshold": 2.0}]} 13:57:57 INFO - Return code: 0 13:57:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:57:57 INFO - # TBPL SUCCESS # 13:57:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:57:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:57:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:57:57 INFO - 2016-10-27 13:57:57.611 screenresolution[1954:19135] starting screenresolution argv=screenresolution get 13:57:57 INFO - 2016-10-27 13:57:57.614 screenresolution[1954:19135] Display 0: 1600x1200x32@60 13:57:57 INFO - 2016-10-27 13:57:57.620 screenresolution[1955:19138] starting screenresolution argv=screenresolution list 13:57:57 INFO - Available Modes on Display 0 13:57:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:57:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:57:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:57:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:57:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:57:57 INFO - Intel Iris: 13:57:57 INFO - Chipset Model: Intel Iris 13:57:57 INFO - Type: GPU 13:57:57 INFO - Bus: Built-In 13:57:57 INFO - VRAM (Dynamic, Max): 1536 MB 13:57:57 INFO - Vendor: Intel (0x8086) 13:57:57 INFO - Device ID: 0x0a2e 13:57:57 INFO - Revision ID: 0x0009 13:57:57 INFO - Displays: 13:57:57 INFO - Display: 13:57:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:57:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:57:57 INFO - Display Serial Number: 1600x1200 60 13:57:57 INFO - Main Display: Yes 13:57:57 INFO - Mirror: Off 13:57:57 INFO - Online: Yes 13:57:57 INFO - Rotation: Supported 13:57:57 INFO - Return code: 0 13:57:57 INFO - Running post-action listener: _resource_record_post_action 13:57:57 INFO - [mozharness: 2016-10-27 20:57:57.852598Z] Finished run-tests step (success) 13:57:57 INFO - Running post-run listener: _resource_record_post_run 13:57:57 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 1191936; Write bytes: 661056000; Read time: 13; Write time: 2032 13:57:57 INFO - TinderboxPrint: CPU usage
53.3% 13:57:57 INFO - TinderboxPrint: I/O read bytes / time
1,191,936 / 13 13:57:57 INFO - TinderboxPrint: I/O write bytes / time
661,056,000 / 2,032 13:57:57 INFO - TinderboxPrint: CPU idle
2,256.7 (46.6%) 13:57:57 INFO - TinderboxPrint: CPU system
966.9 (20.0%) 13:57:57 INFO - TinderboxPrint: CPU user
1,614.0 (33.4%) 13:57:57 INFO - TinderboxPrint: Swap in / out
364,756,992 / 0 13:57:57 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 356250112; Write bytes: 356066816; Read time: 27902; Write time: 649 13:57:57 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 1191936; Write bytes: 294839296; Read time: 13; Write time: 1351 13:57:58 INFO - Running post-run listener: _upload_blobber_files 13:57:58 INFO - Blob upload gear active. 13:57:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:57:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:57:58 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'] 13:57:58 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 13:57:58 INFO - (blobuploader) - INFO - Open directory for files ... 13:57:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:57:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:57:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:57:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:57:59 INFO - (blobuploader) - INFO - Done attempting. 13:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:58:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:58:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:58:00 INFO - (blobuploader) - INFO - Done attempting. 13:58:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:58:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:58:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:58:03 INFO - (blobuploader) - INFO - Done attempting. 13:58:03 INFO - (blobuploader) - INFO - Iteration through files over. 13:58:03 INFO - Return code: 0 13:58:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:58:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:58:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c16192daea6038dcc73127ae6c4d2dba6270a11790fcd1c80a6a1ff96f1ba193e6eb73043989565438164d10a5259f32065518f8c491b11bd3517ac6756fcd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db94be22a3a71ea1cba5f02153a4d12f3d9cd354ca0d20ef04ba757bc6f6eef887f7ed6437f68595016a8aa0da0b93cb415d0673084a756c725db78a01019373", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a04711da9d9c40cb2a719bb4efb321c9110e5433a05e4fa6f3f3f3b4c05a3bb73aaeba880b7fb27125dfcbd843098365893a437b2362ac2a3a004d4c316a3272"} 13:58:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:58:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:58:03 INFO - Contents: 13:58:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c16192daea6038dcc73127ae6c4d2dba6270a11790fcd1c80a6a1ff96f1ba193e6eb73043989565438164d10a5259f32065518f8c491b11bd3517ac6756fcd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db94be22a3a71ea1cba5f02153a4d12f3d9cd354ca0d20ef04ba757bc6f6eef887f7ed6437f68595016a8aa0da0b93cb415d0673084a756c725db78a01019373", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a04711da9d9c40cb2a719bb4efb321c9110e5433a05e4fa6f3f3f3b4c05a3bb73aaeba880b7fb27125dfcbd843098365893a437b2362ac2a3a004d4c316a3272"} 13:58:03 INFO - Running post-run listener: copy_logs_to_upload_dir 13:58:03 INFO - Copying logs to upload dir... 13:58:03 INFO - mkdir: /builds/slave/test/build/upload/logs 13:58:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.641650 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-27 13:58:03.157284) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 13:58:03.160495) ========= 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.N4unvpD8d3/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.osVG2voP3Y/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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/8c16192daea6038dcc73127ae6c4d2dba6270a11790fcd1c80a6a1ff96f1ba193e6eb73043989565438164d10a5259f32065518f8c491b11bd3517ac6756fcd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db94be22a3a71ea1cba5f02153a4d12f3d9cd354ca0d20ef04ba757bc6f6eef887f7ed6437f68595016a8aa0da0b93cb415d0673084a756c725db78a01019373", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a04711da9d9c40cb2a719bb4efb321c9110e5433a05e4fa6f3f3f3b4c05a3bb73aaeba880b7fb27125dfcbd843098365893a437b2362ac2a3a004d4c316a3272"} build_url:https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010848 build_url: 'https://queue.taskcluster.net/v1/task/AXpXoMFERe-_2eSa5lpmbw/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/8c16192daea6038dcc73127ae6c4d2dba6270a11790fcd1c80a6a1ff96f1ba193e6eb73043989565438164d10a5259f32065518f8c491b11bd3517ac6756fcd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db94be22a3a71ea1cba5f02153a4d12f3d9cd354ca0d20ef04ba757bc6f6eef887f7ed6437f68595016a8aa0da0b93cb415d0673084a756c725db78a01019373", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a04711da9d9c40cb2a719bb4efb321c9110e5433a05e4fa6f3f3f3b4c05a3bb73aaeba880b7fb27125dfcbd843098365893a437b2362ac2a3a004d4c316a3272"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 13:58:03.196295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:58:03.197304) ========= 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.N4unvpD8d3/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.osVG2voP3Y/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005212 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:58:03.251274) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 13:58:03.251618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 13:58:03.251969) ========= ========= Total master_lag: 0.20 =========