builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0345 starttime: 1488139115.38 results: success (0) buildid: 20170226105009 builduid: 5b380f508c804466b52b982bf4df27a5 revision: 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:35.381003) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:35.381773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:35.382058) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:35.551641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:35.551890) ========= 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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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-02-26 11:58:35-- 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% 37.7M=0s 2017-02-26 11:58:36 (37.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.642032 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:36.218162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:36.218447) ========= 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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.025440 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:36.266937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:36.267306) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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-02-26 11:58:36,375 truncating revision to first 12 chars 2017-02-26 11:58:36,375 Setting DEBUG logging. 2017-02-26 11:58:36,375 attempt 1/10 2017-02-26 11:58:36,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7ef1e9abd296?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-26 11:58:37,020 unpacking tar archive at: mozilla-central-7ef1e9abd296/testing/mozharness/ program finished with exit code 0 elapsedTime=0.918889 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:37.210279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:37.210583) ========= script_repo_revision: 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:37.210958) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:37.211232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-26 11:58:37.229892) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-02-26 11:58:37.230346) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 11:58:37 INFO - MultiFileLogger online at 20170226 11:58:37 in /builds/slave/test 11:58:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:58:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:58:37 INFO - {'append_to_log': False, 11:58:37 INFO - 'base_work_dir': '/builds/slave/test', 11:58:37 INFO - 'blob_upload_branch': 'Firefox', 11:58:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:58:37 INFO - 'branch': 'Firefox', 11:58:37 INFO - 'buildbot_json_path': 'buildprops.json', 11:58:37 INFO - 'config_files': ('talos/mac_config.py',), 11:58:37 INFO - 'default_actions': ('clobber', 11:58:37 INFO - 'read-buildbot-config', 11:58:37 INFO - 'download-and-extract', 11:58:37 INFO - 'populate-webroot', 11:58:37 INFO - 'create-virtualenv', 11:58:37 INFO - 'install', 11:58:37 INFO - 'run-tests'), 11:58:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:58:37 INFO - 'download_minidump_stackwalk': True, 11:58:37 INFO - 'download_symbols': 'ondemand', 11:58:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:58:37 INFO - 'tooltool.py': '/tools/tooltool.py', 11:58:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:58:37 INFO - '/tools/misc-python/virtualenv.py')}, 11:58:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:58:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:58:37 INFO - 'gecko_profile': False, 11:58:37 INFO - 'gecko_profile_interval': 0, 11:58:37 INFO - 'installer_path': 'installer.exe', 11:58:37 INFO - 'log_level': 'info', 11:58:37 INFO - 'log_name': 'talos', 11:58:37 INFO - 'log_to_console': True, 11:58:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:58:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:58:37 INFO - 'opt_config_files': (), 11:58:37 INFO - 'pip_index': False, 11:58:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:58:37 INFO - 'cmd': ('bash', 11:58:37 INFO - '-c', 11:58:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:58:37 INFO - 'enabled': True, 11:58:37 INFO - 'halt_on_failure': False, 11:58:37 INFO - 'name': 'check_screen_resolution'},), 11:58:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:58:37 INFO - 'cmd': ('bash', 11:58:37 INFO - '-c', 11:58:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:58:37 INFO - 'enabled': True, 11:58:37 INFO - 'halt_on_failure': False, 11:58:37 INFO - 'name': 'check_screen_resolution'},), 11:58:37 INFO - 'run_cmd_checks_enabled': True, 11:58:37 INFO - 'suite': 'dromaeojs', 11:58:37 INFO - 'system_bits': '32', 11:58:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:58:37 INFO - 'title': 't-yosemite-r7-0345', 11:58:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:58:37 INFO - 'use_talos_json': True, 11:58:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:58:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:58:37 INFO - 'work_dir': 'build'} 11:58:37 INFO - [mozharness: 2017-02-26 19:58:37.443660Z] Running clobber step. 11:58:37 INFO - Running pre-action listener: _resource_record_pre_action 11:58:37 INFO - Running main action method: clobber 11:58:37 INFO - rmtree: /builds/slave/test/build 11:58:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:58:40 INFO - Running post-action listener: _resource_record_post_action 11:58:40 INFO - [mozharness: 2017-02-26 19:58:40.007567Z] Finished clobber step (success) 11:58:40 INFO - [mozharness: 2017-02-26 19:58:40.007825Z] Running read-buildbot-config step. 11:58:40 INFO - Running pre-action listener: _resource_record_pre_action 11:58:40 INFO - Running main action method: read_buildbot_config 11:58:40 INFO - Using buildbot properties: 11:58:40 INFO - { 11:58:40 INFO - "project": "", 11:58:40 INFO - "product": "firefox", 11:58:40 INFO - "script_repo_revision": "production", 11:58:40 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 11:58:40 INFO - "repository": "", 11:58:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 11:58:40 INFO - "buildid": "20170226105009", 11:58:40 INFO - "pgo_build": "False", 11:58:40 INFO - "basedir": "/builds/slave/test", 11:58:40 INFO - "buildnumber": 2, 11:58:40 INFO - "slavename": "t-yosemite-r7-0345", 11:58:40 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:58:40 INFO - "platform": "yosemite_r7", 11:58:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:58:40 INFO - "branch": "mozilla-central", 11:58:40 INFO - "repo_path": "mozilla-central", 11:58:40 INFO - "revision": "7ef1e9abd296a8edc39b7efc8d637767ba2f77ed", 11:58:40 INFO - "stage_platform": "macosx64", 11:58:40 INFO - "builduid": "5b380f508c804466b52b982bf4df27a5", 11:58:40 INFO - "slavebuilddir": "test" 11:58:40 INFO - } 11:58:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 11:58:40 INFO - Running post-action listener: _resource_record_post_action 11:58:40 INFO - [mozharness: 2017-02-26 19:58:40.013614Z] Finished read-buildbot-config step (success) 11:58:40 INFO - [mozharness: 2017-02-26 19:58:40.013714Z] Running download-and-extract step. 11:58:40 INFO - Running pre-action listener: _resource_record_pre_action 11:58:40 INFO - Running main action method: download_and_extract 11:58:40 INFO - mkdir: /builds/slave/test/build/tests 11:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:40 INFO - trying https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 11:58:40 INFO - Downloading https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 11:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 11:58:41 INFO - Downloaded 1199 bytes. 11:58:41 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 11:58:41 INFO - Using the following test package requirements: 11:58:41 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 11:58:41 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 11:58:41 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 11:58:41 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'jsshell-mac.zip'], 11:58:41 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 11:58:41 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 11:58:41 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 11:58:41 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 11:58:41 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 11:58:41 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 11:58:41 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:58:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 11:58:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:58:41 INFO - Fetch https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 11:58:43 INFO - Expected file size: 51744837 11:58:43 INFO - Obtained file size: 51744837 11:58:59 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:58:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 11:58:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:58:59 INFO - Fetch https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 11:59:01 INFO - Expected file size: 51744837 11:59:01 INFO - Obtained file size: 51744837 11:59:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 11:59:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:59:16 INFO - Fetch https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 11:59:17 INFO - Expected file size: 14404421 11:59:17 INFO - Obtained file size: 14404421 11:59:17 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')]} 11:59:17 INFO - trying https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:59:17 INFO - Downloading https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 11:59:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 11:59:20 INFO - Downloaded 74975247 bytes. 11:59:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:59:20 INFO - mkdir: /builds/slave/test/properties 11:59:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:59:20 INFO - Writing to file /builds/slave/test/properties/build_url 11:59:20 INFO - Contents: 11:59:20 INFO - build_url:https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:59:20 INFO - Running post-action listener: _resource_record_post_action 11:59:20 INFO - Running post-action listener: set_extra_try_arguments 11:59:20 INFO - [mozharness: 2017-02-26 19:59:20.862450Z] Finished download-and-extract step (success) 11:59:20 INFO - [mozharness: 2017-02-26 19:59:20.862598Z] Running populate-webroot step. 11:59:20 INFO - Running pre-action listener: _resource_record_pre_action 11:59:20 INFO - Running main action method: populate_webroot 11:59:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:59:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:59:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:59:20 INFO - '--tppagecycles', 11:59:20 INFO - '7'], 11:59:20 INFO - 'tests': ['tsvgm']}}, 11:59:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:59:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:59:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:59:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:59:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:59:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:59:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:59:20 INFO - 'talos_options': ['--disable-e10s'], 11:59:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:59:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:59:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:59:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:59:20 INFO - 'talos_options': ['--disable-e10s'], 11:59:20 INFO - 'tests': ['damp', 'tps']}, 11:59:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:59:20 INFO - 'tests': ['damp', 'tps']}, 11:59:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:59:20 INFO - 'tests': ['dromaeo_dom']}, 11:59:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:59:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:59:20 INFO - 'tests': ['basic_compositor_video']}, 11:59:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:59:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:59:20 INFO - 'tests': ['a11yr', 11:59:20 INFO - 'ts_paint', 11:59:20 INFO - 'tpaint', 11:59:20 INFO - 'sessionrestore', 11:59:20 INFO - 'sessionrestore_no_auto_restore', 11:59:20 INFO - 'tabpaint']}, 11:59:20 INFO - 'other-e10s': {'tests': ['a11yr', 11:59:20 INFO - 'ts_paint', 11:59:20 INFO - 'tpaint', 11:59:20 INFO - 'sessionrestore', 11:59:20 INFO - 'sessionrestore_no_auto_restore', 11:59:20 INFO - 'tabpaint']}, 11:59:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:59:20 INFO - 'ts_paint', 11:59:20 INFO - 'tpaint', 11:59:20 INFO - 'sessionrestore', 11:59:20 INFO - 'sessionrestore_no_auto_restore', 11:59:20 INFO - 'tabpaint']}, 11:59:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:59:20 INFO - 'ts_paint', 11:59:20 INFO - 'tpaint', 11:59:20 INFO - 'sessionrestore', 11:59:20 INFO - 'sessionrestore_no_auto_restore', 11:59:20 INFO - 'tabpaint']}, 11:59:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:59:20 INFO - 'tests': ['a11yr', 11:59:20 INFO - 'ts_paint', 11:59:20 INFO - 'tpaint', 11:59:20 INFO - 'sessionrestore', 11:59:20 INFO - 'sessionrestore_no_auto_restore', 11:59:20 INFO - 'tabpaint']}, 11:59:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:59:20 INFO - 'tests': ['a11yr', 11:59:20 INFO - 'ts_paint', 11:59:20 INFO - 'tpaint', 11:59:20 INFO - 'sessionrestore', 11:59:20 INFO - 'sessionrestore_no_auto_restore', 11:59:20 INFO - 'tabpaint']}, 11:59:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:59:20 INFO - 'tests': ['tsvgx', 11:59:20 INFO - 'tsvgr_opacity', 11:59:20 INFO - 'tart', 11:59:20 INFO - 'tscrollx', 11:59:20 INFO - 'cart', 11:59:20 INFO - 'tsvg_static']}, 11:59:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:59:20 INFO - 'tsvgr_opacity', 11:59:20 INFO - 'tart', 11:59:20 INFO - 'tscrollx', 11:59:20 INFO - 'cart', 11:59:20 INFO - 'tsvg_static']}, 11:59:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:59:20 INFO - 'talos_options': ['--disable-e10s'], 11:59:20 INFO - 'tests': ['tp5o']}, 11:59:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:59:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:59:20 INFO - 'talos_options': ['--disable-e10s', 11:59:20 INFO - '--xperf_path', 11:59:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:59:20 INFO - 'tests': ['tp5n']}, 11:59:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:59:20 INFO - 'talos_options': ['--xperf_path', 11:59:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:59:20 INFO - 'tests': ['tp5n']}}, 11:59:20 INFO - 'talos.zip': {'path': '', 11:59:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:59:20 INFO - Running post-action listener: _resource_record_post_action 11:59:20 INFO - [mozharness: 2017-02-26 19:59:20.881046Z] Finished populate-webroot step (success) 11:59:20 INFO - [mozharness: 2017-02-26 19:59:20.881156Z] Running create-virtualenv step. 11:59:20 INFO - Running pre-action listener: _resource_record_pre_action 11:59:20 INFO - Running main action method: create_virtualenv 11:59:20 INFO - Creating virtualenv /builds/slave/test/build/venv 11:59:20 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 11:59:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:59:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:59:21 INFO - Using real prefix '/tools/python27' 11:59:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:59:21 INFO - Installing distribute.............................................................................................................................................................................................done. 11:59:24 INFO - Installing pip.................done. 11:59:24 INFO - Return code: 0 11:59:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:59:24 INFO - Reading from file tmpfile_stdout 11:59:24 INFO - Output received: 11:59:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:59:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59: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')]} 11:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:24 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 0x10147cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10147f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51c8ba30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10125ad30>, '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 0x101181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10124fbe8>, '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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 11:59:24 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 11:59:24 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 11:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9F0Jxs2oA/Render', 11:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:24 INFO - 'HOME': '/Users/cltbld', 11:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:24 INFO - 'LOGNAME': 'cltbld', 11:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:24 INFO - 'MOZ_NO_REMOTE': '1', 11:59:24 INFO - 'NO_EM_RESTART': '1', 11:59:24 INFO - 'PAGER': '/bin/cat', 11:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:24 INFO - 'PWD': '/builds/slave/test', 11:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:24 INFO - 'SHELL': '/bin/bash', 11:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYhqQiPKVH/Listeners', 11:59:24 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 11:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:24 INFO - 'USER': 'cltbld', 11:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:24 INFO - 'XPC_FLAGS': '0x0', 11:59:24 INFO - 'XPC_SERVICE_NAME': '0', 11:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:25 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 11:59:25 INFO - Cleaning up... 11:59:25 INFO - Return code: 0 11:59:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59: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')]} 11:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59: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', '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 0x10147cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10147f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51c8ba30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10125ad30>, '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 0x101181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10124fbe8>, '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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 11:59: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:59: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 psutil>=3.1.1 11:59:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9F0Jxs2oA/Render', 11:59:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:25 INFO - 'HOME': '/Users/cltbld', 11:59:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:25 INFO - 'LOGNAME': 'cltbld', 11:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:25 INFO - 'MOZ_NO_REMOTE': '1', 11:59:25 INFO - 'NO_EM_RESTART': '1', 11:59:25 INFO - 'PAGER': '/bin/cat', 11:59:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:25 INFO - 'PWD': '/builds/slave/test', 11:59:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:25 INFO - 'SHELL': '/bin/bash', 11:59:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYhqQiPKVH/Listeners', 11:59:25 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 11:59:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:25 INFO - 'USER': 'cltbld', 11:59:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:25 INFO - 'XPC_FLAGS': '0x0', 11:59:25 INFO - 'XPC_SERVICE_NAME': '0', 11:59:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:25 INFO - Downloading/unpacking psutil>=3.1.1 11:59:25 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 11:59:25 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 11:59:25 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 11:59:25 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 11:59:25 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 11:59:25 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 11:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:59:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:29 INFO - Installing collected packages: psutil 11:59:29 INFO - Running setup.py install for psutil 11:59:29 INFO - building 'psutil._psutil_osx' extension 11:59:29 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 11:59:30 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 11:59:30 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 11:59:30 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 11:59:30 INFO - building 'psutil._psutil_posix' extension 11:59:30 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 11:59:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:59:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:59:30 INFO - ^ 11:59:30 INFO - 1 warning generated. 11:59:30 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 11:59:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:30 INFO - Successfully installed psutil 11:59:30 INFO - Cleaning up... 11:59:30 INFO - Return code: 0 11:59:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:59:30 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')]} 11:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:30 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')]} 11:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:30 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 0x10147cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10147f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51c8ba30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10125ad30>, '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 0x101181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10124fbe8>, '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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 11:59:30 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 11:59:30 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 11:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9F0Jxs2oA/Render', 11:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:30 INFO - 'HOME': '/Users/cltbld', 11:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:30 INFO - 'LOGNAME': 'cltbld', 11:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:30 INFO - 'MOZ_NO_REMOTE': '1', 11:59:30 INFO - 'NO_EM_RESTART': '1', 11:59:30 INFO - 'PAGER': '/bin/cat', 11:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:30 INFO - 'PWD': '/builds/slave/test', 11:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:30 INFO - 'SHELL': '/bin/bash', 11:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYhqQiPKVH/Listeners', 11:59:30 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 11:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:30 INFO - 'USER': 'cltbld', 11:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:30 INFO - 'XPC_FLAGS': '0x0', 11:59:30 INFO - 'XPC_SERVICE_NAME': '0', 11:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:59:30 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 11:59:30 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 11:59:30 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 11:59:30 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 11:59:30 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 11:59:30 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 11:59:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:59:33 INFO - Installing collected packages: mozsystemmonitor 11:59:33 INFO - Running setup.py install for mozsystemmonitor 11:59:33 INFO - Successfully installed mozsystemmonitor 11:59:33 INFO - Cleaning up... 11:59:33 INFO - Return code: 0 11:59:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10147cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10147f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51c8ba30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10125ad30>, '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 0x101181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10124fbe8>, '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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 11:59:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9F0Jxs2oA/Render', 11:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:33 INFO - 'HOME': '/Users/cltbld', 11:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:33 INFO - 'LOGNAME': 'cltbld', 11:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:33 INFO - 'MOZ_NO_REMOTE': '1', 11:59:33 INFO - 'NO_EM_RESTART': '1', 11:59:33 INFO - 'PAGER': '/bin/cat', 11:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:33 INFO - 'PWD': '/builds/slave/test', 11:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:33 INFO - 'SHELL': '/bin/bash', 11:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYhqQiPKVH/Listeners', 11:59:33 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 11:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:33 INFO - 'USER': 'cltbld', 11:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:33 INFO - 'XPC_FLAGS': '0x0', 11:59:33 INFO - 'XPC_SERVICE_NAME': '0', 11:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:34 INFO - Downloading/unpacking jsonschema==2.5.1 11:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:59:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:59:37 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 11:59:37 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 11:59:37 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 11:59:37 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 11:59:37 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 11:59:37 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 11:59:38 INFO - Downloading functools32-3.2.3-2.tar.gz 11:59:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:59:38 INFO - warning: no files found matching '*.txt' 11:59:38 INFO - no previously-included directories found matching 'build' 11:59:38 INFO - no previously-included directories found matching 'dist' 11:59:38 INFO - no previously-included directories found matching '.git*' 11:59:38 INFO - Installing collected packages: jsonschema, functools32 11:59:38 INFO - Running setup.py install for functools32 11:59:38 INFO - warning: no files found matching '*.txt' 11:59:38 INFO - no previously-included directories found matching 'build' 11:59:38 INFO - no previously-included directories found matching 'dist' 11:59:38 INFO - no previously-included directories found matching '.git*' 11:59:38 INFO - Successfully installed jsonschema functools32 11:59:38 INFO - Cleaning up... 11:59:38 INFO - Return code: 0 11:59:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:38 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 0x10147cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10147f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51c8ba30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10125ad30>, '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 0x101181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10124fbe8>, '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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 11:59:38 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 11:59:38 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 11:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9F0Jxs2oA/Render', 11:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:38 INFO - 'HOME': '/Users/cltbld', 11:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:38 INFO - 'LOGNAME': 'cltbld', 11:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:38 INFO - 'MOZ_NO_REMOTE': '1', 11:59:38 INFO - 'NO_EM_RESTART': '1', 11:59:38 INFO - 'PAGER': '/bin/cat', 11:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:38 INFO - 'PWD': '/builds/slave/test', 11:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:38 INFO - 'SHELL': '/bin/bash', 11:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYhqQiPKVH/Listeners', 11:59:38 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 11:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:38 INFO - 'USER': 'cltbld', 11:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:38 INFO - 'XPC_FLAGS': '0x0', 11:59:38 INFO - 'XPC_SERVICE_NAME': '0', 11:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:59:38 INFO - Cleaning up... 11:59:38 INFO - Return code: 0 11:59:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:38 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 0x10147cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10147f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51c8ba30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10125ad30>, '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 0x101181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10124fbe8>, '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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 11:59:38 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 11:59:38 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 11:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9F0Jxs2oA/Render', 11:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:38 INFO - 'HOME': '/Users/cltbld', 11:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:38 INFO - 'LOGNAME': 'cltbld', 11:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:38 INFO - 'MOZ_NO_REMOTE': '1', 11:59:38 INFO - 'NO_EM_RESTART': '1', 11:59:38 INFO - 'PAGER': '/bin/cat', 11:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:38 INFO - 'PWD': '/builds/slave/test', 11:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:38 INFO - 'SHELL': '/bin/bash', 11:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYhqQiPKVH/Listeners', 11:59:38 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 11:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:38 INFO - 'USER': 'cltbld', 11:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:38 INFO - 'XPC_FLAGS': '0x0', 11:59:38 INFO - 'XPC_SERVICE_NAME': '0', 11:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:38 INFO - Downloading/unpacking blobuploader==1.2.4 11:59:38 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 11:59:38 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 11:59:38 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 11:59:38 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 11:59:38 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 11:59:38 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 11:59:41 INFO - Downloading blobuploader-1.2.4.tar.gz 11:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:59:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:59:41 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 11:59:41 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 11:59:41 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 11:59:41 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 11:59:41 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 11:59:41 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 11:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:59:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:59:42 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 11:59:42 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 11:59:42 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 11:59:42 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 11:59:42 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 11:59:42 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 11:59:42 INFO - Downloading docopt-0.6.1.tar.gz 11:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:59:42 INFO - Installing collected packages: blobuploader, requests, docopt 11:59:42 INFO - Running setup.py install for blobuploader 11:59:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:59:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:59:43 INFO - Running setup.py install for requests 11:59:43 INFO - Running setup.py install for docopt 11:59:43 INFO - Successfully installed blobuploader requests docopt 11:59:43 INFO - Cleaning up... 11:59:43 INFO - Return code: 0 11:59:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:43 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 0x10147cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10147f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51c8ba30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10125ad30>, '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 0x101181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10124fbe8>, '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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 11:59:43 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 11:59:43 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 11:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9F0Jxs2oA/Render', 11:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:43 INFO - 'HOME': '/Users/cltbld', 11:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:43 INFO - 'LOGNAME': 'cltbld', 11:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:43 INFO - 'MOZ_NO_REMOTE': '1', 11:59:43 INFO - 'NO_EM_RESTART': '1', 11:59:43 INFO - 'PAGER': '/bin/cat', 11:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:43 INFO - 'PWD': '/builds/slave/test', 11:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:43 INFO - 'SHELL': '/bin/bash', 11:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYhqQiPKVH/Listeners', 11:59:43 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 11:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:43 INFO - 'USER': 'cltbld', 11:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:43 INFO - 'XPC_FLAGS': '0x0', 11:59:43 INFO - 'XPC_SERVICE_NAME': '0', 11:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-voPC3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-T6Txg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-nqFMGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-EdexI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-kOtlwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-9x18uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-tPZJrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-OwhLNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-hyJlIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-C_BpZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-YdX171-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-E1q6ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-E858xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ptXYlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-kzp1e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-3i8MhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Uat3fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:59:45 INFO - Running setup.py install for manifestparser 11:59:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Running setup.py install for mozcrash 11:59:46 INFO - Running setup.py install for mozdebug 11:59:46 INFO - Running setup.py install for mozdevice 11:59:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Running setup.py install for mozfile 11:59:46 INFO - Running setup.py install for mozhttpd 11:59:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Running setup.py install for mozinfo 11:59:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:59:46 INFO - Running setup.py install for mozInstall 11:59:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:59:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:59:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:59:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:59:47 INFO - Running setup.py install for mozleak 11:59:47 INFO - Running setup.py install for mozlog 11:59:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:59:47 INFO - Running setup.py install for moznetwork 11:59:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:59:47 INFO - Running setup.py install for mozprocess 11:59:47 INFO - Running setup.py install for mozprofile 11:59:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:59:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:59:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:59:47 INFO - Running setup.py install for mozrunner 11:59:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:59:48 INFO - Running setup.py install for mozscreenshot 11:59:48 INFO - Running setup.py install for moztest 11:59:48 INFO - Running setup.py install for mozversion 11:59:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:59:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:59:48 INFO - Cleaning up... 11:59:48 INFO - Return code: 0 11:59:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59: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')]} 11:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:48 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 0x10147cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10147f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51c8ba30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10125ad30>, '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 0x101181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10124fbe8>, '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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 11:59:48 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 11:59:48 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 11:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9F0Jxs2oA/Render', 11:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:48 INFO - 'HOME': '/Users/cltbld', 11:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:48 INFO - 'LOGNAME': 'cltbld', 11:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:48 INFO - 'MOZ_NO_REMOTE': '1', 11:59:48 INFO - 'NO_EM_RESTART': '1', 11:59:48 INFO - 'PAGER': '/bin/cat', 11:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:48 INFO - 'PWD': '/builds/slave/test', 11:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:48 INFO - 'SHELL': '/bin/bash', 11:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYhqQiPKVH/Listeners', 11:59:48 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 11:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:48 INFO - 'USER': 'cltbld', 11:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:48 INFO - 'XPC_FLAGS': '0x0', 11:59:48 INFO - 'XPC_SERVICE_NAME': '0', 11:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:48 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-II5WzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:48 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)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:48 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Iflw9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:48 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-l6ChHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:49 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)) 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:49 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-GrP60I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:49 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-uLs9xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:49 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)) 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:49 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-8CulG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:49 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)) 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:49 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-GTHjHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:49 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)) 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:49 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Ik7hhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:49 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)) 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:49 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-bzv5Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:49 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)) 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:49 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-sT7O3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:49 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)) 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:49 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-O4AuHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:49 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)) 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:49 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-A5jmzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 11:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:50 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-eO4Buk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:50 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)) 11:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:50 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ySkwON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:50 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-XtquHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:50 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)) 11:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:50 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-_quYI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:50 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-tIMz6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:50 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)) 11:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:59:50 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)) 11:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:59:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:53 INFO - Downloading blessings-1.6.tar.gz 11:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:59:53 INFO - Installing collected packages: blessings 11:59:53 INFO - Running setup.py install for blessings 11:59:53 INFO - Successfully installed blessings 11:59:53 INFO - Cleaning up... 11:59:53 INFO - Return code: 0 11:59:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:53 INFO - Reading from file tmpfile_stdout 11:59:53 INFO - Current package versions: 11:59:53 INFO - blessings == 1.6 11:59:53 INFO - blobuploader == 1.2.4 11:59:53 INFO - docopt == 0.6.1 11:59:53 INFO - functools32 == 3.2.3-2 11:59:53 INFO - jsonschema == 2.5.1 11:59:53 INFO - manifestparser == 1.1 11:59:53 INFO - mozInstall == 1.12 11:59:53 INFO - mozcrash == 1.0 11:59:53 INFO - mozdebug == 0.1 11:59:53 INFO - mozdevice == 0.49 11:59:53 INFO - mozfile == 1.2 11:59:53 INFO - mozhttpd == 0.7 11:59:53 INFO - mozinfo == 0.9 11:59:53 INFO - mozleak == 0.1 11:59:53 INFO - mozlog == 3.4 11:59:53 INFO - moznetwork == 0.27 11:59:53 INFO - mozprocess == 0.25 11:59:53 INFO - mozprofile == 0.28 11:59:53 INFO - mozrunner == 6.13 11:59:53 INFO - mozscreenshot == 0.1 11:59:53 INFO - mozsystemmonitor == 0.3 11:59:53 INFO - moztest == 0.8 11:59:53 INFO - mozversion == 1.4 11:59:53 INFO - psutil == 3.1.1 11:59:53 INFO - requests == 1.2.3 11:59:53 INFO - wsgiref == 0.1.2 11:59:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:53 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')]} 11:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:53 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')]} 11:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:53 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 0x10147cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10147f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51c8ba30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10125ad30>, '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 0x101181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10124fbe8>, '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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 11:59:53 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 11:59:53 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 11:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9F0Jxs2oA/Render', 11:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:53 INFO - 'HOME': '/Users/cltbld', 11:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:53 INFO - 'LOGNAME': 'cltbld', 11:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:53 INFO - 'MOZ_NO_REMOTE': '1', 11:59:53 INFO - 'NO_EM_RESTART': '1', 11:59:53 INFO - 'PAGER': '/bin/cat', 11:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:53 INFO - 'PWD': '/builds/slave/test', 11:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:53 INFO - 'SHELL': '/bin/bash', 11:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYhqQiPKVH/Listeners', 11:59:53 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 11:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:53 INFO - 'USER': 'cltbld', 11:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:53 INFO - 'XPC_FLAGS': '0x0', 11:59:53 INFO - 'XPC_SERVICE_NAME': '0', 11:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:54 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)) 11:59:54 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)) 11:59:54 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)) 11:59:54 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)) 11:59:54 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)) 11:59:54 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)) 11:59:54 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)) 11:59:54 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)) 11:59:54 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)) 11:59:54 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)) 11:59:54 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)) 11:59:54 INFO - Cleaning up... 11:59:54 INFO - Return code: 0 11:59:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10147cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10147f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51c8ba30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10125ad30>, '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 0x101181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10124fbe8>, '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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 11:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9F0Jxs2oA/Render', 11:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:54 INFO - 'HOME': '/Users/cltbld', 11:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:54 INFO - 'LOGNAME': 'cltbld', 11:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:54 INFO - 'MOZ_NO_REMOTE': '1', 11:59:54 INFO - 'NO_EM_RESTART': '1', 11:59:54 INFO - 'PAGER': '/bin/cat', 11:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:54 INFO - 'PWD': '/builds/slave/test', 11:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:54 INFO - 'SHELL': '/bin/bash', 11:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYhqQiPKVH/Listeners', 11:59:54 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 11:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:54 INFO - 'USER': 'cltbld', 11:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:54 INFO - 'XPC_FLAGS': '0x0', 11:59:54 INFO - 'XPC_SERVICE_NAME': '0', 11:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:59:54 INFO - Cleaning up... 11:59:54 INFO - Return code: 0 11:59:54 INFO - Running post-action listener: _resource_record_post_action 11:59:54 INFO - Running post-action listener: _start_resource_monitoring 11:59:54 INFO - Starting resource monitoring. 11:59:54 INFO - [mozharness: 2017-02-26 19:59:54.414460Z] Finished create-virtualenv step (success) 11:59:54 INFO - [mozharness: 2017-02-26 19:59:54.415413Z] Running install step. 11:59:54 INFO - Running pre-action listener: _resource_record_pre_action 11:59:54 INFO - Running main action method: install 11:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:54 INFO - Reading from file tmpfile_stdout 11:59:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:59:54 INFO - Reading from file tmpfile_stdout 11:59:54 INFO - Output received: 11:59:54 INFO - Usage: mozinstall [options] installer 11:59:54 INFO - Options: 11:59:54 INFO - -h, --help show this help message and exit 11:59:54 INFO - -d DEST, --destination=DEST 11:59:54 INFO - Directory to install application into. [default: 11:59:54 INFO - "/builds/slave/test"] 11:59:54 INFO - --app=APP Application being installed. [default: firefox] 11:59:54 INFO - mkdir: /builds/slave/test/build/application 11:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:00:14 INFO - Reading from file tmpfile_stdout 12:00:14 INFO - Output received: 12:00:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:00:15 INFO - Running post-action listener: _resource_record_post_action 12:00:15 INFO - [mozharness: 2017-02-26 20:00:15.000660Z] Finished install step (success) 12:00:15 INFO - [mozharness: 2017-02-26 20:00:15.000793Z] Running run-tests step. 12:00:15 INFO - Running pre-action listener: _resource_record_pre_action 12:00:15 INFO - Running main action method: run_tests 12:00:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:00:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:00:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:00:15 INFO - 2017-02-26 12:00:15.015 screenresolution[1644:9787] starting screenresolution argv=screenresolution get 12:00:15 INFO - 2017-02-26 12:00:15.018 screenresolution[1644:9787] Display 0: 1600x1200x32@60 12:00:15 INFO - 2017-02-26 12:00:15.023 screenresolution[1645:9789] starting screenresolution argv=screenresolution list 12:00:15 INFO - Available Modes on Display 0 12:00:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:00:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:00:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:00:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:00:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:00:15 INFO - Intel Iris: 12:00:15 INFO - Chipset Model: Intel Iris 12:00:15 INFO - Type: GPU 12:00:15 INFO - Bus: Built-In 12:00:15 INFO - VRAM (Dynamic, Max): 1536 MB 12:00:15 INFO - Vendor: Intel (0x8086) 12:00:15 INFO - Device ID: 0x0a2e 12:00:15 INFO - Revision ID: 0x0009 12:00:15 INFO - Displays: 12:00:15 INFO - Display: 12:00:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:00:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:00:15 INFO - Display Serial Number: 1600x1200 60 12:00:15 INFO - Main Display: Yes 12:00:15 INFO - Mirror: Off 12:00:15 INFO - Online: Yes 12:00:15 INFO - Rotation: Supported 12:00:15 INFO - Return code: 0 12:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:00:15 INFO - Python 2.7.3 12:00:15 INFO - Return code: 0 12:00:15 INFO - grabbing minidump binary from tooltool 12:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:00:15 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 0x10125ad30>, '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 0x101181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10124fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:00:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:00:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:00:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:00:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:00:15 INFO - Return code: 0 12:00:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:00:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:00:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:00:15 INFO - ENV: RUST_BACKTRACE is now 1 12:00:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:00:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0345 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:00:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9F0Jxs2oA/Render', 12:00:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:15 INFO - 'HOME': '/Users/cltbld', 12:00:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:15 INFO - 'LOGNAME': 'cltbld', 12:00:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:00:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:15 INFO - 'MOZ_NO_REMOTE': '1', 12:00:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:00:15 INFO - 'NO_EM_RESTART': '1', 12:00:15 INFO - 'PAGER': '/bin/cat', 12:00:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:15 INFO - 'PWD': '/builds/slave/test', 12:00:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:00:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:15 INFO - 'RUST_BACKTRACE': '1', 12:00:15 INFO - 'SHELL': '/bin/bash', 12:00:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYhqQiPKVH/Listeners', 12:00:15 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 12:00:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:15 INFO - 'USER': 'cltbld', 12:00:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:15 INFO - 'XPC_FLAGS': '0x0', 12:00:15 INFO - 'XPC_SERVICE_NAME': '0', 12:00:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:00:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:00:15 INFO - mozversion application_buildid: 20170226105009 12:00:15 INFO - mozversion application_changeset: 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed 12:00:15 INFO - mozversion application_display_name: Nightly 12:00:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:00:15 INFO - mozversion application_name: Firefox 12:00:15 INFO - mozversion application_remotingname: firefox 12:00:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:00:15 INFO - mozversion application_vendor: Mozilla 12:00:15 INFO - mozversion application_version: 54.0a1 12:00:15 INFO - mozversion platform_buildid: 20170226105009 12:00:15 INFO - mozversion platform_changeset: 7ef1e9abd296a8edc39b7efc8d637767ba2f77ed 12:00:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:00:15 INFO - mozversion platform_version: 54.0a1 12:00:15 INFO - using testdate: 1488139215 12:00:15 INFO - actual date: 1488139215 12:00:15 INFO - starting webserver on 'localhost:49253' 12:00:15 INFO - SUITE-START | Running 2 tests 12:00:15 INFO - TEST-START | dromaeo_css 12:00:15 INFO - operating with platform_type : mac_ 12:00:15 INFO - Initialising browser for dromaeo_css test... 12:00:15 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpzUAljd/profile http://localhost:49253/getInfo.html) 12:00:18 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 12:00:18 INFO - PROCESS | 1655 | colorDepth:24 12:00:18 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 12:00:18 INFO - PROCESS | 1655 | __metrics 12:00:18 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:00:18 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:00:19 INFO - TEST-INFO | 1655: exit 0 12:00:19 INFO - Browser initialized. 12:00:19 INFO - Running cycle 1/1 for dromaeo_css test... 12:00:19 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpzUAljd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:31 INFO - PROCESS | 1658 | RSS: Main: 230969344 12:00:31 INFO - PROCESS | 1658 | 12:03:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49253/tests/dromaeo/cssquery-ext.html) 12:03:37 INFO - PROCESS | 1658 | RSS: Main: 480083968 12:03:37 INFO - PROCESS | 1658 | 12:05:20 INFO - PROCESS | 1658 | ************************* 12:05:20 INFO - PROCESS | 1658 | A coding exception was thrown and uncaught in a Task. 12:05:20 INFO - PROCESS | 1658 | 12:05:20 ERROR - PROCESS | 1658 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:05:20 INFO - PROCESS | 1658 | Full stack: 12:05:20 INFO - PROCESS | 1658 | ************************* 12:06:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-ext.html (next: http://localhost:49253/tests/dromaeo/cssquery-jquery.html) 12:06:41 INFO - PROCESS | 1658 | RSS: Main: 368398336 12:06:41 INFO - PROCESS | 1658 | 12:09:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49253/tests/dromaeo/cssquery-mootools.html) 12:09:44 INFO - PROCESS | 1658 | RSS: Main: 338444288 12:09:44 INFO - PROCESS | 1658 | 12:12:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49253/tests/dromaeo/cssquery-prototype.html) 12:12:47 INFO - PROCESS | 1658 | RSS: Main: 331956224 12:12:47 INFO - PROCESS | 1658 | 12:15:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49253/tests/dromaeo/cssquery-yui.html) 12:15:52 INFO - PROCESS | 1658 | RSS: Main: 337424384 12:15:52 INFO - PROCESS | 1658 | 12:18:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-yui.html (next: http://localhost:49253/tests/dromaeo/cssquery-dojo.html) 12:18:55 INFO - PROCESS | 1658 | RSS: Main: 373043200 12:18:55 INFO - PROCESS | 1658 | 12:18:55 INFO - PROCESS | 1658 | __start_tp_report 12:18:55 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 12:18:55 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 12:18:55 INFO - PROCESS | 1658 | |i|pagename|runs| 12:18:55 INFO - PROCESS | 1658 | |0;dojo.html;3188.7449004079667;3199.2641692410743;3204.4712622417287;3222.6293976192746;3231.434498962681;5345.037893179236;5374;5464.754086066127;5546.306711661043;5552.500274975251;5475.67145971241;5483.424240454755;5488.17677348398;5533.3083364579425;5545.916811247835;4737.715737055788;4930.03864246472;4965.131102057153;5020.573251273646;5188.558972487343;5104.566111880495;5156.226566015091;5168.767405466763;5197.168453047513;5235.057689615867;4900.995295964319;4974.079795237856;4986.775595098229;5025.221090730943;5093.108705976458;5038.748062596856;5041.8487445376695;5045.318881950926;5061.013102445025;5064.987002599495;4960.578350840183;4962.925556116661;5003.3495645565845;5010.298558201818;5016.623753218487;5459.918101228484;5462.6995515246645;5471.562275018029;5476.069068258365;5498.5876059295715;6024.427679370497;6028.608140470856;6035.245594300713;6048.092786082079;6050;6006.489448396892;6045.969770151165;6083.695815209222;6097.054956481752;6104.572679912408;5568.276124103881;5596.188552659842;5613.382527921925;5622.156676498558;5632.070708333161;6254.8123556293385;6256.468200203034;6256.718447669866;6261.655608941552;6273.686315684197;5751.166080918327;5799.043157878903;5834.066549352084;5986.4013598639785;6022.066579680157;6038.33578306386;6115.724792384353;6131.448169664752;6148.754049838046;6159.4456498915315;6054.878902422015;6079.331273559905;6082.817515474543;6085.269767627913;6121.938780612226;5786.363500014995;6107.877842443215;6129.3870612939245;6131.63210207389;6164.260288765377;4761.262004389325;4829.7585120744525;4830.033993201374;4831.830885918976;4837.806487740521;4277.529471758104;4334.263175260214;4359.847405340861;4360.65114790816;4380.145871555016;5453.400125986138;5459.153831156177;5459.208414779835;5460.262864513319;5470.9452905471235;5952.494038006731;6001.819945401645;6010.609310394811;6014.007688731398;6037.63774173551;5433.0763770159165;5439.700816455133;5464;5494.36814766299;5495.505404513613;4791.377120974321;5196.662216955961;5241.554467870274;5248.05535003703;5267.78928842842;6305.905411418832;6322.083297921776;6326.905096423558;6338.714757835908;6340.270868850142;6172.135900973777;6174.722137503913;6185.6907154641185;6186.659733714689;6192.969035154795;6114.357992410911;6135.814547850547;6144.556029333193;6219.222597175353;6342.39747224013;5847.26909136358;5857.062869940789;5866.354700982974;5869.06095024794;5871.1486834409625;4296.441462609966;5885.440883116097;5942.881142377215;5986.07215881539;6087.604305720114;5848.093545500455;5867.031939729897;5874;5892.646441213541;5917.437843404869;5878.735456904535;5880.14737863016;5887.852803679943;5890.263717035371;5913.881722365442;5543.113101903676;5622.662640241599;5628.493435590816;5728.713564321851;5733.02538568436;5138.383393992595;5169.663971841968;5779.133130030529;5779.797707080232;5784.537237020944;5662.801801936913;5670.149477578396;5682.43175682445;5684.8010319638615;5687.090065589486 12:18:55 INFO - PROCESS | 1658 | |1;ext.html;684.7569112964898;787.283571949526;841.9452735572187;865.8311629232302;866.4498043742221;26838.731612683867;28112.85943570282;28121;28148.296292592695;37483.062923426856;36892.446613300825;38793.806030969805;38845.53276373218;38868;38904.80547597265;8979.146981036807;9146.131117543822;9152.4966126863;9172.266218702487;9217.953910230439;7312.597807120606;7482.588457634828;8985.820283594325;9096.090390960917;9111.589978450986;7475;7476.289752473534;7506.174320824705;10702.946485267563;10907.400092994882;10827;10901;10902.400367979719;10906.236563440561;10915.454227288605;10528.578856845717;10586.04725574702;10591.576336946513;10603.151747860229;10603.257771955967;26097.217083487525;26416.207513774425;26567.867160664267;36015;36262;3140.654528001941;3724.6461586149544;3752.756070855413;3803.334416477133;3873.1672690371424;26761.46477070467;26880.327991800164;27200;27288;27390.452190956068;2965.0956458280216;3087.4905640569277;3150.8897188598517;3157.700018498239;3159.9684003159905;345375.27312363527;346000;346899;347091;348261;49671;49720;49762.50237497651;49807.501924981014;49843.003139937;41743.37384939229;42427.575724242364;42429;44608.55391446044;51344.48655513397;12438.94268987128;12495.375231238402;12543.372831358396;13173.802392964113;13609.047366684435;11727.941360293144;11770.705732356588;11771.88228117725;11776.470058847372;11815.763684726257;11803.114766392555;11896.167268291136;11902.761944761229;11908.821367679491;11920;4412.735235885857;4416.955830441719;4640.579340688415;5201.803585175355;5211.921821172686;886.6807949138305;936.0265324063034;982.0081717465268;1050.3960222871879;1087.5649740103863;25636.615450768255;26339.604905926426;26343.946242150098;26354.73645263561;26881.596776048376;1117.4301106435776;1119.8208286674094;1152.9538818447168;1159.8260260960756;1160.193665402554;10415.188608543593;11198.216124871344;12655.81016284738;12937.417816198105;13548;435191;437068;437082;437244;437436;47855.28217076747;51893.48106518962;51917.22124168141;52019.219711704354;52083;1379.9310034498235;1430.206235539265;1432.0691550492056;1432.4986254810733;1433.0613448191452;24752.876235618707;25725.742742572336;25758.484830303663;25777.742222577534;25900.740992589832;44198.337024944005;44315;44411.777941110086;44416.777916110215;44447;410743;410893;412663;412979.9351003226;413861;25982.480350393264;31500.527492087178;31690.04929852108;31895.202619934687;32156.678433216304;40621.593784061784;41773.74678759642;41992;42297.788511057246;42402.36396453994;33026;33973.83013084919;35237.64762352344;35446;35511.46732799062;33485.33029339351;33594.160145996546;33716.83141584276;34962.300753985284;35041.649583504855;32732.50901236531;34452.07119482776;34778.652213477544;35326.64673353233;35329.94010179699;20303.4924126898;28293.71706282911;30277.486125693187;30789.963613858432;30990.69009309878;18335.724964125282;22042.44893877666;22498.887505563023;22710.31869043931;22893.771062289165 12:18:55 INFO - PROCESS | 1658 | |2;jquery.html;346.7430564204758;383.5091083413232;397.44754790840733;400.52737769432065;424.90864464140225;10731.678049658503;14577.854221457783;19964.60070798585;20433.386998390033;21355;21229.363119106452;21250.831204283757;21537.784622153773;21778.89110554445;21820.563588728215;5906.88186236275;6124.326324104345;6155.661438620874;6163.845903852395;6177.289611694645;5323.494268044549;5724.513416359614;5964.761409543613;6041.486473649745;6052.031674932012;5758.913616295759;5983.282006159246;5985;5990.281166260055;5994.670293133876;5980.491658209035;5996.2504686914135;6044.972354699667;6058.212432383806;6078.483328917047;5242.423333433319;5289.233061206103;5292;5299.205119232108;5485.725713714338;10796.298240614335;13744.793828092586;13747.106438081493;13755.10591811529;21503.569928601497;2487.9378015549573;2511.836730612504;2513.6229565565127;2527.2670925431603;2590.0675756727564;9888.307818452711;9993.050660187344;10030.448325342104;10310.7422314442;10510.159187265077;1755.9525294196872;1782.97325540117;1788.624388878324;1793.7219730941724;1810.9185086671132;118435.15648435174;122501.99999999911;123498.38250808779;124863;128125.35937320346;10829.512671929782;11581.942090289664;11869.287842729464;11873.228240164362;11935.940320298516;14318.85681143196;14687.926560367343;14791.408343666348;15452.304646290944;15459.845401546065;8510.319174466027;8549.743507694779;8607.483550986835;8736.912630873738;8768.386212965159;8322.16778322175;8326.45878017927;8353.791155221168;8500.532470714046;8519.531425771642;4775.689580177277;4787.186178349689;4807.351007613997;4822.95177048232;4891.6575839691595;2005.568802707425;2044.1005957378707;2048.979510204879;2054;2055.98972005139;964.2960638733764;1016.6645007147623;1020.2195320579763;1066.7439814444633;1068.1614932278123;21007.8949605251;22171.55656886853;22252.554948901256;22319.66082035083;22336.553268934855;923.9445633262026;1033.452270296744;1035.6064695415694;1065.2969040433277;1089.536946797608;11090.722731931604;11386.658400248005;11389.829152562717;11390.658280251606;11425.428728563538;689805;691643;694491;704939;719595;136326;140730;147122.7247504171;149806.53288940905;150459.24770376078;946.3990366117565;1005.5877090392904;1036.528379587286;1089.8855620159927;1095.7315457712753;20013.299534516224;20286.884221367374;20521.48696282605;20534.794652053886;20604.38186854397;45144.32283515816;52572.68568285823;53297.40107796773;56232.87534249374;56637;79893;79992;81909.3618127646;82155;82747.58626207072;5946.910796338145;6262.53031022666;7039.577625342496;7646.9617651911385;8320.334373250005;10489.842652360374;11921.821172682243;12868.485260589472;13186.208827470382;13470.663233419244;11097.336639206695;11384.48769805344;11449.885501144881;11559.248648837798;11598.768024639292;10906.34561926287;11070.723231919266;11172.273802203155;11485.425728713699;11522.654320370402;9468.857967130361;10889.564417423215;11242.887571124511;11382.601608943647;11521.308721476738;7265.600391978492;7439.55362678241;7447.366973807287;7671.424643151898;7687.0444741932015;9606.615735370508;10603.681889543326;11031.613893513688;11046.116310695286;11133.721656958642 12:18:55 INFO - PROCESS | 1658 | |3;mootools.html;1452.4335509151426;1465.1575344177102;1485.1683057487808;1485.3167542930246;1490.3516970117996;8288.709895153663;8674.696385626496;8680.869786953193;8686.087960764124;8700.086490918457;8292.336613070955;8631.30949524038;8634.611442485088;8743.038265790758;8754.781130471742;2255.323402979104;2291.2209848651455;2303.366574192094;2305.250793492113;2306.8385213035094;2273.897674604647;2303.8617682938993;2305.9538809223804;2307.469282065126;2308.2613563659634;2271.4094335472732;2271.5911135995516;2291.0950174681075;2295;2295.0704964489323;2192.079326682789;2197.7582465928735;2235.429965358823;2236.194969810867;2249.763774803647;2213.513027134028;2287.8512896661664;2289.4505318723554;2292.1633603734685;2292.3123063081007;8596.570171491463;8679.566021698889;8685.435446695945;8686.56567171639;8691.130886911322;5140.408852981917;5283.498067683602;5287.180487024479;5292.92060619091;5295.364556253236;3051.755859531232;3310.536524886518;3426.2119712466274;3508.7719298245534;3513.472979053137;1193.618042226488;1220.8229806677982;1228.1955319265894;1231.470467698889;1252.2361359570655;10047.849282260771;10394.688159355232;10428.009339112848;10916.962888525577;10922.563097476092;4107.774072426046;4229.767362795014;4232;4253.27694291965;4367.65058795302;8946;9003.729888103237;9021.954890225637;9055.68305109318;9058.547072646474;5183.248428977777;5186.740662966912;5195.558377537952;5198.2722418861385;5200.97399513;3816.3321418751607;4624.635113894324;4771.379720636295;4832.492588278251;4833.3958255218095;3556.9110772230383;3625.3111908737255;3682.760620559655;3711.7958512281543;3726.925461490755;1118.9440527973568;1120.4621781544904;1132.2413982631656;1146.7591805720724;1147.3058799426394;760.8934749135126;844.6410275632832;899.5502248875562;903.2322525852973;943.1841457139525;5264.552248131795;5561.944380556223;5615.775368985195;5785.739641716133;6011.218541589566;873.8383399071192;931.3201363004908;955.6941778630771;963.5278713430508;983.6262220356219;3226.8547915343865;3750.9062273442837;3845.692344612424;3889.3776995680555;3916.8629097981434;9803.117719405287;10088.293819432716;10092.495375231209;10098.343607665478;10127.949360253298;9729.56216970238;9983.800323993479;10075.748106297402;10092.596296148073;10105.848412273821;7836.177201393885;8181.672733090729;8187.222213889671;8191.139930307232;8192.057913339922;5111.258867464271;5644.096944488862;5722.885542289047;5727.625369911275;5983.982722937199;9077;9448.811023779623;9459.95940446564;9620.615175392906;9635.807283854423;8523.74428767138;8846.911530884609;9295.76760580991;9450.338476306593;9749.463779492196;5986.491148252448;6405.615663060231;6543.836404089936;7061;7351.044364232615;8141.633626486941;8240.587970601566;8340.457870238415;8393.28657064132;8429.072801991653;6391.776287829904;7225.747098851725;7293.744718934812;7331.083614548182;7412.666430010555;7171.8565628688175;7197.640117993975;7199.460040497089;7244.963775181302;7360.374368178551;6420.871582568229;6470.579412338183;6476.352364763486;6511.869762604627;6567.671616419256;5005.224190250517;5022.196448568212;5084.618653600921;5104.9744751276;5186.377634683862;4976.3068672635245;5024.307134256392;5102.540771330598;5250.133727934848;5261.631685782112 12:18:55 INFO - PROCESS | 1658 | |4;prototype.html;306.21608681774654;364.475155775683;370.1671239710651;373.704773229149;375.80833774774857;5106.31064806251;5214.696325918516;5215.634905556603;5216.217567364888;5239.742461809167;3946.625070618287;4442.555744425564;4560.286629455469;4679.625629949604;5233.398159211692;3845.807709614508;3856.2094770571966;3888.61113888611;3908.6286802753693;3917.6474117329435;3726;3889.7860617666015;3911.8068988958357;3924.018370722781;3927.803609819512;3327.0185295337933;3599.6400359963927;3848.2495913296916;3875.922481550367;3895.2988462076955;3608.585012723544;3810.542734871833;3899.0642245861072;3915.6280153385383;3923.9215215695667;3342.5320455136302;3342.88299909502;3344.5484859543894;3361.3277344530948;3364.6803553662608;3928.921421571581;4808.821838649518;4986.376702912136;5000.42495113063;5044.621653376012;4052.986753311672;4209.2423363794505;4246.341817018367;4427.4908385535755;4465.933011004805;4539.432570928634;5281.973590132063;5334.51989320963;5380.300560927094;5452.345718513804;2987.581738556582;3022.9697703022907;3188.7289580385695;3645.198056427582;3716.832742526593;4900.338454308659;5572.804951826707;5603.5237004854225;5716.857078573069;5727.3986231445515;3165.8258795766455;3575.1598374382;3587.51568538244;3686;3702.500162478085;3099.4730895747775;3466.9653303466644;3797.4999875049753;3814.7138964577766;3835.36716441784;3804.9429258561145;4225.830966761357;4444.155610434007;4458.375827384169;4477.171723231148;4687.39063921688;4985.875353116201;5488.341399032141;5580.177578358837;5607.719614019283;1234.4074844074714;1241.410993927774;1248.3708760068016;1250.2935841249664;1253.9466847847852;697.7801992372387;801.761278824218;849.3417601358997;861.1743104618249;862.1206369503071;4183.49798024239;4238.364245363158;4291.618151925712;4831.830885918976;4882.316475693406;5020.924686129711;5398.595105367113;5410.403930840412;5417.485338892799;5422.6475279106735;4378.584034516716;4541.636669066466;4598.448186217675;4845.2732090186755;4877.853664390074;2377.4427749823894;2528.608065749812;2645.061003343824;2646.470705858836;2807.4104438068234;4733.928991065137;5241;5456.563474922076;5457.126859702428;5503.504684578407;5019.247112933016;5360.6247562671015;5418.647787893774;5474.890502190014;5534.75093620788;4632.305154226826;4834.661573689878;5515.7242137893745;5524.502794748492;5572.6037803744775;4543.931841022453;4861.368022157097;5367.523930919028;5387.27942389091;5399.514043735925;5036.194208926554;5239.214117882349;5253.581532986149;5572.86067848307;5593.440655934374;5551.833444996495;5695.259616249861;5714.942850571441;5859.736311865891;6026.638401695912;3308.602967643898;3700.6854417374825;3713.124871939653;3720.2559488101947;3720.2559488101947;5233.895322093613;5481.314835645544;5579.358373787067;5615.578831587565;5640.605157638925;4714.504976977505;4751.691140075884;5318.946810531846;5444.8094316698725;5510.8071217507195;4785.138675038387;5018.272350509083;5419.864503387447;5429.592780541396;5440.891182176255;4545.386372839756;4679.9704065105625;4939.876503087452;5368.731563421891;5369.677819330853;4878.707277563358;5128.769205385841;5436.184572314026;5444.237806707143;5496.395396506301;5345.599080068932;5355.758990845499;5370.9731451342495;5410.540104091039;5420.268263784339 12:18:55 INFO - PROCESS | 1658 | |5;yui.html;608.1911058292471;716.5060848131645;718.5365439291655;795.9442839001272;798.7563793043122;15855.84144158558;16650.417235396762;16653.250603722845;16654.83345166548;16683.499495015152;15241.695166096672;15268.694626107472;15408.537743867702;15491.535253942371;15952.52142435726;920.3511524375316;936.484933286693;936.4989730494187;936.7377134402344;940.4592359393342;925.1396201532572;943.7734943613517;943.8018016216603;944.4852555357347;959.9808003839919;1007.9596816127346;1010.525053224983;1011.5953618552564;1011.9949400252989;1013.0376142664461;1004.8090862736057;1005.5223768709841;1006.6979906028236;1006.8892421833592;1007.6171054999054;744.359850528545;744.3635691483812;745.3515441565818;747.2639450141606;747.6747614787585;15218.46735364268;15358.846411535853;15375.846241537552;15414;15523.146226957513;13812.37844296999;13813.585592432242;13994.300284985811;14012.22932738699;14102.506412275521;11415.315081095161;11495.42522873853;11680.357580333079;12111.031117510578;12208.32854193019;3567.137054728538;3655.177585043344;3691.0956815580084;3696.7042636589276;3799.183175617228;98534;100355;101308.49345753224;101623.47564786534;102716.48641756819;9685.903140968641;10438.947805260925;10650.680479585624;10693.251472396858;10853.186011049203;21692.783072169394;22273.55452890933;22435;22689.092436302362;22740.204092857002;7395.482316237812;7468.477206595595;7504.174540800507;7557.848843023109;7608.0489938757655;4013.8795836124964;4044.3933409988736;4107.9178416431505;4311.396404503372;4320.546342634041;3655.469956856241;3756.549214094326;3757.605451427615;3757.9060523487133;3760.9281354813747;682.689376333767;709.5990765217635;712.6650474277081;716.3373879161754;716.4733920568378;627.9902820491196;647.3041480408485;653.7254353171679;659.3768888400416;682.8361193313569;7353.77938661841;8914.28685705142;9382.437053776795;9696.854547181798;9813.950930245303;613.362103412446;634.955553111287;660.5013215022723;700.0828914122516;708.5819366573746;4425.269830478;4476.261416866246;4727.927712761701;4732.834350797774;4757.381540399726;97458;97954.51022744841;100268.49597256047;101092;103163.65199828162;54833.177502337494;63240.68379658072;76552.61723691458;83860.16139838523;84077.15922840816;50854;56643.43356566464;66952;68198.45221668971;69409;8364.53995030255;8944.418612790148;9835.409875407498;10306.845397319195;10411.895881041093;45316;45330.54669453263;46809.765951170026;46920.7653961728;47639.76180119077;57066.7146664264;59069.40930590639;60481.69759151176;60510.39489605048;60634;12419.19275247106;12576.937115314731;12666.683332916751;12679.688905772082;13102.98631314784;13741.88947239812;13811.689573235479;13905.235212063433;14329.57011289663;14494.782578261545;12887.09790314669;12917.468975997412;13093;13376.799348009594;13634.386452609855;12414.503419863466;12614.243145411305;12694.428750706425;12742.235465872078;12816.166949148275;12659.240445573296;12786.296753678636;12834.807477888025;12943.5469758558;13251.933740331237;10463.18260131333;10815.080718138732;10865.619703310345;10870.891291087304;11063.492063492064;8862;9102.550103731319;9201.355905086579;10524.473776311;10703.571857125628 12:18:55 INFO - PROCESS | 1658 | __end_tp_report 12:18:55 INFO - PROCESS | 1658 | __start_cc_report 12:18:55 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,3073 12:18:55 INFO - PROCESS | 1658 | __end_cc_report 12:18:55 INFO - PROCESS | 1658 | __startTimestamp1488140335554__endTimestamp 12:18:55 INFO - PROCESS | 1658 | 12:18:55 INFO - PROCESS | 1658 | ------- Summary: start ------- 12:18:55 INFO - PROCESS | 1658 | Number of tests: 6 12:18:55 INFO - PROCESS | 1658 | 12:18:55 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5545.79 Median:5670.15 stddev:645.28 (11.4%) stddev-sans-first:620.20 12:18:55 INFO - PROCESS | 1658 | Values: 3188.7 3199.3 3204.5 3222.6 3231.4 5345.0 5374.0 5464.8 5546.3 5552.5 5475.7 5483.4 5488.2 5533.3 5545.9 4737.7 4930.0 4965.1 5020.6 5188.6 5104.6 5156.2 5168.8 5197.2 5235.1 4901.0 4974.1 4986.8 5025.2 5093.1 5038.7 5041.8 5045.3 5061.0 5065.0 4960.6 4962.9 5003.3 5010.3 5016.6 5459.9 5462.7 5471.6 5476.1 5498.6 6024.4 6028.6 6035.2 6048.1 6050.0 6006.5 6046.0 6083.7 6097.1 6104.6 5568.3 5596.2 5613.4 5622.2 5632.1 6254.8 6256.5 6256.7 6261.7 6273.7 5751.2 5799.0 5834.1 5986.4 6022.1 6038.3 6115.7 6131.4 6148.8 6159.4 6054.9 6079.3 6082.8 6085.3 6121.9 5786.4 6107.9 6129.4 6131.6 6164.3 4761.3 4829.8 4830.0 4831.8 4837.8 4277.5 4334.3 4359.8 4360.7 4380.1 5453.4 5459.2 5459.2 5460.3 5470.9 5952.5 6001.8 6010.6 6014.0 6037.6 5433.1 5439.7 5464.0 5494.4 5495.5 4791.4 5196.7 5241.6 5248.1 5267.8 6305.9 6322.1 6326.9 6338.7 6340.3 6172.1 6174.7 6185.7 6186.7 6193.0 6114.4 6135.8 6144.6 6219.2 6342.4 5847.3 5857.1 5866.4 5869.1 5871.1 4296.4 5885.4 5942.9 5986.1 6087.6 5848.1 5867.0 5874.0 5892.6 5917.4 5878.7 5880.1 5887.9 5890.3 5913.9 5543.1 5622.7 5628.5 5728.7 5733.0 5138.4 5169.7 5779.1 5779.8 5784.5 5662.8 5670.1 5682.4 5684.8 5687.1 12:18:55 INFO - PROCESS | 1658 | 12:18:55 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:52805.72 Median:33655.50 stddev:106187.34 (315.5%) stddev-sans-first:106413.11 12:18:55 INFO - PROCESS | 1658 | Values: 684.8 787.3 841.9 865.8 866.4 26838.7 28112.9 28121.0 28148.3 37483.1 36892.4 38793.8 38845.5 38868.0 38904.8 8979.1 9146.1 9152.5 9172.3 9218.0 7312.6 7482.6 8985.8 9096.1 9111.6 7475.0 7476.3 7506.2 10702.9 10907.4 10827.0 10901.0 10902.4 10906.2 10915.5 10528.6 10586.0 10591.6 10603.2 10603.3 26097.2 26416.2 26567.9 36015.0 36262.0 3140.7 3724.6 3752.8 3803.3 3873.2 26761.5 26880.3 27200.0 27288.0 27390.5 2965.1 3087.5 3150.9 3157.7 3160.0 345375.3 346000.0 346899.0 347091.0 348261.0 49671.0 49720.0 49762.5 49807.5 49843.0 41743.4 42427.6 42429.0 44608.6 51344.5 12438.9 12495.4 12543.4 13173.8 13609.0 11727.9 11770.7 11771.9 11776.5 11815.8 11803.1 11896.2 11902.8 11908.8 11920.0 4412.7 4417.0 4640.6 5201.8 5211.9 886.7 936.0 982.0 1050.4 1087.6 25636.6 26339.6 26343.9 26354.7 26881.6 1117.4 1119.8 1153.0 1159.8 1160.2 10415.2 11198.2 12655.8 12937.4 13548.0 435191.0 437068.0 437082.0 437244.0 437436.0 47855.3 51893.5 51917.2 52019.2 52083.0 1379.9 1430.2 1432.1 1432.5 1433.1 24752.9 25725.7 25758.5 25777.7 25900.7 44198.3 44315.0 44411.8 44416.8 44447.0 410743.0 410893.0 412663.0 412979.9 413861.0 25982.5 31500.5 31690.0 31895.2 32156.7 40621.6 41773.7 41992.0 42297.8 42402.4 33026.0 33973.8 35237.6 35446.0 35511.5 33485.3 33594.2 33716.8 34962.3 35041.6 32732.5 34452.1 34778.7 35326.6 35329.9 20303.5 28293.7 30277.5 30790.0 30990.7 18335.7 22042.4 22498.9 22710.3 22893.8 12:18:55 INFO - PROCESS | 1658 | 12:18:55 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:38299.05 Median:21520.68 stddev:116605.03 (541.8%) stddev-sans-first:116897.31 12:18:55 INFO - PROCESS | 1658 | Values: 346.7 383.5 397.4 400.5 424.9 10731.7 14577.9 19964.6 20433.4 21355.0 21229.4 21250.8 21537.8 21778.9 21820.6 5906.9 6124.3 6155.7 6163.8 6177.3 5323.5 5724.5 5964.8 6041.5 6052.0 5758.9 5983.3 5985.0 5990.3 5994.7 5980.5 5996.3 6045.0 6058.2 6078.5 5242.4 5289.2 5292.0 5299.2 5485.7 10796.3 13744.8 13747.1 13755.1 21503.6 2487.9 2511.8 2513.6 2527.3 2590.1 9888.3 9993.1 10030.4 10310.7 10510.2 1756.0 1783.0 1788.6 1793.7 1810.9 118435.2 122502.0 123498.4 124863.0 128125.4 10829.5 11581.9 11869.3 11873.2 11935.9 14318.9 14687.9 14791.4 15452.3 15459.8 8510.3 8549.7 8607.5 8736.9 8768.4 8322.2 8326.5 8353.8 8500.5 8519.5 4775.7 4787.2 4807.4 4823.0 4891.7 2005.6 2044.1 2049.0 2054.0 2056.0 964.3 1016.7 1020.2 1066.7 1068.2 21007.9 22171.6 22252.6 22319.7 22336.6 923.9 1033.5 1035.6 1065.3 1089.5 11090.7 11386.7 11389.8 11390.7 11425.4 689805.0 691643.0 694491.0 704939.0 719595.0 136326.0 140730.0 147122.7 149806.5 150459.2 946.4 1005.6 1036.5 1089.9 1095.7 20013.3 20286.9 20521.5 20534.8 20604.4 45144.3 52572.7 53297.4 56232.9 56637.0 79893.0 79992.0 81909.4 82155.0 82747.6 5946.9 6262.5 7039.6 7647.0 8320.3 10489.8 11921.8 12868.5 13186.2 13470.7 11097.3 11384.5 11449.9 11559.2 11598.8 10906.3 11070.7 11172.3 11485.4 11522.7 9468.9 10889.6 11242.9 11382.6 11521.3 7265.6 7439.6 7447.4 7671.4 7687.0 9606.6 10603.7 11031.6 11046.1 11133.7 12:18:55 INFO - PROCESS | 1658 | 12:18:55 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5460.62 Median:5199.62 stddev:3003.23 (57.8%) stddev-sans-first:2996.55 12:18:55 INFO - PROCESS | 1658 | Values: 1452.4 1465.2 1485.2 1485.3 1490.4 8288.7 8674.7 8680.9 8686.1 8700.1 8292.3 8631.3 8634.6 8743.0 8754.8 2255.3 2291.2 2303.4 2305.3 2306.8 2273.9 2303.9 2306.0 2307.5 2308.3 2271.4 2271.6 2291.1 2295.0 2295.1 2192.1 2197.8 2235.4 2236.2 2249.8 2213.5 2287.9 2289.5 2292.2 2292.3 8596.6 8679.6 8685.4 8686.6 8691.1 5140.4 5283.5 5287.2 5292.9 5295.4 3051.8 3310.5 3426.2 3508.8 3513.5 1193.6 1220.8 1228.2 1231.5 1252.2 10047.8 10394.7 10428.0 10917.0 10922.6 4107.8 4229.8 4232.0 4253.3 4367.7 8946.0 9003.7 9022.0 9055.7 9058.5 5183.2 5186.7 5195.6 5198.3 5201.0 3816.3 4624.6 4771.4 4832.5 4833.4 3556.9 3625.3 3682.8 3711.8 3726.9 1118.9 1120.5 1132.2 1146.8 1147.3 760.9 844.6 899.6 903.2 943.2 5264.6 5561.9 5615.8 5785.7 6011.2 873.8 931.3 955.7 963.5 983.6 3226.9 3750.9 3845.7 3889.4 3916.9 9803.1 10088.3 10092.5 10098.3 10127.9 9729.6 9983.8 10075.7 10092.6 10105.8 7836.2 8181.7 8187.2 8191.1 8192.1 5111.3 5644.1 5722.9 5727.6 5984.0 9077.0 9448.8 9460.0 9620.6 9635.8 8523.7 8846.9 9295.8 9450.3 9749.5 5986.5 6405.6 6543.8 7061.0 7351.0 8141.6 8240.6 8340.5 8393.3 8429.1 6391.8 7225.7 7293.7 7331.1 7412.7 7171.9 7197.6 7199.5 7245.0 7360.4 6420.9 6470.6 6476.4 6511.9 6567.7 5005.2 5022.2 5084.6 5105.0 5186.4 4976.3 5024.3 5102.5 5250.1 5261.6 12:18:55 INFO - PROCESS | 1658 | 12:18:55 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4302.24 Median:4796.98 stddev:1339.93 (27.9%) stddev-sans-first:1309.69 12:18:55 INFO - PROCESS | 1658 | Values: 306.2 364.5 370.2 373.7 375.8 5106.3 5214.7 5215.6 5216.2 5239.7 3946.6 4442.6 4560.3 4679.6 5233.4 3845.8 3856.2 3888.6 3908.6 3917.6 3726.0 3889.8 3911.8 3924.0 3927.8 3327.0 3599.6 3848.2 3875.9 3895.3 3608.6 3810.5 3899.1 3915.6 3923.9 3342.5 3342.9 3344.5 3361.3 3364.7 3928.9 4808.8 4986.4 5000.4 5044.6 4053.0 4209.2 4246.3 4427.5 4465.9 4539.4 5282.0 5334.5 5380.3 5452.3 2987.6 3023.0 3188.7 3645.2 3716.8 4900.3 5572.8 5603.5 5716.9 5727.4 3165.8 3575.2 3587.5 3686.0 3702.5 3099.5 3467.0 3797.5 3814.7 3835.4 3804.9 4225.8 4444.2 4458.4 4477.2 4687.4 4985.9 5488.3 5580.2 5607.7 1234.4 1241.4 1248.4 1250.3 1253.9 697.8 801.8 849.3 861.2 862.1 4183.5 4238.4 4291.6 4831.8 4882.3 5020.9 5398.6 5410.4 5417.5 5422.6 4378.6 4541.6 4598.4 4845.3 4877.9 2377.4 2528.6 2645.1 2646.5 2807.4 4733.9 5241.0 5456.6 5457.1 5503.5 5019.2 5360.6 5418.6 5474.9 5534.8 4632.3 4834.7 5515.7 5524.5 5572.6 4543.9 4861.4 5367.5 5387.3 5399.5 5036.2 5239.2 5253.6 5572.9 5593.4 5551.8 5695.3 5714.9 5859.7 6026.6 3308.6 3700.7 3713.1 3720.3 3720.3 5233.9 5481.3 5579.4 5615.6 5640.6 4714.5 4751.7 5318.9 5444.8 5510.8 4785.1 5018.3 5419.9 5429.6 5440.9 4545.4 4680.0 4939.9 5368.7 5369.7 4878.7 5128.8 5436.2 5444.2 5496.4 5345.6 5355.8 5371.0 5410.5 5420.3 12:18:55 INFO - PROCESS | 1658 | 12:18:55 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:18982.40 Median:3757.08 stddev:26597.13 (707.9%) stddev-sans-first:26635.96 12:18:55 INFO - PROCESS | 1658 | Values: 608.2 716.5 718.5 795.9 798.8 15855.8 16650.4 16653.3 16654.8 16683.5 15241.7 15268.7 15408.5 15491.5 15952.5 920.4 936.5 936.5 936.7 940.5 925.1 943.8 943.8 944.5 960.0 1008.0 1010.5 1011.6 1012.0 1013.0 1004.8 1005.5 1006.7 1006.9 1007.6 744.4 744.4 745.4 747.3 747.7 15218.5 15358.8 15375.8 15414.0 15523.1 13812.4 13813.6 13994.3 14012.2 14102.5 11415.3 11495.4 11680.4 12111.0 12208.3 3567.1 3655.2 3691.1 3696.7 3799.2 98534.0 100355.0 101308.5 101623.5 102716.5 9685.9 10438.9 10650.7 10693.3 10853.2 21692.8 22273.6 22435.0 22689.1 22740.2 7395.5 7468.5 7504.2 7557.8 7608.0 4013.9 4044.4 4107.9 4311.4 4320.5 3655.5 3756.5 3757.6 3757.9 3760.9 682.7 709.6 712.7 716.3 716.5 628.0 647.3 653.7 659.4 682.8 7353.8 8914.3 9382.4 9696.9 9814.0 613.4 635.0 660.5 700.1 708.6 4425.3 4476.3 4727.9 4732.8 4757.4 97458.0 97954.5 100268.5 101092.0 103163.7 54833.2 63240.7 76552.6 83860.2 84077.2 50854.0 56643.4 66952.0 68198.5 69409.0 8364.5 8944.4 9835.4 10306.8 10411.9 45316.0 45330.5 46809.8 46920.8 47639.8 57066.7 59069.4 60481.7 60510.4 60634.0 12419.2 12576.9 12666.7 12679.7 13103.0 13741.9 13811.7 13905.2 14329.6 14494.8 12887.1 12917.5 13093.0 13376.8 13634.4 12414.5 12614.2 12694.4 12742.2 12816.2 12659.2 12786.3 12834.8 12943.5 13251.9 10463.2 10815.1 10865.6 10870.9 11063.5 8862.0 9102.6 9201.4 10524.5 10703.6 12:18:55 INFO - PROCESS | 1658 | -------- Summary: end -------- 12:18:55 INFO - PROCESS | 1658 | 12:18:56 INFO - TEST-INFO | 1658: exit 0 12:18:56 INFO - TEST-OK | dromaeo_css | took 1120622ms 12:18:56 INFO - TEST-START | kraken 12:18:56 INFO - operating with platform_type : mac_ 12:18:56 INFO - Initialising browser for kraken test... 12:18:56 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpwmLaeI/profile http://localhost:49253/getInfo.html) 12:18:58 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 12:18:58 INFO - PROCESS | 1663 | colorDepth:24 12:18:58 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 12:18:58 INFO - PROCESS | 1663 | __metrics 12:18:58 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:18:58 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:18:59 INFO - TEST-INFO | 1663: exit 0 12:18:59 INFO - Browser initialized. 12:18:59 INFO - Running cycle 1/1 for kraken test... 12:18:59 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpwmLaeI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:19:11 INFO - PROCESS | 1664 | RSS: Main: 231636992 12:19:11 INFO - PROCESS | 1664 | 12:19:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection) 12:19:15 INFO - PROCESS | 1664 | RSS: Main: 283082752 12:19:15 INFO - PROCESS | 1664 | 12:19:18 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-dft) 12:19:18 INFO - PROCESS | 1664 | RSS: Main: 285970432 12:19:18 INFO - PROCESS | 1664 | 12:19:22 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-fft) 12:19:22 INFO - PROCESS | 1664 | RSS: Main: 376958976 12:19:22 INFO - PROCESS | 1664 | 12:19:24 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator) 12:19:25 INFO - PROCESS | 1664 | RSS: Main: 278978560 12:19:25 INFO - PROCESS | 1664 | 12:19:27 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:19:28 INFO - PROCESS | 1664 | RSS: Main: 283029504 12:19:28 INFO - PROCESS | 1664 | 12:19:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom) 12:19:31 INFO - PROCESS | 1664 | RSS: Main: 326684672 12:19:31 INFO - PROCESS | 1664 | 12:19:35 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate) 12:19:35 INFO - PROCESS | 1664 | RSS: Main: 327069696 12:19:35 INFO - PROCESS | 1664 | 12:19:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial) 12:19:39 INFO - PROCESS | 1664 | RSS: Main: 323530752 12:19:39 INFO - PROCESS | 1664 | 12:19:41 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:19:42 INFO - PROCESS | 1664 | RSS: Main: 300556288 12:19:42 INFO - PROCESS | 1664 | 12:19:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:19:44 INFO - PROCESS | 1664 | RSS: Main: 306819072 12:19:44 INFO - PROCESS | 1664 | 12:19:46 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:19:47 INFO - PROCESS | 1664 | RSS: Main: 311795712 12:19:47 INFO - PROCESS | 1664 | 12:19:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:19:51 INFO - PROCESS | 1664 | RSS: Main: 319193088 12:19:51 INFO - PROCESS | 1664 | 12:19:54 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:19:54 INFO - PROCESS | 1664 | RSS: Main: 318259200 12:19:54 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49253/tests/kraken/driver.html?testName=ai-astar) 12:19:56 INFO - PROCESS | 1664 | RSS: Main: 362934272 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | __start_tp_report 12:19:56 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 12:19:56 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 12:19:56 INFO - PROCESS | 1664 | |i|pagename|runs| 12:19:56 INFO - PROCESS | 1664 | |0;ai-astar;113;114;113;112;113;114;112;113;113;114 12:19:56 INFO - PROCESS | 1664 | |1;audio-beat-detection;136;132;97;173;143;139;110;109;129;109 12:19:56 INFO - PROCESS | 1664 | |2;audio-dft;185;184;185;186;182;181;185;185;185;184 12:19:56 INFO - PROCESS | 1664 | |3;audio-fft;81;63;61;89;64;60;59;61;77;63 12:19:56 INFO - PROCESS | 1664 | |4;audio-oscillator;93;71;85;92;99;100;95;68;69;85 12:19:56 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;87;87;95;134;87;86;89;86;86;86 12:19:56 INFO - PROCESS | 1664 | |6;imaging-darkroom;95;95;94;98;95;95;95;99;95;94 12:19:56 INFO - PROCESS | 1664 | |7;imaging-desaturate;87;88;87;86;100;132;133;85;85;96 12:19:56 INFO - PROCESS | 1664 | |8;json-parse-financial;70;84;93;94;49;54;86;82;93;89 12:19:56 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;57;68;61;67;63;60;60;60;60;61 12:19:56 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;88;90;86;89;87;88;86;89;90;91 12:19:56 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;141;139;150;143;136;143;143;140;224;154 12:19:56 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;167;169;175;172;170;171;170;169;218;154 12:19:56 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;68;68;76;86;74;68;68;66;66;66 12:19:56 INFO - PROCESS | 1664 | __end_tp_report 12:19:56 INFO - PROCESS | 1664 | __start_cc_report 12:19:56 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,2193 12:19:56 INFO - PROCESS | 1664 | __end_cc_report 12:19:56 INFO - PROCESS | 1664 | __startTimestamp1488140396854__endTimestamp 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | ------- Summary: start ------- 12:19:56 INFO - PROCESS | 1664 | Number of tests: 14 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 12:19:56 INFO - PROCESS | 1664 | Values: 113.0 114.0 113.0 112.0 113.0 114.0 112.0 113.0 113.0 114.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:137.50 stddev:22.26 (16.2%) stddev-sans-first:23.40 12:19:56 INFO - PROCESS | 1664 | Values: 136.0 132.0 97.0 173.0 143.0 139.0 110.0 109.0 129.0 109.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:1.55 (0.8%) stddev-sans-first:1.62 12:19:56 INFO - PROCESS | 1664 | Values: 185.0 184.0 185.0 186.0 182.0 181.0 185.0 185.0 185.0 184.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:67.80 Median:63.50 stddev:10.54 (16.6%) stddev-sans-first:10.04 12:19:56 INFO - PROCESS | 1664 | Values: 81.0 63.0 61.0 89.0 64.0 60.0 59.0 61.0 77.0 63.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:85.70 Median:88.50 stddev:12.34 (13.9%) stddev-sans-first:12.80 12:19:56 INFO - PROCESS | 1664 | Values: 93.0 71.0 85.0 92.0 99.0 100.0 95.0 68.0 69.0 85.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:87.00 stddev:14.91 (17.1%) stddev-sans-first:15.69 12:19:56 INFO - PROCESS | 1664 | Values: 87.0 87.0 95.0 134.0 87.0 86.0 89.0 86.0 86.0 86.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:95.00 stddev:1.65 (1.7%) stddev-sans-first:1.74 12:19:56 INFO - PROCESS | 1664 | Values: 95.0 95.0 94.0 98.0 95.0 95.0 95.0 99.0 95.0 94.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:86.50 stddev:18.89 (21.8%) stddev-sans-first:19.62 12:19:56 INFO - PROCESS | 1664 | Values: 87.0 88.0 87.0 86.0 100.0 132.0 133.0 85.0 85.0 96.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:79.40 Median:87.50 stddev:16.34 (18.7%) stddev-sans-first:16.98 12:19:56 INFO - PROCESS | 1664 | Values: 70.0 84.0 93.0 94.0 49.0 54.0 86.0 82.0 93.0 89.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.00 stddev:3.40 (5.6%) stddev-sans-first:3.15 12:19:56 INFO - PROCESS | 1664 | Values: 57.0 68.0 61.0 67.0 63.0 60.0 60.0 60.0 60.0 61.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:89.00 stddev:1.71 (1.9%) stddev-sans-first:1.81 12:19:56 INFO - PROCESS | 1664 | Values: 88.0 90.0 86.0 89.0 87.0 88.0 86.0 89.0 90.0 91.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:143.00 stddev:26.08 (18.2%) stddev-sans-first:27.39 12:19:56 INFO - PROCESS | 1664 | Values: 141.0 139.0 150.0 143.0 136.0 143.0 143.0 140.0 224.0 154.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:170.50 stddev:16.59 (9.7%) stddev-sans-first:17.43 12:19:56 INFO - PROCESS | 1664 | Values: 167.0 169.0 175.0 172.0 170.0 171.0 170.0 169.0 218.0 154.0 12:19:56 INFO - PROCESS | 1664 | 12:19:56 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:68.00 stddev:6.40 (9.4%) stddev-sans-first:6.72 12:19:56 INFO - PROCESS | 1664 | Values: 68.0 68.0 76.0 86.0 74.0 68.0 68.0 66.0 66.0 66.0 12:19:56 INFO - PROCESS | 1664 | -------- Summary: end -------- 12:19:56 INFO - PROCESS | 1664 | 12:19:57 INFO - TEST-INFO | 1664: exit 0 12:19:57 INFO - TEST-OK | kraken | took 61570ms 12:19:57 INFO - SUITE-END | took 1182s 12:19:58 INFO - Completed test suite (00:19:42) 12:19:58 INFO - javascript benchmark 12:19:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7011.648055834115, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.7449004079667, 3199.2641692410743, 3204.4712622417287, 3222.6293976192746, 3231.434498962681, 5345.037893179236, 5374.0, 5464.754086066127, 5546.306711661043, 5552.500274975251, 5475.67145971241, 5483.424240454755, 5488.17677348398, 5533.3083364579425, 5545.916811247835, 4737.715737055788, 4930.03864246472, 4965.131102057153, 5020.573251273646, 5188.558972487343, 5104.566111880495, 5156.226566015091, 5168.767405466763, 5197.168453047513, 5235.057689615867, 4900.995295964319, 4974.079795237856, 4986.775595098229, 5025.221090730943, 5093.108705976458, 5038.748062596856, 5041.8487445376695, 5045.318881950926, 5061.013102445025, 5064.987002599495, 4960.578350840183, 4962.925556116661, 5003.3495645565845, 5010.298558201818, 5016.623753218487, 5459.918101228484, 5462.6995515246645, 5471.562275018029, 5476.069068258365, 5498.5876059295715, 6024.427679370497, 6028.608140470856, 6035.245594300713, 6048.092786082079, 6050.0, 6006.489448396892, 6045.969770151165, 6083.695815209222, 6097.054956481752, 6104.572679912408, 5568.276124103881, 5596.188552659842, 5613.382527921925, 5622.156676498558, 5632.070708333161, 6254.8123556293385, 6256.468200203034, 6256.718447669866, 6261.655608941552, 6273.686315684197, 5751.166080918327, 5799.043157878903, 5834.066549352084, 5986.4013598639785, 6022.066579680157, 6038.33578306386, 6115.724792384353, 6131.448169664752, 6148.754049838046, 6159.4456498915315, 6054.878902422015, 6079.331273559905, 6082.817515474543, 6085.269767627913, 6121.938780612226, 5786.363500014995, 6107.877842443215, 6129.3870612939245, 6131.63210207389, 6164.260288765377, 4761.262004389325, 4829.7585120744525, 4830.033993201374, 4831.830885918976, 4837.806487740521, 4277.529471758104, 4334.263175260214, 4359.847405340861, 4360.65114790816, 4380.145871555016, 5453.400125986138, 5459.153831156177, 5459.208414779835, 5460.262864513319, 5470.9452905471235, 5952.494038006731, 6001.819945401645, 6010.609310394811, 6014.007688731398, 6037.63774173551, 5433.0763770159165, 5439.700816455133, 5464.0, 5494.36814766299, 5495.505404513613, 4791.377120974321, 5196.662216955961, 5241.554467870274, 5248.05535003703, 5267.78928842842, 6305.905411418832, 6322.083297921776, 6326.905096423558, 6338.714757835908, 6340.270868850142, 6172.135900973777, 6174.722137503913, 6185.6907154641185, 6186.659733714689, 6192.969035154795, 6114.357992410911, 6135.814547850547, 6144.556029333193, 6219.222597175353, 6342.39747224013, 5847.26909136358, 5857.062869940789, 5866.354700982974, 5869.06095024794, 5871.1486834409625, 4296.441462609966, 5885.440883116097, 5942.881142377215, 5986.07215881539, 6087.604305720114, 5848.093545500455, 5867.031939729897, 5874.0, 5892.646441213541, 5917.437843404869, 5878.735456904535, 5880.14737863016, 5887.852803679943, 5890.263717035371, 5913.881722365442, 5543.113101903676, 5622.662640241599, 5628.493435590816, 5728.713564321851, 5733.02538568436, 5138.383393992595, 5169.663971841968, 5779.133130030529, 5779.797707080232, 5784.537237020944, 5662.801801936913, 5670.149477578396, 5682.43175682445, 5684.8010319638615, 5687.090065589486], "value": 5503.890895161846, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.7569112964898, 787.283571949526, 841.9452735572187, 865.8311629232302, 866.4498043742221, 26838.731612683867, 28112.85943570282, 28121.0, 28148.296292592695, 37483.062923426856, 36892.446613300825, 38793.806030969805, 38845.53276373218, 38868.0, 38904.80547597265, 8979.146981036807, 9146.131117543822, 9152.4966126863, 9172.266218702487, 9217.953910230439, 7312.597807120606, 7482.588457634828, 8985.820283594325, 9096.090390960917, 9111.589978450986, 7475.0, 7476.289752473534, 7506.174320824705, 10702.946485267563, 10907.400092994882, 10827.0, 10901.0, 10902.400367979719, 10906.236563440561, 10915.454227288605, 10528.578856845717, 10586.04725574702, 10591.576336946513, 10603.151747860229, 10603.257771955967, 26097.217083487525, 26416.207513774425, 26567.867160664267, 36015.0, 36262.0, 3140.654528001941, 3724.6461586149544, 3752.756070855413, 3803.334416477133, 3873.1672690371424, 26761.46477070467, 26880.327991800164, 27200.0, 27288.0, 27390.452190956068, 2965.0956458280216, 3087.4905640569277, 3150.8897188598517, 3157.700018498239, 3159.9684003159905, 345375.27312363527, 346000.0, 346899.0, 347091.0, 348261.0, 49671.0, 49720.0, 49762.50237497651, 49807.501924981014, 49843.003139937, 41743.37384939229, 42427.575724242364, 42429.0, 44608.55391446044, 51344.48655513397, 12438.94268987128, 12495.375231238402, 12543.372831358396, 13173.802392964113, 13609.047366684435, 11727.941360293144, 11770.705732356588, 11771.88228117725, 11776.470058847372, 11815.763684726257, 11803.114766392555, 11896.167268291136, 11902.761944761229, 11908.821367679491, 11920.0, 4412.735235885857, 4416.955830441719, 4640.579340688415, 5201.803585175355, 5211.921821172686, 886.6807949138305, 936.0265324063034, 982.0081717465268, 1050.3960222871879, 1087.5649740103863, 25636.615450768255, 26339.604905926426, 26343.946242150098, 26354.73645263561, 26881.596776048376, 1117.4301106435776, 1119.8208286674094, 1152.9538818447168, 1159.8260260960756, 1160.193665402554, 10415.188608543593, 11198.216124871344, 12655.81016284738, 12937.417816198105, 13548.0, 435191.0, 437068.0, 437082.0, 437244.0, 437436.0, 47855.28217076747, 51893.48106518962, 51917.22124168141, 52019.219711704354, 52083.0, 1379.9310034498235, 1430.206235539265, 1432.0691550492056, 1432.4986254810733, 1433.0613448191452, 24752.876235618707, 25725.742742572336, 25758.484830303663, 25777.742222577534, 25900.740992589832, 44198.337024944005, 44315.0, 44411.777941110086, 44416.777916110215, 44447.0, 410743.0, 410893.0, 412663.0, 412979.9351003226, 413861.0, 25982.480350393264, 31500.527492087178, 31690.04929852108, 31895.202619934687, 32156.678433216304, 40621.593784061784, 41773.74678759642, 41992.0, 42297.788511057246, 42402.36396453994, 33026.0, 33973.83013084919, 35237.64762352344, 35446.0, 35511.46732799062, 33485.33029339351, 33594.160145996546, 33716.83141584276, 34962.300753985284, 35041.649583504855, 32732.50901236531, 34452.07119482776, 34778.652213477544, 35326.64673353233, 35329.94010179699, 20303.4924126898, 28293.71706282911, 30277.486125693187, 30789.963613858432, 30990.69009309878, 18335.724964125282, 22042.44893877666, 22498.887505563023, 22710.31869043931, 22893.771062289165], "value": 17649.55330737832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.7430564204758, 383.5091083413232, 397.44754790840733, 400.52737769432065, 424.90864464140225, 10731.678049658503, 14577.854221457783, 19964.60070798585, 20433.386998390033, 21355.0, 21229.363119106452, 21250.831204283757, 21537.784622153773, 21778.89110554445, 21820.563588728215, 5906.88186236275, 6124.326324104345, 6155.661438620874, 6163.845903852395, 6177.289611694645, 5323.494268044549, 5724.513416359614, 5964.761409543613, 6041.486473649745, 6052.031674932012, 5758.913616295759, 5983.282006159246, 5985.0, 5990.281166260055, 5994.670293133876, 5980.491658209035, 5996.2504686914135, 6044.972354699667, 6058.212432383806, 6078.483328917047, 5242.423333433319, 5289.233061206103, 5292.0, 5299.205119232108, 5485.725713714338, 10796.298240614335, 13744.793828092586, 13747.106438081493, 13755.10591811529, 21503.569928601497, 2487.9378015549573, 2511.836730612504, 2513.6229565565127, 2527.2670925431603, 2590.0675756727564, 9888.307818452711, 9993.050660187344, 10030.448325342104, 10310.7422314442, 10510.159187265077, 1755.9525294196872, 1782.97325540117, 1788.624388878324, 1793.7219730941724, 1810.9185086671132, 118435.15648435174, 122501.99999999911, 123498.38250808779, 124863.0, 128125.35937320346, 10829.512671929782, 11581.942090289664, 11869.287842729464, 11873.228240164362, 11935.940320298516, 14318.85681143196, 14687.926560367343, 14791.408343666348, 15452.304646290944, 15459.845401546065, 8510.319174466027, 8549.743507694779, 8607.483550986835, 8736.912630873738, 8768.386212965159, 8322.16778322175, 8326.45878017927, 8353.791155221168, 8500.532470714046, 8519.531425771642, 4775.689580177277, 4787.186178349689, 4807.351007613997, 4822.95177048232, 4891.6575839691595, 2005.568802707425, 2044.1005957378707, 2048.979510204879, 2054.0, 2055.98972005139, 964.2960638733764, 1016.6645007147623, 1020.2195320579763, 1066.7439814444633, 1068.1614932278123, 21007.8949605251, 22171.55656886853, 22252.554948901256, 22319.66082035083, 22336.553268934855, 923.9445633262026, 1033.452270296744, 1035.6064695415694, 1065.2969040433277, 1089.536946797608, 11090.722731931604, 11386.658400248005, 11389.829152562717, 11390.658280251606, 11425.428728563538, 689805.0, 691643.0, 694491.0, 704939.0, 719595.0, 136326.0, 140730.0, 147122.7247504171, 149806.53288940905, 150459.24770376078, 946.3990366117565, 1005.5877090392904, 1036.528379587286, 1089.8855620159927, 1095.7315457712753, 20013.299534516224, 20286.884221367374, 20521.48696282605, 20534.794652053886, 20604.38186854397, 45144.32283515816, 52572.68568285823, 53297.40107796773, 56232.87534249374, 56637.0, 79893.0, 79992.0, 81909.3618127646, 82155.0, 82747.58626207072, 5946.910796338145, 6262.53031022666, 7039.577625342496, 7646.9617651911385, 8320.334373250005, 10489.842652360374, 11921.821172682243, 12868.485260589472, 13186.208827470382, 13470.663233419244, 11097.336639206695, 11384.48769805344, 11449.885501144881, 11559.248648837798, 11598.768024639292, 10906.34561926287, 11070.723231919266, 11172.273802203155, 11485.425728713699, 11522.654320370402, 9468.857967130361, 10889.564417423215, 11242.887571124511, 11382.601608943647, 11521.308721476738, 7265.600391978492, 7439.55362678241, 7447.366973807287, 7671.424643151898, 7687.0444741932015, 9606.615735370508, 10603.681889543326, 11031.613893513688, 11046.116310695286, 11133.721656958642], "value": 9615.712881642716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.4335509151426, 1465.1575344177102, 1485.1683057487808, 1485.3167542930246, 1490.3516970117996, 8288.709895153663, 8674.696385626496, 8680.869786953193, 8686.087960764124, 8700.086490918457, 8292.336613070955, 8631.30949524038, 8634.611442485088, 8743.038265790758, 8754.781130471742, 2255.323402979104, 2291.2209848651455, 2303.366574192094, 2305.250793492113, 2306.8385213035094, 2273.897674604647, 2303.8617682938993, 2305.9538809223804, 2307.469282065126, 2308.2613563659634, 2271.4094335472732, 2271.5911135995516, 2291.0950174681075, 2295.0, 2295.0704964489323, 2192.079326682789, 2197.7582465928735, 2235.429965358823, 2236.194969810867, 2249.763774803647, 2213.513027134028, 2287.8512896661664, 2289.4505318723554, 2292.1633603734685, 2292.3123063081007, 8596.570171491463, 8679.566021698889, 8685.435446695945, 8686.56567171639, 8691.130886911322, 5140.408852981917, 5283.498067683602, 5287.180487024479, 5292.92060619091, 5295.364556253236, 3051.755859531232, 3310.536524886518, 3426.2119712466274, 3508.7719298245534, 3513.472979053137, 1193.618042226488, 1220.8229806677982, 1228.1955319265894, 1231.470467698889, 1252.2361359570655, 10047.849282260771, 10394.688159355232, 10428.009339112848, 10916.962888525577, 10922.563097476092, 4107.774072426046, 4229.767362795014, 4232.0, 4253.27694291965, 4367.65058795302, 8946.0, 9003.729888103237, 9021.954890225637, 9055.68305109318, 9058.547072646474, 5183.248428977777, 5186.740662966912, 5195.558377537952, 5198.2722418861385, 5200.97399513, 3816.3321418751607, 4624.635113894324, 4771.379720636295, 4832.492588278251, 4833.3958255218095, 3556.9110772230383, 3625.3111908737255, 3682.760620559655, 3711.7958512281543, 3726.925461490755, 1118.9440527973568, 1120.4621781544904, 1132.2413982631656, 1146.7591805720724, 1147.3058799426394, 760.8934749135126, 844.6410275632832, 899.5502248875562, 903.2322525852973, 943.1841457139525, 5264.552248131795, 5561.944380556223, 5615.775368985195, 5785.739641716133, 6011.218541589566, 873.8383399071192, 931.3201363004908, 955.6941778630771, 963.5278713430508, 983.6262220356219, 3226.8547915343865, 3750.9062273442837, 3845.692344612424, 3889.3776995680555, 3916.8629097981434, 9803.117719405287, 10088.293819432716, 10092.495375231209, 10098.343607665478, 10127.949360253298, 9729.56216970238, 9983.800323993479, 10075.748106297402, 10092.596296148073, 10105.848412273821, 7836.177201393885, 8181.672733090729, 8187.222213889671, 8191.139930307232, 8192.057913339922, 5111.258867464271, 5644.096944488862, 5722.885542289047, 5727.625369911275, 5983.982722937199, 9077.0, 9448.811023779623, 9459.95940446564, 9620.615175392906, 9635.807283854423, 8523.74428767138, 8846.911530884609, 9295.76760580991, 9450.338476306593, 9749.463779492196, 5986.491148252448, 6405.615663060231, 6543.836404089936, 7061.0, 7351.044364232615, 8141.633626486941, 8240.587970601566, 8340.457870238415, 8393.28657064132, 8429.072801991653, 6391.776287829904, 7225.747098851725, 7293.744718934812, 7331.083614548182, 7412.666430010555, 7171.8565628688175, 7197.640117993975, 7199.460040497089, 7244.963775181302, 7360.374368178551, 6420.871582568229, 6470.579412338183, 6476.352364763486, 6511.869762604627, 6567.671616419256, 5005.224190250517, 5022.196448568212, 5084.618653600921, 5104.9744751276, 5186.377634683862, 4976.3068672635245, 5024.307134256392, 5102.540771330598, 5250.133727934848, 5261.631685782112], "value": 4415.15267108429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.21608681774654, 364.475155775683, 370.1671239710651, 373.704773229149, 375.80833774774857, 5106.31064806251, 5214.696325918516, 5215.634905556603, 5216.217567364888, 5239.742461809167, 3946.625070618287, 4442.555744425564, 4560.286629455469, 4679.625629949604, 5233.398159211692, 3845.807709614508, 3856.2094770571966, 3888.61113888611, 3908.6286802753693, 3917.6474117329435, 3726.0, 3889.7860617666015, 3911.8068988958357, 3924.018370722781, 3927.803609819512, 3327.0185295337933, 3599.6400359963927, 3848.2495913296916, 3875.922481550367, 3895.2988462076955, 3608.585012723544, 3810.542734871833, 3899.0642245861072, 3915.6280153385383, 3923.9215215695667, 3342.5320455136302, 3342.88299909502, 3344.5484859543894, 3361.3277344530948, 3364.6803553662608, 3928.921421571581, 4808.821838649518, 4986.376702912136, 5000.42495113063, 5044.621653376012, 4052.986753311672, 4209.2423363794505, 4246.341817018367, 4427.4908385535755, 4465.933011004805, 4539.432570928634, 5281.973590132063, 5334.51989320963, 5380.300560927094, 5452.345718513804, 2987.581738556582, 3022.9697703022907, 3188.7289580385695, 3645.198056427582, 3716.832742526593, 4900.338454308659, 5572.804951826707, 5603.5237004854225, 5716.857078573069, 5727.3986231445515, 3165.8258795766455, 3575.1598374382, 3587.51568538244, 3686.0, 3702.500162478085, 3099.4730895747775, 3466.9653303466644, 3797.4999875049753, 3814.7138964577766, 3835.36716441784, 3804.9429258561145, 4225.830966761357, 4444.155610434007, 4458.375827384169, 4477.171723231148, 4687.39063921688, 4985.875353116201, 5488.341399032141, 5580.177578358837, 5607.719614019283, 1234.4074844074714, 1241.410993927774, 1248.3708760068016, 1250.2935841249664, 1253.9466847847852, 697.7801992372387, 801.761278824218, 849.3417601358997, 861.1743104618249, 862.1206369503071, 4183.49798024239, 4238.364245363158, 4291.618151925712, 4831.830885918976, 4882.316475693406, 5020.924686129711, 5398.595105367113, 5410.403930840412, 5417.485338892799, 5422.6475279106735, 4378.584034516716, 4541.636669066466, 4598.448186217675, 4845.2732090186755, 4877.853664390074, 2377.4427749823894, 2528.608065749812, 2645.061003343824, 2646.470705858836, 2807.4104438068234, 4733.928991065137, 5241.0, 5456.563474922076, 5457.126859702428, 5503.504684578407, 5019.247112933016, 5360.6247562671015, 5418.647787893774, 5474.890502190014, 5534.75093620788, 4632.305154226826, 4834.661573689878, 5515.7242137893745, 5524.502794748492, 5572.6037803744775, 4543.931841022453, 4861.368022157097, 5367.523930919028, 5387.27942389091, 5399.514043735925, 5036.194208926554, 5239.214117882349, 5253.581532986149, 5572.86067848307, 5593.440655934374, 5551.833444996495, 5695.259616249861, 5714.942850571441, 5859.736311865891, 6026.638401695912, 3308.602967643898, 3700.6854417374825, 3713.124871939653, 3720.2559488101947, 3720.2559488101947, 5233.895322093613, 5481.314835645544, 5579.358373787067, 5615.578831587565, 5640.605157638925, 4714.504976977505, 4751.691140075884, 5318.946810531846, 5444.8094316698725, 5510.8071217507195, 4785.138675038387, 5018.272350509083, 5419.864503387447, 5429.592780541396, 5440.891182176255, 4545.386372839756, 4679.9704065105625, 4939.876503087452, 5368.731563421891, 5369.677819330853, 4878.707277563358, 5128.769205385841, 5436.184572314026, 5444.237806707143, 5496.395396506301, 5345.599080068932, 5355.758990845499, 5370.9731451342495, 5410.540104091039, 5420.268263784339], "value": 3892.0503003091335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.1911058292471, 716.5060848131645, 718.5365439291655, 795.9442839001272, 798.7563793043122, 15855.84144158558, 16650.417235396762, 16653.250603722845, 16654.83345166548, 16683.499495015152, 15241.695166096672, 15268.694626107472, 15408.537743867702, 15491.535253942371, 15952.52142435726, 920.3511524375316, 936.484933286693, 936.4989730494187, 936.7377134402344, 940.4592359393342, 925.1396201532572, 943.7734943613517, 943.8018016216603, 944.4852555357347, 959.9808003839919, 1007.9596816127346, 1010.525053224983, 1011.5953618552564, 1011.9949400252989, 1013.0376142664461, 1004.8090862736057, 1005.5223768709841, 1006.6979906028236, 1006.8892421833592, 1007.6171054999054, 744.359850528545, 744.3635691483812, 745.3515441565818, 747.2639450141606, 747.6747614787585, 15218.46735364268, 15358.846411535853, 15375.846241537552, 15414.0, 15523.146226957513, 13812.37844296999, 13813.585592432242, 13994.300284985811, 14012.22932738699, 14102.506412275521, 11415.315081095161, 11495.42522873853, 11680.357580333079, 12111.031117510578, 12208.32854193019, 3567.137054728538, 3655.177585043344, 3691.0956815580084, 3696.7042636589276, 3799.183175617228, 98534.0, 100355.0, 101308.49345753224, 101623.47564786534, 102716.48641756819, 9685.903140968641, 10438.947805260925, 10650.680479585624, 10693.251472396858, 10853.186011049203, 21692.783072169394, 22273.55452890933, 22435.0, 22689.092436302362, 22740.204092857002, 7395.482316237812, 7468.477206595595, 7504.174540800507, 7557.848843023109, 7608.0489938757655, 4013.8795836124964, 4044.3933409988736, 4107.9178416431505, 4311.396404503372, 4320.546342634041, 3655.469956856241, 3756.549214094326, 3757.605451427615, 3757.9060523487133, 3760.9281354813747, 682.689376333767, 709.5990765217635, 712.6650474277081, 716.3373879161754, 716.4733920568378, 627.9902820491196, 647.3041480408485, 653.7254353171679, 659.3768888400416, 682.8361193313569, 7353.77938661841, 8914.28685705142, 9382.437053776795, 9696.854547181798, 9813.950930245303, 613.362103412446, 634.955553111287, 660.5013215022723, 700.0828914122516, 708.5819366573746, 4425.269830478, 4476.261416866246, 4727.927712761701, 4732.834350797774, 4757.381540399726, 97458.0, 97954.51022744841, 100268.49597256047, 101092.0, 103163.65199828162, 54833.177502337494, 63240.68379658072, 76552.61723691458, 83860.16139838523, 84077.15922840816, 50854.0, 56643.43356566464, 66952.0, 68198.45221668971, 69409.0, 8364.53995030255, 8944.418612790148, 9835.409875407498, 10306.845397319195, 10411.895881041093, 45316.0, 45330.54669453263, 46809.765951170026, 46920.7653961728, 47639.76180119077, 57066.7146664264, 59069.40930590639, 60481.69759151176, 60510.39489605048, 60634.0, 12419.19275247106, 12576.937115314731, 12666.683332916751, 12679.688905772082, 13102.98631314784, 13741.88947239812, 13811.689573235479, 13905.235212063433, 14329.57011289663, 14494.782578261545, 12887.09790314669, 12917.468975997412, 13093.0, 13376.799348009594, 13634.386452609855, 12414.503419863466, 12614.243145411305, 12694.428750706425, 12742.235465872078, 12816.166949148275, 12659.240445573296, 12786.296753678636, 12834.807477888025, 12943.5469758558, 13251.933740331237, 10463.18260131333, 10815.080718138732, 10865.619703310345, 10870.891291087304, 11063.492063492064, 8862.0, 9102.550103731319, 9201.355905086579, 10524.473776311, 10703.571857125628], "value": 7402.285144673816, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1489.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 112.0, 113.0, 114.0, 112.0, 113.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 97.0, 173.0, 143.0, 139.0, 110.0, 109.0, 129.0, 109.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 186.0, 182.0, 181.0, 185.0, 185.0, 185.0, 184.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 63.0, 61.0, 89.0, 64.0, 60.0, 59.0, 61.0, 77.0, 63.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 71.0, 85.0, 92.0, 99.0, 100.0, 95.0, 68.0, 69.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 95.0, 134.0, 87.0, 86.0, 89.0, 86.0, 86.0, 86.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 98.0, 95.0, 95.0, 95.0, 99.0, 95.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 87.0, 86.0, 100.0, 132.0, 133.0, 85.0, 85.0, 96.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 84.0, 93.0, 94.0, 49.0, 54.0, 86.0, 82.0, 93.0, 89.0], "value": 79.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 68.0, 61.0, 67.0, 63.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 86.0, 89.0, 87.0, 88.0, 86.0, 89.0, 90.0, 91.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 150.0, 143.0, 136.0, 143.0, 143.0, 140.0, 224.0, 154.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 175.0, 172.0, 170.0, 171.0, 170.0, 169.0, 218.0, 154.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 76.0, 86.0, 74.0, 68.0, 68.0, 66.0, 66.0, 66.0], "value": 70.6, "unit": "score"}]}]} 12:19:58 INFO - Return code: 0 12:19:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:19:58 ERROR - # TBPL SUCCESS # 12:19:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:19:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:19:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:19:58 INFO - 2017-02-26 12:19:58.173 screenresolution[1668:12548] starting screenresolution argv=screenresolution get 12:19:58 INFO - 2017-02-26 12:19:58.176 screenresolution[1668:12548] Display 0: 1600x1200x32@60 12:19:58 INFO - 2017-02-26 12:19:58.183 screenresolution[1669:12551] starting screenresolution argv=screenresolution list 12:19:58 INFO - Available Modes on Display 0 12:19:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:19:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:19:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:19:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:19:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:19:58 INFO - Intel Iris: 12:19:58 INFO - Chipset Model: Intel Iris 12:19:58 INFO - Type: GPU 12:19:58 INFO - Bus: Built-In 12:19:58 INFO - VRAM (Dynamic, Max): 1536 MB 12:19:58 INFO - Vendor: Intel (0x8086) 12:19:58 INFO - Device ID: 0x0a2e 12:19:58 INFO - Revision ID: 0x0009 12:19:58 INFO - Displays: 12:19:58 INFO - Display: 12:19:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:19:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:19:58 INFO - Display Serial Number: 1600x1200 60 12:19:58 INFO - Main Display: Yes 12:19:58 INFO - Mirror: Off 12:19:58 INFO - Online: Yes 12:19:58 INFO - Rotation: Supported 12:19:58 INFO - Return code: 0 12:19:58 INFO - Running post-action listener: _resource_record_post_action 12:19:58 INFO - [mozharness: 2017-02-26 20:19:58.426105Z] Finished run-tests step (success) 12:19:58 INFO - Running post-run listener: _resource_record_post_run 12:19:58 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 32599040; Write bytes: 514086912; Read time: 195; Write time: 1586 12:19:58 INFO - TinderboxPrint: CPU usage
53.6% 12:19:58 INFO - TinderboxPrint: I/O read bytes / time
32,599,040 / 195 12:19:58 INFO - TinderboxPrint: I/O write bytes / time
514,086,912 / 1,586 12:19:58 INFO - TinderboxPrint: CPU idle
2,232.2 (46.4%) 12:19:58 INFO - TinderboxPrint: CPU system
958.2 (19.9%) 12:19:58 INFO - TinderboxPrint: CPU user
1,623.3 (33.7%) 12:19:58 INFO - TinderboxPrint: Swap in / out
238,551,040 / 0 12:19:58 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204210688; Write bytes: 203617792; Read time: 15478; Write time: 437 12:19:58 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 30768128; Write bytes: 299807232; Read time: 180; Write time: 1114 12:19:58 INFO - Running post-run listener: _upload_blobber_files 12:19:58 INFO - Blob upload gear active. 12:19:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:19:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:19:59 INFO - (blobuploader) - INFO - Open directory for files ... 12:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:20:00 INFO - (blobuploader) - INFO - Done attempting. 12:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:20:01 INFO - (blobuploader) - INFO - Done attempting. 12:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:20:02 INFO - (blobuploader) - INFO - Done attempting. 12:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:20:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:20:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:20:04 INFO - (blobuploader) - INFO - Done attempting. 12:20:04 INFO - (blobuploader) - INFO - Iteration through files over. 12:20:04 INFO - Return code: 0 12:20:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:20:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:20:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/467ede49112e6ccf3c64b731b88ce7fb267d573d4dec95e595a933f0d67c91e1327f658414a0fea92db1e3e3fd46480e11a93707301d6eff73ab2665b51606e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5bb3c040c59c22b5205a3803a8638f6d0ce97dc906f44225fb68f5d84efd8369f0ab71d504faa61f20e58e331375c50273fe1179dda12ed1ac953d9eb6c317e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/386ec1b1f23705135ab2cad9acf89eb63adc05271a959994bbfb9ba1501d5addc27a51b45801489e5189ce48527c91704c0036a10851d2a56a4af5cec0517f19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05144317ac574e440b7750ce54c70bf9cb89b2ca4f22ef443ef41cab7b3e5048fb80aac4739bddf97a34810406bdaf43d98142f17f6f77fea7970d54950e4669"} 12:20:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:20:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:20:04 INFO - Contents: 12:20:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/467ede49112e6ccf3c64b731b88ce7fb267d573d4dec95e595a933f0d67c91e1327f658414a0fea92db1e3e3fd46480e11a93707301d6eff73ab2665b51606e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5bb3c040c59c22b5205a3803a8638f6d0ce97dc906f44225fb68f5d84efd8369f0ab71d504faa61f20e58e331375c50273fe1179dda12ed1ac953d9eb6c317e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/386ec1b1f23705135ab2cad9acf89eb63adc05271a959994bbfb9ba1501d5addc27a51b45801489e5189ce48527c91704c0036a10851d2a56a4af5cec0517f19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05144317ac574e440b7750ce54c70bf9cb89b2ca4f22ef443ef41cab7b3e5048fb80aac4739bddf97a34810406bdaf43d98142f17f6f77fea7970d54950e4669"} 12:20:04 INFO - Running post-run listener: copy_logs_to_upload_dir 12:20:04 INFO - Copying logs to upload dir... 12:20:04 INFO - mkdir: /builds/slave/test/build/upload/logs 12:20:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.365460 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-02-26 12:20:04.634245) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-26 12:20:04.637504) ========= 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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/467ede49112e6ccf3c64b731b88ce7fb267d573d4dec95e595a933f0d67c91e1327f658414a0fea92db1e3e3fd46480e11a93707301d6eff73ab2665b51606e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5bb3c040c59c22b5205a3803a8638f6d0ce97dc906f44225fb68f5d84efd8369f0ab71d504faa61f20e58e331375c50273fe1179dda12ed1ac953d9eb6c317e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/386ec1b1f23705135ab2cad9acf89eb63adc05271a959994bbfb9ba1501d5addc27a51b45801489e5189ce48527c91704c0036a10851d2a56a4af5cec0517f19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05144317ac574e440b7750ce54c70bf9cb89b2ca4f22ef443ef41cab7b3e5048fb80aac4739bddf97a34810406bdaf43d98142f17f6f77fea7970d54950e4669"} build_url:https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.014523 build_url: 'https://queue.taskcluster.net/v1/task/A41XKsBjQMi814SnorGBRA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/467ede49112e6ccf3c64b731b88ce7fb267d573d4dec95e595a933f0d67c91e1327f658414a0fea92db1e3e3fd46480e11a93707301d6eff73ab2665b51606e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5bb3c040c59c22b5205a3803a8638f6d0ce97dc906f44225fb68f5d84efd8369f0ab71d504faa61f20e58e331375c50273fe1179dda12ed1ac953d9eb6c317e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/386ec1b1f23705135ab2cad9acf89eb63adc05271a959994bbfb9ba1501d5addc27a51b45801489e5189ce48527c91704c0036a10851d2a56a4af5cec0517f19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05144317ac574e440b7750ce54c70bf9cb89b2ca4f22ef443ef41cab7b3e5048fb80aac4739bddf97a34810406bdaf43d98142f17f6f77fea7970d54950e4669"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-26 12:20:04.676467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 12:20:04.676793) ========= 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.t9F0Jxs2oA/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.fYhqQiPKVH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.005500 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 12:20:04.724624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-26 12:20:04.724914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-26 12:20:04.725221) ========= ========= Total master_lag: 0.18 =========