builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0314 starttime: 1470691416.52 results: success (0) buildid: 20160808131625 builduid: 943c4d1a2b8849bf92740c4753819dea revision: fc6ed18f76e16d3e2a392c93fd77b867e12955e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:36.517717) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:36.518103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:36.518421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:36.654102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:36.654472) ========= 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.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-08 14:23:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-08-08 14:23:36 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123403 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:36.810132) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:36.810415) ========= 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.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.025353 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:36.869019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 14:23:36.869352) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev fc6ed18f76e16d3e2a392c93fd77b867e12955e4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev fc6ed18f76e16d3e2a392c93fd77b867e12955e4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-08 14:23:36,954 truncating revision to first 12 chars 2016-08-08 14:23:36,954 Setting DEBUG logging. 2016-08-08 14:23:36,954 attempt 1/10 2016-08-08 14:23:36,954 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/fc6ed18f76e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 14:23:38,284 unpacking tar archive at: autoland-fc6ed18f76e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.600304 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 14:23:38.492040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:38.492409) ========= script_repo_revision: fc6ed18f76e16d3e2a392c93fd77b867e12955e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:38.492900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:38.493220) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:38.511654) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-08 14:23:38.511974) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:23:38 INFO - MultiFileLogger online at 20160808 14:23:38 in /builds/slave/test 14:23:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 14:23:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:38 INFO - {'append_to_log': False, 14:23:38 INFO - 'base_work_dir': '/builds/slave/test', 14:23:38 INFO - 'blob_upload_branch': 'Autoland', 14:23:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:38 INFO - 'branch': 'Autoland', 14:23:38 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:38 INFO - 'config_files': ('talos/mac_config.py',), 14:23:38 INFO - 'default_actions': ('clobber', 14:23:38 INFO - 'read-buildbot-config', 14:23:38 INFO - 'download-and-extract', 14:23:38 INFO - 'populate-webroot', 14:23:38 INFO - 'create-virtualenv', 14:23:38 INFO - 'install', 14:23:38 INFO - 'run-tests'), 14:23:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:38 INFO - 'download_minidump_stackwalk': True, 14:23:38 INFO - 'download_symbols': 'ondemand', 14:23:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:38 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:38 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:38 INFO - 'installer_path': 'installer.exe', 14:23:38 INFO - 'log_level': 'info', 14:23:38 INFO - 'log_name': 'talos', 14:23:38 INFO - 'log_to_console': True, 14:23:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:23:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:23:38 INFO - 'opt_config_files': (), 14:23:38 INFO - 'pip_index': False, 14:23:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:38 INFO - 'cmd': ('bash', 14:23:38 INFO - '-c', 14:23:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:38 INFO - 'enabled': True, 14:23:38 INFO - 'halt_on_failure': False, 14:23:38 INFO - 'name': 'check_screen_resolution'},), 14:23:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:38 INFO - 'cmd': ('bash', 14:23:38 INFO - '-c', 14:23:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:38 INFO - 'enabled': True, 14:23:38 INFO - 'halt_on_failure': False, 14:23:38 INFO - 'name': 'check_screen_resolution'},), 14:23:38 INFO - 'run_cmd_checks_enabled': True, 14:23:38 INFO - 'sps_profile': False, 14:23:38 INFO - 'sps_profile_interval': 0, 14:23:38 INFO - 'suite': 'dromaeojs', 14:23:38 INFO - 'system_bits': '32', 14:23:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:38 INFO - 'title': 't-yosemite-r7-0314', 14:23:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:38 INFO - 'use_talos_json': True, 14:23:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:38 INFO - 'work_dir': 'build'} 14:23:38 INFO - [mozharness: 2016-08-08 21:23:38.705128Z] Running clobber step. 14:23:38 INFO - Running pre-action listener: _resource_record_pre_action 14:23:38 INFO - Running main action method: clobber 14:23:38 INFO - rmtree: /builds/slave/test/build 14:23:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:40 INFO - Running post-action listener: _resource_record_post_action 14:23:40 INFO - [mozharness: 2016-08-08 21:23:40.789168Z] Finished clobber step (success) 14:23:40 INFO - [mozharness: 2016-08-08 21:23:40.789357Z] Running read-buildbot-config step. 14:23:40 INFO - Running pre-action listener: _resource_record_pre_action 14:23:40 INFO - Running main action method: read_buildbot_config 14:23:40 INFO - Using buildbot properties: 14:23:40 INFO - { 14:23:40 INFO - "project": "", 14:23:40 INFO - "product": "firefox", 14:23:40 INFO - "script_repo_revision": "production", 14:23:40 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 14:23:40 INFO - "repository": "", 14:23:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 14:23:40 INFO - "buildid": "20160808131625", 14:23:40 INFO - "pgo_build": "False", 14:23:40 INFO - "basedir": "/builds/slave/test", 14:23:40 INFO - "buildnumber": 91, 14:23:40 INFO - "slavename": "t-yosemite-r7-0314", 14:23:40 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:23:40 INFO - "platform": "yosemite_r7", 14:23:40 INFO - "scheduler": "tests-autoland-macosx64-talos", 14:23:40 INFO - "branch": "autoland", 14:23:40 INFO - "repo_path": "integration/autoland", 14:23:40 INFO - "revision": "fc6ed18f76e16d3e2a392c93fd77b867e12955e4", 14:23:40 INFO - "stage_platform": "macosx64", 14:23:40 INFO - "builduid": "943c4d1a2b8849bf92740c4753819dea", 14:23:40 INFO - "slavebuilddir": "test" 14:23:40 INFO - } 14:23:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:23:40 INFO - Running post-action listener: _resource_record_post_action 14:23:40 INFO - [mozharness: 2016-08-08 21:23:40.792838Z] Finished read-buildbot-config step (success) 14:23:40 INFO - [mozharness: 2016-08-08 21:23:40.792932Z] Running download-and-extract step. 14:23:40 INFO - Running pre-action listener: _resource_record_pre_action 14:23:40 INFO - Running main action method: download_and_extract 14:23:40 INFO - mkdir: /builds/slave/test/build/tests 14:23: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')]} 14:23:40 INFO - trying https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:23:40 INFO - Downloading https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 14:23:42 INFO - Downloaded 1199 bytes. 14:23:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:23:42 INFO - Using the following test package requirements: 14:23:42 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:23:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:42 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:23:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:42 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:23:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:42 INFO - u'jsshell-mac.zip'], 14:23:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:42 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:23:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:23:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:42 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:23:42 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:42 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:23:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:42 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:23:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:42 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:23:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:42 INFO - trying https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:23:42 INFO - Downloading https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:23:43 INFO - Downloaded 16324283 bytes. 14:23:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:23:46 INFO - Return code: 0 14:23:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:46 INFO - trying https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:23:46 INFO - Downloading https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:23:49 INFO - Downloaded 16324283 bytes. 14:23:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:23:52 INFO - Return code: 0 14:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:52 INFO - trying https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:23:52 INFO - Downloading https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:23:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:23:54 INFO - Downloaded 14413723 bytes. 14:23:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:23:54 INFO - Return code: 0 14:23: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')]} 14:23:54 INFO - trying https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:23:54 INFO - Downloading https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 14:24:02 INFO - Downloaded 111977502 bytes. 14:24:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:24:02 INFO - mkdir: /builds/slave/test/properties 14:24:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:24:02 INFO - Writing to file /builds/slave/test/properties/build_url 14:24:02 INFO - Contents: 14:24:02 INFO - build_url:https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:24:03 INFO - Running post-action listener: _resource_record_post_action 14:24:03 INFO - Running post-action listener: set_extra_try_arguments 14:24:03 INFO - [mozharness: 2016-08-08 21:24:03.497265Z] Finished download-and-extract step (success) 14:24:03 INFO - [mozharness: 2016-08-08 21:24:03.497402Z] Running populate-webroot step. 14:24:03 INFO - Running pre-action listener: _resource_record_pre_action 14:24:03 INFO - Running main action method: populate_webroot 14:24:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:24:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:24:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:24:03 INFO - '--tppagecycles', 14:24:03 INFO - '7'], 14:24:03 INFO - 'tests': ['tsvgm']}}, 14:24:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:24:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:24:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:24:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:24:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:24:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:24:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:03 INFO - 'talos_options': ['--disable-e10s'], 14:24:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:03 INFO - 'talos_options': ['--disable-e10s'], 14:24:03 INFO - 'tests': ['damp', 'tps']}, 14:24:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:03 INFO - 'tests': ['damp', 'tps']}, 14:24:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:24:03 INFO - 'tests': ['dromaeo_dom']}, 14:24:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:24:03 INFO - 'tests': ['basic_compositor_video']}, 14:24:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:24:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:24:03 INFO - 'tests': ['a11yr', 14:24:03 INFO - 'ts_paint', 14:24:03 INFO - 'tpaint', 14:24:03 INFO - 'sessionrestore', 14:24:03 INFO - 'sessionrestore_no_auto_restore', 14:24:03 INFO - 'tabpaint']}, 14:24:03 INFO - 'other-e10s': {'tests': ['a11yr', 14:24:03 INFO - 'ts_paint', 14:24:03 INFO - 'tpaint', 14:24:03 INFO - 'sessionrestore', 14:24:03 INFO - 'sessionrestore_no_auto_restore', 14:24:03 INFO - 'tabpaint']}, 14:24:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:24:03 INFO - 'ts_paint', 14:24:03 INFO - 'tpaint', 14:24:03 INFO - 'sessionrestore', 14:24:03 INFO - 'sessionrestore_no_auto_restore', 14:24:03 INFO - 'tabpaint']}, 14:24:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:24:03 INFO - 'ts_paint', 14:24:03 INFO - 'tpaint', 14:24:03 INFO - 'sessionrestore', 14:24:03 INFO - 'sessionrestore_no_auto_restore', 14:24:03 INFO - 'tabpaint']}, 14:24:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:24:03 INFO - 'tests': ['a11yr', 14:24:03 INFO - 'ts_paint', 14:24:03 INFO - 'tpaint', 14:24:03 INFO - 'sessionrestore', 14:24:03 INFO - 'sessionrestore_no_auto_restore', 14:24:03 INFO - 'tabpaint']}, 14:24:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:24:03 INFO - 'tests': ['a11yr', 14:24:03 INFO - 'ts_paint', 14:24:03 INFO - 'tpaint', 14:24:03 INFO - 'sessionrestore', 14:24:03 INFO - 'sessionrestore_no_auto_restore', 14:24:03 INFO - 'tabpaint']}, 14:24:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:24:03 INFO - 'tests': ['tsvgx', 14:24:03 INFO - 'tsvgr_opacity', 14:24:03 INFO - 'tart', 14:24:03 INFO - 'tscrollx', 14:24:03 INFO - 'cart']}, 14:24:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:24:03 INFO - 'tsvgr_opacity', 14:24:03 INFO - 'tart', 14:24:03 INFO - 'tscrollx', 14:24:03 INFO - 'cart']}, 14:24:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:03 INFO - 'talos_options': ['--disable-e10s'], 14:24:03 INFO - 'tests': ['tp5o']}, 14:24:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:03 INFO - 'tests': ['tp5o']}, 14:24:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:03 INFO - 'talos_options': ['--disable-e10s', 14:24:03 INFO - '--xperf_path', 14:24:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:03 INFO - 'tests': ['tp5n']}, 14:24:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:03 INFO - 'talos_options': ['--xperf_path', 14:24:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:03 INFO - 'tests': ['tp5n']}}, 14:24:03 INFO - 'talos.zip': {'path': '', 14:24:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:24:03 INFO - Running post-action listener: _resource_record_post_action 14:24:03 INFO - [mozharness: 2016-08-08 21:24:03.516399Z] Finished populate-webroot step (success) 14:24:03 INFO - [mozharness: 2016-08-08 21:24:03.516509Z] Running create-virtualenv step. 14:24:03 INFO - Running pre-action listener: _resource_record_pre_action 14:24:03 INFO - Running main action method: create_virtualenv 14:24:03 INFO - Creating virtualenv /builds/slave/test/build/venv 14:24:03 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 14:24:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:24:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:03 INFO - Using real prefix '/tools/python27' 14:24:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:24:04 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:07 INFO - Installing pip.................done. 14:24:07 INFO - Return code: 0 14:24:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:24:07 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')]} 14:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:07 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')]} 14:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:07 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 0x10a5dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a672618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a3522090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541d30>, '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 0x10a2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a539b20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:24:07 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 14:24:07 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 14:24:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:24:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:07 INFO - 'HOME': '/Users/cltbld', 14:24:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:07 INFO - 'LOGNAME': 'cltbld', 14:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:07 INFO - 'MOZ_NO_REMOTE': '1', 14:24:07 INFO - 'NO_EM_RESTART': '1', 14:24:07 INFO - 'PAGER': '/bin/cat', 14:24:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:07 INFO - 'PWD': '/builds/slave/test', 14:24:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:07 INFO - 'SHELL': '/bin/bash', 14:24:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:24:07 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:24:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:07 INFO - 'USER': 'cltbld', 14:24:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:07 INFO - 'XPC_FLAGS': '0x0', 14:24:07 INFO - 'XPC_SERVICE_NAME': '0', 14:24:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:07 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 14:24:07 INFO - Cleaning up... 14:24:07 INFO - Return code: 0 14:24:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:24:07 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')]} 14:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:07 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')]} 14:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:07 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 0x10a5dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a672618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a3522090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541d30>, '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 0x10a2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a539b20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:24:07 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 14:24:07 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 14:24:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:24:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:07 INFO - 'HOME': '/Users/cltbld', 14:24:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:07 INFO - 'LOGNAME': 'cltbld', 14:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:07 INFO - 'MOZ_NO_REMOTE': '1', 14:24:07 INFO - 'NO_EM_RESTART': '1', 14:24:07 INFO - 'PAGER': '/bin/cat', 14:24:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:07 INFO - 'PWD': '/builds/slave/test', 14:24:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:07 INFO - 'SHELL': '/bin/bash', 14:24:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:24:07 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:24:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:07 INFO - 'USER': 'cltbld', 14:24:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:07 INFO - 'XPC_FLAGS': '0x0', 14:24:07 INFO - 'XPC_SERVICE_NAME': '0', 14:24:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:07 INFO - Downloading/unpacking psutil>=3.1.1 14:24:07 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 14:24:07 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 14:24:07 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 14:24:07 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 14:24:07 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 14:24:07 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 14:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:11 INFO - Installing collected packages: psutil 14:24:11 INFO - Running setup.py install for psutil 14:24:11 INFO - building 'psutil._psutil_osx' extension 14:24:11 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 14:24:11 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 14:24:11 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 14:24:11 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 14:24:12 INFO - building 'psutil._psutil_posix' extension 14:24:12 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 14:24:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:24:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:24:12 INFO - ^ 14:24:12 INFO - 1 warning generated. 14:24:12 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 14:24:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:12 INFO - Successfully installed psutil 14:24:12 INFO - Cleaning up... 14:24:12 INFO - Return code: 0 14:24:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:24:12 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')]} 14:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:12 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')]} 14:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:12 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 0x10a5dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a672618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a3522090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541d30>, '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 0x10a2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a539b20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:24:12 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 14:24:12 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 14:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:12 INFO - 'HOME': '/Users/cltbld', 14:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:12 INFO - 'LOGNAME': 'cltbld', 14:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:12 INFO - 'MOZ_NO_REMOTE': '1', 14:24:12 INFO - 'NO_EM_RESTART': '1', 14:24:12 INFO - 'PAGER': '/bin/cat', 14:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:12 INFO - 'PWD': '/builds/slave/test', 14:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:12 INFO - 'SHELL': '/bin/bash', 14:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:24:12 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:12 INFO - 'USER': 'cltbld', 14:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:12 INFO - 'XPC_FLAGS': '0x0', 14:24:12 INFO - 'XPC_SERVICE_NAME': '0', 14:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:24:15 INFO - Installing collected packages: mozsystemmonitor 14:24:15 INFO - Running setup.py install for mozsystemmonitor 14:24:15 INFO - Successfully installed mozsystemmonitor 14:24:15 INFO - Cleaning up... 14:24:15 INFO - Return code: 0 14:24:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:15 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 0x10a5dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a672618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a3522090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541d30>, '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 0x10a2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a539b20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:24:15 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 14:24:15 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 14:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:15 INFO - 'HOME': '/Users/cltbld', 14:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:15 INFO - 'LOGNAME': 'cltbld', 14:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:15 INFO - 'MOZ_NO_REMOTE': '1', 14:24:15 INFO - 'NO_EM_RESTART': '1', 14:24:15 INFO - 'PAGER': '/bin/cat', 14:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:15 INFO - 'PWD': '/builds/slave/test', 14:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:15 INFO - 'SHELL': '/bin/bash', 14:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:24:15 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:15 INFO - 'USER': 'cltbld', 14:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:15 INFO - 'XPC_FLAGS': '0x0', 14:24:15 INFO - 'XPC_SERVICE_NAME': '0', 14:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:15 INFO - Downloading/unpacking jsonschema==2.5.1 14:24:15 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 14:24:15 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 14:24:15 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 14:24:15 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 14:24:15 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 14:24:15 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 14:24:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:24:18 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 14:24:18 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 14:24:18 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 14:24:18 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 14:24:18 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 14:24:18 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 14:24:18 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:18 INFO - warning: no files found matching '*.txt' 14:24:18 INFO - no previously-included directories found matching 'build' 14:24:18 INFO - no previously-included directories found matching 'dist' 14:24:18 INFO - no previously-included directories found matching '.git*' 14:24:18 INFO - Installing collected packages: jsonschema, functools32 14:24:18 INFO - Running setup.py install for functools32 14:24:18 INFO - warning: no files found matching '*.txt' 14:24:18 INFO - no previously-included directories found matching 'build' 14:24:18 INFO - no previously-included directories found matching 'dist' 14:24:18 INFO - no previously-included directories found matching '.git*' 14:24:18 INFO - Successfully installed jsonschema functools32 14:24:18 INFO - Cleaning up... 14:24:18 INFO - Return code: 0 14:24:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:24:18 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')]} 14:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:18 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')]} 14:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:18 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 0x10a5dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a672618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a3522090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541d30>, '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 0x10a2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a539b20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:24:18 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 14:24:18 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 14:24:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:24:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:18 INFO - 'HOME': '/Users/cltbld', 14:24:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:18 INFO - 'LOGNAME': 'cltbld', 14:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:18 INFO - 'MOZ_NO_REMOTE': '1', 14:24:18 INFO - 'NO_EM_RESTART': '1', 14:24:18 INFO - 'PAGER': '/bin/cat', 14:24:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:18 INFO - 'PWD': '/builds/slave/test', 14:24:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:18 INFO - 'SHELL': '/bin/bash', 14:24:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:24:18 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:24:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:18 INFO - 'USER': 'cltbld', 14:24:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:18 INFO - 'XPC_FLAGS': '0x0', 14:24:18 INFO - 'XPC_SERVICE_NAME': '0', 14:24:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:24:19 INFO - Cleaning up... 14:24:19 INFO - Return code: 0 14:24:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:19 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 0x10a5dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a672618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a3522090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541d30>, '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 0x10a2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a539b20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:24:19 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 14:24:19 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 14:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:19 INFO - 'HOME': '/Users/cltbld', 14:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:19 INFO - 'LOGNAME': 'cltbld', 14:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:19 INFO - 'MOZ_NO_REMOTE': '1', 14:24:19 INFO - 'NO_EM_RESTART': '1', 14:24:19 INFO - 'PAGER': '/bin/cat', 14:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:19 INFO - 'PWD': '/builds/slave/test', 14:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:19 INFO - 'SHELL': '/bin/bash', 14:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:24:19 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:19 INFO - 'USER': 'cltbld', 14:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:19 INFO - 'XPC_FLAGS': '0x0', 14:24:19 INFO - 'XPC_SERVICE_NAME': '0', 14:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:19 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:19 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 14:24:19 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 14:24:19 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 14:24:19 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 14:24:19 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 14:24:19 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 14:24:21 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:22 INFO - Downloading docopt-0.6.1.tar.gz 14:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:23 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:23 INFO - Running setup.py install for blobuploader 14:24:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:23 INFO - Running setup.py install for requests 14:24:23 INFO - Running setup.py install for docopt 14:24:23 INFO - Successfully installed blobuploader requests docopt 14:24:23 INFO - Cleaning up... 14:24:23 INFO - Return code: 0 14:24:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:23 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')]} 14:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:23 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')]} 14:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:23 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 0x10a5dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a672618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a3522090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541d30>, '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 0x10a2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a539b20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:24:23 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 14:24:23 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 14:24:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:24:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:23 INFO - 'HOME': '/Users/cltbld', 14:24:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:23 INFO - 'LOGNAME': 'cltbld', 14:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:23 INFO - 'MOZ_NO_REMOTE': '1', 14:24:23 INFO - 'NO_EM_RESTART': '1', 14:24:23 INFO - 'PAGER': '/bin/cat', 14:24:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:23 INFO - 'PWD': '/builds/slave/test', 14:24:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:23 INFO - 'SHELL': '/bin/bash', 14:24:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:24:23 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:24:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:23 INFO - 'USER': 'cltbld', 14:24:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:23 INFO - 'XPC_FLAGS': '0x0', 14:24:23 INFO - 'XPC_SERVICE_NAME': '0', 14:24:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:24 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-BKmswP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:24 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-NTzpFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:24 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-tEuQSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:24 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-CtFz7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:24 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-drsr0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:24 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-RicRsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:24 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-SiI4HN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:24 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-IKU59G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-LKQ6ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-fjgQbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-wkWXRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-fEyU_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-XyybQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-pvGwaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-gX791J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-epoBoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-qkfn0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:25 INFO - Running setup.py install for manifestparser 14:24:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:26 INFO - Running setup.py install for mozcrash 14:24:26 INFO - Running setup.py install for mozdebug 14:24:26 INFO - Running setup.py install for mozdevice 14:24:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:24:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:26 INFO - Running setup.py install for mozfile 14:24:26 INFO - Running setup.py install for mozhttpd 14:24:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:26 INFO - Running setup.py install for mozinfo 14:24:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:26 INFO - Running setup.py install for mozInstall 14:24:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:27 INFO - Running setup.py install for mozleak 14:24:27 INFO - Running setup.py install for mozlog 14:24:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:27 INFO - Running setup.py install for moznetwork 14:24:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:27 INFO - Running setup.py install for mozprocess 14:24:27 INFO - Running setup.py install for mozprofile 14:24:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:27 INFO - Running setup.py install for mozrunner 14:24:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:28 INFO - Running setup.py install for mozscreenshot 14:24:28 INFO - Running setup.py install for moztest 14:24:28 INFO - Running setup.py install for mozversion 14:24:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:28 INFO - Cleaning up... 14:24:28 INFO - Return code: 0 14:24:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:28 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 0x10a5dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a672618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a3522090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541d30>, '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 0x10a2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a539b20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:24:28 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 14:24:28 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 14:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:28 INFO - 'HOME': '/Users/cltbld', 14:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:28 INFO - 'LOGNAME': 'cltbld', 14:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:28 INFO - 'MOZ_NO_REMOTE': '1', 14:24:28 INFO - 'NO_EM_RESTART': '1', 14:24:28 INFO - 'PAGER': '/bin/cat', 14:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:28 INFO - 'PWD': '/builds/slave/test', 14:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:28 INFO - 'SHELL': '/bin/bash', 14:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:24:28 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:28 INFO - 'USER': 'cltbld', 14:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:28 INFO - 'XPC_FLAGS': '0x0', 14:24:28 INFO - 'XPC_SERVICE_NAME': '0', 14:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-aSzl2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:28 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)) 14:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-QDyv1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-voOGeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:29 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)) 14:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-CMjCv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-iYXGpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:29 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)) 14:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-idA6lV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:29 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)) 14:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-DO_qi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:29 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)) 14:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Rpx3yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:29 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)) 14:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-W6z9HX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:29 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)) 14:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-w7CI5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 14:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-lZ7NT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:29 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)) 14:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-EzmIar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-RfeulT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:30 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)) 14:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-IQZGjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-kRKHLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:30 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)) 14:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-z6zFkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-2LssrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:30 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)) 14:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:24:30 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)) 14:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:24:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:32 INFO - Downloading blessings-1.6.tar.gz 14:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:24:33 INFO - Installing collected packages: blessings 14:24:33 INFO - Running setup.py install for blessings 14:24:33 INFO - Successfully installed blessings 14:24:33 INFO - Cleaning up... 14:24:33 INFO - Return code: 0 14:24:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:24:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:33 INFO - Reading from file tmpfile_stdout 14:24:33 INFO - Current package versions: 14:24:33 INFO - blessings == 1.6 14:24:33 INFO - blobuploader == 1.2.4 14:24:33 INFO - docopt == 0.6.1 14:24:33 INFO - functools32 == 3.2.3-2 14:24:33 INFO - jsonschema == 2.5.1 14:24:33 INFO - manifestparser == 1.1 14:24:33 INFO - mozInstall == 1.12 14:24:33 INFO - mozcrash == 0.17 14:24:33 INFO - mozdebug == 0.1 14:24:33 INFO - mozdevice == 0.48 14:24:33 INFO - mozfile == 1.2 14:24:33 INFO - mozhttpd == 0.7 14:24:33 INFO - mozinfo == 0.9 14:24:33 INFO - mozleak == 0.1 14:24:33 INFO - mozlog == 3.3 14:24:33 INFO - moznetwork == 0.27 14:24:33 INFO - mozprocess == 0.23 14:24:33 INFO - mozprofile == 0.28 14:24:33 INFO - mozrunner == 6.12 14:24:33 INFO - mozscreenshot == 0.1 14:24:33 INFO - mozsystemmonitor == 0.3 14:24:33 INFO - moztest == 0.7 14:24:33 INFO - mozversion == 1.4 14:24:33 INFO - psutil == 3.1.1 14:24:33 INFO - requests == 1.2.3 14:24:33 INFO - wsgiref == 0.1.2 14:24:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:33 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 0x10a5dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a672618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a3522090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541d30>, '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 0x10a2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a539b20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:24:33 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 14:24:33 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 14:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:33 INFO - 'HOME': '/Users/cltbld', 14:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:33 INFO - 'LOGNAME': 'cltbld', 14:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:33 INFO - 'MOZ_NO_REMOTE': '1', 14:24:33 INFO - 'NO_EM_RESTART': '1', 14:24:33 INFO - 'PAGER': '/bin/cat', 14:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:33 INFO - 'PWD': '/builds/slave/test', 14:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:33 INFO - 'SHELL': '/bin/bash', 14:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:24:33 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:33 INFO - 'USER': 'cltbld', 14:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:33 INFO - 'XPC_FLAGS': '0x0', 14:24:33 INFO - 'XPC_SERVICE_NAME': '0', 14:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:33 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)) 14:24:33 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)) 14:24:33 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)) 14:24:33 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)) 14:24:33 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)) 14:24:33 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)) 14:24:33 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)) 14:24:33 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)) 14:24:33 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)) 14:24:33 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)) 14:24:33 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)) 14:24:33 INFO - Cleaning up... 14:24:33 INFO - Return code: 0 14:24:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a5dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a672618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a3522090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541d30>, '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 0x10a2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a539b20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:24: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'] in /builds/slave/test/build 14:24: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 14:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:33 INFO - 'HOME': '/Users/cltbld', 14:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:33 INFO - 'LOGNAME': 'cltbld', 14:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:33 INFO - 'MOZ_NO_REMOTE': '1', 14:24:33 INFO - 'NO_EM_RESTART': '1', 14:24:33 INFO - 'PAGER': '/bin/cat', 14:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:33 INFO - 'PWD': '/builds/slave/test', 14:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:33 INFO - 'SHELL': '/bin/bash', 14:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:24:33 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:33 INFO - 'USER': 'cltbld', 14:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:33 INFO - 'XPC_FLAGS': '0x0', 14:24:33 INFO - 'XPC_SERVICE_NAME': '0', 14:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:24:34 INFO - Cleaning up... 14:24:34 INFO - Return code: 0 14:24:34 INFO - Running post-action listener: _resource_record_post_action 14:24:34 INFO - Running post-action listener: _start_resource_monitoring 14:24:34 INFO - Starting resource monitoring. 14:24:34 INFO - [mozharness: 2016-08-08 21:24:34.155715Z] Finished create-virtualenv step (success) 14:24:34 INFO - [mozharness: 2016-08-08 21:24:34.156632Z] Running install step. 14:24:34 INFO - Running pre-action listener: _resource_record_pre_action 14:24:34 INFO - Running main action method: install 14:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:34 INFO - Reading from file tmpfile_stdout 14:24:34 INFO - Detecting whether we're running mozinstall >=1.0... 14:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:24:34 INFO - Reading from file tmpfile_stdout 14:24:34 INFO - Output received: 14:24:34 INFO - Usage: mozinstall [options] installer 14:24:34 INFO - Options: 14:24:34 INFO - -h, --help show this help message and exit 14:24:34 INFO - -d DEST, --destination=DEST 14:24:34 INFO - Directory to install application into. [default: 14:24:34 INFO - "/builds/slave/test"] 14:24:34 INFO - --app=APP Application being installed. [default: firefox] 14:24:34 INFO - mkdir: /builds/slave/test/build/application 14:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:25:09 INFO - Reading from file tmpfile_stdout 14:25:09 INFO - Output received: 14:25:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:25:09 INFO - Running post-action listener: _resource_record_post_action 14:25:09 INFO - [mozharness: 2016-08-08 21:25:09.233311Z] Finished install step (success) 14:25:09 INFO - [mozharness: 2016-08-08 21:25:09.233476Z] Running run-tests step. 14:25:09 INFO - Running pre-action listener: _resource_record_pre_action 14:25:09 INFO - Running main action method: run_tests 14:25:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:25:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:25:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:25:09 INFO - 2016-08-08 14:25:09.248 screenresolution[1664:7485] starting screenresolution argv=screenresolution get 14:25:09 INFO - 2016-08-08 14:25:09.250 screenresolution[1664:7485] Display 0: 1600x1200x32@60 14:25:09 INFO - 2016-08-08 14:25:09.256 screenresolution[1665:7487] starting screenresolution argv=screenresolution list 14:25:09 INFO - Available Modes on Display 0 14:25:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:25:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:25:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:25:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:25:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:25:09 INFO - Intel Iris: 14:25:09 INFO - Chipset Model: Intel Iris 14:25:09 INFO - Type: GPU 14:25:09 INFO - Bus: Built-In 14:25:09 INFO - VRAM (Dynamic, Max): 1536 MB 14:25:09 INFO - Vendor: Intel (0x8086) 14:25:09 INFO - Device ID: 0x0a2e 14:25:09 INFO - Revision ID: 0x0009 14:25:09 INFO - Displays: 14:25:09 INFO - Display: 14:25:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:25:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:25:09 INFO - Display Serial Number: 1600x1200 60 14:25:09 INFO - Main Display: Yes 14:25:09 INFO - Mirror: Off 14:25:09 INFO - Online: Yes 14:25:09 INFO - Rotation: Supported 14:25:09 INFO - Return code: 0 14:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:25:09 INFO - Python 2.7.3 14:25:09 INFO - Return code: 0 14:25:09 INFO - grabbing minidump binary from tooltool 14:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:09 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 0x10a541d30>, '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 0x10a2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a539b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:25:09 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 14:25:09 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 14:25:09 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 14:25:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:25:09 INFO - Return code: 0 14:25:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:25:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:25:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:25:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:25:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 14:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0314 --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 14:25:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:25:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:09 INFO - 'HOME': '/Users/cltbld', 14:25:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:09 INFO - 'LOGNAME': 'cltbld', 14:25:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:25:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:09 INFO - 'MOZ_NO_REMOTE': '1', 14:25:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:25:09 INFO - 'NO_EM_RESTART': '1', 14:25:09 INFO - 'PAGER': '/bin/cat', 14:25:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:09 INFO - 'PWD': '/builds/slave/test', 14:25:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:25:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:09 INFO - 'SHELL': '/bin/bash', 14:25:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:25:09 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:25:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:09 INFO - 'USER': 'cltbld', 14:25:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:09 INFO - 'XPC_FLAGS': '0x0', 14:25:09 INFO - 'XPC_SERVICE_NAME': '0', 14:25:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 14:25:09 INFO - mozversion application_buildid: 20160808131625 14:25:09 INFO - mozversion application_changeset: fc6ed18f76e16d3e2a392c93fd77b867e12955e4 14:25:09 INFO - mozversion application_display_name: Nightly 14:25:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:25:09 INFO - mozversion application_name: Firefox 14:25:09 INFO - mozversion application_remotingname: firefox 14:25:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:25:09 INFO - mozversion application_vendor: Mozilla 14:25:09 INFO - mozversion application_version: 51.0a1 14:25:09 INFO - mozversion platform_buildid: 20160808131625 14:25:09 INFO - mozversion platform_changeset: fc6ed18f76e16d3e2a392c93fd77b867e12955e4 14:25:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:25:09 INFO - mozversion platform_version: 51.0a1 14:25:09 INFO - using testdate: 1470691509 14:25:09 INFO - actual date: 1470691509 14:25:09 INFO - starting webserver on 'localhost:49271' 14:25:09 INFO - SUITE-START | Running 2 tests 14:25:09 INFO - TEST-START | dromaeo_css 14:25:09 INFO - operating with platform_type : mac_ 14:25:09 INFO - Initialising browser for dromaeo_css test... 14:25:09 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpZxgMdD/profile http://localhost:49271/getInfo.html) 14:25:12 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 14:25:12 INFO - PROCESS | 1675 | colorDepth:24 14:25:12 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 14:25:12 INFO - PROCESS | 1675 | __metrics 14:25:12 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:25:12 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:25:13 INFO - TEST-INFO | 1675: exit 0 14:25:13 INFO - Browser initialized. 14:25:13 INFO - Running cycle 1/1 for dromaeo_css test... 14:25:13 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpZxgMdD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:24 INFO - PROCESS | 1678 | RSS: Main: 243445760 14:25:24 INFO - PROCESS | 1678 | 14:26:16 INFO - PROCESS | 1678 | 1470691576754 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:28:29 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 14:28:30 INFO - PROCESS | 1678 | RSS: Main: 375742464 14:28:30 INFO - PROCESS | 1678 | 14:31:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 14:31:33 INFO - PROCESS | 1678 | RSS: Main: 387575808 14:31:33 INFO - PROCESS | 1678 | 14:34:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 14:34:36 INFO - PROCESS | 1678 | RSS: Main: 356368384 14:34:36 INFO - PROCESS | 1678 | 14:37:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 14:37:39 INFO - PROCESS | 1678 | RSS: Main: 366370816 14:37:39 INFO - PROCESS | 1678 | 14:40:43 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 14:40:43 INFO - PROCESS | 1678 | RSS: Main: 350072832 14:40:43 INFO - PROCESS | 1678 | 14:43:46 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 14:43:47 INFO - PROCESS | 1678 | RSS: Main: 425340928 14:43:47 INFO - PROCESS | 1678 | 14:43:47 INFO - PROCESS | 1678 | __start_tp_report 14:43:47 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 14:43:47 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 14:43:47 INFO - PROCESS | 1678 | |i|pagename|runs| 14:43:47 INFO - PROCESS | 1678 | |0;dojo.html;2936.6476022877255;3406.0463070340315;3421.8289085545716;3423.9144021399447;3465.6534346565345;5659.943400565993;5753.1370294455855;5786.132080187974;5791.76832926683;5801.303843538776;5756.107803290486;5761.1358296255585;5792.71036448177;5793;5799.9130013049835;5219.243209734595;5260.789568417259;5278.498542638443;5287.762050707727;5347.0909945309195;5310.575153987691;5329.946700533003;5330.546903513206;5336.092864213074;5347.491988261109;5239.10935141025;5250.31745873036;5269.683818970855;5270.4729527047375;5326.280952071479;5321.600879934021;5323.866903327409;5323.946760532423;5349;5361.571074314045;5106.668066575698;5127.384713834326;5196;5235.345581802275;5246.7901283948595;5644.8024319148635;5698.800541981011;5744.569157313218;5774.105013722879;5803.941960580382;6263.43629073381;6325.051242313643;6338.683065846689;6341.239051313872;6345.33373995733;6206.100115483275;6226.315105338409;6235.906461403082;6265.624062556261;6265.968670156665;5596.300462442236;5891.882162356729;5943.286805583271;5978.133170690226;5983.072623743326;6305.558610897193;6320.525960552977;6325.177726895474;6327.240731112204;6330.272018717815;6086.482648974798;6113.810786210604;6128.1114238435175;6237.844053898689;6263.279722831841;6275.02737075754;6290.276618188876;6294.181756371734;6300.401461861115;6320.336364681642;6232.501399887998;6316.715747791361;6318.178636777281;6320.462760665395;6324.747010119636;6149.0776383542825;6246.063090536456;6300.338464461165;6307.306196318401;6341.143945567289;4984.37695288089;4998.400191976913;5015.824446144367;5025.296458495814;5034.748262586856;4471.7987690554;4473.373727678128;4477.574630410106;4484.865454036384;4515.345274935116;5632.155176723442;5703.230063941398;5764.740586673526;5817.331006934172;5840.532757379399;6203.844903877439;6243.8126856194385;6270.623762574261;6276.592021518587;6298.685065746694;4886.60907127429;5772.855678608068;5774.797882074107;5776.191333213354;5782.797602083991;5422.132458806572;5506.91739623906;5526.392096869341;5527.364353099365;5531.2809334787025;6244.375562443719;6273.18448601688;6340.365963403623;6340.714667839866;6401.135846660642;6274.780382686584;6282.842928926813;6284.497240220863;6293.559450838397;6296.968515157395;6371.74513019474;6382.5532212744665;6385.648789316632;6404.199475065617;6424.903626445701;6066.484348830399;6157.692115394123;6197.721102550487;6204.100405441276;6289.465395441439;6241.500679945684;6288.402601752826;6300.7479700811455;6302.621842689453;6320.399562041599;6029.095635654687;6167.321594624677;6180.165677633462;6194.504439644727;6204.410580994799;6024.096385542204;6142.232220972379;6156.384361563808;6161.784337548164;6233.501319894488;6060.969695151496;6068.250436993457;6107.877842443215;6110.358412366815;6122.510199183966;6076.210092687922;6202.100695399232;6208.348123447154;6208.596441231305;6223.719932603134;5963;5989.311229208697;6084.726187321493;6089.969550152221;6091.756329746938 14:43:47 INFO - PROCESS | 1678 | |1;ext.html;490.76933841094694;503.227545717324;520.45352380001;534.4975722820549;536.118085748943;31008.224794380123;32814.507782383254;35758;40404.79797601015;40843.79578102113;43520.782396088056;43907;44075;44086.33870491945;44234.77882610582;9574.617015319396;9756.560954757053;9769.169620582223;9773.853392199122;9778.853317200212;9743.610255589769;9836.655717049905;9843.064908833649;9848.803023939518;9855.162311203556;9814.214862810957;9843.409395436262;9872.753181170456;9872.753181170492;9876.703698889009;9782.608695652165;9859.211263098934;9864.60541578336;9865.80268394628;9873.555689993931;8264.462809917337;9705.563249653782;9711.320207585472;9732;9744.02559744027;33031;40838.79580602108;40928.590714092774;40989.97525061868;40993.77018689444;3342.2647017656077;3567.7324200684793;3629.3104310181243;3886.358750806142;3894.785786781726;31199.688003119903;32176.839115804505;32382.190445238823;32429.837850810833;32536.837315813507;3213.3091385352263;3363.8822641207685;3372.8650853966055;3373.291608762163;3409.437442821931;485971.1402885961;489556;514957;517470;519301;53787;53840;53879.03665298446;53903;54019.45980540223;63696;63777.36222637807;63894.36105638977;63940.721185576025;63985.680071599345;16419.507414777574;16715.247813848408;16754.329826807036;16776.077315747752;16778.161091945352;10623.89376106229;12486.750264994831;12492.81260781089;12508.437120329607;12529.060320476001;16030.919845400931;16580.253888575044;16598.75101873473;16630.251638676287;16770.496885093467;6995.26549712283;7058.6823592938445;7070.399016083587;7124.216336203013;7165.176004759415;737.0750752244214;766.4673052228759;849.8045449546639;928.7167413938679;980.9068138526828;29125.27186820304;30180.396392072034;30438;30574.593560726473;30973.380532389227;1064.2869277584036;1075.8224892892742;1093.945302734876;1111.7276267314398;1145.3299819605625;15694.76457853133;15869.52391428259;15889.68220635604;16103.677926441405;16177.757333640006;673821;676232;681479;684881.1511884817;686956;59907.700461497414;60077.399226008056;60165.69917150474;60270;60322.698386507785;1267.1256832785348;1303.2245813740808;1356.891448684103;1386.986130138706;1422.3030714949807;28680.713192867803;30558.388832223674;30652.08043758691;31400.842995784875;31953.201169970936;46069.76965115153;49958.000839983724;51328.74335628298;52292.7385363086;52329.47670523398;559365;562596;562603;562855;564461;26356.472870542864;26931;27006.324841878326;28168.43663126767;41244.1751164981;47799.52200477951;48832.75583622059;49150.5084949146;49219;49362.75318623384;34621.307573848884;35549;38061;39152;40776.59223407847;39253.60746392499;39290.60709392984;40268.597314027655;40876;40884.386734198415;37553.6244637561;38151.80924095362;38209.617903821716;38340;38385.4242186373;33092;33908;34180.658193417745;34442.82778586091;34461.31077378388;25627.6155857666;25681.61477577875;25787.355316117246;26064;26403 14:43:47 INFO - PROCESS | 1678 | |2;jquery.html;354.2101114514634;374.42554060176957;375.1072447574772;382.46836896713563;404.4883222723254;15540.378384864605;15583.298751556178;20108.59782804347;20964.750463678116;20975.16099356024;19965.101570429328;20215.696764548542;20215.797842021577;20223.49441263969;20238.29165979191;4672.602828759543;5831.679257640828;6064.181335519715;6064.636121832682;6074.5747797654185;5863.208466856962;6030.306514750816;6033.456988871001;6035.60768550045;6047.304559975593;5969.194158788551;6026.819195424145;6028.728707208164;6565.277819439858;6610.8016759497295;6415.582987105847;6578.144841170617;6587.901181482282;6596.142501474802;6616.20605527335;5560.888782224333;5695.946249943732;5775;5787.913181302284;5807.5644326675665;12913.870861291362;12922.676933076747;12944.546940857024;13121.671958201121;13147.14543554666;2171.8371122165745;2304.37781798915;2308.4805918668335;2356.399118224842;2795.7279437855727;8665.82668346636;10302;10315.742106447324;12916.289604071771;14487.130772153705;1556.657535342223;1796.8203179682057;1814.2833580735535;1869.8784579002322;1870.7942126366088;120795;132603.6739632601;133914.99127513095;134448;134449;11025.338479691245;11176.105911527058;11337.546498140147;11501.597444089417;11699;14128.94032947533;14306.28468576567;14510.927445362706;14513.637159071108;14518.20149891766;7387.8179491281135;8384.496930184208;8434.662613495391;8513.531755753369;8536.487810731376;8211.753647390588;8347.666093356198;8370.581470926429;8510.957445212858;8710.303175745925;4493.550644935545;4517.774111294422;4533.161365147393;4533.455985281721;4597.885052873638;1900.8024944285012;1948.074664534335;1953.2675246782458;1954.9120289586717;1992.551675872946;876.307716903639;892.4912799704107;917.6421195733669;968.1431932739576;984.5077461269366;16228.107454090139;17673.939563626223;18842;20792.27227047046;20831;822.6503735912213;842.9831403371899;938.6151677812064;996.3573495095623;1013.9847902281472;10151.289409741246;10781.191410644233;10913.39976301311;10924.289921155258;10940.945295273632;433420;515257;517469;616647;617436;126142;139894;141808.29095854456;149259;156375;960.078324808178;992.6029588164647;1000.4397537379091;1001.2040427859869;1033.8655974723088;17403.825961740728;17889.926604403776;17995;18110.55899379114;18170.22188339311;54020.044266492994;54482.36552903419;54566.3630091082;55178;55764.72117639386;56911.71544142253;83523;85720;86106.13893860982;91905.54047229722;6948.895766563404;7579.355754760907;7961.243681850215;7990.240927111915;8060.798480038046;10787.784244314913;11088.501017454073;12648.557300494807;12684.365781710692;13027.544035958696;8795.780105497413;10848.837267440837;11341.943290283496;11476.196666233283;11491.885081149081;11003.669889903316;11031.39327336972;11375.54497820078;11402.771944561227;11556.826647600124;11321.773564528829;11496.770064598493;11760.35318057515;11777.705557361134;11861.406929653655;7240.610598502376;7266.818329541592;7428.517146385468;7609.315161635479;7609.847803044019;9821.65624203178;11013.504392302206;11474.368909709712;11488.655340339803;11548.653540393801 14:43:47 INFO - PROCESS | 1678 | |3;mootools.html;1363.820295444441;1511.76567632017;1540.9691806163878;1733.349993752343;1911.6176764647073;6807.421369183619;8111.39164562658;8405.32757379409;8629.611667474963;8661.91338086619;8572.442791218566;8614.440061396004;8619.698310559132;8620.482771033743;8620.913790862089;2329.499157681098;2337.609122572067;2338.38032921276;2368.3960590049514;2370.988145059281;2332.4751930815514;2363.0311572255378;2371.1937941100023;2374.726906405768;2376.976230237701;2328.569214695287;2346.5658853112145;2364.5270945810908;2366.100881664965;2371.3834403055243;2308.83403881039;2339.7426283108844;2342.7657234276608;2343.16817529777;2351.094828491026;1998.8900610466565;2327.0459111764094;2328.953420931589;2330.673705681206;2337.8480398774027;8546.359023073295;8642.22220000203;8672.696455624086;8678.869816952687;8695.130486951317;5102.209157580581;5309.33633295838;5309.62832601718;5343.3587969443915;5346.518813306821;3552.182997910495;3568.678818906311;3619.8371073301764;3639.4176931690804;3659.9085022874374;1074.2856000759487;1087.363892123101;1087.6030248959153;1109.0960866893456;1111.8054340490382;9795.461249631267;11229.60696375631;11233.887661123366;11286.774264514746;11330.036946859527;4347.7826108694435;4435.512093669694;4551.45382554089;4586.3579098926175;4588.816447342069;8961.686340978034;8962.82074358509;8964.193222609865;8976;8988.146126118008;4439.711418757771;5135.383753949475;5138.820141295037;5143.12566863634;5144.61415393847;4310.31035034393;4482.170798402306;4645.233536466513;4802.759862006886;4810.975945120322;3120.7971481853606;3721.4789929409903;3758.661720445173;3799.3920972644246;3879.6120387960977;996.003996003996;1139.5384869128015;1148.787474317254;1149.2644707387278;1168.3106966889407;746.8319628083638;866.7789713622985;892.3931726426092;906.909309069101;948.7296120605595;5618.157276408489;5706.343770466367;5849.268841394825;5881.617694849821;6051.0923361496125;804.6982381606897;890.6259371064039;892.3887137310962;902.4134312696799;953.6948176583427;3932.193900250499;3933.3706606943324;3962.5244970603712;4074.6332830044844;4074.837006519706;10208.234382421348;10624.096951759033;10632.521536530874;10637.202209834293;10638.042576168182;10573.101286390589;10582.841257381146;10586.10018148466;10610.734731631617;10669;7694.153643099255;8035.236652518119;8056.0332760067995;8150.3479721622125;8150.75547733569;5938.732757025858;6013;6014.8195554133445;6017.097435384552;6051.939480605138;9681.177099946302;9705.223582113273;9868.555914983986;9934.602615895572;9971.30200885931;9842.852357214791;10127.79744405093;10163.170629286504;10243.38539687621;10285.588576457158;7354.96322518384;7464.888026679713;7539.359154471712;7556.206598307099;7557.206493318123;8077.394195435249;8179;8181.304589109992;8185.467944583583;8186;7271.527350722186;7434.925650743639;7471.551706897603;7493.88759168602;7588.62056897164;7310.342069213796;7370.6314684266645;7395.630218488946;7437.590932498548;7439.8140046499275;6850;6986.406155476841;6994.985727069648;6995.650217489207;7003.789886303419;4836;4906.435759887516;4965.900681986413;5025.3718285214345;5058.620603454682;4857.854264371933;4955.083309587738;5052.797888084436;5096.031753966735;5176.637635365639 14:43:47 INFO - PROCESS | 1678 | |4;prototype.html;285.5360039935105;299.5192715691314;301.3957016182554;309.8621113604446;319.030148349019;3943.78309192995;4233.915321693572;4907.1412502812;4997.475769890182;5109;4869.805207791693;5240.554552863011;5248.71132087735;5271.341082364705;5277.70419867357;3218.92379415277;3573.0888623401124;3871.419287106942;3912.8434862605463;3935.626115519021;3938.2911076006308;3956.8812935611977;4002.519697636273;4004.259212045766;4030.9721021139567;3661.1213308805827;3681.576618688845;3782.7919464429447;3875.418687196929;3925.489686340786;3362.2771104212466;3858.1704933439446;3900.3369427197304;3907.628775266345;3927.9018024549327;3162.778605497616;3267.2648654052887;3384.729221662261;3404.1829960809473;3405.7615966882327;3968.4840970673918;4747.667663263573;5003.349564556621;5061.417936937262;5092.465291144451;3809.9619003809885;4131.462909821704;4137.81379837905;4299.968007678166;4507.526709695468;5516.613837031409;5521.702399936012;5521.917171242435;5523.613347065667;5563.860903477405;2924.22774620739;3245.9837700811345;3777.6222377762006;3777.7166712496396;3795.886123416302;4596.908061838744;5085.4914508548845;5266.789328426858;5463.847475918331;5531.302758159102;3813.951163430079;3814.2180852925085;3835.53973523179;3843.2889915365745;3844.4809950656304;3740.532433445819;3797.9240415192094;3889.871937138255;3912.300512646265;3921.5882332355263;3958.267720471722;4312.55529397649;4323.740575565476;4362.8746695925265;4464.866054018385;4943.826966056243;5437.13005919051;5505;5509.862253443615;5539.224508568804;1284.5054653958293;1313.6190504753706;1316;1316.4602512969827;1329.3154025676783;704.7286794584122;792.7502836606451;821.708293555779;848.9794289590858;861.3195575495414;4999.875003124878;5033.144365457881;5060.215666571614;5061.316722242524;5078.5937125029905;4641.791119399635;4827.927581086286;5243.8164664236565;5528.391876893538;5654.575906807006;4333.804978775963;4727.929081063787;4891.33966914462;4893.266010098442;4942.085714142895;2550.91586075917;2730.1536523677723;2825.5055365310986;2978.627671541057;2999.2351950252546;4589.862304130881;5553.361363443256;5834.883302333929;5843.970780146072;5863.355030946593;5168.596602579819;5479.671219726829;5788.27646544182;5808.448197421239;5819.854503637358;4741.644376671763;5835.416458354215;5853.824385268449;5856.209411729362;5857.648541087548;4540.818367265272;4761.524007516003;5665.518430933252;5684.289463817023;5704.572157088152;5100.837480761951;5113.284140220298;5533.6956467393065;5587.8882422352135;5613.635113717595;5083.847484575469;5401.864953376197;5426.457354264542;5544;5861.179434879035;3651.8721844735305;3759.8684046058256;3793.544774626952;3799.6200379961783;3816.332141875105;4897.436794768505;5393.7033463159905;5591.944080559142;5601.60788744784;5603.915941260802;5457.508824205841;5469;5473.480019398151;5499.538042799774;5503.147012213113;4712.175369310426;5091.974540127276;5417.702026388429;5441.61238884082;5467.972660136674;4752.3149420577265;5375.301210842722;5417.918731219113;5429.864253393539;5434.3207099112615;5317.787288508416;5457.263269458731;5533.861653458534;5546.751980804448;5595.216669666332;5110.335656364798;5226.458194832458;5380;5428.70142142186;5450.182472629137 14:43:47 INFO - PROCESS | 1678 | |5;yui.html;701.4423533291035;737.8302990312228;739.8779201431764;781.644351819922;835.5070508400042;15196.240187990597;16004.359825606962;16028.919855400736;16046.679066418665;16063.518094457171;14386.568402947929;14551.417943282282;14565.344559494823;14565.635859103528;14617.634559136028;685.116200101868;708.7979925721171;710.6340234779093;711.7793484019944;852.526847599582;711.0436462957314;714.1858281559001;843.995780021099;874.8425283448977;877.1360210192955;908.7818923458356;917.2386918857333;926.5321012888515;926.8887733471959;930.0420566816157;918.0223062438482;919.7562645898809;919.9724008279762;921.3826736086838;921.8478950973081;535.9437259087817;678.7115475922714;683.1051322767141;683.1392445518633;686.0361192524512;13833.79249311261;14314.284285785669;14355.210463424508;14374.856251437457;14378.856211437856;14136.929315353358;14535.273236338247;14668.046576972463;14721.92639036798;14777.408903643842;10203.489825508696;11805.819418058212;11976.880231197663;11990.580329688419;12343.753124937452;3860.7297489175767;3875.283072631544;3876.8836934891715;3934.350832112698;4027.939580906289;122633.16050259254;122732;122746.38626806898;122858;122922.3853880725;10774.946125269324;10907.563697452171;11251.662450126345;11266.94366528162;11310.886891131147;19189.232430702614;22873.542529149658;22883.427914302276;22927.426814329774;23014;8045.155258697752;8070.0719417267765;8076.798080048045;8300.958495207486;8411.831763364698;4498.347739577743;4603.930941035887;4661.86014419568;4677.4854765975715;4792.640551958617;3517.4899639552123;3676.852925882935;3682.2819550187455;3682.760620559655;3701.333759923186;645.5287640022809;657.6580178307254;663.131297999622;673.054358626131;679.0866284846971;597.745957967862;635.414640472016;664.5481072870494;667.8363800868818;702.118840854724;8871.423357481743;9558.56986435612;9607.423554586747;9701.320907536547;9727.805443891082;579.2730123694736;607.5868409481595;682.6586706646676;699.3181647893264;700.0933790741003;3931.233409485123;4141.840284720283;4492.146492166478;4654.906901861944;4670.743109128963;92947.60578591327;150261.248693758;159864;163567;165289;140535;140939.65771540307;144474;145321;147325.2633736846;110890.44554777336;119690.40154799345;120939.39530302292;126752.99999999815;127998;7027.964860175666;7784.260495252942;8588.914110858812;8935.642574296955;9100.453972761656;54613.1808022872;66950.66524667345;67699;69096.30903690899;69245;96835.54746678665;102688.43278918086;102937;104809.47595261974;105305.94694053268;11852.585159519376;11890.524379025088;11916.523339066687;12015.699607509881;12462.065345099336;13227.40476678571;13269.203847769164;13454.663633409244;13664.65838354049;13941.651458713613;12244.326562039174;12381.380930953235;12557.623271301876;12564.748705026032;12771.552995645108;12218.327991960528;12222.938885305517;12455.190412623151;12559.623211303675;12607.810882836948;12183.329916854658;12189.573364932185;12203.511859525875;12226.449809758404;12659.430325635552;9455.479948602893;10363.430011349146;10428.259264581062;10648.84026739584;11048.226624136234;10241.795164096528;10637.015338783272;10673.946630266799;10691.732706682395;10728.249022568658 14:43:47 INFO - PROCESS | 1678 | __end_tp_report 14:43:47 INFO - PROCESS | 1678 | __start_cc_report 14:43:47 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1325 14:43:47 INFO - PROCESS | 1678 | __end_cc_report 14:43:47 INFO - PROCESS | 1678 | __startTimestamp1470692627165__endTimestamp 14:43:47 INFO - PROCESS | 1678 | 14:43:47 INFO - PROCESS | 1678 | ------- Summary: start ------- 14:43:47 INFO - PROCESS | 1678 | Number of tests: 6 14:43:47 INFO - PROCESS | 1678 | 14:43:47 INFO - PROCESS | 1678 | [#0] dojo.html Cycles:165 Average:5803.06 Median:6076.21 stddev:648.46 (10.7%) stddev-sans-first:610.22 14:43:47 INFO - PROCESS | 1678 | Values: 2936.6 3406.0 3421.8 3423.9 3465.7 5659.9 5753.1 5786.1 5791.8 5801.3 5756.1 5761.1 5792.7 5793.0 5799.9 5219.2 5260.8 5278.5 5287.8 5347.1 5310.6 5329.9 5330.5 5336.1 5347.5 5239.1 5250.3 5269.7 5270.5 5326.3 5321.6 5323.9 5323.9 5349.0 5361.6 5106.7 5127.4 5196.0 5235.3 5246.8 5644.8 5698.8 5744.6 5774.1 5803.9 6263.4 6325.1 6338.7 6341.2 6345.3 6206.1 6226.3 6235.9 6265.6 6266.0 5596.3 5891.9 5943.3 5978.1 5983.1 6305.6 6320.5 6325.2 6327.2 6330.3 6086.5 6113.8 6128.1 6237.8 6263.3 6275.0 6290.3 6294.2 6300.4 6320.3 6232.5 6316.7 6318.2 6320.5 6324.7 6149.1 6246.1 6300.3 6307.3 6341.1 4984.4 4998.4 5015.8 5025.3 5034.7 4471.8 4473.4 4477.6 4484.9 4515.3 5632.2 5703.2 5764.7 5817.3 5840.5 6203.8 6243.8 6270.6 6276.6 6298.7 4886.6 5772.9 5774.8 5776.2 5782.8 5422.1 5506.9 5526.4 5527.4 5531.3 6244.4 6273.2 6340.4 6340.7 6401.1 6274.8 6282.8 6284.5 6293.6 6297.0 6371.7 6382.6 6385.6 6404.2 6424.9 6066.5 6157.7 6197.7 6204.1 6289.5 6241.5 6288.4 6300.7 6302.6 6320.4 6029.1 6167.3 6180.2 6194.5 6204.4 6024.1 6142.2 6156.4 6161.8 6233.5 6061.0 6068.3 6107.9 6110.4 6122.5 6076.2 6202.1 6208.3 6208.6 6223.7 5963.0 5989.3 6084.7 6090.0 6091.8 14:43:47 INFO - PROCESS | 1678 | 14:43:47 INFO - PROCESS | 1678 | [#1] ext.html Cycles:180 Average:71439.87 Median:40906.49 stddev:157100.21 (384.0%) stddev-sans-first:157450.60 14:43:47 INFO - PROCESS | 1678 | Values: 490.8 503.2 520.5 534.5 536.1 31008.2 32814.5 35758.0 40404.8 40843.8 43520.8 43907.0 44075.0 44086.3 44234.8 9574.6 9756.6 9769.2 9773.9 9778.9 9743.6 9836.7 9843.1 9848.8 9855.2 9814.2 9843.4 9872.8 9872.8 9876.7 9782.6 9859.2 9864.6 9865.8 9873.6 8264.5 9705.6 9711.3 9732.0 9744.0 33031.0 40838.8 40928.6 40990.0 40993.8 3342.3 3567.7 3629.3 3886.4 3894.8 31199.7 32176.8 32382.2 32429.8 32536.8 3213.3 3363.9 3372.9 3373.3 3409.4 485971.1 489556.0 514957.0 517470.0 519301.0 53787.0 53840.0 53879.0 53903.0 54019.5 63696.0 63777.4 63894.4 63940.7 63985.7 16419.5 16715.2 16754.3 16776.1 16778.2 10623.9 12486.8 12492.8 12508.4 12529.1 16030.9 16580.3 16598.8 16630.3 16770.5 6995.3 7058.7 7070.4 7124.2 7165.2 737.1 766.5 849.8 928.7 980.9 29125.3 30180.4 30438.0 30574.6 30973.4 1064.3 1075.8 1093.9 1111.7 1145.3 15694.8 15869.5 15889.7 16103.7 16177.8 673821.0 676232.0 681479.0 684881.2 686956.0 59907.7 60077.4 60165.7 60270.0 60322.7 1267.1 1303.2 1356.9 1387.0 1422.3 28680.7 30558.4 30652.1 31400.8 31953.2 46069.8 49958.0 51328.7 52292.7 52329.5 559365.0 562596.0 562603.0 562855.0 564461.0 26356.5 26931.0 27006.3 28168.4 41244.2 47799.5 48832.8 49150.5 49219.0 49362.8 34621.3 35549.0 38061.0 39152.0 40776.6 39253.6 39290.6 40268.6 40876.0 40884.4 37553.6 38151.8 38209.6 38340.0 38385.4 33092.0 33908.0 34180.7 34442.8 34461.3 25627.6 25681.6 25787.4 26064.0 26403.0 14:43:47 INFO - PROCESS | 1678 | 14:43:47 INFO - PROCESS | 1678 | [#2] jquery.html Cycles:180 Average:33856.68 Median:11573.50 stddev:92449.18 (798.8%) stddev-sans-first:92674.30 14:43:47 INFO - PROCESS | 1678 | Values: 354.2 374.4 375.1 382.5 404.5 15540.4 15583.3 20108.6 20964.8 20975.2 19965.1 20215.7 20215.8 20223.5 20238.3 4672.6 5831.7 6064.2 6064.6 6074.6 5863.2 6030.3 6033.5 6035.6 6047.3 5969.2 6026.8 6028.7 6565.3 6610.8 6415.6 6578.1 6587.9 6596.1 6616.2 5560.9 5695.9 5775.0 5787.9 5807.6 12913.9 12922.7 12944.5 13121.7 13147.1 2171.8 2304.4 2308.5 2356.4 2795.7 8665.8 10302.0 10315.7 12916.3 14487.1 1556.7 1796.8 1814.3 1869.9 1870.8 120795.0 132603.7 133915.0 134448.0 134449.0 11025.3 11176.1 11337.5 11501.6 11699.0 14128.9 14306.3 14510.9 14513.6 14518.2 7387.8 8384.5 8434.7 8513.5 8536.5 8211.8 8347.7 8370.6 8511.0 8710.3 4493.6 4517.8 4533.2 4533.5 4597.9 1900.8 1948.1 1953.3 1954.9 1992.6 876.3 892.5 917.6 968.1 984.5 16228.1 17673.9 18842.0 20792.3 20831.0 822.7 843.0 938.6 996.4 1014.0 10151.3 10781.2 10913.4 10924.3 10940.9 433420.0 515257.0 517469.0 616647.0 617436.0 126142.0 139894.0 141808.3 149259.0 156375.0 960.1 992.6 1000.4 1001.2 1033.9 17403.8 17889.9 17995.0 18110.6 18170.2 54020.0 54482.4 54566.4 55178.0 55764.7 56911.7 83523.0 85720.0 86106.1 91905.5 6948.9 7579.4 7961.2 7990.2 8060.8 10787.8 11088.5 12648.6 12684.4 13027.5 8795.8 10848.8 11341.9 11476.2 11491.9 11003.7 11031.4 11375.5 11402.8 11556.8 11321.8 11496.8 11760.4 11777.7 11861.4 7240.6 7266.8 7428.5 7609.3 7609.8 9821.7 11013.5 11474.4 11488.7 11548.7 14:43:47 INFO - PROCESS | 1678 | 14:43:47 INFO - PROCESS | 1678 | [#3] mootools.html Cycles:180 Average:5601.44 Median:5077.33 stddev:3112.38 (61.3%) stddev-sans-first:3104.81 14:43:47 INFO - PROCESS | 1678 | Values: 1363.8 1511.8 1541.0 1733.3 1911.6 6807.4 8111.4 8405.3 8629.6 8661.9 8572.4 8614.4 8619.7 8620.5 8620.9 2329.5 2337.6 2338.4 2368.4 2371.0 2332.5 2363.0 2371.2 2374.7 2377.0 2328.6 2346.6 2364.5 2366.1 2371.4 2308.8 2339.7 2342.8 2343.2 2351.1 1998.9 2327.0 2329.0 2330.7 2337.8 8546.4 8642.2 8672.7 8678.9 8695.1 5102.2 5309.3 5309.6 5343.4 5346.5 3552.2 3568.7 3619.8 3639.4 3659.9 1074.3 1087.4 1087.6 1109.1 1111.8 9795.5 11229.6 11233.9 11286.8 11330.0 4347.8 4435.5 4551.5 4586.4 4588.8 8961.7 8962.8 8964.2 8976.0 8988.1 4439.7 5135.4 5138.8 5143.1 5144.6 4310.3 4482.2 4645.2 4802.8 4811.0 3120.8 3721.5 3758.7 3799.4 3879.6 996.0 1139.5 1148.8 1149.3 1168.3 746.8 866.8 892.4 906.9 948.7 5618.2 5706.3 5849.3 5881.6 6051.1 804.7 890.6 892.4 902.4 953.7 3932.2 3933.4 3962.5 4074.6 4074.8 10208.2 10624.1 10632.5 10637.2 10638.0 10573.1 10582.8 10586.1 10610.7 10669.0 7694.2 8035.2 8056.0 8150.3 8150.8 5938.7 6013.0 6014.8 6017.1 6051.9 9681.2 9705.2 9868.6 9934.6 9971.3 9842.9 10127.8 10163.2 10243.4 10285.6 7355.0 7464.9 7539.4 7556.2 7557.2 8077.4 8179.0 8181.3 8185.5 8186.0 7271.5 7434.9 7471.6 7493.9 7588.6 7310.3 7370.6 7395.6 7437.6 7439.8 6850.0 6986.4 6995.0 6995.7 7003.8 4836.0 4906.4 4965.9 5025.4 5058.6 4857.9 4955.1 5052.8 5096.0 5176.6 14:43:47 INFO - PROCESS | 1678 | 14:43:47 INFO - PROCESS | 1678 | [#4] prototype.html Cycles:180 Average:4390.12 Median:4942.96 stddev:1359.64 (27.5%) stddev-sans-first:1328.09 14:43:47 INFO - PROCESS | 1678 | Values: 285.5 299.5 301.4 309.9 319.0 3943.8 4233.9 4907.1 4997.5 5109.0 4869.8 5240.6 5248.7 5271.3 5277.7 3218.9 3573.1 3871.4 3912.8 3935.6 3938.3 3956.9 4002.5 4004.3 4031.0 3661.1 3681.6 3782.8 3875.4 3925.5 3362.3 3858.2 3900.3 3907.6 3927.9 3162.8 3267.3 3384.7 3404.2 3405.8 3968.5 4747.7 5003.3 5061.4 5092.5 3810.0 4131.5 4137.8 4300.0 4507.5 5516.6 5521.7 5521.9 5523.6 5563.9 2924.2 3246.0 3777.6 3777.7 3795.9 4596.9 5085.5 5266.8 5463.8 5531.3 3814.0 3814.2 3835.5 3843.3 3844.5 3740.5 3797.9 3889.9 3912.3 3921.6 3958.3 4312.6 4323.7 4362.9 4464.9 4943.8 5437.1 5505.0 5509.9 5539.2 1284.5 1313.6 1316.0 1316.5 1329.3 704.7 792.8 821.7 849.0 861.3 4999.9 5033.1 5060.2 5061.3 5078.6 4641.8 4827.9 5243.8 5528.4 5654.6 4333.8 4727.9 4891.3 4893.3 4942.1 2550.9 2730.2 2825.5 2978.6 2999.2 4589.9 5553.4 5834.9 5844.0 5863.4 5168.6 5479.7 5788.3 5808.4 5819.9 4741.6 5835.4 5853.8 5856.2 5857.6 4540.8 4761.5 5665.5 5684.3 5704.6 5100.8 5113.3 5533.7 5587.9 5613.6 5083.8 5401.9 5426.5 5544.0 5861.2 3651.9 3759.9 3793.5 3799.6 3816.3 4897.4 5393.7 5591.9 5601.6 5603.9 5457.5 5469.0 5473.5 5499.5 5503.1 4712.2 5092.0 5417.7 5441.6 5468.0 4752.3 5375.3 5417.9 5429.9 5434.3 5317.8 5457.3 5533.9 5546.8 5595.2 5110.3 5226.5 5380.0 5428.7 5450.2 14:43:47 INFO - PROCESS | 1678 | 14:43:47 INFO - PROCESS | 1678 | [#5] yui.html Cycles:180 Average:26094.20 Median:22970.71 stddev:42910.38 (186.8%) stddev-sans-first:42988.40 14:43:47 INFO - PROCESS | 1678 | Values: 701.4 737.8 739.9 781.6 835.5 15196.2 16004.4 16028.9 16046.7 16063.5 14386.6 14551.4 14565.3 14565.6 14617.6 685.1 708.8 710.6 711.8 852.5 711.0 714.2 844.0 874.8 877.1 908.8 917.2 926.5 926.9 930.0 918.0 919.8 920.0 921.4 921.8 535.9 678.7 683.1 683.1 686.0 13833.8 14314.3 14355.2 14374.9 14378.9 14136.9 14535.3 14668.0 14721.9 14777.4 10203.5 11805.8 11976.9 11990.6 12343.8 3860.7 3875.3 3876.9 3934.4 4027.9 122633.2 122732.0 122746.4 122858.0 122922.4 10774.9 10907.6 11251.7 11266.9 11310.9 19189.2 22873.5 22883.4 22927.4 23014.0 8045.2 8070.1 8076.8 8301.0 8411.8 4498.3 4603.9 4661.9 4677.5 4792.6 3517.5 3676.9 3682.3 3682.8 3701.3 645.5 657.7 663.1 673.1 679.1 597.7 635.4 664.5 667.8 702.1 8871.4 9558.6 9607.4 9701.3 9727.8 579.3 607.6 682.7 699.3 700.1 3931.2 4141.8 4492.1 4654.9 4670.7 92947.6 150261.2 159864.0 163567.0 165289.0 140535.0 140939.7 144474.0 145321.0 147325.3 110890.4 119690.4 120939.4 126753.0 127998.0 7028.0 7784.3 8588.9 8935.6 9100.5 54613.2 66950.7 67699.0 69096.3 69245.0 96835.5 102688.4 102937.0 104809.5 105305.9 11852.6 11890.5 11916.5 12015.7 12462.1 13227.4 13269.2 13454.7 13664.7 13941.7 12244.3 12381.4 12557.6 12564.7 12771.6 12218.3 12222.9 12455.2 12559.6 12607.8 12183.3 12189.6 12203.5 12226.4 12659.4 9455.5 10363.4 10428.3 10648.8 11048.2 10241.8 10637.0 10673.9 10691.7 10728.2 14:43:47 INFO - PROCESS | 1678 | -------- Summary: end -------- 14:43:47 INFO - PROCESS | 1678 | 14:43:47 INFO - TEST-INFO | 1678: exit 0 14:43:47 INFO - TEST-OK | dromaeo_css | took 1117942ms 14:43:47 INFO - TEST-START | kraken 14:43:47 INFO - operating with platform_type : mac_ 14:43:47 INFO - Initialising browser for kraken test... 14:43:47 INFO - TEST-INFO | started process 1796 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpEjzRYi/profile http://localhost:49271/getInfo.html) 14:43:50 INFO - PROCESS | 1796 | __metrics Screen width/height:1600/1200 14:43:50 INFO - PROCESS | 1796 | colorDepth:24 14:43:50 INFO - PROCESS | 1796 | Browser inner width/height: 1024/689 14:43:50 INFO - PROCESS | 1796 | __metrics 14:43:50 INFO - PROCESS | 1796 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:43:50 INFO - PROCESS | 1796 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:43:50 INFO - TEST-INFO | 1796: exit 0 14:43:50 INFO - Browser initialized. 14:43:50 INFO - Running cycle 1/1 for kraken test... 14:43:50 INFO - TEST-INFO | started process 1797 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpEjzRYi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:02 INFO - PROCESS | 1797 | RSS: Main: 243613696 14:44:02 INFO - PROCESS | 1797 | 14:44:05 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 14:44:06 INFO - PROCESS | 1797 | RSS: Main: 294526976 14:44:06 INFO - PROCESS | 1797 | 14:44:09 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 14:44:09 INFO - PROCESS | 1797 | RSS: Main: 301121536 14:44:09 INFO - PROCESS | 1797 | 14:44:13 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 14:44:14 INFO - PROCESS | 1797 | RSS: Main: 397094912 14:44:14 INFO - PROCESS | 1797 | 14:44:16 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 14:44:16 INFO - PROCESS | 1797 | RSS: Main: 297598976 14:44:16 INFO - PROCESS | 1797 | 14:44:18 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:44:19 INFO - PROCESS | 1797 | RSS: Main: 302923776 14:44:19 INFO - PROCESS | 1797 | 14:44:22 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 14:44:22 INFO - PROCESS | 1797 | RSS: Main: 341803008 14:44:22 INFO - PROCESS | 1797 | 14:44:25 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 14:44:26 INFO - PROCESS | 1797 | RSS: Main: 343080960 14:44:26 INFO - PROCESS | 1797 | 14:44:29 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 14:44:29 INFO - PROCESS | 1797 | RSS: Main: 340525056 14:44:29 INFO - PROCESS | 1797 | 14:44:31 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:32 INFO - PROCESS | 1797 | RSS: Main: 313982976 14:44:32 INFO - PROCESS | 1797 | 14:44:33 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:34 INFO - PROCESS | 1797 | RSS: Main: 320335872 14:44:34 INFO - PROCESS | 1797 | 14:44:36 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:37 INFO - PROCESS | 1797 | RSS: Main: 323510272 14:44:37 INFO - PROCESS | 1797 | 14:44:40 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:40 INFO - PROCESS | 1797 | RSS: Main: 332824576 14:44:40 INFO - PROCESS | 1797 | 14:44:43 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:44 INFO - PROCESS | 1797 | RSS: Main: 334073856 14:44:44 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 14:44:46 INFO - PROCESS | 1797 | RSS: Main: 377389056 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | __start_tp_report 14:44:46 INFO - PROCESS | 1797 | _x_x_mozilla_page_load 14:44:46 INFO - PROCESS | 1797 | _x_x_mozilla_page_load_details 14:44:46 INFO - PROCESS | 1797 | |i|pagename|runs| 14:44:46 INFO - PROCESS | 1797 | |0;ai-astar;101;112;113;112;114;113;112;114;114;111 14:44:46 INFO - PROCESS | 1797 | |1;audio-beat-detection;144;109;110;166;103;107;131;107;139;106 14:44:46 INFO - PROCESS | 1797 | |2;audio-dft;184;186;189;187;183;183;184;187;181;182 14:44:46 INFO - PROCESS | 1797 | |3;audio-fft;79;58;63;93;60;57;65;63;84;58 14:44:46 INFO - PROCESS | 1797 | |4;audio-oscillator;87;69;101;74;78;69;97;69;67;102 14:44:46 INFO - PROCESS | 1797 | |5;imaging-gaussian-blur;90;85;89;86;90;86;92;130;116;86 14:44:46 INFO - PROCESS | 1797 | |6;imaging-darkroom;93;93;98;142;110;95;95;94;94;112 14:44:46 INFO - PROCESS | 1797 | |7;imaging-desaturate;85;87;86;87;85;89;87;91;123;86 14:44:46 INFO - PROCESS | 1797 | |8;json-parse-financial;52;52;53;53;53;51;53;52;53;54 14:44:46 INFO - PROCESS | 1797 | |9;json-stringify-tinderbox;66;66;74;75;74;69;69;72;72;72 14:44:46 INFO - PROCESS | 1797 | |10;stanford-crypto-aes;86;84;81;85;82;83;85;80;82;85 14:44:46 INFO - PROCESS | 1797 | |11;stanford-crypto-ccm;136;136;141;137;137;137;135;141;148;140 14:44:46 INFO - PROCESS | 1797 | |12;stanford-crypto-pbkdf2;162;166;165;167;165;165;166;163;158;160 14:44:46 INFO - PROCESS | 1797 | |13;stanford-crypto-sha256-iterative;67;66;68;67;67;69;82;82;83;82 14:44:46 INFO - PROCESS | 1797 | __end_tp_report 14:44:46 INFO - PROCESS | 1797 | __start_cc_report 14:44:46 INFO - PROCESS | 1797 | _x_x_mozilla_cycle_collect,2104 14:44:46 INFO - PROCESS | 1797 | __end_cc_report 14:44:46 INFO - PROCESS | 1797 | __startTimestamp1470692686445__endTimestamp 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | ------- Summary: start ------- 14:44:46 INFO - PROCESS | 1797 | Number of tests: 14 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.86 (3.4%) stddev-sans-first:1.09 14:44:46 INFO - PROCESS | 1797 | Values: 101.0 112.0 113.0 112.0 114.0 113.0 112.0 114.0 114.0 111.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:120.50 stddev:21.52 (17.9%) stddev-sans-first:21.34 14:44:46 INFO - PROCESS | 1797 | Values: 144.0 109.0 110.0 166.0 103.0 107.0 131.0 107.0 139.0 106.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.00 stddev:2.55 (1.4%) stddev-sans-first:2.69 14:44:46 INFO - PROCESS | 1797 | Values: 184.0 186.0 189.0 187.0 183.0 183.0 184.0 187.0 181.0 182.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#3] audio-fft Cycles:10 Average:68.00 Median:64.00 stddev:12.68 (19.8%) stddev-sans-first:12.80 14:44:46 INFO - PROCESS | 1797 | Values: 79.0 58.0 63.0 93.0 60.0 57.0 65.0 63.0 84.0 58.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:71.50 stddev:14.21 (19.9%) stddev-sans-first:14.92 14:44:46 INFO - PROCESS | 1797 | Values: 87.0 69.0 101.0 74.0 78.0 69.0 97.0 69.0 67.0 102.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:87.50 stddev:15.29 (17.5%) stddev-sans-first:16.11 14:44:46 INFO - PROCESS | 1797 | Values: 90.0 85.0 89.0 86.0 90.0 86.0 92.0 130.0 116.0 86.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:94.00 stddev:15.51 (16.5%) stddev-sans-first:16.05 14:44:46 INFO - PROCESS | 1797 | Values: 93.0 93.0 98.0 142.0 110.0 95.0 95.0 94.0 94.0 112.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#7] imaging-desaturate Cycles:10 Average:90.60 Median:87.00 stddev:11.53 (13.3%) stddev-sans-first:12.05 14:44:46 INFO - PROCESS | 1797 | Values: 85.0 87.0 86.0 87.0 85.0 89.0 87.0 91.0 123.0 86.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.84 (1.6%) stddev-sans-first:0.87 14:44:46 INFO - PROCESS | 1797 | Values: 52.0 52.0 53.0 53.0 53.0 51.0 53.0 52.0 53.0 54.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:72.00 stddev:3.25 (4.5%) stddev-sans-first:2.92 14:44:46 INFO - PROCESS | 1797 | Values: 66.0 66.0 74.0 75.0 74.0 69.0 69.0 72.0 72.0 72.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.50 stddev:2.00 (2.4%) stddev-sans-first:1.87 14:44:46 INFO - PROCESS | 1797 | Values: 86.0 84.0 81.0 85.0 82.0 83.0 85.0 80.0 82.0 85.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:138.50 stddev:3.88 (2.8%) stddev-sans-first:3.98 14:44:46 INFO - PROCESS | 1797 | Values: 136.0 136.0 141.0 137.0 137.0 137.0 135.0 141.0 148.0 140.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:165.00 stddev:2.91 (1.8%) stddev-sans-first:3.02 14:44:46 INFO - PROCESS | 1797 | Values: 162.0 166.0 165.0 167.0 165.0 165.0 166.0 163.0 158.0 160.0 14:44:46 INFO - PROCESS | 1797 | 14:44:46 INFO - PROCESS | 1797 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:75.50 stddev:7.75 (10.3%) stddev-sans-first:7.87 14:44:46 INFO - PROCESS | 1797 | Values: 67.0 66.0 68.0 67.0 67.0 69.0 82.0 82.0 83.0 82.0 14:44:46 INFO - PROCESS | 1797 | -------- Summary: end -------- 14:44:46 INFO - PROCESS | 1797 | 14:44:47 INFO - TEST-INFO | 1797: exit 0 14:44:47 INFO - TEST-OK | kraken | took 59509ms 14:44:47 INFO - SUITE-END | took 1177s 14:44:47 INFO - Completed test suite (00:19:37) 14:44:47 INFO - javascript benchmark 14:44:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2936.6476022877255, 3406.0463070340315, 3421.8289085545716, 3423.9144021399447, 3465.6534346565345, 5659.943400565993, 5753.1370294455855, 5786.132080187974, 5791.76832926683, 5801.303843538776, 5756.107803290486, 5761.1358296255585, 5792.71036448177, 5793.0, 5799.9130013049835, 5219.243209734595, 5260.789568417259, 5278.498542638443, 5287.762050707727, 5347.0909945309195, 5310.575153987691, 5329.946700533003, 5330.546903513206, 5336.092864213074, 5347.491988261109, 5239.10935141025, 5250.31745873036, 5269.683818970855, 5270.4729527047375, 5326.280952071479, 5321.600879934021, 5323.866903327409, 5323.946760532423, 5349.0, 5361.571074314045, 5106.668066575698, 5127.384713834326, 5196.0, 5235.345581802275, 5246.7901283948595, 5644.8024319148635, 5698.800541981011, 5744.569157313218, 5774.105013722879, 5803.941960580382, 6263.43629073381, 6325.051242313643, 6338.683065846689, 6341.239051313872, 6345.33373995733, 6206.100115483275, 6226.315105338409, 6235.906461403082, 6265.624062556261, 6265.968670156665, 5596.300462442236, 5891.882162356729, 5943.286805583271, 5978.133170690226, 5983.072623743326, 6305.558610897193, 6320.525960552977, 6325.177726895474, 6327.240731112204, 6330.272018717815, 6086.482648974798, 6113.810786210604, 6128.1114238435175, 6237.844053898689, 6263.279722831841, 6275.02737075754, 6290.276618188876, 6294.181756371734, 6300.401461861115, 6320.336364681642, 6232.501399887998, 6316.715747791361, 6318.178636777281, 6320.462760665395, 6324.747010119636, 6149.0776383542825, 6246.063090536456, 6300.338464461165, 6307.306196318401, 6341.143945567289, 4984.37695288089, 4998.400191976913, 5015.824446144367, 5025.296458495814, 5034.748262586856, 4471.7987690554, 4473.373727678128, 4477.574630410106, 4484.865454036384, 4515.345274935116, 5632.155176723442, 5703.230063941398, 5764.740586673526, 5817.331006934172, 5840.532757379399, 6203.844903877439, 6243.8126856194385, 6270.623762574261, 6276.592021518587, 6298.685065746694, 4886.60907127429, 5772.855678608068, 5774.797882074107, 5776.191333213354, 5782.797602083991, 5422.132458806572, 5506.91739623906, 5526.392096869341, 5527.364353099365, 5531.2809334787025, 6244.375562443719, 6273.18448601688, 6340.365963403623, 6340.714667839866, 6401.135846660642, 6274.780382686584, 6282.842928926813, 6284.497240220863, 6293.559450838397, 6296.968515157395, 6371.74513019474, 6382.5532212744665, 6385.648789316632, 6404.199475065617, 6424.903626445701, 6066.484348830399, 6157.692115394123, 6197.721102550487, 6204.100405441276, 6289.465395441439, 6241.500679945684, 6288.402601752826, 6300.7479700811455, 6302.621842689453, 6320.399562041599, 6029.095635654687, 6167.321594624677, 6180.165677633462, 6194.504439644727, 6204.410580994799, 6024.096385542204, 6142.232220972379, 6156.384361563808, 6161.784337548164, 6233.501319894488, 6060.969695151496, 6068.250436993457, 6107.877842443215, 6110.358412366815, 6122.510199183966, 6076.210092687922, 6202.100695399232, 6208.348123447154, 6208.596441231305, 6223.719932603134, 5963.0, 5989.311229208697, 6084.726187321493, 6089.969550152221, 6091.756329746938], "value": 5760.329139793507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.76933841094694, 503.227545717324, 520.45352380001, 534.4975722820549, 536.118085748943, 31008.224794380123, 32814.507782383254, 35758.0, 40404.79797601015, 40843.79578102113, 43520.782396088056, 43907.0, 44075.0, 44086.33870491945, 44234.77882610582, 9574.617015319396, 9756.560954757053, 9769.169620582223, 9773.853392199122, 9778.853317200212, 9743.610255589769, 9836.655717049905, 9843.064908833649, 9848.803023939518, 9855.162311203556, 9814.214862810957, 9843.409395436262, 9872.753181170456, 9872.753181170492, 9876.703698889009, 9782.608695652165, 9859.211263098934, 9864.60541578336, 9865.80268394628, 9873.555689993931, 8264.462809917337, 9705.563249653782, 9711.320207585472, 9732.0, 9744.02559744027, 33031.0, 40838.79580602108, 40928.590714092774, 40989.97525061868, 40993.77018689444, 3342.2647017656077, 3567.7324200684793, 3629.3104310181243, 3886.358750806142, 3894.785786781726, 31199.688003119903, 32176.839115804505, 32382.190445238823, 32429.837850810833, 32536.837315813507, 3213.3091385352263, 3363.8822641207685, 3372.8650853966055, 3373.291608762163, 3409.437442821931, 485971.1402885961, 489556.0, 514957.0, 517470.0, 519301.0, 53787.0, 53840.0, 53879.03665298446, 53903.0, 54019.45980540223, 63696.0, 63777.36222637807, 63894.36105638977, 63940.721185576025, 63985.680071599345, 16419.507414777574, 16715.247813848408, 16754.329826807036, 16776.077315747752, 16778.161091945352, 10623.89376106229, 12486.750264994831, 12492.81260781089, 12508.437120329607, 12529.060320476001, 16030.919845400931, 16580.253888575044, 16598.75101873473, 16630.251638676287, 16770.496885093467, 6995.26549712283, 7058.6823592938445, 7070.399016083587, 7124.216336203013, 7165.176004759415, 737.0750752244214, 766.4673052228759, 849.8045449546639, 928.7167413938679, 980.9068138526828, 29125.27186820304, 30180.396392072034, 30438.0, 30574.593560726473, 30973.380532389227, 1064.2869277584036, 1075.8224892892742, 1093.945302734876, 1111.7276267314398, 1145.3299819605625, 15694.76457853133, 15869.52391428259, 15889.68220635604, 16103.677926441405, 16177.757333640006, 673821.0, 676232.0, 681479.0, 684881.1511884817, 686956.0, 59907.700461497414, 60077.399226008056, 60165.69917150474, 60270.0, 60322.698386507785, 1267.1256832785348, 1303.2245813740808, 1356.891448684103, 1386.986130138706, 1422.3030714949807, 28680.713192867803, 30558.388832223674, 30652.08043758691, 31400.842995784875, 31953.201169970936, 46069.76965115153, 49958.000839983724, 51328.74335628298, 52292.7385363086, 52329.47670523398, 559365.0, 562596.0, 562603.0, 562855.0, 564461.0, 26356.472870542864, 26931.0, 27006.324841878326, 28168.43663126767, 41244.1751164981, 47799.52200477951, 48832.75583622059, 49150.5084949146, 49219.0, 49362.75318623384, 34621.307573848884, 35549.0, 38061.0, 39152.0, 40776.59223407847, 39253.60746392499, 39290.60709392984, 40268.597314027655, 40876.0, 40884.386734198415, 37553.6244637561, 38151.80924095362, 38209.617903821716, 38340.0, 38385.4242186373, 33092.0, 33908.0, 34180.658193417745, 34442.82778586091, 34461.31077378388, 25627.6155857666, 25681.61477577875, 25787.355316117246, 26064.0, 26403.0], "value": 20043.23089802411, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.2101114514634, 374.42554060176957, 375.1072447574772, 382.46836896713563, 404.4883222723254, 15540.378384864605, 15583.298751556178, 20108.59782804347, 20964.750463678116, 20975.16099356024, 19965.101570429328, 20215.696764548542, 20215.797842021577, 20223.49441263969, 20238.29165979191, 4672.602828759543, 5831.679257640828, 6064.181335519715, 6064.636121832682, 6074.5747797654185, 5863.208466856962, 6030.306514750816, 6033.456988871001, 6035.60768550045, 6047.304559975593, 5969.194158788551, 6026.819195424145, 6028.728707208164, 6565.277819439858, 6610.8016759497295, 6415.582987105847, 6578.144841170617, 6587.901181482282, 6596.142501474802, 6616.20605527335, 5560.888782224333, 5695.946249943732, 5775.0, 5787.913181302284, 5807.5644326675665, 12913.870861291362, 12922.676933076747, 12944.546940857024, 13121.671958201121, 13147.14543554666, 2171.8371122165745, 2304.37781798915, 2308.4805918668335, 2356.399118224842, 2795.7279437855727, 8665.82668346636, 10302.0, 10315.742106447324, 12916.289604071771, 14487.130772153705, 1556.657535342223, 1796.8203179682057, 1814.2833580735535, 1869.8784579002322, 1870.7942126366088, 120795.0, 132603.6739632601, 133914.99127513095, 134448.0, 134449.0, 11025.338479691245, 11176.105911527058, 11337.546498140147, 11501.597444089417, 11699.0, 14128.94032947533, 14306.28468576567, 14510.927445362706, 14513.637159071108, 14518.20149891766, 7387.8179491281135, 8384.496930184208, 8434.662613495391, 8513.531755753369, 8536.487810731376, 8211.753647390588, 8347.666093356198, 8370.581470926429, 8510.957445212858, 8710.303175745925, 4493.550644935545, 4517.774111294422, 4533.161365147393, 4533.455985281721, 4597.885052873638, 1900.8024944285012, 1948.074664534335, 1953.2675246782458, 1954.9120289586717, 1992.551675872946, 876.307716903639, 892.4912799704107, 917.6421195733669, 968.1431932739576, 984.5077461269366, 16228.107454090139, 17673.939563626223, 18842.0, 20792.27227047046, 20831.0, 822.6503735912213, 842.9831403371899, 938.6151677812064, 996.3573495095623, 1013.9847902281472, 10151.289409741246, 10781.191410644233, 10913.39976301311, 10924.289921155258, 10940.945295273632, 433420.0, 515257.0, 517469.0, 616647.0, 617436.0, 126142.0, 139894.0, 141808.29095854456, 149259.0, 156375.0, 960.078324808178, 992.6029588164647, 1000.4397537379091, 1001.2040427859869, 1033.8655974723088, 17403.825961740728, 17889.926604403776, 17995.0, 18110.55899379114, 18170.22188339311, 54020.044266492994, 54482.36552903419, 54566.3630091082, 55178.0, 55764.72117639386, 56911.71544142253, 83523.0, 85720.0, 86106.13893860982, 91905.54047229722, 6948.895766563404, 7579.355754760907, 7961.243681850215, 7990.240927111915, 8060.798480038046, 10787.784244314913, 11088.501017454073, 12648.557300494807, 12684.365781710692, 13027.544035958696, 8795.780105497413, 10848.837267440837, 11341.943290283496, 11476.196666233283, 11491.885081149081, 11003.669889903316, 11031.39327336972, 11375.54497820078, 11402.771944561227, 11556.826647600124, 11321.773564528829, 11496.770064598493, 11760.35318057515, 11777.705557361134, 11861.406929653655, 7240.610598502376, 7266.818329541592, 7428.517146385468, 7609.315161635479, 7609.847803044019, 9821.65624203178, 11013.504392302206, 11474.368909709712, 11488.655340339803, 11548.653540393801], "value": 9404.128801522293, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.820295444441, 1511.76567632017, 1540.9691806163878, 1733.349993752343, 1911.6176764647073, 6807.421369183619, 8111.39164562658, 8405.32757379409, 8629.611667474963, 8661.91338086619, 8572.442791218566, 8614.440061396004, 8619.698310559132, 8620.482771033743, 8620.913790862089, 2329.499157681098, 2337.609122572067, 2338.38032921276, 2368.3960590049514, 2370.988145059281, 2332.4751930815514, 2363.0311572255378, 2371.1937941100023, 2374.726906405768, 2376.976230237701, 2328.569214695287, 2346.5658853112145, 2364.5270945810908, 2366.100881664965, 2371.3834403055243, 2308.83403881039, 2339.7426283108844, 2342.7657234276608, 2343.16817529777, 2351.094828491026, 1998.8900610466565, 2327.0459111764094, 2328.953420931589, 2330.673705681206, 2337.8480398774027, 8546.359023073295, 8642.22220000203, 8672.696455624086, 8678.869816952687, 8695.130486951317, 5102.209157580581, 5309.33633295838, 5309.62832601718, 5343.3587969443915, 5346.518813306821, 3552.182997910495, 3568.678818906311, 3619.8371073301764, 3639.4176931690804, 3659.9085022874374, 1074.2856000759487, 1087.363892123101, 1087.6030248959153, 1109.0960866893456, 1111.8054340490382, 9795.461249631267, 11229.60696375631, 11233.887661123366, 11286.774264514746, 11330.036946859527, 4347.7826108694435, 4435.512093669694, 4551.45382554089, 4586.3579098926175, 4588.816447342069, 8961.686340978034, 8962.82074358509, 8964.193222609865, 8976.0, 8988.146126118008, 4439.711418757771, 5135.383753949475, 5138.820141295037, 5143.12566863634, 5144.61415393847, 4310.31035034393, 4482.170798402306, 4645.233536466513, 4802.759862006886, 4810.975945120322, 3120.7971481853606, 3721.4789929409903, 3758.661720445173, 3799.3920972644246, 3879.6120387960977, 996.003996003996, 1139.5384869128015, 1148.787474317254, 1149.2644707387278, 1168.3106966889407, 746.8319628083638, 866.7789713622985, 892.3931726426092, 906.909309069101, 948.7296120605595, 5618.157276408489, 5706.343770466367, 5849.268841394825, 5881.617694849821, 6051.0923361496125, 804.6982381606897, 890.6259371064039, 892.3887137310962, 902.4134312696799, 953.6948176583427, 3932.193900250499, 3933.3706606943324, 3962.5244970603712, 4074.6332830044844, 4074.837006519706, 10208.234382421348, 10624.096951759033, 10632.521536530874, 10637.202209834293, 10638.042576168182, 10573.101286390589, 10582.841257381146, 10586.10018148466, 10610.734731631617, 10669.0, 7694.153643099255, 8035.236652518119, 8056.0332760067995, 8150.3479721622125, 8150.75547733569, 5938.732757025858, 6013.0, 6014.8195554133445, 6017.097435384552, 6051.939480605138, 9681.177099946302, 9705.223582113273, 9868.555914983986, 9934.602615895572, 9971.30200885931, 9842.852357214791, 10127.79744405093, 10163.170629286504, 10243.38539687621, 10285.588576457158, 7354.96322518384, 7464.888026679713, 7539.359154471712, 7556.206598307099, 7557.206493318123, 8077.394195435249, 8179.0, 8181.304589109992, 8185.467944583583, 8186.0, 7271.527350722186, 7434.925650743639, 7471.551706897603, 7493.88759168602, 7588.62056897164, 7310.342069213796, 7370.6314684266645, 7395.630218488946, 7437.590932498548, 7439.8140046499275, 6850.0, 6986.406155476841, 6994.985727069648, 6995.650217489207, 7003.789886303419, 4836.0, 4906.435759887516, 4965.900681986413, 5025.3718285214345, 5058.620603454682, 4857.854264371933, 4955.083309587738, 5052.797888084436, 5096.031753966735, 5176.637635365639], "value": 4502.508142880909, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.5360039935105, 299.5192715691314, 301.3957016182554, 309.8621113604446, 319.030148349019, 3943.78309192995, 4233.915321693572, 4907.1412502812, 4997.475769890182, 5109.0, 4869.805207791693, 5240.554552863011, 5248.71132087735, 5271.341082364705, 5277.70419867357, 3218.92379415277, 3573.0888623401124, 3871.419287106942, 3912.8434862605463, 3935.626115519021, 3938.2911076006308, 3956.8812935611977, 4002.519697636273, 4004.259212045766, 4030.9721021139567, 3661.1213308805827, 3681.576618688845, 3782.7919464429447, 3875.418687196929, 3925.489686340786, 3362.2771104212466, 3858.1704933439446, 3900.3369427197304, 3907.628775266345, 3927.9018024549327, 3162.778605497616, 3267.2648654052887, 3384.729221662261, 3404.1829960809473, 3405.7615966882327, 3968.4840970673918, 4747.667663263573, 5003.349564556621, 5061.417936937262, 5092.465291144451, 3809.9619003809885, 4131.462909821704, 4137.81379837905, 4299.968007678166, 4507.526709695468, 5516.613837031409, 5521.702399936012, 5521.917171242435, 5523.613347065667, 5563.860903477405, 2924.22774620739, 3245.9837700811345, 3777.6222377762006, 3777.7166712496396, 3795.886123416302, 4596.908061838744, 5085.4914508548845, 5266.789328426858, 5463.847475918331, 5531.302758159102, 3813.951163430079, 3814.2180852925085, 3835.53973523179, 3843.2889915365745, 3844.4809950656304, 3740.532433445819, 3797.9240415192094, 3889.871937138255, 3912.300512646265, 3921.5882332355263, 3958.267720471722, 4312.55529397649, 4323.740575565476, 4362.8746695925265, 4464.866054018385, 4943.826966056243, 5437.13005919051, 5505.0, 5509.862253443615, 5539.224508568804, 1284.5054653958293, 1313.6190504753706, 1316.0, 1316.4602512969827, 1329.3154025676783, 704.7286794584122, 792.7502836606451, 821.708293555779, 848.9794289590858, 861.3195575495414, 4999.875003124878, 5033.144365457881, 5060.215666571614, 5061.316722242524, 5078.5937125029905, 4641.791119399635, 4827.927581086286, 5243.8164664236565, 5528.391876893538, 5654.575906807006, 4333.804978775963, 4727.929081063787, 4891.33966914462, 4893.266010098442, 4942.085714142895, 2550.91586075917, 2730.1536523677723, 2825.5055365310986, 2978.627671541057, 2999.2351950252546, 4589.862304130881, 5553.361363443256, 5834.883302333929, 5843.970780146072, 5863.355030946593, 5168.596602579819, 5479.671219726829, 5788.27646544182, 5808.448197421239, 5819.854503637358, 4741.644376671763, 5835.416458354215, 5853.824385268449, 5856.209411729362, 5857.648541087548, 4540.818367265272, 4761.524007516003, 5665.518430933252, 5684.289463817023, 5704.572157088152, 5100.837480761951, 5113.284140220298, 5533.6956467393065, 5587.8882422352135, 5613.635113717595, 5083.847484575469, 5401.864953376197, 5426.457354264542, 5544.0, 5861.179434879035, 3651.8721844735305, 3759.8684046058256, 3793.544774626952, 3799.6200379961783, 3816.332141875105, 4897.436794768505, 5393.7033463159905, 5591.944080559142, 5601.60788744784, 5603.915941260802, 5457.508824205841, 5469.0, 5473.480019398151, 5499.538042799774, 5503.147012213113, 4712.175369310426, 5091.974540127276, 5417.702026388429, 5441.61238884082, 5467.972660136674, 4752.3149420577265, 5375.301210842722, 5417.918731219113, 5429.864253393539, 5434.3207099112615, 5317.787288508416, 5457.263269458731, 5533.861653458534, 5546.751980804448, 5595.216669666332, 5110.335656364798, 5226.458194832458, 5380.0, 5428.70142142186, 5450.182472629137], "value": 3956.5166721585892, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.4423533291035, 737.8302990312228, 739.8779201431764, 781.644351819922, 835.5070508400042, 15196.240187990597, 16004.359825606962, 16028.919855400736, 16046.679066418665, 16063.518094457171, 14386.568402947929, 14551.417943282282, 14565.344559494823, 14565.635859103528, 14617.634559136028, 685.116200101868, 708.7979925721171, 710.6340234779093, 711.7793484019944, 852.526847599582, 711.0436462957314, 714.1858281559001, 843.995780021099, 874.8425283448977, 877.1360210192955, 908.7818923458356, 917.2386918857333, 926.5321012888515, 926.8887733471959, 930.0420566816157, 918.0223062438482, 919.7562645898809, 919.9724008279762, 921.3826736086838, 921.8478950973081, 535.9437259087817, 678.7115475922714, 683.1051322767141, 683.1392445518633, 686.0361192524512, 13833.79249311261, 14314.284285785669, 14355.210463424508, 14374.856251437457, 14378.856211437856, 14136.929315353358, 14535.273236338247, 14668.046576972463, 14721.92639036798, 14777.408903643842, 10203.489825508696, 11805.819418058212, 11976.880231197663, 11990.580329688419, 12343.753124937452, 3860.7297489175767, 3875.283072631544, 3876.8836934891715, 3934.350832112698, 4027.939580906289, 122633.16050259254, 122732.0, 122746.38626806898, 122858.0, 122922.3853880725, 10774.946125269324, 10907.563697452171, 11251.662450126345, 11266.94366528162, 11310.886891131147, 19189.232430702614, 22873.542529149658, 22883.427914302276, 22927.426814329774, 23014.0, 8045.155258697752, 8070.0719417267765, 8076.798080048045, 8300.958495207486, 8411.831763364698, 4498.347739577743, 4603.930941035887, 4661.86014419568, 4677.4854765975715, 4792.640551958617, 3517.4899639552123, 3676.852925882935, 3682.2819550187455, 3682.760620559655, 3701.333759923186, 645.5287640022809, 657.6580178307254, 663.131297999622, 673.054358626131, 679.0866284846971, 597.745957967862, 635.414640472016, 664.5481072870494, 667.8363800868818, 702.118840854724, 8871.423357481743, 9558.56986435612, 9607.423554586747, 9701.320907536547, 9727.805443891082, 579.2730123694736, 607.5868409481595, 682.6586706646676, 699.3181647893264, 700.0933790741003, 3931.233409485123, 4141.840284720283, 4492.146492166478, 4654.906901861944, 4670.743109128963, 92947.60578591327, 150261.248693758, 159864.0, 163567.0, 165289.0, 140535.0, 140939.65771540307, 144474.0, 145321.0, 147325.2633736846, 110890.44554777336, 119690.40154799345, 120939.39530302292, 126752.99999999815, 127998.0, 7027.964860175666, 7784.260495252942, 8588.914110858812, 8935.642574296955, 9100.453972761656, 54613.1808022872, 66950.66524667345, 67699.0, 69096.30903690899, 69245.0, 96835.54746678665, 102688.43278918086, 102937.0, 104809.47595261974, 105305.94694053268, 11852.585159519376, 11890.524379025088, 11916.523339066687, 12015.699607509881, 12462.065345099336, 13227.40476678571, 13269.203847769164, 13454.663633409244, 13664.65838354049, 13941.651458713613, 12244.326562039174, 12381.380930953235, 12557.623271301876, 12564.748705026032, 12771.552995645108, 12218.327991960528, 12222.938885305517, 12455.190412623151, 12559.623211303675, 12607.810882836948, 12183.329916854658, 12189.573364932185, 12203.511859525875, 12226.449809758404, 12659.430325635552, 9455.479948602893, 10363.430011349146, 10428.259264581062, 10648.84026739584, 11048.226624136234, 10241.795164096528, 10637.015338783272, 10673.946630266799, 10691.732706682395, 10728.249022568658], "value": 7801.791922471495, "unit": "score"}], "name": "dromaeo_css", "value": 7296.656663995913, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 113.0, 112.0, 114.0, 113.0, 112.0, 114.0, 114.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 110.0, 166.0, 103.0, 107.0, 131.0, 107.0, 139.0, 106.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 189.0, 187.0, 183.0, 183.0, 184.0, 187.0, 181.0, 182.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 63.0, 93.0, 60.0, 57.0, 65.0, 63.0, 84.0, 58.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 101.0, 74.0, 78.0, 69.0, 97.0, 69.0, 67.0, 102.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 89.0, 86.0, 90.0, 86.0, 92.0, 130.0, 116.0, 86.0], "value": 95.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 98.0, 142.0, 110.0, 95.0, 95.0, 94.0, 94.0, 112.0], "value": 102.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 86.0, 87.0, 85.0, 89.0, 87.0, 91.0, 123.0, 86.0], "value": 90.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 53.0, 51.0, 53.0, 52.0, 53.0, 54.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 74.0, 75.0, 74.0, 69.0, 69.0, 72.0, 72.0, 72.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 81.0, 85.0, 82.0, 83.0, 85.0, 80.0, 82.0, 85.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 141.0, 137.0, 137.0, 137.0, 135.0, 141.0, 148.0, 140.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 165.0, 167.0, 165.0, 165.0, 166.0, 163.0, 158.0, 160.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 67.0, 67.0, 69.0, 82.0, 82.0, 83.0, 82.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1438.5, "alertThreshold": 2.0}]} 14:44:47 INFO - Return code: 0 14:44:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:44:47 INFO - # TBPL SUCCESS # 14:44:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:44:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:44:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:44:47 INFO - 2016-08-08 14:44:47.712 screenresolution[1807:9729] starting screenresolution argv=screenresolution get 14:44:47 INFO - 2016-08-08 14:44:47.715 screenresolution[1807:9729] Display 0: 1600x1200x32@60 14:44:47 INFO - 2016-08-08 14:44:47.721 screenresolution[1808:9732] starting screenresolution argv=screenresolution list 14:44:47 INFO - Available Modes on Display 0 14:44:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:44:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:44:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:44:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:44:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:44:47 INFO - Intel Iris: 14:44:47 INFO - Chipset Model: Intel Iris 14:44:47 INFO - Type: GPU 14:44:47 INFO - Bus: Built-In 14:44:47 INFO - VRAM (Dynamic, Max): 1536 MB 14:44:47 INFO - Vendor: Intel (0x8086) 14:44:47 INFO - Device ID: 0x0a2e 14:44:47 INFO - Revision ID: 0x0009 14:44:47 INFO - Displays: 14:44:47 INFO - Display: 14:44:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:44:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:44:47 INFO - Display Serial Number: 1600x1200 60 14:44:47 INFO - Main Display: Yes 14:44:47 INFO - Mirror: Off 14:44:47 INFO - Online: Yes 14:44:47 INFO - Rotation: Supported 14:44:47 INFO - Return code: 0 14:44:47 INFO - Running post-action listener: _resource_record_post_action 14:44:47 INFO - [mozharness: 2016-08-08 21:44:47.958010Z] Finished run-tests step (success) 14:44:47 INFO - Running post-run listener: _resource_record_post_run 14:44:48 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 36738048; Write bytes: 710713344; Read time: 234; Write time: 2097 14:44:48 INFO - TinderboxPrint: CPU usage
53.7% 14:44:48 INFO - TinderboxPrint: I/O read bytes / time
36,738,048 / 234 14:44:48 INFO - TinderboxPrint: I/O write bytes / time
710,713,344 / 2,097 14:44:48 INFO - TinderboxPrint: CPU idle
2,248.1 (46.3%) 14:44:48 INFO - TinderboxPrint: CPU system
977.6 (20.1%) 14:44:48 INFO - TinderboxPrint: CPU user
1,627.8 (33.5%) 14:44:48 INFO - TinderboxPrint: Swap in / out
443,662,336 / 0 14:44:48 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 413372928; Write bytes: 412018176; Read time: 31264; Write time: 931 14:44:48 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29166592; Write bytes: 294834688; Read time: 170; Write time: 1148 14:44:48 INFO - Running post-run listener: _upload_blobber_files 14:44:48 INFO - Blob upload gear active. 14:44:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:48 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 14:44:48 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:44:48 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:44:48 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:44:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:44:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:49 INFO - (blobuploader) - INFO - Done attempting. 14:44:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:44:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:44:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:50 INFO - (blobuploader) - INFO - Done attempting. 14:44:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:44:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:44:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:53 INFO - (blobuploader) - INFO - Done attempting. 14:44:53 INFO - (blobuploader) - INFO - Iteration through files over. 14:44:53 INFO - Return code: 0 14:44:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:44:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:44:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a0850c2421122f619fde55442cdfa8495f5e4dd7548299b2b776fae61f206c49ed97f090ae9c3f982b6c214ea31c4930bbf52d152409b8ac01154ee53f32dde9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8cb0b8fe64c7a9ccdfc7121e6f287fe21ab5019d015b3870345f215055d7435c9b5cf270585cf3f7437462b9d54434f24cc8df5be4563dc3e9fbc62b86eeecd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb9024dc171d6ad46d91ff29dcc55bd53494d9feab16acfe0cdcc2cee4790ef1b08b1365b09ba938f738317748b3a80183face1e67b049f93ce353dd9dbb8ac8"} 14:44:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:44:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:44:53 INFO - Contents: 14:44:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a0850c2421122f619fde55442cdfa8495f5e4dd7548299b2b776fae61f206c49ed97f090ae9c3f982b6c214ea31c4930bbf52d152409b8ac01154ee53f32dde9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8cb0b8fe64c7a9ccdfc7121e6f287fe21ab5019d015b3870345f215055d7435c9b5cf270585cf3f7437462b9d54434f24cc8df5be4563dc3e9fbc62b86eeecd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb9024dc171d6ad46d91ff29dcc55bd53494d9feab16acfe0cdcc2cee4790ef1b08b1365b09ba938f738317748b3a80183face1e67b049f93ce353dd9dbb8ac8"} 14:44:53 INFO - Running post-run listener: copy_logs_to_upload_dir 14:44:53 INFO - Copying logs to upload dir... 14:44:53 INFO - mkdir: /builds/slave/test/build/upload/logs 14:44:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.782189 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-08 14:44:53.346976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 14:44:53.351175) ========= 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.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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/Autoland/sha512/a0850c2421122f619fde55442cdfa8495f5e4dd7548299b2b776fae61f206c49ed97f090ae9c3f982b6c214ea31c4930bbf52d152409b8ac01154ee53f32dde9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8cb0b8fe64c7a9ccdfc7121e6f287fe21ab5019d015b3870345f215055d7435c9b5cf270585cf3f7437462b9d54434f24cc8df5be4563dc3e9fbc62b86eeecd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb9024dc171d6ad46d91ff29dcc55bd53494d9feab16acfe0cdcc2cee4790ef1b08b1365b09ba938f738317748b3a80183face1e67b049f93ce353dd9dbb8ac8"} build_url:https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011011 build_url: 'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a0850c2421122f619fde55442cdfa8495f5e4dd7548299b2b776fae61f206c49ed97f090ae9c3f982b6c214ea31c4930bbf52d152409b8ac01154ee53f32dde9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8cb0b8fe64c7a9ccdfc7121e6f287fe21ab5019d015b3870345f215055d7435c9b5cf270585cf3f7437462b9d54434f24cc8df5be4563dc3e9fbc62b86eeecd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb9024dc171d6ad46d91ff29dcc55bd53494d9feab16acfe0cdcc2cee4790ef1b08b1365b09ba938f738317748b3a80183face1e67b049f93ce353dd9dbb8ac8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 14:44:53.389481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:44:53.390062) ========= 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.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.005233 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:44:53.439369) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 14:44:53.439699) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 14:44:53.440015) ========= ========= Total master_lag: 0.21 =========