builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0017 starttime: 1483665320.01 results: success (0) buildid: 20170105154114 builduid: 3598ded0a57e4fbeb56a5b8516671d87 revision: aa6ce690f3d85f4b17679628e32d28ee0fc59c39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:20.007396) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:20.007845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:20.008159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:20.153460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:20.154071) ========= 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.cuHCvhSjbV/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.bJleDE4jol/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-05 17:15:20-- 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% 5.96M=0.002s 2017-01-05 17:15:20 (5.96 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110795 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:20.317040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:20.317351) ========= 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.cuHCvhSjbV/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.bJleDE4jol/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.020520 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:20.397583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:20.397928) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev aa6ce690f3d85f4b17679628e32d28ee0fc59c39 --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-beta --rev aa6ce690f3d85f4b17679628e32d28ee0fc59c39 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cuHCvhSjbV/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.bJleDE4jol/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-05 17:15:20,475 truncating revision to first 12 chars 2017-01-05 17:15:20,475 Setting DEBUG logging. 2017-01-05 17:15:20,475 attempt 1/10 2017-01-05 17:15:20,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/aa6ce690f3d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 17:15:21,122 unpacking tar archive at: mozilla-beta-aa6ce690f3d8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.911452 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:21.337492) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:21.337775) ========= script_repo_revision: aa6ce690f3d85f4b17679628e32d28ee0fc59c39 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:21.338175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:21.338450) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 17:15:21.358474) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-05 17:15:21.358808) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cuHCvhSjbV/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.bJleDE4jol/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 17:15:21 INFO - MultiFileLogger online at 20170105 17:15:21 in /builds/slave/test 17:15:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:15:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:15:21 INFO - {'append_to_log': False, 17:15:21 INFO - 'base_work_dir': '/builds/slave/test', 17:15:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:15:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:15:21 INFO - 'branch': 'Mozilla-Beta', 17:15:21 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:21 INFO - 'config_files': ('talos/mac_config.py',), 17:15:21 INFO - 'default_actions': ('clobber', 17:15:21 INFO - 'read-buildbot-config', 17:15:21 INFO - 'download-and-extract', 17:15:21 INFO - 'populate-webroot', 17:15:21 INFO - 'create-virtualenv', 17:15:21 INFO - 'install', 17:15:21 INFO - 'run-tests'), 17:15:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:21 INFO - 'download_minidump_stackwalk': True, 17:15:21 INFO - 'download_symbols': 'ondemand', 17:15:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:15:21 INFO - 'tooltool.py': '/tools/tooltool.py', 17:15:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:15:21 INFO - '/tools/misc-python/virtualenv.py')}, 17:15:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:21 INFO - 'installer_path': 'installer.exe', 17:15:21 INFO - 'log_level': 'info', 17:15:21 INFO - 'log_name': 'talos', 17:15:21 INFO - 'log_to_console': True, 17:15:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:15:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:15:21 INFO - 'opt_config_files': (), 17:15:21 INFO - 'pip_index': False, 17:15:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:15:21 INFO - 'cmd': ('bash', 17:15:21 INFO - '-c', 17:15:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:15:21 INFO - 'enabled': True, 17:15:21 INFO - 'halt_on_failure': False, 17:15:21 INFO - 'name': 'check_screen_resolution'},), 17:15:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:15:21 INFO - 'cmd': ('bash', 17:15:21 INFO - '-c', 17:15:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:15:21 INFO - 'enabled': True, 17:15:21 INFO - 'halt_on_failure': False, 17:15:21 INFO - 'name': 'check_screen_resolution'},), 17:15:21 INFO - 'run_cmd_checks_enabled': True, 17:15:21 INFO - 'sps_profile': False, 17:15:21 INFO - 'sps_profile_interval': 0, 17:15:21 INFO - 'suite': 'dromaeojs', 17:15:21 INFO - 'system_bits': '32', 17:15:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:21 INFO - 'title': 't-yosemite-r7-0017', 17:15:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:21 INFO - 'use_talos_json': True, 17:15:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:15:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:21 INFO - 'work_dir': 'build'} 17:15:21 INFO - [mozharness: 2017-01-06 01:15:21.559086Z] Running clobber step. 17:15:21 INFO - Running pre-action listener: _resource_record_pre_action 17:15:21 INFO - Running main action method: clobber 17:15:21 INFO - rmtree: /builds/slave/test/build 17:15:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:15:22 INFO - Running post-action listener: _resource_record_post_action 17:15:22 INFO - [mozharness: 2017-01-06 01:15:22.530636Z] Finished clobber step (success) 17:15:22 INFO - [mozharness: 2017-01-06 01:15:22.531066Z] Running read-buildbot-config step. 17:15:22 INFO - Running pre-action listener: _resource_record_pre_action 17:15:22 INFO - Running main action method: read_buildbot_config 17:15:22 INFO - Using buildbot properties: 17:15:22 INFO - { 17:15:22 INFO - "project": "", 17:15:22 INFO - "product": "firefox", 17:15:22 INFO - "script_repo_revision": "production", 17:15:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:15:22 INFO - "repository": "", 17:15:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:15:22 INFO - "buildid": "20170105154114", 17:15:22 INFO - "pgo_build": "False", 17:15:22 INFO - "basedir": "/builds/slave/test", 17:15:22 INFO - "buildnumber": 6, 17:15:22 INFO - "slavename": "t-yosemite-r7-0017", 17:15:22 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:15:22 INFO - "platform": "yosemite_r7", 17:15:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:15:22 INFO - "branch": "mozilla-beta", 17:15:22 INFO - "repo_path": "releases/mozilla-beta", 17:15:22 INFO - "revision": "aa6ce690f3d85f4b17679628e32d28ee0fc59c39", 17:15:22 INFO - "stage_platform": "macosx64", 17:15:22 INFO - "builduid": "3598ded0a57e4fbeb56a5b8516671d87", 17:15:22 INFO - "slavebuilddir": "test" 17:15:22 INFO - } 17:15:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 17:15:22 INFO - Running post-action listener: _resource_record_post_action 17:15:22 INFO - [mozharness: 2017-01-06 01:15:22.538101Z] Finished read-buildbot-config step (success) 17:15:22 INFO - [mozharness: 2017-01-06 01:15:22.538265Z] Running download-and-extract step. 17:15:22 INFO - Running pre-action listener: _resource_record_pre_action 17:15:22 INFO - Running main action method: download_and_extract 17:15:22 INFO - mkdir: /builds/slave/test/build/tests 17:15:22 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')]} 17:15:22 INFO - trying https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 17:15:22 INFO - Downloading https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 17:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 17:15:23 INFO - Downloaded 1165 bytes. 17:15:23 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 17:15:23 INFO - Using the following test package requirements: 17:15:23 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 17:15:23 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:15:23 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 17:15:23 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:15:23 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 17:15:23 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:15:23 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:15:23 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 17:15:23 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 17:15:23 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:15:23 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 17:15:23 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:15:23 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 17:15:23 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:15:23 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 17:15:23 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:15:23 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 17:15:23 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 17:15:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 17:15:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 17:15:23 INFO - Fetch https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 17:15:24 INFO - Expected file size: 16234502 17:15:31 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:15:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 17:15:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 17:15:31 INFO - Fetch https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 17:15:31 INFO - Expected file size: 16234502 17:15:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 17:15:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 17:15:38 INFO - Fetch https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 17:15:49 INFO - Expected file size: 14414089 17:15:50 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')]} 17:15:50 INFO - trying https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:15:50 INFO - Downloading https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 17:15:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 17:15:53 INFO - Downloaded 86144166 bytes. 17:15:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:15:53 INFO - mkdir: /builds/slave/test/properties 17:15:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:53 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:53 INFO - Contents: 17:15:53 INFO - build_url:https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:15:53 INFO - Running post-action listener: _resource_record_post_action 17:15:53 INFO - Running post-action listener: set_extra_try_arguments 17:15:53 INFO - [mozharness: 2017-01-06 01:15:53.800903Z] Finished download-and-extract step (success) 17:15:53 INFO - [mozharness: 2017-01-06 01:15:53.801032Z] Running populate-webroot step. 17:15:53 INFO - Running pre-action listener: _resource_record_pre_action 17:15:53 INFO - Running main action method: populate_webroot 17:15:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:53 INFO - '--tppagecycles', 17:15:53 INFO - '7'], 17:15:53 INFO - 'tests': ['tsvgm']}}, 17:15:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:15:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:15:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:53 INFO - 'talos_options': ['--disable-e10s'], 17:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:53 INFO - 'talos_options': ['--disable-e10s'], 17:15:53 INFO - 'tests': ['damp', 'tps']}, 17:15:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:53 INFO - 'tests': ['damp', 'tps']}, 17:15:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:15:53 INFO - 'tests': ['dromaeo_dom']}, 17:15:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:15:53 INFO - 'tests': ['basic_compositor_video']}, 17:15:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:15:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:15:53 INFO - 'tests': ['a11yr', 17:15:53 INFO - 'ts_paint', 17:15:53 INFO - 'tpaint', 17:15:53 INFO - 'sessionrestore', 17:15:53 INFO - 'sessionrestore_no_auto_restore', 17:15:53 INFO - 'tabpaint']}, 17:15:53 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:53 INFO - 'ts_paint', 17:15:53 INFO - 'tpaint', 17:15:53 INFO - 'sessionrestore', 17:15:53 INFO - 'sessionrestore_no_auto_restore', 17:15:53 INFO - 'tabpaint']}, 17:15:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:15:53 INFO - 'ts_paint', 17:15:53 INFO - 'tpaint', 17:15:53 INFO - 'sessionrestore', 17:15:53 INFO - 'sessionrestore_no_auto_restore', 17:15:53 INFO - 'tabpaint']}, 17:15:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:15:53 INFO - 'ts_paint', 17:15:53 INFO - 'tpaint', 17:15:53 INFO - 'sessionrestore', 17:15:53 INFO - 'sessionrestore_no_auto_restore', 17:15:53 INFO - 'tabpaint']}, 17:15:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:15:53 INFO - 'tests': ['a11yr', 17:15:53 INFO - 'ts_paint', 17:15:53 INFO - 'tpaint', 17:15:53 INFO - 'sessionrestore', 17:15:53 INFO - 'sessionrestore_no_auto_restore', 17:15:53 INFO - 'tabpaint']}, 17:15:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:15:53 INFO - 'tests': ['a11yr', 17:15:53 INFO - 'ts_paint', 17:15:53 INFO - 'tpaint', 17:15:53 INFO - 'sessionrestore', 17:15:53 INFO - 'sessionrestore_no_auto_restore', 17:15:53 INFO - 'tabpaint']}, 17:15:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:15:53 INFO - 'tests': ['tsvgx', 17:15:53 INFO - 'tsvgr_opacity', 17:15:53 INFO - 'tart', 17:15:53 INFO - 'tscrollx', 17:15:53 INFO - 'cart']}, 17:15:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:53 INFO - 'tsvgr_opacity', 17:15:53 INFO - 'tart', 17:15:53 INFO - 'tscrollx', 17:15:53 INFO - 'cart']}, 17:15:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:53 INFO - 'talos_options': ['--disable-e10s'], 17:15:53 INFO - 'tests': ['tp5o']}, 17:15:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:53 INFO - 'tests': ['tp5o']}, 17:15:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:53 INFO - 'talos_options': ['--disable-e10s', 17:15:53 INFO - '--xperf_path', 17:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:53 INFO - 'tests': ['tp5n']}, 17:15:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:53 INFO - 'talos_options': ['--xperf_path', 17:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:53 INFO - 'tests': ['tp5n']}}, 17:15:53 INFO - 'talos.zip': {'path': '', 17:15:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:53 INFO - Running post-action listener: _resource_record_post_action 17:15:53 INFO - [mozharness: 2017-01-06 01:15:53.819200Z] Finished populate-webroot step (success) 17:15:53 INFO - [mozharness: 2017-01-06 01:15:53.819333Z] Running create-virtualenv step. 17:15:53 INFO - Running pre-action listener: _resource_record_pre_action 17:15:53 INFO - Running main action method: create_virtualenv 17:15:53 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:53 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 17:15:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:53 INFO - Using real prefix '/tools/python27' 17:15:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:54 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:57 INFO - Installing pip.................done. 17:15:57 INFO - Return code: 0 17:15:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:57 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 0x106f39490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eaf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d1d97aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4dd30>, '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 0x106bb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d45b20>, '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.cuHCvhSjbV/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.bJleDE4jol/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 17:15:57 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 17:15:57 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 17:15:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuHCvhSjbV/Render', 17:15:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:57 INFO - 'HOME': '/Users/cltbld', 17:15:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:57 INFO - 'LOGNAME': 'cltbld', 17:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:57 INFO - 'MOZ_NO_REMOTE': '1', 17:15:57 INFO - 'NO_EM_RESTART': '1', 17:15:57 INFO - 'PAGER': '/bin/cat', 17:15:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:57 INFO - 'PWD': '/builds/slave/test', 17:15:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:57 INFO - 'SHELL': '/bin/bash', 17:15:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJleDE4jol/Listeners', 17:15:57 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 17:15:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:57 INFO - 'USER': 'cltbld', 17:15:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:57 INFO - 'XPC_FLAGS': '0x0', 17:15:57 INFO - 'XPC_SERVICE_NAME': '0', 17:15:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:57 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 17:15:57 INFO - Cleaning up... 17:15:57 INFO - Return code: 0 17:15:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:57 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 0x106f39490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eaf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d1d97aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4dd30>, '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 0x106bb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d45b20>, '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.cuHCvhSjbV/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.bJleDE4jol/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 17:15:57 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 17:15:57 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 17:15:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuHCvhSjbV/Render', 17:15:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:57 INFO - 'HOME': '/Users/cltbld', 17:15:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:57 INFO - 'LOGNAME': 'cltbld', 17:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:57 INFO - 'MOZ_NO_REMOTE': '1', 17:15:57 INFO - 'NO_EM_RESTART': '1', 17:15:57 INFO - 'PAGER': '/bin/cat', 17:15:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:57 INFO - 'PWD': '/builds/slave/test', 17:15:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:57 INFO - 'SHELL': '/bin/bash', 17:15:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJleDE4jol/Listeners', 17:15:57 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 17:15:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:57 INFO - 'USER': 'cltbld', 17:15:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:57 INFO - 'XPC_FLAGS': '0x0', 17:15:57 INFO - 'XPC_SERVICE_NAME': '0', 17:15:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:58 INFO - Downloading/unpacking psutil>=3.1.1 17:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:16:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:01 INFO - Installing collected packages: psutil 17:16:01 INFO - Running setup.py install for psutil 17:16:02 INFO - building 'psutil._psutil_osx' extension 17:16:02 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 17:16:02 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 17:16:02 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 17:16:02 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 17:16:02 INFO - building 'psutil._psutil_posix' extension 17:16:02 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 17:16:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:16:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:16:02 INFO - ^ 17:16:02 INFO - 1 warning generated. 17:16:02 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 17:16:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:02 INFO - Successfully installed psutil 17:16:02 INFO - Cleaning up... 17:16:02 INFO - Return code: 0 17:16:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106f39490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eaf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d1d97aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4dd30>, '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 0x106bb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d45b20>, '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.cuHCvhSjbV/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.bJleDE4jol/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 17:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:16:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuHCvhSjbV/Render', 17:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:02 INFO - 'HOME': '/Users/cltbld', 17:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:02 INFO - 'LOGNAME': 'cltbld', 17:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:02 INFO - 'MOZ_NO_REMOTE': '1', 17:16:02 INFO - 'NO_EM_RESTART': '1', 17:16:02 INFO - 'PAGER': '/bin/cat', 17:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:02 INFO - 'PWD': '/builds/slave/test', 17:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:02 INFO - 'SHELL': '/bin/bash', 17:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJleDE4jol/Listeners', 17:16:02 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 17:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:02 INFO - 'USER': 'cltbld', 17:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:02 INFO - 'XPC_FLAGS': '0x0', 17:16:02 INFO - 'XPC_SERVICE_NAME': '0', 17:16:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:16:05 INFO - Installing collected packages: mozsystemmonitor 17:16:05 INFO - Running setup.py install for mozsystemmonitor 17:16:05 INFO - Successfully installed mozsystemmonitor 17:16:05 INFO - Cleaning up... 17:16:06 INFO - Return code: 0 17:16:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106f39490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eaf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d1d97aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4dd30>, '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 0x106bb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d45b20>, '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.cuHCvhSjbV/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.bJleDE4jol/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 17:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:16:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuHCvhSjbV/Render', 17:16:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:06 INFO - 'HOME': '/Users/cltbld', 17:16:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:06 INFO - 'LOGNAME': 'cltbld', 17:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:06 INFO - 'MOZ_NO_REMOTE': '1', 17:16:06 INFO - 'NO_EM_RESTART': '1', 17:16:06 INFO - 'PAGER': '/bin/cat', 17:16:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:06 INFO - 'PWD': '/builds/slave/test', 17:16:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:06 INFO - 'SHELL': '/bin/bash', 17:16:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJleDE4jol/Listeners', 17:16:06 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 17:16:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:06 INFO - 'USER': 'cltbld', 17:16:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:06 INFO - 'XPC_FLAGS': '0x0', 17:16:06 INFO - 'XPC_SERVICE_NAME': '0', 17:16:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:06 INFO - Downloading/unpacking jsonschema==2.5.1 17:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:16:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:16:08 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 17:16:08 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 17:16:08 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 17:16:08 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 17:16:08 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 17:16:08 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 17:16:09 INFO - Downloading functools32-3.2.3-2.tar.gz 17:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:16:09 INFO - warning: no files found matching '*.txt' 17:16:09 INFO - no previously-included directories found matching 'build' 17:16:09 INFO - no previously-included directories found matching 'dist' 17:16:09 INFO - no previously-included directories found matching '.git*' 17:16:09 INFO - Installing collected packages: jsonschema, functools32 17:16:09 INFO - Running setup.py install for functools32 17:16:09 INFO - warning: no files found matching '*.txt' 17:16:09 INFO - no previously-included directories found matching 'build' 17:16:09 INFO - no previously-included directories found matching 'dist' 17:16:09 INFO - no previously-included directories found matching '.git*' 17:16:09 INFO - Successfully installed jsonschema functools32 17:16:09 INFO - Cleaning up... 17:16:09 INFO - Return code: 0 17:16:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:09 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 0x106f39490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eaf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d1d97aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4dd30>, '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 0x106bb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d45b20>, '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.cuHCvhSjbV/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.bJleDE4jol/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 17:16:09 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 17:16:09 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 17:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuHCvhSjbV/Render', 17:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:09 INFO - 'HOME': '/Users/cltbld', 17:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:09 INFO - 'LOGNAME': 'cltbld', 17:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:09 INFO - 'MOZ_NO_REMOTE': '1', 17:16:09 INFO - 'NO_EM_RESTART': '1', 17:16:09 INFO - 'PAGER': '/bin/cat', 17:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:09 INFO - 'PWD': '/builds/slave/test', 17:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:09 INFO - 'SHELL': '/bin/bash', 17:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJleDE4jol/Listeners', 17:16:09 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 17:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:09 INFO - 'USER': 'cltbld', 17:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:09 INFO - 'XPC_FLAGS': '0x0', 17:16:09 INFO - 'XPC_SERVICE_NAME': '0', 17:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:16:09 INFO - Cleaning up... 17:16:09 INFO - Return code: 0 17:16:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:09 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 0x106f39490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eaf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d1d97aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4dd30>, '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 0x106bb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d45b20>, '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.cuHCvhSjbV/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.bJleDE4jol/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 17:16:09 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 17:16:09 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 17:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuHCvhSjbV/Render', 17:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:09 INFO - 'HOME': '/Users/cltbld', 17:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:09 INFO - 'LOGNAME': 'cltbld', 17:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:09 INFO - 'MOZ_NO_REMOTE': '1', 17:16:09 INFO - 'NO_EM_RESTART': '1', 17:16:09 INFO - 'PAGER': '/bin/cat', 17:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:09 INFO - 'PWD': '/builds/slave/test', 17:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:09 INFO - 'SHELL': '/bin/bash', 17:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJleDE4jol/Listeners', 17:16:09 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 17:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:09 INFO - 'USER': 'cltbld', 17:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:09 INFO - 'XPC_FLAGS': '0x0', 17:16:09 INFO - 'XPC_SERVICE_NAME': '0', 17:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:10 INFO - Downloading/unpacking blobuploader==1.2.4 17:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:12 INFO - Downloading blobuploader-1.2.4.tar.gz 17:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:16:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:16:12 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 17:16:12 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 17:16:12 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 17:16:12 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 17:16:12 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 17:16:12 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 17:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:16:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:16:13 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 17:16:13 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 17:16:13 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 17:16:13 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 17:16:13 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 17:16:13 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 17:16:13 INFO - Downloading docopt-0.6.1.tar.gz 17:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:16:14 INFO - Installing collected packages: blobuploader, requests, docopt 17:16:14 INFO - Running setup.py install for blobuploader 17:16:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:16:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:16:14 INFO - Running setup.py install for requests 17:16:14 INFO - Running setup.py install for docopt 17:16:14 INFO - Successfully installed blobuploader requests docopt 17:16:14 INFO - Cleaning up... 17:16:14 INFO - Return code: 0 17:16:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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')]} 17:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:14 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 0x106f39490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eaf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d1d97aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4dd30>, '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 0x106bb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d45b20>, '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.cuHCvhSjbV/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.bJleDE4jol/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 17:16:14 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 17:16:14 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 17:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuHCvhSjbV/Render', 17:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:14 INFO - 'HOME': '/Users/cltbld', 17:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:14 INFO - 'LOGNAME': 'cltbld', 17:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:14 INFO - 'MOZ_NO_REMOTE': '1', 17:16:14 INFO - 'NO_EM_RESTART': '1', 17:16:14 INFO - 'PAGER': '/bin/cat', 17:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:14 INFO - 'PWD': '/builds/slave/test', 17:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:14 INFO - 'SHELL': '/bin/bash', 17:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJleDE4jol/Listeners', 17:16:14 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 17:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:14 INFO - 'USER': 'cltbld', 17:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:14 INFO - 'XPC_FLAGS': '0x0', 17:16:14 INFO - 'XPC_SERVICE_NAME': '0', 17:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-j5vAVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-wI_Ne_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-bIeAET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-WNN72v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-5FJXcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-XUT8EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-i3o1vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-TCalUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-02TX2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-GrZ0g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-G5gFUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-o1yg65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-wbWYzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-IQvR9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-lNipMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-kXDgDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-u2Jy6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:16:16 INFO - Running setup.py install for manifestparser 17:16:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:16:17 INFO - Running setup.py install for mozcrash 17:16:17 INFO - Running setup.py install for mozdebug 17:16:17 INFO - Running setup.py install for mozdevice 17:16:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:16:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:16:17 INFO - Running setup.py install for mozfile 17:16:17 INFO - Running setup.py install for mozhttpd 17:16:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:16:17 INFO - Running setup.py install for mozinfo 17:16:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:16:17 INFO - Running setup.py install for mozInstall 17:16:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:16:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:16:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:16:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:16:18 INFO - Running setup.py install for mozleak 17:16:18 INFO - Running setup.py install for mozlog 17:16:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:16:18 INFO - Running setup.py install for moznetwork 17:16:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:16:18 INFO - Running setup.py install for mozprocess 17:16:18 INFO - Running setup.py install for mozprofile 17:16:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:16:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:16:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:16:18 INFO - Running setup.py install for mozrunner 17:16:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:16:19 INFO - Running setup.py install for mozscreenshot 17:16:19 INFO - Running setup.py install for moztest 17:16:19 INFO - Running setup.py install for mozversion 17:16:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:16:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:16:19 INFO - Cleaning up... 17:16:19 INFO - Return code: 0 17:16:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:19 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')]} 17:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:19 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')]} 17:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:19 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 0x106f39490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eaf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d1d97aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4dd30>, '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 0x106bb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d45b20>, '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.cuHCvhSjbV/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.bJleDE4jol/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 17:16:19 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 17:16:19 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 17:16:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuHCvhSjbV/Render', 17:16:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:19 INFO - 'HOME': '/Users/cltbld', 17:16:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:19 INFO - 'LOGNAME': 'cltbld', 17:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:19 INFO - 'MOZ_NO_REMOTE': '1', 17:16:19 INFO - 'NO_EM_RESTART': '1', 17:16:19 INFO - 'PAGER': '/bin/cat', 17:16:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:19 INFO - 'PWD': '/builds/slave/test', 17:16:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:19 INFO - 'SHELL': '/bin/bash', 17:16:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJleDE4jol/Listeners', 17:16:19 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 17:16:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:19 INFO - 'USER': 'cltbld', 17:16:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:19 INFO - 'XPC_FLAGS': '0x0', 17:16:19 INFO - 'XPC_SERVICE_NAME': '0', 17:16:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:19 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-3BTb0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:19 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)) 17:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:19 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-LfxwBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:20 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)) 17:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-sr22n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:20 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)) 17:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-zoNgcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:20 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)) 17:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-XQYh5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:20 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)) 17:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-_BwDIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:20 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)) 17:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-PNa8tA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:20 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)) 17:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-2hw4PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:20 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)) 17:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-x7V_tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:20 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)) 17:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-CRvNDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:20 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)) 17:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-e6CeeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:21 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)) 17:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-givfmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:21 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)) 17:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-y9Lpnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:21 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)) 17:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-FObSgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:21 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)) 17:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-rUhK37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:21 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)) 17:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-CCjdv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:21 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)) 17:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-sM02Mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:21 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)) 17:16:21 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)) 17:16:21 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)) 17:16:21 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)) 17:16:21 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)) 17:16:21 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)) 17:16:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:16:21 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 17:16:21 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 17:16:21 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 17:16:21 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 17:16:21 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 17:16:21 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 17:16:24 INFO - Downloading blessings-1.6.tar.gz 17:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:16:24 INFO - Installing collected packages: blessings 17:16:24 INFO - Running setup.py install for blessings 17:16:24 INFO - Successfully installed blessings 17:16:24 INFO - Cleaning up... 17:16:24 INFO - Return code: 0 17:16:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:16:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:24 INFO - Reading from file tmpfile_stdout 17:16:24 INFO - Current package versions: 17:16:24 INFO - blessings == 1.6 17:16:24 INFO - blobuploader == 1.2.4 17:16:24 INFO - docopt == 0.6.1 17:16:24 INFO - functools32 == 3.2.3-2 17:16:24 INFO - jsonschema == 2.5.1 17:16:24 INFO - manifestparser == 1.1 17:16:24 INFO - mozInstall == 1.12 17:16:24 INFO - mozcrash == 0.17 17:16:24 INFO - mozdebug == 0.1 17:16:24 INFO - mozdevice == 0.48 17:16:24 INFO - mozfile == 1.2 17:16:24 INFO - mozhttpd == 0.7 17:16:24 INFO - mozinfo == 0.9 17:16:24 INFO - mozleak == 0.1 17:16:24 INFO - mozlog == 3.4 17:16:24 INFO - moznetwork == 0.27 17:16:24 INFO - mozprocess == 0.23 17:16:24 INFO - mozprofile == 0.28 17:16:24 INFO - mozrunner == 6.12 17:16:24 INFO - mozscreenshot == 0.1 17:16:24 INFO - mozsystemmonitor == 0.3 17:16:24 INFO - moztest == 0.7 17:16:24 INFO - mozversion == 1.4 17:16:24 INFO - psutil == 3.1.1 17:16:24 INFO - requests == 1.2.3 17:16:24 INFO - wsgiref == 0.1.2 17:16:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:24 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 0x106f39490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eaf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d1d97aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4dd30>, '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 0x106bb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d45b20>, '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.cuHCvhSjbV/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.bJleDE4jol/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 17:16:24 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 17:16:24 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 17:16:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuHCvhSjbV/Render', 17:16:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:24 INFO - 'HOME': '/Users/cltbld', 17:16:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:24 INFO - 'LOGNAME': 'cltbld', 17:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:24 INFO - 'MOZ_NO_REMOTE': '1', 17:16:24 INFO - 'NO_EM_RESTART': '1', 17:16:24 INFO - 'PAGER': '/bin/cat', 17:16:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:24 INFO - 'PWD': '/builds/slave/test', 17:16:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:24 INFO - 'SHELL': '/bin/bash', 17:16:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJleDE4jol/Listeners', 17:16:24 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 17:16:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:24 INFO - 'USER': 'cltbld', 17:16:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:24 INFO - 'XPC_FLAGS': '0x0', 17:16:24 INFO - 'XPC_SERVICE_NAME': '0', 17:16:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:25 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)) 17:16:25 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)) 17:16:25 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)) 17:16:25 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)) 17:16:25 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)) 17:16:25 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)) 17:16:25 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)) 17:16:25 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)) 17:16:25 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)) 17:16:25 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)) 17:16:25 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)) 17:16:25 INFO - Cleaning up... 17:16:25 INFO - Return code: 0 17:16:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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')]} 17:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106f39490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eaf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d1d97aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4dd30>, '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 0x106bb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d45b20>, '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.cuHCvhSjbV/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.bJleDE4jol/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 17:16: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', 'jsonschema'] in /builds/slave/test/build 17:16: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 jsonschema 17:16:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuHCvhSjbV/Render', 17:16:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:25 INFO - 'HOME': '/Users/cltbld', 17:16:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:25 INFO - 'LOGNAME': 'cltbld', 17:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:25 INFO - 'MOZ_NO_REMOTE': '1', 17:16:25 INFO - 'NO_EM_RESTART': '1', 17:16:25 INFO - 'PAGER': '/bin/cat', 17:16:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:25 INFO - 'PWD': '/builds/slave/test', 17:16:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:25 INFO - 'SHELL': '/bin/bash', 17:16:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJleDE4jol/Listeners', 17:16:25 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 17:16:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:25 INFO - 'USER': 'cltbld', 17:16:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:25 INFO - 'XPC_FLAGS': '0x0', 17:16:25 INFO - 'XPC_SERVICE_NAME': '0', 17:16:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:16:25 INFO - Cleaning up... 17:16:25 INFO - Return code: 0 17:16:25 INFO - Running post-action listener: _resource_record_post_action 17:16:25 INFO - Running post-action listener: _start_resource_monitoring 17:16:25 INFO - Starting resource monitoring. 17:16:25 INFO - [mozharness: 2017-01-06 01:16:25.471264Z] Finished create-virtualenv step (success) 17:16:25 INFO - [mozharness: 2017-01-06 01:16:25.472283Z] Running install step. 17:16:25 INFO - Running pre-action listener: _resource_record_pre_action 17:16:25 INFO - Running main action method: install 17:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:25 INFO - Reading from file tmpfile_stdout 17:16:25 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:16:25 INFO - Reading from file tmpfile_stdout 17:16:25 INFO - Output received: 17:16:25 INFO - Usage: mozinstall [options] installer 17:16:25 INFO - Options: 17:16:25 INFO - -h, --help show this help message and exit 17:16:25 INFO - -d DEST, --destination=DEST 17:16:25 INFO - Directory to install application into. [default: 17:16:25 INFO - "/builds/slave/test"] 17:16:25 INFO - --app=APP Application being installed. [default: firefox] 17:16:25 INFO - mkdir: /builds/slave/test/build/application 17:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:16:48 INFO - Reading from file tmpfile_stdout 17:16:48 INFO - Output received: 17:16:48 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:16:48 INFO - Running post-action listener: _resource_record_post_action 17:16:48 INFO - [mozharness: 2017-01-06 01:16:48.316560Z] Finished install step (success) 17:16:48 INFO - [mozharness: 2017-01-06 01:16:48.316695Z] Running run-tests step. 17:16:48 INFO - Running pre-action listener: _resource_record_pre_action 17:16:48 INFO - Running main action method: run_tests 17:16:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:16:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:16:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:16:48 INFO - 2017-01-05 17:16:48.331 screenresolution[1906:13486] starting screenresolution argv=screenresolution get 17:16:48 INFO - 2017-01-05 17:16:48.333 screenresolution[1906:13486] Display 0: 1600x1200x32@50 17:16:48 INFO - 2017-01-05 17:16:48.339 screenresolution[1907:13489] starting screenresolution argv=screenresolution list 17:16:48 INFO - Available Modes on Display 0 17:16:48 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 17:16:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:16:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:16:48 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 17:16:48 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 17:16:48 INFO - Graphics/Displays: 17:16:48 INFO - Intel Iris: 17:16:48 INFO - Chipset Model: Intel Iris 17:16:48 INFO - Type: GPU 17:16:48 INFO - Bus: Built-In 17:16:48 INFO - VRAM (Dynamic, Max): 1536 MB 17:16:48 INFO - Vendor: Intel (0x8086) 17:16:48 INFO - Device ID: 0x0a2e 17:16:48 INFO - Revision ID: 0x0009 17:16:48 INFO - Displays: 17:16:48 INFO - Display: 17:16:48 INFO - Resolution: 1600 x 1200 @ 50 Hz 17:16:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:16:48 INFO - Display Serial Number: 1600x1200 50 17:16:48 INFO - Main Display: Yes 17:16:48 INFO - Mirror: Off 17:16:48 INFO - Online: Yes 17:16:48 INFO - Rotation: Supported 17:16:48 INFO - Return code: 0 17:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:16:48 INFO - Python 2.7.3 17:16:48 INFO - Return code: 0 17:16:48 INFO - grabbing minidump binary from tooltool 17:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4dd30>, '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 0x106bb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d45b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:16:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:16:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:16:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:16:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:48 INFO - Return code: 0 17:16:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:16:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:16:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:16:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:16:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--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 17:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0017 --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 17:16:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuHCvhSjbV/Render', 17:16:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:48 INFO - 'HOME': '/Users/cltbld', 17:16:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:48 INFO - 'LOGNAME': 'cltbld', 17:16:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:48 INFO - 'MOZ_NO_REMOTE': '1', 17:16:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:48 INFO - 'NO_EM_RESTART': '1', 17:16:48 INFO - 'PAGER': '/bin/cat', 17:16:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:48 INFO - 'PWD': '/builds/slave/test', 17:16:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:48 INFO - 'SHELL': '/bin/bash', 17:16:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJleDE4jol/Listeners', 17:16:48 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 17:16:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:48 INFO - 'USER': 'cltbld', 17:16:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:48 INFO - 'XPC_FLAGS': '0x0', 17:16:48 INFO - 'XPC_SERVICE_NAME': '0', 17:16:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--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 17:16:48 INFO - mozversion application_buildid: 20170105154114 17:16:48 INFO - mozversion application_changeset: aa6ce690f3d85f4b17679628e32d28ee0fc59c39 17:16:48 INFO - mozversion application_display_name: Firefox 17:16:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:48 INFO - mozversion application_name: Firefox 17:16:48 INFO - mozversion application_remotingname: firefox 17:16:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:16:48 INFO - mozversion application_vendor: Mozilla 17:16:48 INFO - mozversion application_version: 51.0 17:16:48 INFO - mozversion platform_buildid: 20170105154114 17:16:48 INFO - mozversion platform_changeset: aa6ce690f3d85f4b17679628e32d28ee0fc59c39 17:16:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:16:48 INFO - mozversion platform_version: 51.0 17:16:48 INFO - using testdate: 1483665408 17:16:48 INFO - actual date: 1483665408 17:16:48 INFO - starting webserver on 'localhost:49714' 17:16:48 INFO - SUITE-START | Running 2 tests 17:16:48 INFO - TEST-START | dromaeo_css 17:16:48 INFO - operating with platform_type : mac_ 17:16:48 INFO - Initialising browser for dromaeo_css test... 17:16:48 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpVwDRkq/profile http://localhost:49714/getInfo.html) 17:16:51 INFO - PROCESS | 1917 | __metrics Screen width/height:1600/1200 17:16:51 INFO - PROCESS | 1917 | colorDepth:24 17:16:51 INFO - PROCESS | 1917 | Browser inner width/height: 1024/689 17:16:51 INFO - PROCESS | 1917 | __metrics 17:16:51 INFO - PROCESS | 1917 | 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" 17:16:51 INFO - PROCESS | 1917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:16:52 INFO - TEST-INFO | 1917: exit 0 17:16:52 INFO - Browser initialized. 17:16:52 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:52 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpVwDRkq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:04 INFO - PROCESS | 1920 | RSS: Main: 169136128 17:17:04 INFO - PROCESS | 1920 | 17:17:55 INFO - PROCESS | 1920 | 1483665475940 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] 17:20:06 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49714/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49714/tests/dromaeo/cssquery-ext.html) 17:20:07 INFO - PROCESS | 1920 | RSS: Main: 317681664 17:20:07 INFO - PROCESS | 1920 | 17:23:10 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49714/tests/dromaeo/cssquery-ext.html (next: http://localhost:49714/tests/dromaeo/cssquery-jquery.html) 17:23:11 INFO - PROCESS | 1920 | RSS: Main: 300290048 17:23:11 INFO - PROCESS | 1920 | 17:26:13 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49714/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49714/tests/dromaeo/cssquery-mootools.html) 17:26:14 INFO - PROCESS | 1920 | RSS: Main: 260583424 17:26:14 INFO - PROCESS | 1920 | 17:29:16 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49714/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49714/tests/dromaeo/cssquery-prototype.html) 17:29:17 INFO - PROCESS | 1920 | RSS: Main: 291799040 17:29:17 INFO - PROCESS | 1920 | 17:32:20 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49714/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49714/tests/dromaeo/cssquery-yui.html) 17:32:20 INFO - PROCESS | 1920 | RSS: Main: 260612096 17:32:20 INFO - PROCESS | 1920 | 17:35:23 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49714/tests/dromaeo/cssquery-yui.html (next: http://localhost:49714/tests/dromaeo/cssquery-dojo.html) 17:35:24 INFO - PROCESS | 1920 | RSS: Main: 343617536 17:35:24 INFO - PROCESS | 1920 | 17:35:24 INFO - PROCESS | 1920 | __start_tp_report 17:35:24 INFO - PROCESS | 1920 | _x_x_mozilla_page_load 17:35:24 INFO - PROCESS | 1920 | _x_x_mozilla_page_load_details 17:35:24 INFO - PROCESS | 1920 | |i|pagename|runs| 17:35:24 INFO - PROCESS | 1920 | |0;dojo.html;3381.797092174469;3395.0833275015752;3423.8116903570294;3447.793132412057;3477.8956631301053;5669.348024977124;5693.3452652944925;5720.9713951430185;5742.511886489643;5754.935336962665;5628.71856407179;5728.942710572893;5750.424957504248;5769.990251705945;5776.4223577642215;5222.712750798704;5225.634205605609;5239.79040838366;5243.737813109329;5276.630635855492;5180.481951804827;5211.817586384477;5318;5321.733913304339;5356.758945847446;5216.217567364888;5221.817236396727;5233.816816411427;5249.580033597303;5253.947460525404;5220.947790522103;5239.13554263546;5240.213967904807;5280.735963201824;5301;5166.199239117943;5232.03207406631;5242.7640756166065;5247.580193584504;5297.496737809902;5568.832935011957;5630.465105814982;5636.464535869086;5637.605367624268;5670.914936275959;6119.592558463849;6188.443040126365;6191.938080619181;6200.379962003809;6215.316315205324;6266.968665156691;6318.652474113922;6329.556931014831;6340.682965851689;6365.554411191219;5639.943600563983;5691.8861622768145;5697.3448053474385;5726.971365143231;5803.564732645069;6215.192025036807;6225.875482490324;6254.593451425642;6270.122182894398;6273.1844860167885;6150.538709596798;6160.507159427235;6167.229096362955;6181.84545386369;6184.969075154595;6065.5754097212775;6194.876102477925;6280.528960327993;6286.277078135981;6290;6113.111460343413;6175.073738939195;6176.629402235881;6199.473044791243;6274.592151510137;6236.251649802053;6291.245050593958;6299.842503937347;6306.716197771111;6318.6524741138755;4923.556879880828;4978.5270399312;4979;5003.874903127451;5007.173816320339;4380.649548036149;4415.757133357696;4430.955690443118;4431.180231657154;4475.149721552894;5925.466707996301;5926.614770039933;5938.287405511366;5958.404159584007;5964.194833697482;6307.905381419282;6331.620102793847;6333.873322533524;6341.112244285804;6369.8089057327425;5604.439556044363;5705.5150312223095;5709.486146246774;5821.534277257894;5894.145348924382;5379.1393377059485;5416.729163541807;5424.213489044067;5443.401225865152;5451.945480545223;6277.372262773686;6289.49684025286;6293.118963345135;6296.811095667137;6297.244330680348;6124.816255512342;6302.873942521215;6335.714892829926;6356.237251529846;6359.618422894641;5274.498922602346;6200.441960223601;6230.345813689497;6272.372762723691;6280.120783090462;6184.350643182581;6236.03341482071;6243.406876346739;6266.028765541349;6281.811545653638;6272.529560283088;6327.778527751507;6329.588576742497;6342.175517182736;6342.460890824332;5974.6713930732485;6046.909296360646;6050.939490605214;6086.147939288415;6158.661273629814;6151.0773383992755;6161.969190154021;6162.568620196723;6180.6909654517995;6185.474234690102;5857.47282744555;5990.670513121646;5997.670128142994;6022.638641681513;6025.487833534199;5989.970050149721;6013.398660133952;6075.969620151871;6101.542384321105;6125.816225513242;5912.49743771767;6019.54853385989;6048.213732214784;6053.788117415869;6059.424354686298 17:35:24 INFO - PROCESS | 1920 | |1;ext.html;475.0925731852163;494.84165067178503;505.4743067210102;523.3562717857034;547.3459216236599;28505.572416413743;42767.99999999996;43660.345094823606;43702;45850.77074614622;44927.326090108596;45495.77252113743;45607;45613.31580026294;45637.54362456375;9841.852372214405;10020.749481262954;10035.648752293671;10036.347637403545;10083.243756718239;9215.124563166522;9406.388584742004;12182.573609923655;12430.502779888793;12432.440540175669;12315.076369272296;12380.071494637938;12386.566470173546;12402.379881005914;12418.006559475265;12330.815037774395;12400.441980110916;12403.689907752288;12421.93789031058;12449.75100497985;12109.697257568543;12148.817767733492;12185.634430967086;12196.939015304955;12213.206141600767;41520.169596608204;41948.95127621803;41957;41957.58042419567;42008.57991420108;3468.115630514228;3652.726045546595;3668.8715894943816;3732.5707543632557;3984.5218573771044;26924.86537567319;30264;31091.689083109104;32998.17504562405;33070.50394244088;3120.968790312113;3424.6746559076846;3462.3767721810063;3500.5099286099967;3519.454484554898;387566;389977;390268;390978;390987;34991.475127873106;35464.64535354665;35709.28581428357;64709.67645161744;64966.35033649697;35801.64198357983;36016.819915900254;36070.09824754402;36084.63915360865;36100.45849312263;15598.9220053899;15809.367625294859;15820.525384238492;15830.28763705636;15844.683106337809;12364.258144511357;12511.874881251071;13207.07550471477;13273;13284.734305314032;7925.167857374892;8159.877601835978;8166.346692264605;8190.140035296327;8249.752507424666;3279.7868138571394;3340.1816554944194;3340.916477088044;3343;3365.7139143172617;902.8600566912007;1033.0599154769125;1053.7365658585354;1076.5747529725716;1086.9891301086889;28394.574081388382;29845.10464686063;30677;30883.69116308853;30909.334537640083;931.8089791592707;976.3214565876648;1033.225081189108;1081.324172392255;1143.4968613809897;15767.186773521193;16418.753718694228;16460.341586336654;16502.390603109874;16518.42185523525;717271;724996;725698;725726;726052;61669.691651541456;62263.68868155721;62287;62429.37570624326;62464.37535624677;1166.5683697032152;1193.647873877191;1312.068431413688;1349.2174538767688;1410.8941829362634;31465.528017079305;31518.212044699067;32404.675953240167;32454.026379208663;32978.5053224197;52046;52747.736261318445;52830.471695282555;53017.7349113252;53121.734391327795;599596.0020199871;604764;606636;606652;900232;24575.754242457348;27465.588016179372;27997.720022799513;28024.439511209253;28742.425151496434;48601.75699121482;49131.5086849127;49260.26109608287;49473.75263123805;49730;39529.80235098921;40680.79659601683;42165.367519486615;42520.149597007265;42636.78681606572;40408;40422;41014;41872.79063604662;42120.78939605282;34323.65676343304;40145.59854401419;40658;40755;42457.57542424536;32672.673273266962;35682.82158589294;36119;36513.90458286255;36532.634673653985;26277.868610656824;26476.338091547866;26608.600870986564;26871.73159117685;26948.461030778883 17:35:24 INFO - PROCESS | 1920 | |2;jquery.html;368.15875723970714;374.0965568152911;384.164442337915;391.8824352694191;407.8715204710516;19898.90050549747;21613.891930540325;22030.669539956874;22259.55480890383;22578.88710556449;18399.816001839976;20977.16091356344;21167.153313867428;21584.784152158474;21938.89030554845;5915.260592425947;5937.643741375531;5992.131140984566;6260.342664020281;6306.0225665022;4116.403121547389;4140.730852494593;6227.844303892393;6267.937320626781;6283.497320214395;6573.211214654249;6855.006024126498;6935.514513984023;6989.056477375566;7000.824979375531;6198.1632479615355;6271.999999999977;6296;6336.2396512418345;6971.442284617218;5904.321003084658;6126.448619624255;6143.078538219258;6147.293061297919;6148.38516148386;13213.86786132136;13628.114172578751;13642.931785341108;13644.93177534106;14558.927205363905;2369.680093187415;2477.5168842075805;2498.5502609530276;2597.5843864981703;2721.142840005392;9779.41323520591;10154.28919975602;10225.590976360936;10257.487125643687;10264.794704105876;1566.890317677763;1911.0864788899698;1919.1172060852025;1981.7621885373703;1983.7917018712972;88834;119036;124499.13251301147;130077;136282;11241.606543771093;11548.653540393801;11598.420078996016;11655.76688466226;11765.941170294265;14681.192534410497;14682.486112985995;14692.338844752012;14718;14727.926360368343;8591.871121933176;8854.77863053416;8870.51212183336;8980.955095224483;9030.413023153475;8985.820283594292;9003.594838232295;9025.277977761763;9046.909530904739;9125;4448.310511870665;4456.9331460028125;4464.620507256919;4467.910641787146;4518.796654150571;1739.9391021314193;1795.634582519807;1839.8160183981763;1891.7351570780102;1892.9148188331558;797.2983774278598;867.3260607028495;921.995390023059;954.3081266082035;954.9713508594754;21850.35641294047;21998.89000554987;22154;22156.778432215793;22224.88887555552;936.9953150234205;937.9155875971059;943.4905151218403;966.3622009473713;974.8635191073255;11232.606858760068;11577.732131880142;11749.060075194135;11758.529658813723;11790;630610;644063;644149;653534;660886;98685;128250;135304.99999999802;146626.2668686671;158096;862.4652715316544;949.9287553433381;998.6404894238068;1049.4437947887632;1051.8369652703996;18715.438536843918;19362;20283.895260980153;20475;20584.485387865425;54667.179992300946;57003;58605;61263;61441.77116457735;85177;86487;86770.13229867621;87190.1280987182;88664.5566772162;7300.634968251672;7620.8475830481975;8155.469894456842;8314.792130196793;8345.916540834756;12699.428525716181;13272.535461258809;13309.201447912768;13389.397477113747;13848;11492.425378731197;11588.594399195988;11768.823467648162;11772.941135294268;11900.702482438008;11226.550937962716;11321.660350189508;11596.826047609462;11656.941715291368;11876.465559050037;8332.000319923054;8338.393843764545;10122.797544049225;11562.47968841421;11868.703282418008;7502.474826762293;7505.286997735207;7534.924650753423;7656.349210317186;7844.803879903048;11022.50398732075;11264.887351126385;11413.258138220988;11589.188756786943;11750.471228794553 17:35:24 INFO - PROCESS | 1920 | |3;mootools.html;1537.262114185191;1559.1502631066069;1701.957451063724;1791.8835275707079;1941.9611607767845;8828.426152300104;9409.106134917189;9412.341136120474;9428.858567121499;9429.245660347173;8192.18078192182;8244.917550824504;9033.819323613523;9172.908270917289;9205.63177472902;2440.328909549875;2474.9752502475017;2477.4054226985572;2477.442575420534;2478.033566908907;2391.175044609607;2445.8654773987423;2447.339218411028;2447.3514518652573;2447.755224477547;2426.5429215894774;2435.744246854081;2449.608062709967;2450.9142180023705;2453.852768833876;2423.8060955123547;2427.720812106613;2427.987860060706;2428.9878550607223;2458.2870967419426;2426.6602675625427;2432.9270121896193;2442.5237078769646;2445.2786428003606;2447.49826285611;9099.681511147079;9297.953510232473;9307.441553506744;9307.76730581734;9308.720738377859;5457.863553411157;5638.267025286727;5638.4361563843695;5638.605297629168;5639.830805075854;3534.861408847636;3653.0319465341704;3726.919193433901;3728.832202550892;3737.5328083989502;1096.117625311624;1115.8047341715167;1120.3166068698088;1140.2588317593547;1145.34715212329;12137.757244855053;12229.694257643541;12254.019678425793;12258.570950016707;12258.957988571072;4388.648908087345;4652.651051171176;4853.0779151961015;4982.10322142018;5032.270320803536;10399.012093851072;10404.5838166474;10411.375317480975;10426.791464170674;10432.68701938943;5563.109902415594;5567.526760225345;5581.804636837691;5589.580781441408;5590.636608620427;4646.256598944153;4703.929441058387;4817.638677099231;5092.0579692756955;5095.694258344512;4078.9592104079175;4103.7688693391865;4206.747595144301;4219.346001369792;4235.97882010588;1307.3397934043248;1310.6133690561308;1319.070055610792;1328.8671132886634;1330.6673331667084;912.9729054813336;923.4690053219425;925.3799954030816;936.578539657157;951.1819834941945;5838.211841401441;5953.613015154001;6039.667818270037;6050.818475445743;6388.2653494847755;461.83835657520274;465.52051387070696;467.4904354253812;469.6970454057114;477.37940677119605;3990.2418540477215;4036;4068.1253530490494;4087.2847251731423;4099.713020088565;10907.29102608328;11430.885691142983;11435.828462573068;11460.59887903936;11481.655550333504;11331.263467874562;11368.317900925971;11379.886201137882;11394.544218231344;11407.828882566768;8472.364572657076;8503.957480212559;8584.31325493959;8600.311975041981;8600.483970961763;5869.735861886311;5950.702464876826;6037.335893051673;6058.4244496772735;6103.551493406211;10104.949475252577;10221.846672299773;10399.376037437778;10513.158947284046;10526.052655261063;10697.732556686145;10750.354978701303;10758.462076895967;10762.300450470695;10823.134149267882;6939.4448444125355;7506.099268087864;7822.491538050009;7916.564588947663;8042.638081286474;8613.353998450266;8842.425242359226;8847.557622118997;8852.822943540965;8864.73405797827;7715.459917805924;7834.412419068479;7872.685092596232;7975.481593696391;7983.20167983197;7568.508046976929;7601.619919004138;7692.8461430772195;7730.111037230566;7750.689972401041;7141.285871413025;7256.4194864409665;7263.0921134858145;7266.564006159436;7267.527610705287;4801;4861.635377346643;4971.776270067928;4989.501049894981;5089.0839648862075;4893.314935908905;4899.363082799213;5062.974685126551;5111.182210846247;5112.488751124858 17:35:24 INFO - PROCESS | 1920 | |4;prototype.html;305.27192645540384;306.14432660713305;314.7450565042315;316.3057089688135;322.3408130373386;5477.78088876445;5498.972505137479;5529.281193444856;5544.6673199608;5559.388467268607;5161.329027226455;5238.580913526918;5387.925648625278;5400.243965844775;5480.287562616854;3821.3823530881436;3934.7212156049254;4174.8121334539865;4178.498580170369;4208.253574766468;4169.124483858393;4188.308929026723;4193.483909654214;4218.4516012918275;4239.533651298355;3982.62165094317;4156.812943417538;4157.7548124013;4182.142660754554;4189.832406703744;3737.9907424995235;3865.45808674806;3951.3085210088407;4084.326086195774;4186.204621122008;3207.6471588125287;3353.6814002669707;3376.834991927781;3408.522806807049;3689.7786132832116;4981.252812078181;5116.05826649678;5296.960670141984;5336.786528538853;5391.649542779707;4613.5847773700525;4641.280601506772;4667;4688.226442636961;4699.835505757316;5278.313819203518;5428.701421421821;5554.2779438672715;5735.139729040636;5748.5975981681295;3142.3872344892757;3652.214773823641;3796.6393192646656;3834.290656228579;3837.424386342043;5497.9828731684765;5561.860953476195;6003.729832157564;6032.788852390146;6062.424069713415;3344.1973926257524;3491.5810102787827;3986.282469155522;3991.5210174779213;4000.319945609195;3908.3746600543777;4027.469561566586;4074.694397920168;4076.5515793262716;4084.7753373564146;3967.3652215645357;4315.3095504719095;4640.350350950869;4698.449511661143;4707.670463067621;4839.733814640158;4843.467218605951;5198.298229738937;5352;5773.364929857712;1178.675864137352;1209.5464200924653;1285.466531389463;1325.2114991579995;1338.3709656461447;902.5397047505688;920.2147833203697;924.4915296586851;925.22281283722;927.188709878856;5008.874778130576;5283.2075188722;5518.724063796794;5518.779248830002;5552.278203833475;4950.702957822542;5580.2466666999435;5800;5918.46733793952;5960.612560183574;4874.8537543873745;5376.946230537723;5474.084070575346;5485.626339800993;5500.312460942382;2910.3306239565018;2962.70372962702;3040.920473232015;3084;3092.567040614316;5021.012497563944;5039.118154322979;5671.943280567141;6015.639061656315;6044.546659000593;5185.974070129625;5204.193350030751;5840.474357307778;5993.583657315288;6001.459868611846;5066.695998240118;5270.893112446276;5998.25021872266;6057;6063.484603808637;5140.537351638371;5292.259083728358;5755.53955683536;5796.652200867961;5847.766089356378;5581.162825576033;5780.913286300624;5805.8548536286935;5809.360970293349;5815.94184058154;5760.308762948473;6024.909626355696;6049.909251361145;6196.597221180609;6212.235555177903;3335.416302147163;3593.3531964246686;3686.870959516404;3734.738568300193;4036.6367026967714;5552.7223638818705;5557.610967232255;6084.7566097357385;6114.541409394402;6128.142060111499;5485.369182543899;5868.853278668067;5872.853178670567;5878.735456904364;5922.3485416605;5134.204198349262;5176.637635365639;5473.945260547343;5835.387284335084;5862.501687356623;5124.641275110706;5194.97402512985;5458.744488767685;5550.500454959073;5589.832305030855;5223.608229382736;5288.153895376721;5375.00562395958;5793.710314484343;5794.304683438015;5331.453878375228;5590.692511911884;5655.236543066798;5671.688057156896;5671.873047607147 17:35:24 INFO - PROCESS | 1920 | |5;yui.html;747.7083937264467;778.1790211327051;805.9032916050074;833.5415521463194;857.879896814446;16334.591635209112;17085.82914170861;17094.91452542737;17179.742303865452;17211.397601083965;12681.17572357796;14496.275186240671;14548.272586370666;14556.490522831704;14565.92717036416;859.8925134358221;878.9648414063462;879.7360791762478;880.6345366672823;881.823635272948;699.2657709405104;717.6196615793638;717.6268340462956;871.8648609465542;876.5398165962889;749.4716225061319;923.6443969071922;947.8720372749694;952.9142377186051;953.4041224234853;942.1991307388734;944.1266828183936;944.1785646487565;944.4427787605346;944.9905500944972;698.4656737595743;698.7135274537466;698.9336013078749;699.164498424383;700.184285307616;16006.439774607832;16067.758983615255;16077.91961040199;16090.597735056717;16127.435539756052;14405.20771357575;14644.341004654816;14700.485483008044;14728.705425891529;14740.3366848491;13104.475820967149;13147.276899770508;13316.733665326736;13331;13687.24720140392;4608.262677971508;4653.325267836145;4656.906861862778;4821.63837712173;4840;125990.37004814917;129824;129829.35085324607;130279.69720302771;130410;10893.183011274186;11300.15248856339;11459.828102578467;11588.94205528967;11688.70778230534;19525.804741952397;22921.88539057294;23267.418314541934;23316.65025024626;23334.64998025031;8068.47554908929;8216.876746848802;8317.459365141247;8361.707340243061;8488.872666910001;4150.501939767248;4335.978320108379;4354.521002689701;4472.060867217856;4502.662300327489;3518.665726755954;3662.9633703663153;3665.1753355495334;3665.9266814663556;3669.3945498992366;641.2785616181795;655.452696998012;666.8299583606247;669.4477056428466;670.7162113005224;552.4530714592524;613.9140520327157;628.739073284591;631.5231999840091;638.6295948349946;8570.4000719949;8879.556022198864;8935.106489351143;9018.819623607622;9065.909340906506;588.9204957330705;609.8993666045142;610.0056907241169;645.3772109913956;655.452696998012;4298.140371925628;4329.502107257643;4354.129174165179;4411.228035093845;4457.086297309044;98001;107743.46128269308;132890;138550.30724846313;150783.24608376887;127084.7291527073;129943.35028324797;130321.34839325743;133520;135535;76685.61657191678;78694;114566;116234.41882790701;116512.41743791227;9634.229261659191;9929.553170107218;9932.702018939442;9939.751506212113;9948.850767238642;64348.71302574016;64681;64710.352896472315;65553.01670474852;66172.33827661662;70517;74818.25181748113;75370;103679.4816025915;106833.46583267034;13705.314734263446;13938.860611393757;14485.782713259521;14534;14801.407943682132;14847.331870065656;14889.702205956037;15934.442294519637;16012.919935400249;16077.75883361727;14076.78884816749;14631.414743410145;14659.120452772868;14681.853181468048;14698.191599462132;14120.50578229757;14186.787198192242;14578.198199099152;14898.478553250585;14940.477083302032;13983.650408739863;14324.856751432353;14574;14799.18604476764;14974.326155323255;10549.736256593647;10864.728381790519;11236.719082023015;11593.7101572458;11891.643250702493;8965.865512017455;11608.187426880037;11889.28664280146;11898.881011189776;11912.76174476523 17:35:24 INFO - PROCESS | 1920 | __end_tp_report 17:35:24 INFO - PROCESS | 1920 | __start_cc_report 17:35:24 INFO - PROCESS | 1920 | _x_x_mozilla_cycle_collect,1322 17:35:24 INFO - PROCESS | 1920 | __end_cc_report 17:35:24 INFO - PROCESS | 1920 | __startTimestamp1483666524228__endTimestamp 17:35:24 INFO - PROCESS | 1920 | 17:35:24 INFO - PROCESS | 1920 | ------- Summary: start ------- 17:35:24 INFO - PROCESS | 1920 | Number of tests: 6 17:35:24 INFO - PROCESS | 1920 | 17:35:24 INFO - PROCESS | 1920 | [#0] dojo.html Cycles:165 Average:5770.79 Median:6013.40 stddev:632.21 (10.5%) stddev-sans-first:605.73 17:35:24 INFO - PROCESS | 1920 | Values: 3381.8 3395.1 3423.8 3447.8 3477.9 5669.3 5693.3 5721.0 5742.5 5754.9 5628.7 5728.9 5750.4 5770.0 5776.4 5222.7 5225.6 5239.8 5243.7 5276.6 5180.5 5211.8 5318.0 5321.7 5356.8 5216.2 5221.8 5233.8 5249.6 5253.9 5220.9 5239.1 5240.2 5280.7 5301.0 5166.2 5232.0 5242.8 5247.6 5297.5 5568.8 5630.5 5636.5 5637.6 5670.9 6119.6 6188.4 6191.9 6200.4 6215.3 6267.0 6318.7 6329.6 6340.7 6365.6 5639.9 5691.9 5697.3 5727.0 5803.6 6215.2 6225.9 6254.6 6270.1 6273.2 6150.5 6160.5 6167.2 6181.8 6185.0 6065.6 6194.9 6280.5 6286.3 6290.0 6113.1 6175.1 6176.6 6199.5 6274.6 6236.3 6291.2 6299.8 6306.7 6318.7 4923.6 4978.5 4979.0 5003.9 5007.2 4380.6 4415.8 4431.0 4431.2 4475.1 5925.5 5926.6 5938.3 5958.4 5964.2 6307.9 6331.6 6333.9 6341.1 6369.8 5604.4 5705.5 5709.5 5821.5 5894.1 5379.1 5416.7 5424.2 5443.4 5451.9 6277.4 6289.5 6293.1 6296.8 6297.2 6124.8 6302.9 6335.7 6356.2 6359.6 5274.5 6200.4 6230.3 6272.4 6280.1 6184.4 6236.0 6243.4 6266.0 6281.8 6272.5 6327.8 6329.6 6342.2 6342.5 5974.7 6046.9 6050.9 6086.1 6158.7 6151.1 6162.0 6162.6 6180.7 6185.5 5857.5 5990.7 5997.7 6022.6 6025.5 5990.0 6013.4 6076.0 6101.5 6125.8 5912.5 6019.5 6048.2 6053.8 6059.4 17:35:24 INFO - PROCESS | 1920 | 17:35:24 INFO - PROCESS | 1920 | [#1] ext.html Cycles:180 Average:71769.46 Median:35696.05 stddev:165073.99 (462.4%) stddev-sans-first:165450.27 17:35:24 INFO - PROCESS | 1920 | Values: 475.1 494.8 505.5 523.4 547.3 28505.6 42768.0 43660.3 43702.0 45850.8 44927.3 45495.8 45607.0 45613.3 45637.5 9841.9 10020.7 10035.6 10036.3 10083.2 9215.1 9406.4 12182.6 12430.5 12432.4 12315.1 12380.1 12386.6 12402.4 12418.0 12330.8 12400.4 12403.7 12421.9 12449.8 12109.7 12148.8 12185.6 12196.9 12213.2 41520.2 41949.0 41957.0 41957.6 42008.6 3468.1 3652.7 3668.9 3732.6 3984.5 26924.9 30264.0 31091.7 32998.2 33070.5 3121.0 3424.7 3462.4 3500.5 3519.5 387566.0 389977.0 390268.0 390978.0 390987.0 34991.5 35464.6 35709.3 64709.7 64966.4 35801.6 36016.8 36070.1 36084.6 36100.5 15598.9 15809.4 15820.5 15830.3 15844.7 12364.3 12511.9 13207.1 13273.0 13284.7 7925.2 8159.9 8166.3 8190.1 8249.8 3279.8 3340.2 3340.9 3343.0 3365.7 902.9 1033.1 1053.7 1076.6 1087.0 28394.6 29845.1 30677.0 30883.7 30909.3 931.8 976.3 1033.2 1081.3 1143.5 15767.2 16418.8 16460.3 16502.4 16518.4 717271.0 724996.0 725698.0 725726.0 726052.0 61669.7 62263.7 62287.0 62429.4 62464.4 1166.6 1193.6 1312.1 1349.2 1410.9 31465.5 31518.2 32404.7 32454.0 32978.5 52046.0 52747.7 52830.5 53017.7 53121.7 599596.0 604764.0 606636.0 606652.0 900232.0 24575.8 27465.6 27997.7 28024.4 28742.4 48601.8 49131.5 49260.3 49473.8 49730.0 39529.8 40680.8 42165.4 42520.1 42636.8 40408.0 40422.0 41014.0 41872.8 42120.8 34323.7 40145.6 40658.0 40755.0 42457.6 32672.7 35682.8 36119.0 36513.9 36532.6 26277.9 26476.3 26608.6 26871.7 26948.5 17:35:24 INFO - PROCESS | 1920 | 17:35:24 INFO - PROCESS | 1920 | [#2] jquery.html Cycles:180 Average:36880.62 Median:2659.36 stddev:107905.73 (4057.6%) stddev-sans-first:108173.60 17:35:24 INFO - PROCESS | 1920 | Values: 368.2 374.1 384.2 391.9 407.9 19898.9 21613.9 22030.7 22259.6 22578.9 18399.8 20977.2 21167.2 21584.8 21938.9 5915.3 5937.6 5992.1 6260.3 6306.0 4116.4 4140.7 6227.8 6267.9 6283.5 6573.2 6855.0 6935.5 6989.1 7000.8 6198.2 6272.0 6296.0 6336.2 6971.4 5904.3 6126.4 6143.1 6147.3 6148.4 13213.9 13628.1 13642.9 13644.9 14558.9 2369.7 2477.5 2498.6 2597.6 2721.1 9779.4 10154.3 10225.6 10257.5 10264.8 1566.9 1911.1 1919.1 1981.8 1983.8 88834.0 119036.0 124499.1 130077.0 136282.0 11241.6 11548.7 11598.4 11655.8 11765.9 14681.2 14682.5 14692.3 14718.0 14727.9 8591.9 8854.8 8870.5 8981.0 9030.4 8985.8 9003.6 9025.3 9046.9 9125.0 4448.3 4456.9 4464.6 4467.9 4518.8 1739.9 1795.6 1839.8 1891.7 1892.9 797.3 867.3 922.0 954.3 955.0 21850.4 21998.9 22154.0 22156.8 22224.9 937.0 937.9 943.5 966.4 974.9 11232.6 11577.7 11749.1 11758.5 11790.0 630610.0 644063.0 644149.0 653534.0 660886.0 98685.0 128250.0 135305.0 146626.3 158096.0 862.5 949.9 998.6 1049.4 1051.8 18715.4 19362.0 20283.9 20475.0 20584.5 54667.2 57003.0 58605.0 61263.0 61441.8 85177.0 86487.0 86770.1 87190.1 88664.6 7300.6 7620.8 8155.5 8314.8 8345.9 12699.4 13272.5 13309.2 13389.4 13848.0 11492.4 11588.6 11768.8 11772.9 11900.7 11226.6 11321.7 11596.8 11656.9 11876.5 8332.0 8338.4 10122.8 11562.5 11868.7 7502.5 7505.3 7534.9 7656.3 7844.8 11022.5 11264.9 11413.3 11589.2 11750.5 17:35:24 INFO - PROCESS | 1920 | 17:35:24 INFO - PROCESS | 1920 | [#3] mootools.html Cycles:180 Average:5947.68 Median:468.59 stddev:3398.44 (725.2%) stddev-sans-first:3391.81 17:35:24 INFO - PROCESS | 1920 | Values: 1537.3 1559.2 1702.0 1791.9 1942.0 8828.4 9409.1 9412.3 9428.9 9429.2 8192.2 8244.9 9033.8 9172.9 9205.6 2440.3 2475.0 2477.4 2477.4 2478.0 2391.2 2445.9 2447.3 2447.4 2447.8 2426.5 2435.7 2449.6 2450.9 2453.9 2423.8 2427.7 2428.0 2429.0 2458.3 2426.7 2432.9 2442.5 2445.3 2447.5 9099.7 9298.0 9307.4 9307.8 9308.7 5457.9 5638.3 5638.4 5638.6 5639.8 3534.9 3653.0 3726.9 3728.8 3737.5 1096.1 1115.8 1120.3 1140.3 1145.3 12137.8 12229.7 12254.0 12258.6 12259.0 4388.6 4652.7 4853.1 4982.1 5032.3 10399.0 10404.6 10411.4 10426.8 10432.7 5563.1 5567.5 5581.8 5589.6 5590.6 4646.3 4703.9 4817.6 5092.1 5095.7 4079.0 4103.8 4206.7 4219.3 4236.0 1307.3 1310.6 1319.1 1328.9 1330.7 913.0 923.5 925.4 936.6 951.2 5838.2 5953.6 6039.7 6050.8 6388.3 461.8 465.5 467.5 469.7 477.4 3990.2 4036.0 4068.1 4087.3 4099.7 10907.3 11430.9 11435.8 11460.6 11481.7 11331.3 11368.3 11379.9 11394.5 11407.8 8472.4 8504.0 8584.3 8600.3 8600.5 5869.7 5950.7 6037.3 6058.4 6103.6 10104.9 10221.8 10399.4 10513.2 10526.1 10697.7 10750.4 10758.5 10762.3 10823.1 6939.4 7506.1 7822.5 7916.6 8042.6 8613.4 8842.4 8847.6 8852.8 8864.7 7715.5 7834.4 7872.7 7975.5 7983.2 7568.5 7601.6 7692.8 7730.1 7750.7 7141.3 7256.4 7263.1 7266.6 7267.5 4801.0 4861.6 4971.8 4989.5 5089.1 4893.3 4899.4 5063.0 5111.2 5112.5 17:35:24 INFO - PROCESS | 1920 | 17:35:24 INFO - PROCESS | 1920 | [#4] prototype.html Cycles:180 Average:4624.71 Median:5254.74 stddev:1430.82 (27.2%) stddev-sans-first:1397.62 17:35:24 INFO - PROCESS | 1920 | Values: 305.3 306.1 314.7 316.3 322.3 5477.8 5499.0 5529.3 5544.7 5559.4 5161.3 5238.6 5387.9 5400.2 5480.3 3821.4 3934.7 4174.8 4178.5 4208.3 4169.1 4188.3 4193.5 4218.5 4239.5 3982.6 4156.8 4157.8 4182.1 4189.8 3738.0 3865.5 3951.3 4084.3 4186.2 3207.6 3353.7 3376.8 3408.5 3689.8 4981.3 5116.1 5297.0 5336.8 5391.6 4613.6 4641.3 4667.0 4688.2 4699.8 5278.3 5428.7 5554.3 5735.1 5748.6 3142.4 3652.2 3796.6 3834.3 3837.4 5498.0 5561.9 6003.7 6032.8 6062.4 3344.2 3491.6 3986.3 3991.5 4000.3 3908.4 4027.5 4074.7 4076.6 4084.8 3967.4 4315.3 4640.4 4698.4 4707.7 4839.7 4843.5 5198.3 5352.0 5773.4 1178.7 1209.5 1285.5 1325.2 1338.4 902.5 920.2 924.5 925.2 927.2 5008.9 5283.2 5518.7 5518.8 5552.3 4950.7 5580.2 5800.0 5918.5 5960.6 4874.9 5376.9 5474.1 5485.6 5500.3 2910.3 2962.7 3040.9 3084.0 3092.6 5021.0 5039.1 5671.9 6015.6 6044.5 5186.0 5204.2 5840.5 5993.6 6001.5 5066.7 5270.9 5998.3 6057.0 6063.5 5140.5 5292.3 5755.5 5796.7 5847.8 5581.2 5780.9 5805.9 5809.4 5815.9 5760.3 6024.9 6049.9 6196.6 6212.2 3335.4 3593.4 3686.9 3734.7 4036.6 5552.7 5557.6 6084.8 6114.5 6128.1 5485.4 5868.9 5872.9 5878.7 5922.3 5134.2 5176.6 5473.9 5835.4 5862.5 5124.6 5195.0 5458.7 5550.5 5589.8 5223.6 5288.2 5375.0 5793.7 5794.3 5331.5 5590.7 5655.2 5671.7 5671.9 17:35:24 INFO - PROCESS | 1920 | 17:35:24 INFO - PROCESS | 1920 | [#5] yui.html Cycles:180 Average:24835.12 Median:3665.55 stddev:38739.57 (1056.9%) stddev-sans-first:38806.03 17:35:24 INFO - PROCESS | 1920 | Values: 747.7 778.2 805.9 833.5 857.9 16334.6 17085.8 17094.9 17179.7 17211.4 12681.2 14496.3 14548.3 14556.5 14565.9 859.9 879.0 879.7 880.6 881.8 699.3 717.6 717.6 871.9 876.5 749.5 923.6 947.9 952.9 953.4 942.2 944.1 944.2 944.4 945.0 698.5 698.7 698.9 699.2 700.2 16006.4 16067.8 16077.9 16090.6 16127.4 14405.2 14644.3 14700.5 14728.7 14740.3 13104.5 13147.3 13316.7 13331.0 13687.2 4608.3 4653.3 4656.9 4821.6 4840.0 125990.4 129824.0 129829.4 130279.7 130410.0 10893.2 11300.2 11459.8 11588.9 11688.7 19525.8 22921.9 23267.4 23316.7 23334.6 8068.5 8216.9 8317.5 8361.7 8488.9 4150.5 4336.0 4354.5 4472.1 4502.7 3518.7 3663.0 3665.2 3665.9 3669.4 641.3 655.5 666.8 669.4 670.7 552.5 613.9 628.7 631.5 638.6 8570.4 8879.6 8935.1 9018.8 9065.9 588.9 609.9 610.0 645.4 655.5 4298.1 4329.5 4354.1 4411.2 4457.1 98001.0 107743.5 132890.0 138550.3 150783.2 127084.7 129943.4 130321.3 133520.0 135535.0 76685.6 78694.0 114566.0 116234.4 116512.4 9634.2 9929.6 9932.7 9939.8 9948.9 64348.7 64681.0 64710.4 65553.0 66172.3 70517.0 74818.3 75370.0 103679.5 106833.5 13705.3 13938.9 14485.8 14534.0 14801.4 14847.3 14889.7 15934.4 16012.9 16077.8 14076.8 14631.4 14659.1 14681.9 14698.2 14120.5 14186.8 14578.2 14898.5 14940.5 13983.7 14324.9 14574.0 14799.2 14974.3 10549.7 10864.7 11236.7 11593.7 11891.6 8965.9 11608.2 11889.3 11898.9 11912.8 17:35:24 INFO - PROCESS | 1920 | -------- Summary: end -------- 17:35:24 INFO - PROCESS | 1920 | 17:35:24 INFO - TEST-INFO | 1920: exit 0 17:35:24 INFO - TEST-OK | dromaeo_css | took 1115876ms 17:35:24 INFO - TEST-START | kraken 17:35:24 INFO - operating with platform_type : mac_ 17:35:24 INFO - Initialising browser for kraken test... 17:35:24 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpH9mMEO/profile http://localhost:49714/getInfo.html) 17:35:26 INFO - PROCESS | 1924 | __metrics Screen width/height:1600/1200 17:35:26 INFO - PROCESS | 1924 | colorDepth:24 17:35:26 INFO - PROCESS | 1924 | Browser inner width/height: 1024/689 17:35:26 INFO - PROCESS | 1924 | __metrics 17:35:26 INFO - PROCESS | 1924 | 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" 17:35:26 INFO - PROCESS | 1924 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:35:27 INFO - TEST-INFO | 1924: exit 0 17:35:27 INFO - Browser initialized. 17:35:27 INFO - Running cycle 1/1 for kraken test... 17:35:27 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpH9mMEO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:39 INFO - PROCESS | 1926 | RSS: Main: 168701952 17:35:39 INFO - PROCESS | 1926 | 17:35:42 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49714/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:43 INFO - PROCESS | 1926 | RSS: Main: 219615232 17:35:43 INFO - PROCESS | 1926 | 17:35:46 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49714/tests/kraken/driver.html?testName=audio-dft) 17:35:46 INFO - PROCESS | 1926 | RSS: Main: 234082304 17:35:46 INFO - PROCESS | 1926 | 17:35:49 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49714/tests/kraken/driver.html?testName=audio-fft) 17:35:50 INFO - PROCESS | 1926 | RSS: Main: 329568256 17:35:50 INFO - PROCESS | 1926 | 17:35:52 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49714/tests/kraken/driver.html?testName=audio-oscillator) 17:35:52 INFO - PROCESS | 1926 | RSS: Main: 227680256 17:35:52 INFO - PROCESS | 1926 | 17:35:54 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49714/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:55 INFO - PROCESS | 1926 | RSS: Main: 228302848 17:35:55 INFO - PROCESS | 1926 | 17:35:58 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49714/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:58 INFO - PROCESS | 1926 | RSS: Main: 267956224 17:35:59 INFO - PROCESS | 1926 | 17:36:02 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49714/tests/kraken/driver.html?testName=imaging-desaturate) 17:36:02 INFO - PROCESS | 1926 | RSS: Main: 268021760 17:36:02 INFO - PROCESS | 1926 | 17:36:05 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49714/tests/kraken/driver.html?testName=json-parse-financial) 17:36:05 INFO - PROCESS | 1926 | RSS: Main: 266272768 17:36:05 INFO - PROCESS | 1926 | 17:36:07 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49714/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:36:08 INFO - PROCESS | 1926 | RSS: Main: 239497216 17:36:08 INFO - PROCESS | 1926 | 17:36:09 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49714/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:36:10 INFO - PROCESS | 1926 | RSS: Main: 245280768 17:36:10 INFO - PROCESS | 1926 | 17:36:12 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49714/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:36:13 INFO - PROCESS | 1926 | RSS: Main: 247394304 17:36:13 INFO - PROCESS | 1926 | 17:36:16 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:36:17 INFO - PROCESS | 1926 | RSS: Main: 265035776 17:36:17 INFO - PROCESS | 1926 | 17:36:19 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:36:20 INFO - PROCESS | 1926 | RSS: Main: 258506752 17:36:20 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49714/tests/kraken/driver.html?testName=ai-astar) 17:36:22 INFO - PROCESS | 1926 | RSS: Main: 302817280 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | __start_tp_report 17:36:22 INFO - PROCESS | 1926 | _x_x_mozilla_page_load 17:36:22 INFO - PROCESS | 1926 | _x_x_mozilla_page_load_details 17:36:22 INFO - PROCESS | 1926 | |i|pagename|runs| 17:36:22 INFO - PROCESS | 1926 | |0;ai-astar;116;159;164;113;113;114;111;113;113;114 17:36:22 INFO - PROCESS | 1926 | |1;audio-beat-detection;143;109;115;173;136;91;137;135;165;125 17:36:22 INFO - PROCESS | 1926 | |2;audio-dft;181;183;183;184;181;182;184;183;185;182 17:36:22 INFO - PROCESS | 1926 | |3;audio-fft;81;58;59;104;86;81;62;57;82;59 17:36:22 INFO - PROCESS | 1926 | |4;audio-oscillator;89;69;93;70;68;69;90;69;68;91 17:36:22 INFO - PROCESS | 1926 | |5;imaging-gaussian-blur;91;87;91;87;88;128;91;86;78;93 17:36:22 INFO - PROCESS | 1926 | |6;imaging-darkroom;98;98;97;98;97;111;158;95;157;157 17:36:22 INFO - PROCESS | 1926 | |7;imaging-desaturate;86;83;85;83;84;84;84;85;84;89 17:36:22 INFO - PROCESS | 1926 | |8;json-parse-financial;55;52;52;51;54;57;56;57;57;57 17:36:22 INFO - PROCESS | 1926 | |9;json-stringify-tinderbox;63;72;69;81;74;73;69;70;70;75 17:36:22 INFO - PROCESS | 1926 | |10;stanford-crypto-aes;83;89;97;97;94;69;96;91;97;98 17:36:22 INFO - PROCESS | 1926 | |11;stanford-crypto-ccm;137;135;135;132;133;134;139;142;165;133 17:36:22 INFO - PROCESS | 1926 | |12;stanford-crypto-pbkdf2;215;144;196;211;162;182;199;157;161;161 17:36:22 INFO - PROCESS | 1926 | |13;stanford-crypto-sha256-iterative;65;65;63;65;64;66;66;63;67;64 17:36:22 INFO - PROCESS | 1926 | __end_tp_report 17:36:22 INFO - PROCESS | 1926 | __start_cc_report 17:36:22 INFO - PROCESS | 1926 | _x_x_mozilla_cycle_collect,1962 17:36:22 INFO - PROCESS | 1926 | __end_cc_report 17:36:22 INFO - PROCESS | 1926 | __startTimestamp1483666582478__endTimestamp 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | ------- Summary: start ------- 17:36:22 INFO - PROCESS | 1926 | Number of tests: 14 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#0] ai-astar Cycles:10 Average:123.00 Median:114.00 stddev:20.36 (17.9%) stddev-sans-first:21.44 17:36:22 INFO - PROCESS | 1926 | Values: 116.0 159.0 164.0 113.0 113.0 114.0 111.0 113.0 113.0 114.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:140.00 stddev:24.68 (17.6%) stddev-sans-first:25.90 17:36:22 INFO - PROCESS | 1926 | Values: 143.0 109.0 115.0 173.0 136.0 91.0 137.0 135.0 165.0 125.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:1.32 (0.7%) stddev-sans-first:1.22 17:36:22 INFO - PROCESS | 1926 | Values: 181.0 183.0 183.0 184.0 181.0 182.0 184.0 183.0 185.0 182.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#3] audio-fft Cycles:10 Average:72.90 Median:71.50 stddev:16.10 (22.5%) stddev-sans-first:16.81 17:36:22 INFO - PROCESS | 1926 | Values: 81.0 58.0 59.0 104.0 86.0 81.0 62.0 57.0 82.0 59.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.50 stddev:11.37 (14.3%) stddev-sans-first:11.29 17:36:22 INFO - PROCESS | 1926 | Values: 89.0 69.0 93.0 70.0 68.0 69.0 90.0 69.0 68.0 91.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:89.50 stddev:13.32 (14.9%) stddev-sans-first:14.13 17:36:22 INFO - PROCESS | 1926 | Values: 91.0 87.0 91.0 87.0 88.0 128.0 91.0 86.0 78.0 93.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#6] imaging-darkroom Cycles:10 Average:116.60 Median:97.00 stddev:28.45 (29.3%) stddev-sans-first:29.36 17:36:22 INFO - PROCESS | 1926 | Values: 98.0 98.0 97.0 98.0 97.0 111.0 158.0 95.0 157.0 157.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:84.50 stddev:1.77 (2.1%) stddev-sans-first:1.81 17:36:22 INFO - PROCESS | 1926 | Values: 86.0 83.0 85.0 83.0 84.0 84.0 84.0 85.0 84.0 89.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:56.50 stddev:2.39 (4.2%) stddev-sans-first:2.54 17:36:22 INFO - PROCESS | 1926 | Values: 55.0 52.0 52.0 51.0 54.0 57.0 56.0 57.0 57.0 57.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.50 stddev:4.72 (6.5%) stddev-sans-first:3.84 17:36:22 INFO - PROCESS | 1926 | Values: 63.0 72.0 69.0 81.0 74.0 73.0 69.0 70.0 70.0 75.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:96.50 stddev:9.09 (9.4%) stddev-sans-first:9.15 17:36:22 INFO - PROCESS | 1926 | Values: 83.0 89.0 97.0 97.0 94.0 69.0 96.0 91.0 97.0 98.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:136.00 stddev:9.80 (7.2%) stddev-sans-first:10.38 17:36:22 INFO - PROCESS | 1926 | Values: 137.0 135.0 135.0 132.0 133.0 134.0 139.0 142.0 165.0 133.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:189.00 stddev:25.09 (13.3%) stddev-sans-first:22.93 17:36:22 INFO - PROCESS | 1926 | Values: 215.0 144.0 196.0 211.0 162.0 182.0 199.0 157.0 161.0 161.0 17:36:22 INFO - PROCESS | 1926 | 17:36:22 INFO - PROCESS | 1926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.32 (2.0%) stddev-sans-first:1.39 17:36:22 INFO - PROCESS | 1926 | Values: 65.0 65.0 63.0 65.0 64.0 66.0 66.0 63.0 67.0 64.0 17:36:22 INFO - PROCESS | 1926 | -------- Summary: end -------- 17:36:22 INFO - PROCESS | 1926 | 17:36:23 INFO - TEST-INFO | 1926: exit 0 17:36:23 INFO - TEST-OK | kraken | took 58479ms 17:36:23 INFO - SUITE-END | took 1174s 17:36:23 INFO - Completed test suite (00:19:34) 17:36:23 INFO - javascript benchmark 17:36:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3381.797092174469, 3395.0833275015752, 3423.8116903570294, 3447.793132412057, 3477.8956631301053, 5669.348024977124, 5693.3452652944925, 5720.9713951430185, 5742.511886489643, 5754.935336962665, 5628.71856407179, 5728.942710572893, 5750.424957504248, 5769.990251705945, 5776.4223577642215, 5222.712750798704, 5225.634205605609, 5239.79040838366, 5243.737813109329, 5276.630635855492, 5180.481951804827, 5211.817586384477, 5318.0, 5321.733913304339, 5356.758945847446, 5216.217567364888, 5221.817236396727, 5233.816816411427, 5249.580033597303, 5253.947460525404, 5220.947790522103, 5239.13554263546, 5240.213967904807, 5280.735963201824, 5301.0, 5166.199239117943, 5232.03207406631, 5242.7640756166065, 5247.580193584504, 5297.496737809902, 5568.832935011957, 5630.465105814982, 5636.464535869086, 5637.605367624268, 5670.914936275959, 6119.592558463849, 6188.443040126365, 6191.938080619181, 6200.379962003809, 6215.316315205324, 6266.968665156691, 6318.652474113922, 6329.556931014831, 6340.682965851689, 6365.554411191219, 5639.943600563983, 5691.8861622768145, 5697.3448053474385, 5726.971365143231, 5803.564732645069, 6215.192025036807, 6225.875482490324, 6254.593451425642, 6270.122182894398, 6273.1844860167885, 6150.538709596798, 6160.507159427235, 6167.229096362955, 6181.84545386369, 6184.969075154595, 6065.5754097212775, 6194.876102477925, 6280.528960327993, 6286.277078135981, 6290.0, 6113.111460343413, 6175.073738939195, 6176.629402235881, 6199.473044791243, 6274.592151510137, 6236.251649802053, 6291.245050593958, 6299.842503937347, 6306.716197771111, 6318.6524741138755, 4923.556879880828, 4978.5270399312, 4979.0, 5003.874903127451, 5007.173816320339, 4380.649548036149, 4415.757133357696, 4430.955690443118, 4431.180231657154, 4475.149721552894, 5925.466707996301, 5926.614770039933, 5938.287405511366, 5958.404159584007, 5964.194833697482, 6307.905381419282, 6331.620102793847, 6333.873322533524, 6341.112244285804, 6369.8089057327425, 5604.439556044363, 5705.5150312223095, 5709.486146246774, 5821.534277257894, 5894.145348924382, 5379.1393377059485, 5416.729163541807, 5424.213489044067, 5443.401225865152, 5451.945480545223, 6277.372262773686, 6289.49684025286, 6293.118963345135, 6296.811095667137, 6297.244330680348, 6124.816255512342, 6302.873942521215, 6335.714892829926, 6356.237251529846, 6359.618422894641, 5274.498922602346, 6200.441960223601, 6230.345813689497, 6272.372762723691, 6280.120783090462, 6184.350643182581, 6236.03341482071, 6243.406876346739, 6266.028765541349, 6281.811545653638, 6272.529560283088, 6327.778527751507, 6329.588576742497, 6342.175517182736, 6342.460890824332, 5974.6713930732485, 6046.909296360646, 6050.939490605214, 6086.147939288415, 6158.661273629814, 6151.0773383992755, 6161.969190154021, 6162.568620196723, 6180.6909654517995, 6185.474234690102, 5857.47282744555, 5990.670513121646, 5997.670128142994, 6022.638641681513, 6025.487833534199, 5989.970050149721, 6013.398660133952, 6075.969620151871, 6101.542384321105, 6125.816225513242, 5912.49743771767, 6019.54853385989, 6048.213732214784, 6053.788117415869, 6059.424354686298], "value": 5730.552812170638, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.0925731852163, 494.84165067178503, 505.4743067210102, 523.3562717857034, 547.3459216236599, 28505.572416413743, 42767.99999999996, 43660.345094823606, 43702.0, 45850.77074614622, 44927.326090108596, 45495.77252113743, 45607.0, 45613.31580026294, 45637.54362456375, 9841.852372214405, 10020.749481262954, 10035.648752293671, 10036.347637403545, 10083.243756718239, 9215.124563166522, 9406.388584742004, 12182.573609923655, 12430.502779888793, 12432.440540175669, 12315.076369272296, 12380.071494637938, 12386.566470173546, 12402.379881005914, 12418.006559475265, 12330.815037774395, 12400.441980110916, 12403.689907752288, 12421.93789031058, 12449.75100497985, 12109.697257568543, 12148.817767733492, 12185.634430967086, 12196.939015304955, 12213.206141600767, 41520.169596608204, 41948.95127621803, 41957.0, 41957.58042419567, 42008.57991420108, 3468.115630514228, 3652.726045546595, 3668.8715894943816, 3732.5707543632557, 3984.5218573771044, 26924.86537567319, 30264.0, 31091.689083109104, 32998.17504562405, 33070.50394244088, 3120.968790312113, 3424.6746559076846, 3462.3767721810063, 3500.5099286099967, 3519.454484554898, 387566.0, 389977.0, 390268.0, 390978.0, 390987.0, 34991.475127873106, 35464.64535354665, 35709.28581428357, 64709.67645161744, 64966.35033649697, 35801.64198357983, 36016.819915900254, 36070.09824754402, 36084.63915360865, 36100.45849312263, 15598.9220053899, 15809.367625294859, 15820.525384238492, 15830.28763705636, 15844.683106337809, 12364.258144511357, 12511.874881251071, 13207.07550471477, 13273.0, 13284.734305314032, 7925.167857374892, 8159.877601835978, 8166.346692264605, 8190.140035296327, 8249.752507424666, 3279.7868138571394, 3340.1816554944194, 3340.916477088044, 3343.0, 3365.7139143172617, 902.8600566912007, 1033.0599154769125, 1053.7365658585354, 1076.5747529725716, 1086.9891301086889, 28394.574081388382, 29845.10464686063, 30677.0, 30883.69116308853, 30909.334537640083, 931.8089791592707, 976.3214565876648, 1033.225081189108, 1081.324172392255, 1143.4968613809897, 15767.186773521193, 16418.753718694228, 16460.341586336654, 16502.390603109874, 16518.42185523525, 717271.0, 724996.0, 725698.0, 725726.0, 726052.0, 61669.691651541456, 62263.68868155721, 62287.0, 62429.37570624326, 62464.37535624677, 1166.5683697032152, 1193.647873877191, 1312.068431413688, 1349.2174538767688, 1410.8941829362634, 31465.528017079305, 31518.212044699067, 32404.675953240167, 32454.026379208663, 32978.5053224197, 52046.0, 52747.736261318445, 52830.471695282555, 53017.7349113252, 53121.734391327795, 599596.0020199871, 604764.0, 606636.0, 606652.0, 900232.0, 24575.754242457348, 27465.588016179372, 27997.720022799513, 28024.439511209253, 28742.425151496434, 48601.75699121482, 49131.5086849127, 49260.26109608287, 49473.75263123805, 49730.0, 39529.80235098921, 40680.79659601683, 42165.367519486615, 42520.149597007265, 42636.78681606572, 40408.0, 40422.0, 41014.0, 41872.79063604662, 42120.78939605282, 34323.65676343304, 40145.59854401419, 40658.0, 40755.0, 42457.57542424536, 32672.673273266962, 35682.82158589294, 36119.0, 36513.90458286255, 36532.634673653985, 26277.868610656824, 26476.338091547866, 26608.600870986564, 26871.73159117685, 26948.461030778883], "value": 19627.90018802286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.15875723970714, 374.0965568152911, 384.164442337915, 391.8824352694191, 407.8715204710516, 19898.90050549747, 21613.891930540325, 22030.669539956874, 22259.55480890383, 22578.88710556449, 18399.816001839976, 20977.16091356344, 21167.153313867428, 21584.784152158474, 21938.89030554845, 5915.260592425947, 5937.643741375531, 5992.131140984566, 6260.342664020281, 6306.0225665022, 4116.403121547389, 4140.730852494593, 6227.844303892393, 6267.937320626781, 6283.497320214395, 6573.211214654249, 6855.006024126498, 6935.514513984023, 6989.056477375566, 7000.824979375531, 6198.1632479615355, 6271.999999999977, 6296.0, 6336.2396512418345, 6971.442284617218, 5904.321003084658, 6126.448619624255, 6143.078538219258, 6147.293061297919, 6148.38516148386, 13213.86786132136, 13628.114172578751, 13642.931785341108, 13644.93177534106, 14558.927205363905, 2369.680093187415, 2477.5168842075805, 2498.5502609530276, 2597.5843864981703, 2721.142840005392, 9779.41323520591, 10154.28919975602, 10225.590976360936, 10257.487125643687, 10264.794704105876, 1566.890317677763, 1911.0864788899698, 1919.1172060852025, 1981.7621885373703, 1983.7917018712972, 88834.0, 119036.0, 124499.13251301147, 130077.0, 136282.0, 11241.606543771093, 11548.653540393801, 11598.420078996016, 11655.76688466226, 11765.941170294265, 14681.192534410497, 14682.486112985995, 14692.338844752012, 14718.0, 14727.926360368343, 8591.871121933176, 8854.77863053416, 8870.51212183336, 8980.955095224483, 9030.413023153475, 8985.820283594292, 9003.594838232295, 9025.277977761763, 9046.909530904739, 9125.0, 4448.310511870665, 4456.9331460028125, 4464.620507256919, 4467.910641787146, 4518.796654150571, 1739.9391021314193, 1795.634582519807, 1839.8160183981763, 1891.7351570780102, 1892.9148188331558, 797.2983774278598, 867.3260607028495, 921.995390023059, 954.3081266082035, 954.9713508594754, 21850.35641294047, 21998.89000554987, 22154.0, 22156.778432215793, 22224.88887555552, 936.9953150234205, 937.9155875971059, 943.4905151218403, 966.3622009473713, 974.8635191073255, 11232.606858760068, 11577.732131880142, 11749.060075194135, 11758.529658813723, 11790.0, 630610.0, 644063.0, 644149.0, 653534.0, 660886.0, 98685.0, 128250.0, 135304.99999999802, 146626.2668686671, 158096.0, 862.4652715316544, 949.9287553433381, 998.6404894238068, 1049.4437947887632, 1051.8369652703996, 18715.438536843918, 19362.0, 20283.895260980153, 20475.0, 20584.485387865425, 54667.179992300946, 57003.0, 58605.0, 61263.0, 61441.77116457735, 85177.0, 86487.0, 86770.13229867621, 87190.1280987182, 88664.5566772162, 7300.634968251672, 7620.8475830481975, 8155.469894456842, 8314.792130196793, 8345.916540834756, 12699.428525716181, 13272.535461258809, 13309.201447912768, 13389.397477113747, 13848.0, 11492.425378731197, 11588.594399195988, 11768.823467648162, 11772.941135294268, 11900.702482438008, 11226.550937962716, 11321.660350189508, 11596.826047609462, 11656.941715291368, 11876.465559050037, 8332.000319923054, 8338.393843764545, 10122.797544049225, 11562.47968841421, 11868.703282418008, 7502.474826762293, 7505.286997735207, 7534.924650753423, 7656.349210317186, 7844.803879903048, 11022.50398732075, 11264.887351126385, 11413.258138220988, 11589.188756786943, 11750.471228794553], "value": 9688.020259715617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.262114185191, 1559.1502631066069, 1701.957451063724, 1791.8835275707079, 1941.9611607767845, 8828.426152300104, 9409.106134917189, 9412.341136120474, 9428.858567121499, 9429.245660347173, 8192.18078192182, 8244.917550824504, 9033.819323613523, 9172.908270917289, 9205.63177472902, 2440.328909549875, 2474.9752502475017, 2477.4054226985572, 2477.442575420534, 2478.033566908907, 2391.175044609607, 2445.8654773987423, 2447.339218411028, 2447.3514518652573, 2447.755224477547, 2426.5429215894774, 2435.744246854081, 2449.608062709967, 2450.9142180023705, 2453.852768833876, 2423.8060955123547, 2427.720812106613, 2427.987860060706, 2428.9878550607223, 2458.2870967419426, 2426.6602675625427, 2432.9270121896193, 2442.5237078769646, 2445.2786428003606, 2447.49826285611, 9099.681511147079, 9297.953510232473, 9307.441553506744, 9307.76730581734, 9308.720738377859, 5457.863553411157, 5638.267025286727, 5638.4361563843695, 5638.605297629168, 5639.830805075854, 3534.861408847636, 3653.0319465341704, 3726.919193433901, 3728.832202550892, 3737.5328083989502, 1096.117625311624, 1115.8047341715167, 1120.3166068698088, 1140.2588317593547, 1145.34715212329, 12137.757244855053, 12229.694257643541, 12254.019678425793, 12258.570950016707, 12258.957988571072, 4388.648908087345, 4652.651051171176, 4853.0779151961015, 4982.10322142018, 5032.270320803536, 10399.012093851072, 10404.5838166474, 10411.375317480975, 10426.791464170674, 10432.68701938943, 5563.109902415594, 5567.526760225345, 5581.804636837691, 5589.580781441408, 5590.636608620427, 4646.256598944153, 4703.929441058387, 4817.638677099231, 5092.0579692756955, 5095.694258344512, 4078.9592104079175, 4103.7688693391865, 4206.747595144301, 4219.346001369792, 4235.97882010588, 1307.3397934043248, 1310.6133690561308, 1319.070055610792, 1328.8671132886634, 1330.6673331667084, 912.9729054813336, 923.4690053219425, 925.3799954030816, 936.578539657157, 951.1819834941945, 5838.211841401441, 5953.613015154001, 6039.667818270037, 6050.818475445743, 6388.2653494847755, 461.83835657520274, 465.52051387070696, 467.4904354253812, 469.6970454057114, 477.37940677119605, 3990.2418540477215, 4036.0, 4068.1253530490494, 4087.2847251731423, 4099.713020088565, 10907.29102608328, 11430.885691142983, 11435.828462573068, 11460.59887903936, 11481.655550333504, 11331.263467874562, 11368.317900925971, 11379.886201137882, 11394.544218231344, 11407.828882566768, 8472.364572657076, 8503.957480212559, 8584.31325493959, 8600.311975041981, 8600.483970961763, 5869.735861886311, 5950.702464876826, 6037.335893051673, 6058.4244496772735, 6103.551493406211, 10104.949475252577, 10221.846672299773, 10399.376037437778, 10513.158947284046, 10526.052655261063, 10697.732556686145, 10750.354978701303, 10758.462076895967, 10762.300450470695, 10823.134149267882, 6939.4448444125355, 7506.099268087864, 7822.491538050009, 7916.564588947663, 8042.638081286474, 8613.353998450266, 8842.425242359226, 8847.557622118997, 8852.822943540965, 8864.73405797827, 7715.459917805924, 7834.412419068479, 7872.685092596232, 7975.481593696391, 7983.20167983197, 7568.508046976929, 7601.619919004138, 7692.8461430772195, 7730.111037230566, 7750.689972401041, 7141.285871413025, 7256.4194864409665, 7263.0921134858145, 7266.564006159436, 7267.527610705287, 4801.0, 4861.635377346643, 4971.776270067928, 4989.501049894981, 5089.0839648862075, 4893.314935908905, 4899.363082799213, 5062.974685126551, 5111.182210846247, 5112.488751124858], "value": 4682.341596920402, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.27192645540384, 306.14432660713305, 314.7450565042315, 316.3057089688135, 322.3408130373386, 5477.78088876445, 5498.972505137479, 5529.281193444856, 5544.6673199608, 5559.388467268607, 5161.329027226455, 5238.580913526918, 5387.925648625278, 5400.243965844775, 5480.287562616854, 3821.3823530881436, 3934.7212156049254, 4174.8121334539865, 4178.498580170369, 4208.253574766468, 4169.124483858393, 4188.308929026723, 4193.483909654214, 4218.4516012918275, 4239.533651298355, 3982.62165094317, 4156.812943417538, 4157.7548124013, 4182.142660754554, 4189.832406703744, 3737.9907424995235, 3865.45808674806, 3951.3085210088407, 4084.326086195774, 4186.204621122008, 3207.6471588125287, 3353.6814002669707, 3376.834991927781, 3408.522806807049, 3689.7786132832116, 4981.252812078181, 5116.05826649678, 5296.960670141984, 5336.786528538853, 5391.649542779707, 4613.5847773700525, 4641.280601506772, 4667.0, 4688.226442636961, 4699.835505757316, 5278.313819203518, 5428.701421421821, 5554.2779438672715, 5735.139729040636, 5748.5975981681295, 3142.3872344892757, 3652.214773823641, 3796.6393192646656, 3834.290656228579, 3837.424386342043, 5497.9828731684765, 5561.860953476195, 6003.729832157564, 6032.788852390146, 6062.424069713415, 3344.1973926257524, 3491.5810102787827, 3986.282469155522, 3991.5210174779213, 4000.319945609195, 3908.3746600543777, 4027.469561566586, 4074.694397920168, 4076.5515793262716, 4084.7753373564146, 3967.3652215645357, 4315.3095504719095, 4640.350350950869, 4698.449511661143, 4707.670463067621, 4839.733814640158, 4843.467218605951, 5198.298229738937, 5352.0, 5773.364929857712, 1178.675864137352, 1209.5464200924653, 1285.466531389463, 1325.2114991579995, 1338.3709656461447, 902.5397047505688, 920.2147833203697, 924.4915296586851, 925.22281283722, 927.188709878856, 5008.874778130576, 5283.2075188722, 5518.724063796794, 5518.779248830002, 5552.278203833475, 4950.702957822542, 5580.2466666999435, 5800.0, 5918.46733793952, 5960.612560183574, 4874.8537543873745, 5376.946230537723, 5474.084070575346, 5485.626339800993, 5500.312460942382, 2910.3306239565018, 2962.70372962702, 3040.920473232015, 3084.0, 3092.567040614316, 5021.012497563944, 5039.118154322979, 5671.943280567141, 6015.639061656315, 6044.546659000593, 5185.974070129625, 5204.193350030751, 5840.474357307778, 5993.583657315288, 6001.459868611846, 5066.695998240118, 5270.893112446276, 5998.25021872266, 6057.0, 6063.484603808637, 5140.537351638371, 5292.259083728358, 5755.53955683536, 5796.652200867961, 5847.766089356378, 5581.162825576033, 5780.913286300624, 5805.8548536286935, 5809.360970293349, 5815.94184058154, 5760.308762948473, 6024.909626355696, 6049.909251361145, 6196.597221180609, 6212.235555177903, 3335.416302147163, 3593.3531964246686, 3686.870959516404, 3734.738568300193, 4036.6367026967714, 5552.7223638818705, 5557.610967232255, 6084.7566097357385, 6114.541409394402, 6128.142060111499, 5485.369182543899, 5868.853278668067, 5872.853178670567, 5878.735456904364, 5922.3485416605, 5134.204198349262, 5176.637635365639, 5473.945260547343, 5835.387284335084, 5862.501687356623, 5124.641275110706, 5194.97402512985, 5458.744488767685, 5550.500454959073, 5589.832305030855, 5223.608229382736, 5288.153895376721, 5375.00562395958, 5793.710314484343, 5794.304683438015, 5331.453878375228, 5590.692511911884, 5655.236543066798, 5671.688057156896, 5671.873047607147], "value": 4164.656507070282, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.7083937264467, 778.1790211327051, 805.9032916050074, 833.5415521463194, 857.879896814446, 16334.591635209112, 17085.82914170861, 17094.91452542737, 17179.742303865452, 17211.397601083965, 12681.17572357796, 14496.275186240671, 14548.272586370666, 14556.490522831704, 14565.92717036416, 859.8925134358221, 878.9648414063462, 879.7360791762478, 880.6345366672823, 881.823635272948, 699.2657709405104, 717.6196615793638, 717.6268340462956, 871.8648609465542, 876.5398165962889, 749.4716225061319, 923.6443969071922, 947.8720372749694, 952.9142377186051, 953.4041224234853, 942.1991307388734, 944.1266828183936, 944.1785646487565, 944.4427787605346, 944.9905500944972, 698.4656737595743, 698.7135274537466, 698.9336013078749, 699.164498424383, 700.184285307616, 16006.439774607832, 16067.758983615255, 16077.91961040199, 16090.597735056717, 16127.435539756052, 14405.20771357575, 14644.341004654816, 14700.485483008044, 14728.705425891529, 14740.3366848491, 13104.475820967149, 13147.276899770508, 13316.733665326736, 13331.0, 13687.24720140392, 4608.262677971508, 4653.325267836145, 4656.906861862778, 4821.63837712173, 4840.0, 125990.37004814917, 129824.0, 129829.35085324607, 130279.69720302771, 130410.0, 10893.183011274186, 11300.15248856339, 11459.828102578467, 11588.94205528967, 11688.70778230534, 19525.804741952397, 22921.88539057294, 23267.418314541934, 23316.65025024626, 23334.64998025031, 8068.47554908929, 8216.876746848802, 8317.459365141247, 8361.707340243061, 8488.872666910001, 4150.501939767248, 4335.978320108379, 4354.521002689701, 4472.060867217856, 4502.662300327489, 3518.665726755954, 3662.9633703663153, 3665.1753355495334, 3665.9266814663556, 3669.3945498992366, 641.2785616181795, 655.452696998012, 666.8299583606247, 669.4477056428466, 670.7162113005224, 552.4530714592524, 613.9140520327157, 628.739073284591, 631.5231999840091, 638.6295948349946, 8570.4000719949, 8879.556022198864, 8935.106489351143, 9018.819623607622, 9065.909340906506, 588.9204957330705, 609.8993666045142, 610.0056907241169, 645.3772109913956, 655.452696998012, 4298.140371925628, 4329.502107257643, 4354.129174165179, 4411.228035093845, 4457.086297309044, 98001.0, 107743.46128269308, 132890.0, 138550.30724846313, 150783.24608376887, 127084.7291527073, 129943.35028324797, 130321.34839325743, 133520.0, 135535.0, 76685.61657191678, 78694.0, 114566.0, 116234.41882790701, 116512.41743791227, 9634.229261659191, 9929.553170107218, 9932.702018939442, 9939.751506212113, 9948.850767238642, 64348.71302574016, 64681.0, 64710.352896472315, 65553.01670474852, 66172.33827661662, 70517.0, 74818.25181748113, 75370.0, 103679.4816025915, 106833.46583267034, 13705.314734263446, 13938.860611393757, 14485.782713259521, 14534.0, 14801.407943682132, 14847.331870065656, 14889.702205956037, 15934.442294519637, 16012.919935400249, 16077.75883361727, 14076.78884816749, 14631.414743410145, 14659.120452772868, 14681.853181468048, 14698.191599462132, 14120.50578229757, 14186.787198192242, 14578.198199099152, 14898.478553250585, 14940.477083302032, 13983.650408739863, 14324.856751432353, 14574.0, 14799.18604476764, 14974.326155323255, 10549.736256593647, 10864.728381790519, 11236.719082023015, 11593.7101572458, 11891.643250702493, 8965.865512017455, 11608.187426880037, 11889.28664280146, 11898.881011189776, 11912.76174476523], "value": 8045.235112868217, "unit": "score"}], "name": "dromaeo_css", "value": 7449.979295193186, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 159.0, 164.0, 113.0, 113.0, 114.0, 111.0, 113.0, 113.0, 114.0], "value": 123.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 115.0, 173.0, 136.0, 91.0, 137.0, 135.0, 165.0, 125.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 183.0, 184.0, 181.0, 182.0, 184.0, 183.0, 185.0, 182.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 104.0, 86.0, 81.0, 62.0, 57.0, 82.0, 59.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 93.0, 70.0, 68.0, 69.0, 90.0, 69.0, 68.0, 91.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 91.0, 87.0, 88.0, 128.0, 91.0, 86.0, 78.0, 93.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 97.0, 98.0, 97.0, 111.0, 158.0, 95.0, 157.0, 157.0], "value": 116.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 83.0, 84.0, 84.0, 84.0, 85.0, 84.0, 89.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 51.0, 54.0, 57.0, 56.0, 57.0, 57.0, 57.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 69.0, 81.0, 74.0, 73.0, 69.0, 70.0, 70.0, 75.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 89.0, 97.0, 97.0, 94.0, 69.0, 96.0, 91.0, 97.0, 98.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 135.0, 132.0, 133.0, 134.0, 139.0, 142.0, 165.0, 133.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 144.0, 196.0, 211.0, 162.0, 182.0, 199.0, 157.0, 161.0, 161.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 65.0, 64.0, 66.0, 66.0, 63.0, 67.0, 64.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1482.1, "alertThreshold": 2.0}]} 17:36:23 INFO - Return code: 0 17:36:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:36:23 INFO - # TBPL SUCCESS # 17:36:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:36:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:36:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:36:23 INFO - 2017-01-05 17:36:23.823 screenresolution[1930:15568] starting screenresolution argv=screenresolution get 17:36:23 INFO - 2017-01-05 17:36:23.825 screenresolution[1930:15568] Display 0: 1600x1200x32@50 17:36:23 INFO - 2017-01-05 17:36:23.831 screenresolution[1931:15571] starting screenresolution argv=screenresolution list 17:36:23 INFO - Available Modes on Display 0 17:36:23 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 17:36:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:36:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:36:23 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 17:36:23 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 17:36:24 INFO - Graphics/Displays: 17:36:24 INFO - Intel Iris: 17:36:24 INFO - Chipset Model: Intel Iris 17:36:24 INFO - Type: GPU 17:36:24 INFO - Bus: Built-In 17:36:24 INFO - VRAM (Dynamic, Max): 1536 MB 17:36:24 INFO - Vendor: Intel (0x8086) 17:36:24 INFO - Device ID: 0x0a2e 17:36:24 INFO - Revision ID: 0x0009 17:36:24 INFO - Displays: 17:36:24 INFO - Display: 17:36:24 INFO - Resolution: 1600 x 1200 @ 50 Hz 17:36:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:36:24 INFO - Display Serial Number: 1600x1200 50 17:36:24 INFO - Main Display: Yes 17:36:24 INFO - Mirror: Off 17:36:24 INFO - Online: Yes 17:36:24 INFO - Rotation: Supported 17:36:24 INFO - Return code: 0 17:36:24 INFO - Running post-action listener: _resource_record_post_action 17:36:24 INFO - [mozharness: 2017-01-06 01:36:24.065760Z] Finished run-tests step (success) 17:36:24 INFO - Running post-run listener: _resource_record_post_run 17:36:24 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 1130496; Write bytes: 495246336; Read time: 9; Write time: 1700 17:36:24 INFO - TinderboxPrint: CPU usage
53.3% 17:36:24 INFO - TinderboxPrint: I/O read bytes / time
1,130,496 / 9 17:36:24 INFO - TinderboxPrint: I/O write bytes / time
495,246,336 / 1,700 17:36:24 INFO - TinderboxPrint: CPU idle
2,237.5 (46.7%) 17:36:24 INFO - TinderboxPrint: CPU system
958.2 (20.0%) 17:36:24 INFO - TinderboxPrint: CPU user
1,598.0 (33.3%) 17:36:24 INFO - TinderboxPrint: Swap in / out
196,272,128 / 0 17:36:24 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 187240960; Write bytes: 188168192; Read time: 17498; Write time: 441 17:36:24 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 1130496; Write bytes: 296952832; Read time: 9; Write time: 1221 17:36:24 INFO - Running post-run listener: _upload_blobber_files 17:36:24 INFO - Blob upload gear active. 17:36:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:36:24 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 17:36:24 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:36:24 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:36:24 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:25 INFO - (blobuploader) - INFO - Done attempting. 17:36:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:36:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:36:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:26 INFO - (blobuploader) - INFO - Done attempting. 17:36:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:36:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:36:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:29 INFO - (blobuploader) - INFO - Done attempting. 17:36:29 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:29 INFO - Return code: 0 17:36:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:36:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f9f1645d79a6ab4900f071dcc2877f56e0721b9352db339ff795552e86e95df8df73705a7db31b4664f73d8810225a6ab3beed5a2bc493f3d6b4ad75a162039", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0820d8f936e49c9f3102158cb774f708e31b712d2e27f2316d05e02e747ed2c0a378d71949a11cde83b6fd2084033f64cb6926648f686d5ddfc8b06d7b200170", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f344c5eebafdeac9670b831790944c247fac25097a92462ad8344e0d6d500b008db423bba6cb81b74c106ded72cce192e51c0e7617b850527a6ce77b85519c53"} 17:36:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:36:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:36:29 INFO - Contents: 17:36:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f9f1645d79a6ab4900f071dcc2877f56e0721b9352db339ff795552e86e95df8df73705a7db31b4664f73d8810225a6ab3beed5a2bc493f3d6b4ad75a162039", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0820d8f936e49c9f3102158cb774f708e31b712d2e27f2316d05e02e747ed2c0a378d71949a11cde83b6fd2084033f64cb6926648f686d5ddfc8b06d7b200170", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f344c5eebafdeac9670b831790944c247fac25097a92462ad8344e0d6d500b008db423bba6cb81b74c106ded72cce192e51c0e7617b850527a6ce77b85519c53"} 17:36:29 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:29 INFO - Copying logs to upload dir... 17:36:29 INFO - mkdir: /builds/slave/test/build/upload/logs 17:36:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.793999 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-05 17:36:29.189873) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 17:36:29.193464) ========= 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.cuHCvhSjbV/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.bJleDE4jol/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-Beta/sha512/0f9f1645d79a6ab4900f071dcc2877f56e0721b9352db339ff795552e86e95df8df73705a7db31b4664f73d8810225a6ab3beed5a2bc493f3d6b4ad75a162039", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0820d8f936e49c9f3102158cb774f708e31b712d2e27f2316d05e02e747ed2c0a378d71949a11cde83b6fd2084033f64cb6926648f686d5ddfc8b06d7b200170", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f344c5eebafdeac9670b831790944c247fac25097a92462ad8344e0d6d500b008db423bba6cb81b74c106ded72cce192e51c0e7617b850527a6ce77b85519c53"} build_url:https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011139 build_url: 'https://queue.taskcluster.net/v1/task/W9pQb6lJQBmpJ3zFNrgPJA/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f9f1645d79a6ab4900f071dcc2877f56e0721b9352db339ff795552e86e95df8df73705a7db31b4664f73d8810225a6ab3beed5a2bc493f3d6b4ad75a162039", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0820d8f936e49c9f3102158cb774f708e31b712d2e27f2316d05e02e747ed2c0a378d71949a11cde83b6fd2084033f64cb6926648f686d5ddfc8b06d7b200170", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f344c5eebafdeac9670b831790944c247fac25097a92462ad8344e0d6d500b008db423bba6cb81b74c106ded72cce192e51c0e7617b850527a6ce77b85519c53"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 17:36:29.232726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:36:29.233534) ========= 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.cuHCvhSjbV/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.bJleDE4jol/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.005202 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:36:29.281710) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 17:36:29.282003) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 17:36:29.282308) ========= ========= Total master_lag: 0.25 =========