builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0370 starttime: 1469110693.81 results: success (0) buildid: 20160721051621 builduid: bf131c21c7b14185b0b77d876625dce3 revision: 512d3ff7151c16f30ea8f93414d048c708815110 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:13.810228) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:13.810752) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:13.811060) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:13.886053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:13.886491) ========= 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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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-07-21 07:18:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-07-21 07:18:14 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128998 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:14.039714) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:14.040250) ========= 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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.021307 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:14.090508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-21 07:18:14.090852) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 512d3ff7151c16f30ea8f93414d048c708815110 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 512d3ff7151c16f30ea8f93414d048c708815110 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k4RDGw3iPX/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.aEYTDlQMZW/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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-07-21 07:18:14,173 truncating revision to first 12 chars 2016-07-21 07:18:14,174 Setting DEBUG logging. 2016-07-21 07:18:14,174 attempt 1/10 2016-07-21 07:18:14,174 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/512d3ff7151c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 07:18:16,111 unpacking tar archive at: mozilla-beta-512d3ff7151c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.195251 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-21 07:18:16.310183) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:16.310616) ========= script_repo_revision: 512d3ff7151c16f30ea8f93414d048c708815110 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:16.311120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:16.311529) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:16.331394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-21 07:18:16.331838) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k4RDGw3iPX/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.aEYTDlQMZW/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:18:16 INFO - MultiFileLogger online at 20160721 07:18:16 in /builds/slave/test 07:18:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:18:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:18:16 INFO - {'append_to_log': False, 07:18:16 INFO - 'base_work_dir': '/builds/slave/test', 07:18:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:18:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:18:16 INFO - 'branch': 'Mozilla-Beta', 07:18:16 INFO - 'buildbot_json_path': 'buildprops.json', 07:18:16 INFO - 'config_files': ('talos/mac_config.py',), 07:18:16 INFO - 'default_actions': ('clobber', 07:18:16 INFO - 'read-buildbot-config', 07:18:16 INFO - 'download-and-extract', 07:18:16 INFO - 'populate-webroot', 07:18:16 INFO - 'create-virtualenv', 07:18:16 INFO - 'install', 07:18:16 INFO - 'run-tests'), 07:18:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:18:16 INFO - 'download_minidump_stackwalk': True, 07:18:16 INFO - 'download_symbols': 'ondemand', 07:18:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:18:16 INFO - 'tooltool.py': '/tools/tooltool.py', 07:18:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:18:16 INFO - '/tools/misc-python/virtualenv.py')}, 07:18:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:18:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:18:16 INFO - 'installer_path': 'installer.exe', 07:18:16 INFO - 'log_level': 'info', 07:18:16 INFO - 'log_name': 'talos', 07:18:16 INFO - 'log_to_console': True, 07:18:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:18:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:18:16 INFO - 'opt_config_files': (), 07:18:16 INFO - 'pip_index': False, 07:18:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:18:16 INFO - 'cmd': ('bash', 07:18:16 INFO - '-c', 07:18:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:18:16 INFO - 'enabled': True, 07:18:16 INFO - 'halt_on_failure': False, 07:18:16 INFO - 'name': 'check_screen_resolution'},), 07:18:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:18:16 INFO - 'cmd': ('bash', 07:18:16 INFO - '-c', 07:18:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:18:16 INFO - 'enabled': True, 07:18:16 INFO - 'halt_on_failure': False, 07:18:16 INFO - 'name': 'check_screen_resolution'},), 07:18:16 INFO - 'run_cmd_checks_enabled': True, 07:18:16 INFO - 'sps_profile': False, 07:18:16 INFO - 'sps_profile_interval': 0, 07:18:16 INFO - 'suite': 'dromaeojs', 07:18:16 INFO - 'system_bits': '32', 07:18:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:18:16 INFO - 'title': 't-yosemite-r7-0370', 07:18:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:18:16 INFO - 'use_talos_json': True, 07:18:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:18:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:18:16 INFO - 'work_dir': 'build'} 07:18:16 INFO - ##### 07:18:16 INFO - ##### Running clobber step. 07:18:16 INFO - ##### 07:18:16 INFO - Running pre-action listener: _resource_record_pre_action 07:18:16 INFO - Running main action method: clobber 07:18:16 INFO - rmtree: /builds/slave/test/build 07:18:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:18:17 INFO - Running post-action listener: _resource_record_post_action 07:18:17 INFO - ##### 07:18:17 INFO - ##### Running read-buildbot-config step. 07:18:17 INFO - ##### 07:18:17 INFO - Running pre-action listener: _resource_record_pre_action 07:18:17 INFO - Running main action method: read_buildbot_config 07:18:17 INFO - Using buildbot properties: 07:18:17 INFO - { 07:18:17 INFO - "project": "", 07:18:17 INFO - "product": "firefox", 07:18:17 INFO - "script_repo_revision": "production", 07:18:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:18:17 INFO - "repository": "", 07:18:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:18:17 INFO - "buildid": "20160721051621", 07:18:17 INFO - "pgo_build": "False", 07:18:17 INFO - "basedir": "/builds/slave/test", 07:18:17 INFO - "buildnumber": 6, 07:18:17 INFO - "slavename": "t-yosemite-r7-0370", 07:18:17 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:18:17 INFO - "platform": "yosemite_r7", 07:18:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:18:17 INFO - "branch": "mozilla-beta", 07:18:17 INFO - "repo_path": "releases/mozilla-beta", 07:18:17 INFO - "revision": "512d3ff7151c16f30ea8f93414d048c708815110", 07:18:17 INFO - "stage_platform": "macosx64", 07:18:17 INFO - "builduid": "bf131c21c7b14185b0b77d876625dce3", 07:18:17 INFO - "slavebuilddir": "test" 07:18:17 INFO - } 07:18:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 07:18:17 INFO - Running post-action listener: _resource_record_post_action 07:18:17 INFO - ##### 07:18:17 INFO - ##### Running download-and-extract step. 07:18:17 INFO - ##### 07:18:17 INFO - Running pre-action listener: _resource_record_pre_action 07:18:17 INFO - Running main action method: download_and_extract 07:18:17 INFO - mkdir: /builds/slave/test/build/tests 07:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:17 INFO - https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:18:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:18:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:18:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 07:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 07:18:18 INFO - Downloaded 1165 bytes. 07:18:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 07:18:18 INFO - Using the following test package requirements: 07:18:18 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:18:18 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:18 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 07:18:18 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:18 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 07:18:18 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:18:18 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:18 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 07:18:18 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:18:18 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:18 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 07:18:18 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:18 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 07:18:18 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:18 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 07:18:18 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:18 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 07:18:18 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 07:18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:18 INFO - https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:18:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 07:18:20 INFO - Downloaded 18314783 bytes. 07:18:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:18:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:18:23 INFO - Return code: 0 07:18:23 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:23 INFO - https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:18:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 07:18:25 INFO - Downloaded 18314783 bytes. 07:18:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:18:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:18:28 INFO - Return code: 0 07:18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:28 INFO - https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:18:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:18:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:18:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 07:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 07:18:29 INFO - Downloaded 10840145 bytes. 07:18:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:18:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:18:29 INFO - Return code: 0 07:18:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:29 INFO - https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 07:18:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:18:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:18:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 07:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 07:18:32 INFO - Downloaded 86192072 bytes. 07:18:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:18:32 INFO - mkdir: /builds/slave/test/properties 07:18:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:18:32 INFO - Writing to file /builds/slave/test/properties/build_url 07:18:32 INFO - Contents: 07:18:32 INFO - build_url:https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:18:34 INFO - Running post-action listener: _resource_record_post_action 07:18:34 INFO - Running post-action listener: set_extra_try_arguments 07:18:34 INFO - ##### 07:18:34 INFO - ##### Running populate-webroot step. 07:18:34 INFO - ##### 07:18:34 INFO - Running pre-action listener: _resource_record_pre_action 07:18:34 INFO - Running main action method: populate_webroot 07:18:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:18:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:18:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:18:34 INFO - '--tppagecycles', 07:18:34 INFO - '7'], 07:18:34 INFO - 'tests': ['tsvgm']}}, 07:18:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:18:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:18:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:18:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:18:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['damp', 'tps']}, 07:18:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'tests': ['damp', 'tps']}, 07:18:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['dromaeo_dom']}, 07:18:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:18:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'other-e10s': {'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['tsvgx', 07:18:34 INFO - 'tsvgr_opacity', 07:18:34 INFO - 'tart', 07:18:34 INFO - 'tscrollx', 07:18:34 INFO - 'cart']}, 07:18:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:18:34 INFO - 'tsvgr_opacity', 07:18:34 INFO - 'tart', 07:18:34 INFO - 'tscrollx', 07:18:34 INFO - 'cart']}, 07:18:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['tp5o']}, 07:18:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'tests': ['tp5o']}, 07:18:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'talos_options': ['--disable-e10s', 07:18:34 INFO - '--xperf_path', 07:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:34 INFO - 'tests': ['tp5n']}, 07:18:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'talos_options': ['--xperf_path', 07:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:34 INFO - 'tests': ['tp5n']}}, 07:18:34 INFO - 'talos.zip': {'path': '', 07:18:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:18:34 INFO - Running post-action listener: _resource_record_post_action 07:18:34 INFO - ##### 07:18:34 INFO - ##### Running create-virtualenv step. 07:18:34 INFO - ##### 07:18:34 INFO - Running pre-action listener: _resource_record_pre_action 07:18:34 INFO - Running main action method: create_virtualenv 07:18:34 INFO - Creating virtualenv /builds/slave/test/build/venv 07:18:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:18:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:18:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:18:34 INFO - Using real prefix '/tools/python27' 07:18:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:18:35 INFO - Installing distribute.............................................................................................................................................................................................done. 07:18:37 INFO - Installing pip.................done. 07:18:37 INFO - Return code: 0 07:18:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:37 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 0x110584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6425aa1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110423e00>, '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 0x11028cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11041eb20>, '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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:18:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k4RDGw3iPX/Render', 07:18:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:37 INFO - 'HOME': '/Users/cltbld', 07:18:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:37 INFO - 'LOGNAME': 'cltbld', 07:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:37 INFO - 'MOZ_NO_REMOTE': '1', 07:18:37 INFO - 'NO_EM_RESTART': '1', 07:18:37 INFO - 'PAGER': '/bin/cat', 07:18:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:37 INFO - 'PWD': '/builds/slave/test', 07:18:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:37 INFO - 'SHELL': '/bin/bash', 07:18:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aEYTDlQMZW/Listeners', 07:18:37 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 07:18:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:37 INFO - 'USER': 'cltbld', 07:18:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:37 INFO - 'XPC_FLAGS': '0x0', 07:18:37 INFO - 'XPC_SERVICE_NAME': '0', 07:18:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:18:38 INFO - Cleaning up... 07:18:38 INFO - Return code: 0 07:18:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6425aa1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110423e00>, '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 0x11028cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11041eb20>, '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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:18:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k4RDGw3iPX/Render', 07:18:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:38 INFO - 'HOME': '/Users/cltbld', 07:18:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:38 INFO - 'LOGNAME': 'cltbld', 07:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:38 INFO - 'MOZ_NO_REMOTE': '1', 07:18:38 INFO - 'NO_EM_RESTART': '1', 07:18:38 INFO - 'PAGER': '/bin/cat', 07:18:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:38 INFO - 'PWD': '/builds/slave/test', 07:18:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:38 INFO - 'SHELL': '/bin/bash', 07:18:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aEYTDlQMZW/Listeners', 07:18:38 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 07:18:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:38 INFO - 'USER': 'cltbld', 07:18:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:38 INFO - 'XPC_FLAGS': '0x0', 07:18:38 INFO - 'XPC_SERVICE_NAME': '0', 07:18:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:38 INFO - Downloading/unpacking psutil>=0.7.1 07:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:18:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:41 INFO - Installing collected packages: psutil 07:18:41 INFO - Running setup.py install for psutil 07:18:41 INFO - building 'psutil._psutil_osx' extension 07:18:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:18:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:18:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:18:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:18:41 INFO - building 'psutil._psutil_posix' extension 07:18:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:18:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:18:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:18:41 INFO - ^ 07:18:41 INFO - 1 warning generated. 07:18:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:18:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:42 INFO - Successfully installed psutil 07:18:42 INFO - Cleaning up... 07:18:42 INFO - Return code: 0 07:18:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:42 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6425aa1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110423e00>, '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 0x11028cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11041eb20>, '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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:18:42 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.0.0'] in /builds/slave/test/build 07:18:42 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.0.0 07:18:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k4RDGw3iPX/Render', 07:18:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:42 INFO - 'HOME': '/Users/cltbld', 07:18:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:42 INFO - 'LOGNAME': 'cltbld', 07:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:42 INFO - 'MOZ_NO_REMOTE': '1', 07:18:42 INFO - 'NO_EM_RESTART': '1', 07:18:42 INFO - 'PAGER': '/bin/cat', 07:18:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:42 INFO - 'PWD': '/builds/slave/test', 07:18:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:42 INFO - 'SHELL': '/bin/bash', 07:18:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aEYTDlQMZW/Listeners', 07:18:42 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 07:18:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:42 INFO - 'USER': 'cltbld', 07:18:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:42 INFO - 'XPC_FLAGS': '0x0', 07:18:42 INFO - 'XPC_SERVICE_NAME': '0', 07:18:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:18:45 INFO - Installing collected packages: mozsystemmonitor 07:18:45 INFO - Running setup.py install for mozsystemmonitor 07:18:45 INFO - Successfully installed mozsystemmonitor 07:18:45 INFO - Cleaning up... 07:18:45 INFO - Return code: 0 07:18:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:18:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:45 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 0x110584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6425aa1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110423e00>, '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 0x11028cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11041eb20>, '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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:18:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k4RDGw3iPX/Render', 07:18:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:45 INFO - 'HOME': '/Users/cltbld', 07:18:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:45 INFO - 'LOGNAME': 'cltbld', 07:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:45 INFO - 'MOZ_NO_REMOTE': '1', 07:18:45 INFO - 'NO_EM_RESTART': '1', 07:18:45 INFO - 'PAGER': '/bin/cat', 07:18:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:45 INFO - 'PWD': '/builds/slave/test', 07:18:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:45 INFO - 'SHELL': '/bin/bash', 07:18:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aEYTDlQMZW/Listeners', 07:18:45 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 07:18:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:45 INFO - 'USER': 'cltbld', 07:18:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:45 INFO - 'XPC_FLAGS': '0x0', 07:18:45 INFO - 'XPC_SERVICE_NAME': '0', 07:18:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:45 INFO - Downloading/unpacking blobuploader==1.2.4 07:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:47 INFO - Downloading blobuploader-1.2.4.tar.gz 07:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:18:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:18:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:49 INFO - Downloading docopt-0.6.1.tar.gz 07:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:18:49 INFO - Installing collected packages: blobuploader, requests, docopt 07:18:49 INFO - Running setup.py install for blobuploader 07:18:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:18:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:18:49 INFO - Running setup.py install for requests 07:18:49 INFO - Running setup.py install for docopt 07:18:49 INFO - Successfully installed blobuploader requests docopt 07:18:49 INFO - Cleaning up... 07:18:50 INFO - Return code: 0 07:18:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 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 0x110584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6425aa1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110423e00>, '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 0x11028cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11041eb20>, '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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k4RDGw3iPX/Render', 07:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:50 INFO - 'HOME': '/Users/cltbld', 07:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:50 INFO - 'LOGNAME': 'cltbld', 07:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:50 INFO - 'MOZ_NO_REMOTE': '1', 07:18:50 INFO - 'NO_EM_RESTART': '1', 07:18:50 INFO - 'PAGER': '/bin/cat', 07:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:50 INFO - 'PWD': '/builds/slave/test', 07:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:50 INFO - 'SHELL': '/bin/bash', 07:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aEYTDlQMZW/Listeners', 07:18:50 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 07:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:50 INFO - 'USER': 'cltbld', 07:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:50 INFO - 'XPC_FLAGS': '0x0', 07:18:50 INFO - 'XPC_SERVICE_NAME': '0', 07:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:18:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-9GRxWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:18:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-q3XIAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:18:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-7Djk0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:18:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-7FKg8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:18:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-IhSCOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:18:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-CCnP3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:18:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Xae62q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:18:51 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-F18C8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:18:51 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-nbjQDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:18:51 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-wLrHmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:18:51 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-NgUL4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:18:51 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-00WWiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:18:51 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-jNyqEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:18:51 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-kKsrKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:51 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-q2nv4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:51 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-wKmluP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:52 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-3Ska5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:18:52 INFO - Running setup.py install for manifestparser 07:18:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:18:52 INFO - Running setup.py install for mozcrash 07:18:52 INFO - Running setup.py install for mozdebug 07:18:52 INFO - Running setup.py install for mozdevice 07:18:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:18:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:18:52 INFO - Running setup.py install for mozfile 07:18:52 INFO - Running setup.py install for mozhttpd 07:18:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:18:53 INFO - Running setup.py install for mozinfo 07:18:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:18:53 INFO - Running setup.py install for mozInstall 07:18:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:18:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:18:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:18:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:18:53 INFO - Running setup.py install for mozleak 07:18:53 INFO - Running setup.py install for mozlog 07:18:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:18:53 INFO - Running setup.py install for moznetwork 07:18:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:18:53 INFO - Running setup.py install for mozprocess 07:18:53 INFO - Running setup.py install for mozprofile 07:18:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:18:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:18:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:18:54 INFO - Running setup.py install for mozrunner 07:18:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:18:54 INFO - Running setup.py install for mozscreenshot 07:18:54 INFO - Running setup.py install for moztest 07:18:54 INFO - Running setup.py install for mozversion 07:18:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:18:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:18:54 INFO - Cleaning up... 07:18:54 INFO - Return code: 0 07:18:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:54 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 0x110584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6425aa1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110423e00>, '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 0x11028cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11041eb20>, '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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k4RDGw3iPX/Render', 07:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:54 INFO - 'HOME': '/Users/cltbld', 07:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:54 INFO - 'LOGNAME': 'cltbld', 07:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:54 INFO - 'MOZ_NO_REMOTE': '1', 07:18:54 INFO - 'NO_EM_RESTART': '1', 07:18:54 INFO - 'PAGER': '/bin/cat', 07:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:54 INFO - 'PWD': '/builds/slave/test', 07:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:54 INFO - 'SHELL': '/bin/bash', 07:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aEYTDlQMZW/Listeners', 07:18:54 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 07:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:54 INFO - 'USER': 'cltbld', 07:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:54 INFO - 'XPC_FLAGS': '0x0', 07:18:54 INFO - 'XPC_SERVICE_NAME': '0', 07:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:18:54 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Tvduy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:18:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-sECVqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:18:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-JfZwM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:18:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-60W1XB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:18:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ylKvz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:18:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Mmd919-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:18:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-JxJGNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:18:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-jQ99yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:18:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-uIUD5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:18:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-3wIRYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:18:56 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Dwaaf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:18:56 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-vW4lKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:18:56 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-EktawS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:18:56 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-mPM6q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:56 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-gFjRnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:56 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-X07D2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:56 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-nLTAdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:59 INFO - Downloading blessings-1.6.tar.gz 07:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:18:59 INFO - Installing collected packages: blessings 07:18:59 INFO - Running setup.py install for blessings 07:18:59 INFO - Successfully installed blessings 07:18:59 INFO - Cleaning up... 07:18:59 INFO - Return code: 0 07:18:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:18:59 INFO - Reading from file tmpfile_stdout 07:18:59 INFO - Current package versions: 07:18:59 INFO - blessings == 1.6 07:18:59 INFO - blobuploader == 1.2.4 07:18:59 INFO - docopt == 0.6.1 07:18:59 INFO - manifestparser == 1.1 07:18:59 INFO - mozInstall == 1.12 07:18:59 INFO - mozcrash == 0.17 07:18:59 INFO - mozdebug == 0.1 07:18:59 INFO - mozdevice == 0.48 07:18:59 INFO - mozfile == 1.2 07:18:59 INFO - mozhttpd == 0.7 07:18:59 INFO - mozinfo == 0.9 07:18:59 INFO - mozleak == 0.1 07:18:59 INFO - mozlog == 3.1 07:18:59 INFO - moznetwork == 0.27 07:18:59 INFO - mozprocess == 0.22 07:18:59 INFO - mozprofile == 0.28 07:18:59 INFO - mozrunner == 6.11 07:18:59 INFO - mozscreenshot == 0.1 07:18:59 INFO - mozsystemmonitor == 0.0 07:18:59 INFO - moztest == 0.7 07:18:59 INFO - mozversion == 1.4 07:18:59 INFO - psutil == 3.1.1 07:18:59 INFO - requests == 1.2.3 07:18:59 INFO - wsgiref == 0.1.2 07:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:59 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 0x110584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6425aa1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110423e00>, '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 0x11028cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11041eb20>, '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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k4RDGw3iPX/Render', 07:18:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:59 INFO - 'HOME': '/Users/cltbld', 07:18:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:59 INFO - 'LOGNAME': 'cltbld', 07:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:59 INFO - 'MOZ_NO_REMOTE': '1', 07:18:59 INFO - 'NO_EM_RESTART': '1', 07:18:59 INFO - 'PAGER': '/bin/cat', 07:18:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:59 INFO - 'PWD': '/builds/slave/test', 07:18:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:59 INFO - 'SHELL': '/bin/bash', 07:18:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aEYTDlQMZW/Listeners', 07:18:59 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 07:18:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:59 INFO - 'USER': 'cltbld', 07:18:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:59 INFO - 'XPC_FLAGS': '0x0', 07:18:59 INFO - 'XPC_SERVICE_NAME': '0', 07:18:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:19:00 INFO - Cleaning up... 07:19:00 INFO - Return code: 0 07:19:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:19:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:00 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 0x110584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6425aa1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110423e00>, '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 0x11028cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11041eb20>, '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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k4RDGw3iPX/Render', 07:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:19:00 INFO - 'HOME': '/Users/cltbld', 07:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:19:00 INFO - 'LOGNAME': 'cltbld', 07:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:00 INFO - 'MOZ_NO_REMOTE': '1', 07:19:00 INFO - 'NO_EM_RESTART': '1', 07:19:00 INFO - 'PAGER': '/bin/cat', 07:19:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:00 INFO - 'PWD': '/builds/slave/test', 07:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:19:00 INFO - 'SHELL': '/bin/bash', 07:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aEYTDlQMZW/Listeners', 07:19:00 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 07:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:19:00 INFO - 'USER': 'cltbld', 07:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:00 INFO - 'XPC_FLAGS': '0x0', 07:19:00 INFO - 'XPC_SERVICE_NAME': '0', 07:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:00 INFO - Downloading/unpacking jsonschema 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:19:02 INFO - Downloading/unpacking functools32 (from jsonschema) 07:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:03 INFO - Downloading functools32-3.2.3-2.tar.gz 07:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:19:03 INFO - warning: no files found matching '*.txt' 07:19:03 INFO - no previously-included directories found matching 'build' 07:19:03 INFO - no previously-included directories found matching 'dist' 07:19:03 INFO - no previously-included directories found matching '.git*' 07:19:03 INFO - Installing collected packages: jsonschema, functools32 07:19:03 INFO - Running setup.py install for functools32 07:19:03 INFO - warning: no files found matching '*.txt' 07:19:03 INFO - no previously-included directories found matching 'build' 07:19:03 INFO - no previously-included directories found matching 'dist' 07:19:03 INFO - no previously-included directories found matching '.git*' 07:19:03 INFO - Successfully installed jsonschema functools32 07:19:03 INFO - Cleaning up... 07:19:03 INFO - Return code: 0 07:19:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:19:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:03 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6425aa1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110423e00>, '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 0x11028cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11041eb20>, '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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:19:03 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', 'flake8'] in /builds/slave/test/build 07:19:03 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 flake8 07:19:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k4RDGw3iPX/Render', 07:19:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:19:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:19:03 INFO - 'HOME': '/Users/cltbld', 07:19:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:19:03 INFO - 'LOGNAME': 'cltbld', 07:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:03 INFO - 'MOZ_NO_REMOTE': '1', 07:19:03 INFO - 'NO_EM_RESTART': '1', 07:19:03 INFO - 'PAGER': '/bin/cat', 07:19:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:03 INFO - 'PWD': '/builds/slave/test', 07:19:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:19:03 INFO - 'SHELL': '/bin/bash', 07:19:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aEYTDlQMZW/Listeners', 07:19:03 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 07:19:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:19:03 INFO - 'USER': 'cltbld', 07:19:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:19:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:03 INFO - 'XPC_FLAGS': '0x0', 07:19:03 INFO - 'XPC_SERVICE_NAME': '0', 07:19:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:03 INFO - Downloading/unpacking flake8 07:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:19:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:19:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:19:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:19:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:19:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:19:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:19:07 INFO - no previously-included directories found matching 'docs/_build' 07:19:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:19:07 INFO - Running setup.py install for pep8 07:19:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:19:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:19:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:19:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:19:07 INFO - no previously-included directories found matching 'docs/_build' 07:19:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:19:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:19:07 INFO - Cleaning up... 07:19:08 INFO - Return code: 0 07:19:08 INFO - Running post-action listener: _resource_record_post_action 07:19:08 INFO - Running post-action listener: _start_resource_monitoring 07:19:08 INFO - Starting resource monitoring. 07:19:08 INFO - ##### 07:19:08 INFO - ##### Running install step. 07:19:08 INFO - ##### 07:19:08 INFO - Running pre-action listener: _resource_record_pre_action 07:19:08 INFO - Running main action method: install 07:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:08 INFO - Reading from file tmpfile_stdout 07:19:08 INFO - Detecting whether we're running mozinstall >=1.0... 07:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:19:08 INFO - Reading from file tmpfile_stdout 07:19:08 INFO - Output received: 07:19:08 INFO - Usage: mozinstall [options] installer 07:19:08 INFO - Options: 07:19:08 INFO - -h, --help show this help message and exit 07:19:08 INFO - -d DEST, --destination=DEST 07:19:08 INFO - Directory to install application into. [default: 07:19:08 INFO - "/builds/slave/test"] 07:19:08 INFO - --app=APP Application being installed. [default: firefox] 07:19:08 INFO - mkdir: /builds/slave/test/build/application 07:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:19:30 INFO - Reading from file tmpfile_stdout 07:19:30 INFO - Output received: 07:19:30 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:19:30 INFO - Running post-action listener: _resource_record_post_action 07:19:30 INFO - ##### 07:19:30 INFO - ##### Running run-tests step. 07:19:30 INFO - ##### 07:19:30 INFO - Running pre-action listener: _resource_record_pre_action 07:19:30 INFO - Running main action method: run_tests 07:19:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:19:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:19:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:19:30 INFO - 2016-07-21 07:19:30.931 screenresolution[2515:28940] starting screenresolution argv=screenresolution get 07:19:30 INFO - 2016-07-21 07:19:30.934 screenresolution[2515:28940] Display 0: 1600x1200x32@60 07:19:30 INFO - 2016-07-21 07:19:30.940 screenresolution[2516:28943] starting screenresolution argv=screenresolution list 07:19:30 INFO - Available Modes on Display 0 07:19:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:19:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:19:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:19:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:19:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:19:31 INFO - Intel Iris: 07:19:31 INFO - Chipset Model: Intel Iris 07:19:31 INFO - Type: GPU 07:19:31 INFO - Bus: Built-In 07:19:31 INFO - VRAM (Dynamic, Max): 1536 MB 07:19:31 INFO - Vendor: Intel (0x8086) 07:19:31 INFO - Device ID: 0x0a2e 07:19:31 INFO - Revision ID: 0x0009 07:19:31 INFO - Displays: 07:19:31 INFO - Display: 07:19:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:19:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:19:31 INFO - Display Serial Number: 1600x1200 60 07:19:31 INFO - Main Display: Yes 07:19:31 INFO - Mirror: Off 07:19:31 INFO - Online: Yes 07:19:31 INFO - Rotation: Supported 07:19:31 INFO - Return code: 0 07:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:19:31 INFO - Python 2.7.3 07:19:31 INFO - Return code: 0 07:19:31 INFO - grabbing minidump binary from tooltool 07:19:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:31 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110423e00>, '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 0x11028cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11041eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:19:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:19:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:19:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:19:31 INFO - Return code: 0 07:19:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:19:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:19:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:19:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:19:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:19:32 INFO - Return code: 0 07:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0370 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k4RDGw3iPX/Render', 07:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:19:32 INFO - 'HOME': '/Users/cltbld', 07:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:19:32 INFO - 'LOGNAME': 'cltbld', 07:19:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:19:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:32 INFO - 'MOZ_NO_REMOTE': '1', 07:19:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:19:32 INFO - 'NO_EM_RESTART': '1', 07:19:32 INFO - 'PAGER': '/bin/cat', 07:19:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:32 INFO - 'PWD': '/builds/slave/test', 07:19:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:19:32 INFO - 'SHELL': '/bin/bash', 07:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aEYTDlQMZW/Listeners', 07:19:32 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 07:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:19:32 INFO - 'USER': 'cltbld', 07:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:32 INFO - 'XPC_FLAGS': '0x0', 07:19:32 INFO - 'XPC_SERVICE_NAME': '0', 07:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:19:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:19:32 INFO - mozversion application_buildid: 20160721051621 07:19:32 INFO - mozversion application_changeset: 512d3ff7151c16f30ea8f93414d048c708815110 07:19:32 INFO - mozversion application_display_name: Firefox 07:19:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:19:32 INFO - mozversion application_name: Firefox 07:19:32 INFO - mozversion application_remotingname: firefox 07:19:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:19:32 INFO - mozversion application_vendor: Mozilla 07:19:32 INFO - mozversion application_version: 48.0 07:19:32 INFO - mozversion platform_buildid: 20160721051621 07:19:32 INFO - mozversion platform_changeset: 512d3ff7151c16f30ea8f93414d048c708815110 07:19:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:19:32 INFO - mozversion platform_version: 48.0 07:19:32 INFO - using testdate: 1469110772 07:19:32 INFO - actual date: 1469110772 07:19:32 INFO - starting webserver on 'localhost:55460' 07:19:32 INFO - SUITE-START | Running 2 tests 07:19:32 INFO - TEST-START | dromaeo_css 07:19:32 INFO - operating with platform_type : mac_ 07:19:32 INFO - Initialising browser for dromaeo_css test... 07:19:32 INFO - TEST-INFO | started process 2534 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpB57s8I/profile http://localhost:55460/getInfo.html) 07:19:34 INFO - PROCESS | 2534 | __metrics Screen width/height:1600/1200 07:19:34 INFO - PROCESS | 2534 | colorDepth:24 07:19:34 INFO - PROCESS | 2534 | Browser inner width/height: 1024/689 07:19:34 INFO - PROCESS | 2534 | __metrics 07:19:34 INFO - PROCESS | 2534 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:19:34 ERROR - PROCESS | 2534 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:19:35 INFO - TEST-INFO | 2534: exit 0 07:19:35 INFO - Browser initialized. 07:19:35 INFO - Running cycle 1/1 for dromaeo_css test... 07:19:35 INFO - TEST-INFO | started process 2537 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpB57s8I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:47 INFO - PROCESS | 2537 | RSS: Main: 160337920 07:19:47 INFO - PROCESS | 2537 | 07:20:38 INFO - PROCESS | 2537 | 1469110838230 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:22:48 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:55460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55460/tests/dromaeo/cssquery-ext.html) 07:22:49 INFO - PROCESS | 2537 | RSS: Main: 297168896 07:22:49 INFO - PROCESS | 2537 | 07:25:52 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:55460/tests/dromaeo/cssquery-ext.html (next: http://localhost:55460/tests/dromaeo/cssquery-jquery.html) 07:25:53 INFO - PROCESS | 2537 | RSS: Main: 304492544 07:25:53 INFO - PROCESS | 2537 | 07:28:55 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:55460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55460/tests/dromaeo/cssquery-mootools.html) 07:28:55 INFO - PROCESS | 2537 | RSS: Main: 308756480 07:28:55 INFO - PROCESS | 2537 | 07:31:57 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:55460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55460/tests/dromaeo/cssquery-prototype.html) 07:31:58 INFO - PROCESS | 2537 | RSS: Main: 306040832 07:31:58 INFO - PROCESS | 2537 | 07:35:01 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:55460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55460/tests/dromaeo/cssquery-yui.html) 07:35:02 INFO - PROCESS | 2537 | RSS: Main: 275353600 07:35:02 INFO - PROCESS | 2537 | 07:38:04 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:55460/tests/dromaeo/cssquery-yui.html (next: http://localhost:55460/tests/dromaeo/cssquery-dojo.html) 07:38:05 INFO - PROCESS | 2537 | RSS: Main: 314564608 07:38:05 INFO - PROCESS | 2537 | 07:38:05 INFO - PROCESS | 2537 | __start_tp_report 07:38:05 INFO - PROCESS | 2537 | _x_x_mozilla_page_load 07:38:05 INFO - PROCESS | 2537 | _x_x_mozilla_page_load_details 07:38:05 INFO - PROCESS | 2537 | |i|pagename|runs| 07:38:05 INFO - PROCESS | 2537 | |0;dojo.html;2672.26512709005;3509.631488693686;3550.1834578047033;3563.8752643657476;3620.515588608671;5814.418558144189;5824.563157763168;5836.824895253144;5862.73617687204;5876.4417380348905;5874.823755287348;5911.615744976573;5928.762849486026;5932.673702946337;5947.999999999989;5294.126469132598;5331.6534425262425;5334.973325133388;5379.919301210485;5434.755436005369;5407.918881216765;5431.538319242869;5445.782168713266;5448.564114870821;5449.56403487722;5313.282706834586;5375.731213439332;5409.891802163955;5419.945800541984;5432.158015507603;5411.458854114577;5431.864203394907;5457.317835270591;5468.671879687232;5512.944870551283;4891.926621100686;5254.500822421864;5331.760070796785;5354.759035843396;5366.865828354284;5685.545156387479;5728.598998070137;5759.5968282220265;5788.218590490272;5820;6265.154204182422;6278.152449419361;6288.591241569329;6289.559730818844;6305.180326557518;6149.600275982047;6171.783987560414;6275.278342990523;6279.686015699197;6288.748450061992;6016.839990252096;6020.247469066367;6069.969650151721;6082.847928801771;6085.2393450818645;6405.48756099511;6421.325760795143;6422.967885160544;6429.1320671709655;6442.452391546677;5122.436531981479;6190.164327815777;6262.2172228471445;6310.842228944313;6336.746530138835;6289.465395441439;6313.558050936482;6315.179026726496;6320.367963203643;6334.461570766536;6194.442500175006;6259.186305780219;6263.937360626335;6282.277538083087;6289.905651415233;6190.969045154746;6223.813285601439;6260.342664020303;6314.179156709598;6321.525885558602;5046.596272298208;5077.416097148875;5077.984403119391;5085.313482679865;5089.643724939218;4562.498125206224;4564.634829213722;4570.040291538814;4571.977140114278;4606.746628935441;5817.069268917037;5901.7639294427745;5929.199558059693;5929.318128415288;5937.732802023919;6183.938160618426;6253.093301471261;6273.435390814849;6281.937180628135;6290.308066112724;5890.204822349014;5891.322497912709;5912.083627037816;5926.111083337448;5944.108383742473;4677.789499472532;5449.591280653967;5522.420145884705;5526.889462210734;5536.474034966672;6415.390537898892;6493.8701225976165;6507.349265073455;6560.475161987125;6577.63822989721;6292.622442653455;6332.968335158294;6358.586691865199;6370.458511026614;6510.251321098134;6640.435562977201;6649.368310010735;6650.767223147167;6654.035164901159;6662.133922590032;6187.597806142587;6197.163382943425;6239.064140378798;6288.088227207121;6301.6219026858535;6318.684065796784;6321.367863213642;6346.904796427965;6348.873022539616;6358.427741503102;6262.123302737711;6265.279492858197;6277.5605707600025;6288.213973253343;6296.874062518816;6120.782376608402;6159.384061593805;6221.440070393686;6265.122882796321;6281.309056003744;5075.949240507695;6066.9696651518225;6133.693315334304;6165.260168779775;6206.875862482815;6118.051701986199;6235.345288744798;6273.215848018997;6283.937160628335;6299.685015749286;6121.877562448815;6178.41305076017;6207.16203312547;6215;6221.2845522765465 07:38:05 INFO - PROCESS | 2537 | |1;ext.html;513.8561202863198;526.9802931327881;531.9840404787856;551.5477308606944;596.4304089594438;26534;39833.60166398339;39852;40143.39784903221;40175;45199.32201016979;45663;45689.7715511422;45793.77103114488;45849.7707511462;8977.281817454621;9828.999999999982;10055;10057.497125143751;10083.394996300209;9424;11878.524859005629;12055;12064.396780161002;12144.878551214508;11780.882191178065;11877.524899004029;11881.287122772617;11884.108691848103;11884.7623047539;11707.824382634268;11794;11820.172587918805;11825.763484730343;11833.526658933632;11642.417879106011;11774.882251177463;11779.646610601696;12059.577914773028;12060.517579296818;41343;41967;41972;41984.74045778631;41988.37017444741;3285.8204822462994;3318.5354050432957;3327.8336083195745;3431.1422144463886;3435.9828200859088;28428;28640.570391444144;30175.396492070035;30719;30809.229769255722;2783.5685468752376;2783.5685468752376;2828.1656911211244;2883.1494709060876;2899.289674029876;514273;515586;516907;517211;517631.4118429421;37218.069548260966;37446.812765935996;37575.436368454495;62640.37359626345;63623.681881590295;29910.850445748067;36240.81879590585;36276.455853162224;36417.90746277616;36533.721319754215;15736.213189340488;15874.603134921488;15882.44411445617;15883.841161588236;15912.92043539775;12829.037822163375;12989.090763646644;13001.609951701465;13026.739465210832;13564.05051646395;8302.916970830334;8402.075771665111;8460.8730869037;8475.618597163142;8493.490390576586;3320.3027364253294;3418.3676019936393;3463.809490478048;3487.773294735885;3504.632013638582;951.5955718819474;1028.7222449938624;1055.37205362809;1088.2382332367217;1107.617871834216;29310.413791724048;29662.851685741432;29924;30201.546976795365;30986.535201971987;1129.4409267412684;1133.6882357351794;1148.7472755993667;1194.4147367789722;1282.9037822163189;12795.680107997188;15467.922660386626;15641.765373519178;15802.288896999433;15900.52298431049;600054;608103;609234;609365;609422;61704.38295617076;63628.68185659135;63753.681231593546;63811;63920;1256.5225214418645;1448.3482432905025;1547.6981988512357;1568.5608029751688;1595.5532450913763;28760;29139.417211656073;29691.55462668105;30223;31374.37251255008;51226.74386628043;51579.74210128925;51679;51758;51865;427828;429450;430149.8492507517;430598;430963;24325.635115473637;27856.582151268154;28129.859350703115;28438;28452;43411;44777.104457910005;45252;45320.773396132805;45664.54335456603;36353;36746.63253367432;36901.815490922374;37296;42917.356239655805;40854.591454086265;41905.37141942934;42211.3668294982;42975.14049719051;43607.34588981104;39285.60714392934;39984.00039999023;40359.79820100881;41523.58476415197;41565.37651935284;38874.4168837462;39093.609063908996;39255.41116883306;39608;40012.799936000134;20668.066727423804;27225;27239.727602724513;27262.318442039108;27297.044603438786 07:38:05 INFO - PROCESS | 2537 | |2;jquery.html;416.2486711485767;416.49603979185184;418.9162167566486;423.30155243847645;428.2826266004442;20740.688889666668;20850.791492085093;21433;22522.54954900901;22793.886030569825;22235.44411389716;22465.775342246572;22548.8872555637;22922.885385573092;22955.885220573873;5895.233619629442;6163.414475624809;6221.191245138149;6225.159603453521;6225.937740622581;4379.781010949456;4505.887352816189;4623.306504024406;6157.907631385533;6294.7482100715915;6584.045313429549;6898.75854345098;6903.344182302699;6913.239543650195;6923.965380173092;6533.281339052701;6798.2182049064;6817.250102488722;6848.2809305023;6890.2076261230095;4063.6952228582677;5755.280589926259;5986.341502434729;6009.1587177795145;6018.337982821886;26742.465150696877;26754.464910701678;27144.1856744298;27147.914083436637;27166.049188278317;2080.6150862090412;2296.253717541789;2297.276357947258;2470.0737223541173;2777.472280266743;14523.709525809425;14771.852281477155;14793.482228122071;14840.851591484055;14940.551783446514;1531.5328824708458;1795.425463851568;1806.8735188536807;1901.4010586665156;1980.6137803128395;115420;122109;124087;124311;126278.3686081573;11923.880761192451;12127.454264558117;12145.878541214475;12197.146199765932;12292.754144917231;15915.283812228477;15947;15963.962342447703;15974.520764377086;15977.121258330671;7591.3547348475995;9267.490288034089;9418.858717119248;9495.76260593477;9551.188149007274;9374.625014999323;9389.793398551335;9407.717768466957;9461.148496635336;9515.857262141073;4842.564169224786;4900.632452566;4911.533404326655;4916.557509824133;4988.90022199554;1969.8621096523107;2043.9049973776998;2062.8143467088034;2085.7392825896763;2093.2150443583655;930.7161315798611;981.3964411886639;981.5141504955093;1003.3377970539409;1014.7919676466307;17623.383181588582;20429.489262768253;20712.378628641163;20829.58340833175;21570.35288941334;914.6798620482778;968.1963969904962;1003.4029752297517;1012.4583347908833;1073.0503504398664;11209.775804484028;11478.081753459703;11525.020373268198;11541.538338466535;11567.88432115685;632257;633112;639891;642604;652241;113386;128129;131017;132396.3380183093;136630;932.6362718539775;1070.2668671959732;1100.0979197058334;1116.771061932302;1118.9888101119047;16310.755338670167;18828.905855471185;19327.51681207981;19747.111379988222;20012.49968750793;47863.28205076857;52711.20933186082;52897;52981.73509132584;53622.73188634032;75754;75964.62017689877;75970;78297.60851195708;80880;8411;8553.700620478254;8554.401191916755;8650.524221167896;8752.444851575645;12313.384330783247;12321.260724356567;12663.873361266269;12765.170263932814;12804.039697022574;10618.09746171584;10769.353838769699;11124.165687573302;11278.379689117177;11306.434678266218;10656;10842.457877105955;10847.891521085005;11151.832722509007;11221.326720396803;8539.76173454858;10992.450377481255;11139.997400234019;11230.101591872794;11276.436178191221;8302.792430189294;8721.651133954825;11472.541098355972;11791.587294444653;12010.879891201326;10240.743981400525;11081.722956926142;11434.542618295174;11630.767384652429;11677.124215683687 07:38:05 INFO - PROCESS | 2537 | |3;mootools.html;1488.240997091483;1605.5022942887701;1633.730434478311;1919.1076149590438;2036.8676036057655;8314.79213019674;8984.685536006242;9144.177024067832;9153.633854645806;9170.495622740755;7304.561726296426;9088.545572721354;9110.635574577025;9111.043340449256;9115.99724030356;2538.5557527432716;2572.5498037843395;2573.819832611718;2575;2576.1627471071884;2486.6021436570154;2580.225932220336;2586.767190952814;2586.793056555471;2588.896444142232;2533.873306334676;2572.305477521068;2574.1376638825923;2575.87120643968;2578.948421031578;2536.264483299841;2555.897764089434;2573.1122762646855;2583.7803786678155;2593.8314009589317;2500.462400583883;2553.8978440862343;2557.0666706652123;2560.577504711739;2562.513122506736;7519.736809211706;8716.866807315071;9087.136722011399;9124.817503649956;9163.08369163085;5634.549236061105;5752.712364381806;5799.971000145015;5801.7099145043;5809.622374545641;3648.8175591220333;3731.9626803731885;3791.4502397152532;3798.8480460781534;3804.144067584799;1030.2685093583564;1050.8844027157006;1053.9051485366354;1065.1585247654343;1088.7985722641258;12519.12366134371;12591.055670824633;12605.684857878627;12607.369631518479;12633.431495582721;3791.829367678461;4739.431268247832;4850.938351200725;4855.635827312965;4865.221564549655;9719.951400243095;9728.17310528613;9747.3664211826;9753;9761.170300524534;5552.639078459968;5594.608377413542;5618.943810561842;5622.32532096151;5629.971850140805;4620.145273124483;4725.10223057618;4774.331593576902;4778.092162489116;5217.2695822584865;3426.229098452878;3721.5162028936065;3751.531058617673;4103;4108.8356465741035;1227.7728620205112;1258.8741125887339;1260.3446207971804;1267.8985681145487;1269.9111062225556;862.6808081010066;927.888653361601;939.5114540438933;947.0718695678274;968.8498282766183;5672.376038635747;5826.65040097587;6040.456358927718;6054.061620448838;6189.721462534197;916.9220616247694;919.3794188922451;923.6582464488048;954.2175416158822;968.0561452583815;3744.700423966076;3999.140184860269;4027.7381970172432;4089;4091.4067460218102;10859.728506787393;11208.831867521994;11271.492782824793;11432.199746017699;11442.256253343507;11253.831192532118;11253.887461125283;11254.606088786853;11265.54937802495;11285;8051.5571643559;8631.568421578895;8699.739007829776;8711.738647840575;8720.258778003814;6059.969700151471;6066.908996364969;6096;6115.877682446415;6169.81490555284;9658.806823863624;10109.696709098738;10118.49407529606;10339.327943683937;10343.27597068198;9849.60601575929;10361.689149325532;10408.583656653649;10441.321314114559;10442.582296708046;7068.081149450744;7221.638918054181;7694.038245219348;7865.842683146419;7994;8510.48937063778;8617.69838055665;8687.956560217159;8709.782255443411;8710.346723995599;6445.677716114269;7523.1348394935285;7567.621618919142;7591.164971852982;7770.261825126604;7464.925350746423;7474.551526908403;7508.962455187689;7524;7603.467757256939;6950.4787140965645;7015.0529678494795;7017.05269788572;7026.227115017242;7030.683619237045;4302.204092242945;4945.455999840086;4986.6010719143105;5080.161773307363;5197.246399272009;5107.700887299894;5115.74421278942;5146.588272938231;5173.456787037307;5177.223416487557 07:38:05 INFO - PROCESS | 2537 | |4;prototype.html;334.3313373253493;339.80461234790005;343.94496880499116;349.6503496503498;351.28688761813527;6591.538592298541;6606.942889137733;6608.173978252718;6637.137172167618;6650.5012124090645;6587.044878492616;6598.8020359389175;6626.337366263371;6641.833954151149;6660.134182556261;4741.834035808747;4865.464798872121;4866.707997520142;4994.250862370637;5051.9494805051845;4443.4445694288215;4610.492845786977;5027.195648696209;5034.446210916796;5036.294918711384;4968.031233909389;4971.105201063807;4982.252662100677;4984.526469985346;4992.251162325644;4678.929816052762;4800.15997200492;4908.9263661045115;4928.901421971576;4956.677815941952;4225.19721252961;4242.957570424287;4243.681723870691;4255.744655320691;4258.87223383299;5527.834164975057;6177.567570270083;6386.329435409261;6401.199850018747;6507.2191337039385;4985.501449854985;5753.769849206027;5915.704214789286;5943.959807033795;5949.137375080632;5664.26364572603;7165.283471652793;7173.820654483628;7183.856322873566;7201.13586369639;4345.261305578059;4800.279958006292;4812.903741925177;4815.0610630926985;4833.371661683958;7465.738699145504;7523.586202758846;7527.247275272483;7536.284053014955;7539.811504712371;4869.488703686062;4886.60907127429;4891.33966914462;4895.216765317532;4899.730514821719;4954.1825598775795;4963.60291176705;4967.801287948441;4974.278729584263;4997.7251251180805;5708.486236238676;5922.526197904157;5939.524838012949;5942.940570594325;5947;7177.856442871113;7204.783856484314;7215.314545118205;7216.60308683017;7234.565926044349;1685.7471379292958;1727.5681079730068;1729.723244280909;1731.3940120957816;1732.0040976438347;1035.694470131313;1056.0442799266675;1106.1085543720328;1113.3320007995137;1136.3352438823215;6170.81487555374;6654.6672666366485;6807.863842723118;6815.114035175396;6841.24746277919;7457.403407727369;7491;7492.700291988368;7496.212897645778;7501.587412692245;6769.458443324522;6890.20762612306;6945.51381403307;6948.33990770876;6950.826229344206;3771.4342848572387;3899.6880249579967;3940.2907476654477;3941.2511622791576;3946.7631942083567;7747.031621047369;7839.080459770115;7850.8429831403055;7858.0963189232825;7892.684292628345;7673.961630191925;7678.961605191938;7703.268189521987;7714.884276735854;7720.3051725344985;7806;7816.257455541714;7818.843623127505;7822.687092516349;7849.960750196441;7212.459065570209;7359.337659610446;7463.589502577411;7470.402367810453;7477.177510473734;7253.673584688596;7322.3775979042375;7324.670389832364;7345.412367010519;7350.228226036403;6250.374962503895;7017.05269788572;7066.646667666699;7996.160403157817;7998.760037198894;4899.632527560519;4905.23968784839;4909.803607855646;4924.975375123101;4927.950720492892;7177.318154775288;7454.888176677463;7470.738524151629;7473.663685134074;7498.400127989638;7187.993680884785;7254.0207072046705;7257.927420725937;7268.563886166847;7278.890816637649;7202.495825292389;7221.602811845399;7225.819354516179;7231.63841807918;7242.6740796663225;7080.858382832417;7083.82290442743;7085.751998680022;7093;7097.929020709933;6895.10363652742;7111.466640001917;7151.7854464366155;7157.284271572801;7229.168645605822;6765.560238584476;6785.89821152693;6911.516193866582;6927.549709268881;7021.789346319619 07:38:05 INFO - PROCESS | 2537 | |5;yui.html;685.3386482044829;746.0674157303373;766.9118051424081;767.5279702982667;781.2695130053401;13092.6252743462;15392.307346169422;15786.605334866605;15818.60453488662;15820.971636843597;11385.430728463565;14632.634184145401;14632.926835365835;14647.780283295733;14674.779878301808;755.8412733326008;787.6573690444646;948.3882895532378;971.9988411935717;972.5915115651443;955.5652178258911;958.8705524754139;961.6345788600322;963.2871674960513;963.8843338799319;809.3686924199134;1034.2243317511866;1036.7719101797593;1037.4968140451874;1043.327054050141;824.9463784853965;825.0017478850598;827.8261565071342;1003.3428104591504;1032.1278519650882;771.2287712287713;774.0749803984241;774.2064384006383;774.8527779721835;777.2538363171362;15308.464203752927;15365.846341536553;15367.538973830691;15386.15376154311;15417.074975501506;12921.547745828944;13179.868201318055;13284.269365184911;13308.866911330957;13392.86607133926;10241.027102425332;11246.887531124667;11343.262687925258;11627.709307267385;11729.941350293278;3215;3516.1209697575605;3546.078019714867;3611.6749492545796;3666.2484190740834;86322.56838715829;88959;92002.61996069997;92764.53617731936;93158;9530.01961155195;9766.560504777302;9784.608615655436;9910.603575856885;10013.998600139928;21816.45458863541;21961.23135690275;22079.33761987143;22081;22165.335039948826;7626.847463050819;7654.693812247448;7772.65023073963;7773.067231932205;8013.599320033975;4260.6378457830815;4335.219660461147;4387.934180987288;4406.449193850769;4616.8614941551805;3185.2036990752313;3766.9246615067545;3843.3466310726685;3844.231153769257;3844.8462061517785;682;693.3724978894008;704.2007321689919;707.6214225389494;713.5825542057954;560.4871542538532;561.4694114062172;621.8196722950294;622.2781573374954;637.5951270942985;7310.305520975498;8013.599320034092;8534.829303413897;8573.18554737299;8652.826943461221;559.9836297120713;563.712506621626;601.9367966363557;619.4177473175291;626.3298270850238;3966.167104907944;3992.1017771001293;4060.573639767841;4062.7968601569805;4123.237201117803;82101.17898821055;91749.16501669929;92513;92542.07457925334;92546;77301.6134919333;79661;79882.20117798864;79928.60035699785;82742.75885861716;64927.701445970815;66050.33949660441;66325.6683716588;66581;67511.64976700439;6565.376289252514;7581.658825352762;7633.122190948112;7857.646405911633;7901.802454938443;51000.489995099575;51024.72438189075;51317;52046;52620.736896316805;52152;58020.83958320726;67804.32195677981;72754.27245727475;73038;10143.695689129338;10216.693499195037;10304.536295866554;10416;10457.895421045692;10738;10842.620508282173;12126.878731212928;12150.817737734118;12819.487220511448;8527.319554503028;11404.315741055232;11791.705207369885;12159.696007599881;12438.440270188044;11170.832437513282;11705.063594912557;11764.764704706029;11803.468843902217;12080.093992950387;11391.772164556829;11509.94245028803;11615;11630.94184529072;12079.51681932713;9677.70966870995;9783.047703576602;10078.748031299276;10153.492325383553;10343.431111288952;9778.462184579916;10037.996200380196;10038.247131465316;10175.135113515435;10290 07:38:05 INFO - PROCESS | 2537 | __end_tp_report 07:38:05 INFO - PROCESS | 2537 | __start_cc_report 07:38:05 INFO - PROCESS | 2537 | _x_x_mozilla_cycle_collect,1175 07:38:05 INFO - PROCESS | 2537 | __end_cc_report 07:38:05 INFO - PROCESS | 2537 | __startTimestamp1469111884998__endTimestamp 07:38:05 INFO - PROCESS | 2537 | 07:38:05 INFO - PROCESS | 2537 | ------- Summary: start ------- 07:38:05 INFO - PROCESS | 2537 | Number of tests: 6 07:38:05 INFO - PROCESS | 2537 | 07:38:05 INFO - PROCESS | 2537 | [#0] dojo.html Cycles:165 Average:5869.32 Median:6149.60 stddev:658.87 (10.7%) stddev-sans-first:611.30 07:38:05 INFO - PROCESS | 2537 | Values: 2672.3 3509.6 3550.2 3563.9 3620.5 5814.4 5824.6 5836.8 5862.7 5876.4 5874.8 5911.6 5928.8 5932.7 5948.0 5294.1 5331.7 5335.0 5379.9 5434.8 5407.9 5431.5 5445.8 5448.6 5449.6 5313.3 5375.7 5409.9 5419.9 5432.2 5411.5 5431.9 5457.3 5468.7 5512.9 4891.9 5254.5 5331.8 5354.8 5366.9 5685.5 5728.6 5759.6 5788.2 5820.0 6265.2 6278.2 6288.6 6289.6 6305.2 6149.6 6171.8 6275.3 6279.7 6288.7 6016.8 6020.2 6070.0 6082.8 6085.2 6405.5 6421.3 6423.0 6429.1 6442.5 5122.4 6190.2 6262.2 6310.8 6336.7 6289.5 6313.6 6315.2 6320.4 6334.5 6194.4 6259.2 6263.9 6282.3 6289.9 6191.0 6223.8 6260.3 6314.2 6321.5 5046.6 5077.4 5078.0 5085.3 5089.6 4562.5 4564.6 4570.0 4572.0 4606.7 5817.1 5901.8 5929.2 5929.3 5937.7 6183.9 6253.1 6273.4 6281.9 6290.3 5890.2 5891.3 5912.1 5926.1 5944.1 4677.8 5449.6 5522.4 5526.9 5536.5 6415.4 6493.9 6507.3 6560.5 6577.6 6292.6 6333.0 6358.6 6370.5 6510.3 6640.4 6649.4 6650.8 6654.0 6662.1 6187.6 6197.2 6239.1 6288.1 6301.6 6318.7 6321.4 6346.9 6348.9 6358.4 6262.1 6265.3 6277.6 6288.2 6296.9 6120.8 6159.4 6221.4 6265.1 6281.3 5075.9 6067.0 6133.7 6165.3 6206.9 6118.1 6235.3 6273.2 6283.9 6299.7 6121.9 6178.4 6207.2 6215.0 6221.3 07:38:05 INFO - PROCESS | 2537 | 07:38:05 INFO - PROCESS | 2537 | [#1] ext.html Cycles:180 Average:65201.78 Median:3475.79 stddev:139492.82 (4013.3%) stddev-sans-first:139799.59 07:38:05 INFO - PROCESS | 2537 | Values: 513.9 527.0 532.0 551.5 596.4 26534.0 39833.6 39852.0 40143.4 40175.0 45199.3 45663.0 45689.8 45793.8 45849.8 8977.3 9829.0 10055.0 10057.5 10083.4 9424.0 11878.5 12055.0 12064.4 12144.9 11780.9 11877.5 11881.3 11884.1 11884.8 11707.8 11794.0 11820.2 11825.8 11833.5 11642.4 11774.9 11779.6 12059.6 12060.5 41343.0 41967.0 41972.0 41984.7 41988.4 3285.8 3318.5 3327.8 3431.1 3436.0 28428.0 28640.6 30175.4 30719.0 30809.2 2783.6 2783.6 2828.2 2883.1 2899.3 514273.0 515586.0 516907.0 517211.0 517631.4 37218.1 37446.8 37575.4 62640.4 63623.7 29910.9 36240.8 36276.5 36417.9 36533.7 15736.2 15874.6 15882.4 15883.8 15912.9 12829.0 12989.1 13001.6 13026.7 13564.1 8302.9 8402.1 8460.9 8475.6 8493.5 3320.3 3418.4 3463.8 3487.8 3504.6 951.6 1028.7 1055.4 1088.2 1107.6 29310.4 29662.9 29924.0 30201.5 30986.5 1129.4 1133.7 1148.7 1194.4 1282.9 12795.7 15467.9 15641.8 15802.3 15900.5 600054.0 608103.0 609234.0 609365.0 609422.0 61704.4 63628.7 63753.7 63811.0 63920.0 1256.5 1448.3 1547.7 1568.6 1595.6 28760.0 29139.4 29691.6 30223.0 31374.4 51226.7 51579.7 51679.0 51758.0 51865.0 427828.0 429450.0 430149.8 430598.0 430963.0 24325.6 27856.6 28129.9 28438.0 28452.0 43411.0 44777.1 45252.0 45320.8 45664.5 36353.0 36746.6 36901.8 37296.0 42917.4 40854.6 41905.4 42211.4 42975.1 43607.3 39285.6 39984.0 40359.8 41523.6 41565.4 38874.4 39093.6 39255.4 39608.0 40012.8 20668.1 27225.0 27239.7 27262.3 27297.0 07:38:05 INFO - PROCESS | 2537 | 07:38:05 INFO - PROCESS | 2537 | [#2] jquery.html Cycles:180 Average:36775.68 Median:22350.61 stddev:106451.53 (476.3%) stddev-sans-first:106715.15 07:38:05 INFO - PROCESS | 2537 | Values: 416.2 416.5 418.9 423.3 428.3 20740.7 20850.8 21433.0 22522.5 22793.9 22235.4 22465.8 22548.9 22922.9 22955.9 5895.2 6163.4 6221.2 6225.2 6225.9 4379.8 4505.9 4623.3 6157.9 6294.7 6584.0 6898.8 6903.3 6913.2 6924.0 6533.3 6798.2 6817.3 6848.3 6890.2 4063.7 5755.3 5986.3 6009.2 6018.3 26742.5 26754.5 27144.2 27147.9 27166.0 2080.6 2296.3 2297.3 2470.1 2777.5 14523.7 14771.9 14793.5 14840.9 14940.6 1531.5 1795.4 1806.9 1901.4 1980.6 115420.0 122109.0 124087.0 124311.0 126278.4 11923.9 12127.5 12145.9 12197.1 12292.8 15915.3 15947.0 15964.0 15974.5 15977.1 7591.4 9267.5 9418.9 9495.8 9551.2 9374.6 9389.8 9407.7 9461.1 9515.9 4842.6 4900.6 4911.5 4916.6 4988.9 1969.9 2043.9 2062.8 2085.7 2093.2 930.7 981.4 981.5 1003.3 1014.8 17623.4 20429.5 20712.4 20829.6 21570.4 914.7 968.2 1003.4 1012.5 1073.1 11209.8 11478.1 11525.0 11541.5 11567.9 632257.0 633112.0 639891.0 642604.0 652241.0 113386.0 128129.0 131017.0 132396.3 136630.0 932.6 1070.3 1100.1 1116.8 1119.0 16310.8 18828.9 19327.5 19747.1 20012.5 47863.3 52711.2 52897.0 52981.7 53622.7 75754.0 75964.6 75970.0 78297.6 80880.0 8411.0 8553.7 8554.4 8650.5 8752.4 12313.4 12321.3 12663.9 12765.2 12804.0 10618.1 10769.4 11124.2 11278.4 11306.4 10656.0 10842.5 10847.9 11151.8 11221.3 8539.8 10992.5 11140.0 11230.1 11276.4 8302.8 8721.7 11472.5 11791.6 12010.9 10240.7 11081.7 11434.5 11630.8 11677.1 07:38:05 INFO - PROCESS | 2537 | 07:38:05 INFO - PROCESS | 2537 | [#3] mootools.html Cycles:180 Average:5876.92 Median:5093.93 stddev:3297.68 (64.7%) stddev-sans-first:3290.44 07:38:05 INFO - PROCESS | 2537 | Values: 1488.2 1605.5 1633.7 1919.1 2036.9 8314.8 8984.7 9144.2 9153.6 9170.5 7304.6 9088.5 9110.6 9111.0 9116.0 2538.6 2572.5 2573.8 2575.0 2576.2 2486.6 2580.2 2586.8 2586.8 2588.9 2533.9 2572.3 2574.1 2575.9 2578.9 2536.3 2555.9 2573.1 2583.8 2593.8 2500.5 2553.9 2557.1 2560.6 2562.5 7519.7 8716.9 9087.1 9124.8 9163.1 5634.5 5752.7 5800.0 5801.7 5809.6 3648.8 3732.0 3791.5 3798.8 3804.1 1030.3 1050.9 1053.9 1065.2 1088.8 12519.1 12591.1 12605.7 12607.4 12633.4 3791.8 4739.4 4850.9 4855.6 4865.2 9720.0 9728.2 9747.4 9753.0 9761.2 5552.6 5594.6 5618.9 5622.3 5630.0 4620.1 4725.1 4774.3 4778.1 5217.3 3426.2 3721.5 3751.5 4103.0 4108.8 1227.8 1258.9 1260.3 1267.9 1269.9 862.7 927.9 939.5 947.1 968.8 5672.4 5826.7 6040.5 6054.1 6189.7 916.9 919.4 923.7 954.2 968.1 3744.7 3999.1 4027.7 4089.0 4091.4 10859.7 11208.8 11271.5 11432.2 11442.3 11253.8 11253.9 11254.6 11265.5 11285.0 8051.6 8631.6 8699.7 8711.7 8720.3 6060.0 6066.9 6096.0 6115.9 6169.8 9658.8 10109.7 10118.5 10339.3 10343.3 9849.6 10361.7 10408.6 10441.3 10442.6 7068.1 7221.6 7694.0 7865.8 7994.0 8510.5 8617.7 8688.0 8709.8 8710.3 6445.7 7523.1 7567.6 7591.2 7770.3 7464.9 7474.6 7509.0 7524.0 7603.5 6950.5 7015.1 7017.1 7026.2 7030.7 4302.2 4945.5 4986.6 5080.2 5197.2 5107.7 5115.7 5146.6 5173.5 5177.2 07:38:05 INFO - PROCESS | 2537 | 07:38:05 INFO - PROCESS | 2537 | [#4] prototype.html Cycles:180 Average:5899.13 Median:6646.17 stddev:1868.09 (28.1%) stddev-sans-first:1826.04 07:38:05 INFO - PROCESS | 2537 | Values: 334.3 339.8 343.9 349.7 351.3 6591.5 6606.9 6608.2 6637.1 6650.5 6587.0 6598.8 6626.3 6641.8 6660.1 4741.8 4865.5 4866.7 4994.3 5051.9 4443.4 4610.5 5027.2 5034.4 5036.3 4968.0 4971.1 4982.3 4984.5 4992.3 4678.9 4800.2 4908.9 4928.9 4956.7 4225.2 4243.0 4243.7 4255.7 4258.9 5527.8 6177.6 6386.3 6401.2 6507.2 4985.5 5753.8 5915.7 5944.0 5949.1 5664.3 7165.3 7173.8 7183.9 7201.1 4345.3 4800.3 4812.9 4815.1 4833.4 7465.7 7523.6 7527.2 7536.3 7539.8 4869.5 4886.6 4891.3 4895.2 4899.7 4954.2 4963.6 4967.8 4974.3 4997.7 5708.5 5922.5 5939.5 5942.9 5947.0 7177.9 7204.8 7215.3 7216.6 7234.6 1685.7 1727.6 1729.7 1731.4 1732.0 1035.7 1056.0 1106.1 1113.3 1136.3 6170.8 6654.7 6807.9 6815.1 6841.2 7457.4 7491.0 7492.7 7496.2 7501.6 6769.5 6890.2 6945.5 6948.3 6950.8 3771.4 3899.7 3940.3 3941.3 3946.8 7747.0 7839.1 7850.8 7858.1 7892.7 7674.0 7679.0 7703.3 7714.9 7720.3 7806.0 7816.3 7818.8 7822.7 7850.0 7212.5 7359.3 7463.6 7470.4 7477.2 7253.7 7322.4 7324.7 7345.4 7350.2 6250.4 7017.1 7066.6 7996.2 7998.8 4899.6 4905.2 4909.8 4925.0 4928.0 7177.3 7454.9 7470.7 7473.7 7498.4 7188.0 7254.0 7257.9 7268.6 7278.9 7202.5 7221.6 7225.8 7231.6 7242.7 7080.9 7083.8 7085.8 7093.0 7097.9 6895.1 7111.5 7151.8 7157.3 7229.2 6765.6 6785.9 6911.5 6927.5 7021.8 07:38:05 INFO - PROCESS | 2537 | 07:38:05 INFO - PROCESS | 2537 | [#5] yui.html Cycles:180 Average:18536.86 Median:51681.50 stddev:26094.08 (50.5%) stddev-sans-first:26132.85 07:38:05 INFO - PROCESS | 2537 | Values: 685.3 746.1 766.9 767.5 781.3 13092.6 15392.3 15786.6 15818.6 15821.0 11385.4 14632.6 14632.9 14647.8 14674.8 755.8 787.7 948.4 972.0 972.6 955.6 958.9 961.6 963.3 963.9 809.4 1034.2 1036.8 1037.5 1043.3 824.9 825.0 827.8 1003.3 1032.1 771.2 774.1 774.2 774.9 777.3 15308.5 15365.8 15367.5 15386.2 15417.1 12921.5 13179.9 13284.3 13308.9 13392.9 10241.0 11246.9 11343.3 11627.7 11729.9 3215.0 3516.1 3546.1 3611.7 3666.2 86322.6 88959.0 92002.6 92764.5 93158.0 9530.0 9766.6 9784.6 9910.6 10014.0 21816.5 21961.2 22079.3 22081.0 22165.3 7626.8 7654.7 7772.7 7773.1 8013.6 4260.6 4335.2 4387.9 4406.4 4616.9 3185.2 3766.9 3843.3 3844.2 3844.8 682.0 693.4 704.2 707.6 713.6 560.5 561.5 621.8 622.3 637.6 7310.3 8013.6 8534.8 8573.2 8652.8 560.0 563.7 601.9 619.4 626.3 3966.2 3992.1 4060.6 4062.8 4123.2 82101.2 91749.2 92513.0 92542.1 92546.0 77301.6 79661.0 79882.2 79928.6 82742.8 64927.7 66050.3 66325.7 66581.0 67511.6 6565.4 7581.7 7633.1 7857.6 7901.8 51000.5 51024.7 51317.0 52046.0 52620.7 52152.0 58020.8 67804.3 72754.3 73038.0 10143.7 10216.7 10304.5 10416.0 10457.9 10738.0 10842.6 12126.9 12150.8 12819.5 8527.3 11404.3 11791.7 12159.7 12438.4 11170.8 11705.1 11764.8 11803.5 12080.1 11391.8 11509.9 11615.0 11630.9 12079.5 9677.7 9783.0 10078.7 10153.5 10343.4 9778.5 10038.0 10038.2 10175.1 10290.0 07:38:05 INFO - PROCESS | 2537 | -------- Summary: end -------- 07:38:05 INFO - PROCESS | 2537 | 07:38:05 INFO - TEST-INFO | 2537: exit 0 07:38:05 INFO - TEST-OK | dromaeo_css | took 1112985ms 07:38:05 INFO - TEST-START | kraken 07:38:05 INFO - operating with platform_type : mac_ 07:38:05 INFO - Initialising browser for kraken test... 07:38:05 INFO - TEST-INFO | started process 2541 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpeCWqXh/profile http://localhost:55460/getInfo.html) 07:38:07 INFO - PROCESS | 2541 | __metrics Screen width/height:1600/1200 07:38:07 INFO - PROCESS | 2541 | colorDepth:24 07:38:07 INFO - PROCESS | 2541 | Browser inner width/height: 1024/689 07:38:07 INFO - PROCESS | 2541 | __metrics 07:38:07 INFO - PROCESS | 2541 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:07 ERROR - PROCESS | 2541 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:38:08 INFO - TEST-INFO | 2541: exit 0 07:38:08 INFO - Browser initialized. 07:38:08 INFO - Running cycle 1/1 for kraken test... 07:38:08 INFO - TEST-INFO | started process 2544 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpeCWqXh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:20 INFO - PROCESS | 2544 | RSS: Main: 160288768 07:38:20 INFO - PROCESS | 2544 | 07:38:22 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55460/tests/kraken/driver.html?testName=audio-beat-detection) 07:38:23 INFO - PROCESS | 2544 | RSS: Main: 223961088 07:38:23 INFO - PROCESS | 2544 | 07:38:26 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55460/tests/kraken/driver.html?testName=audio-dft) 07:38:27 INFO - PROCESS | 2544 | RSS: Main: 239632384 07:38:27 INFO - PROCESS | 2544 | 07:38:30 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55460/tests/kraken/driver.html?testName=audio-fft) 07:38:30 INFO - PROCESS | 2544 | RSS: Main: 326971392 07:38:30 INFO - PROCESS | 2544 | 07:38:32 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55460/tests/kraken/driver.html?testName=audio-oscillator) 07:38:33 INFO - PROCESS | 2544 | RSS: Main: 230944768 07:38:33 INFO - PROCESS | 2544 | 07:38:35 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:38:36 INFO - PROCESS | 2544 | RSS: Main: 231034880 07:38:36 INFO - PROCESS | 2544 | 07:38:39 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55460/tests/kraken/driver.html?testName=imaging-darkroom) 07:38:39 INFO - PROCESS | 2544 | RSS: Main: 269938688 07:38:39 INFO - PROCESS | 2544 | 07:38:42 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55460/tests/kraken/driver.html?testName=imaging-desaturate) 07:38:43 INFO - PROCESS | 2544 | RSS: Main: 271400960 07:38:43 INFO - PROCESS | 2544 | 07:38:46 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55460/tests/kraken/driver.html?testName=json-parse-financial) 07:38:46 INFO - PROCESS | 2544 | RSS: Main: 269692928 07:38:46 INFO - PROCESS | 2544 | 07:38:48 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:38:48 INFO - PROCESS | 2544 | RSS: Main: 260804608 07:38:48 INFO - PROCESS | 2544 | 07:38:50 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55460/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:38:51 INFO - PROCESS | 2544 | RSS: Main: 267911168 07:38:51 INFO - PROCESS | 2544 | 07:38:53 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:38:54 INFO - PROCESS | 2544 | RSS: Main: 271437824 07:38:54 INFO - PROCESS | 2544 | 07:38:56 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:38:57 INFO - PROCESS | 2544 | RSS: Main: 277766144 07:38:57 INFO - PROCESS | 2544 | 07:39:00 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:39:01 INFO - PROCESS | 2544 | RSS: Main: 274812928 07:39:01 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:55460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55460/tests/kraken/driver.html?testName=ai-astar) 07:39:02 INFO - PROCESS | 2544 | RSS: Main: 335699968 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | __start_tp_report 07:39:02 INFO - PROCESS | 2544 | _x_x_mozilla_page_load 07:39:02 INFO - PROCESS | 2544 | _x_x_mozilla_page_load_details 07:39:02 INFO - PROCESS | 2544 | |i|pagename|runs| 07:39:02 INFO - PROCESS | 2544 | |0;ai-astar;112;112;119;111;110;111;111;111;113;132 07:39:02 INFO - PROCESS | 2544 | |1;audio-beat-detection;159;117;143;166;126;167;168;144;168;117 07:39:02 INFO - PROCESS | 2544 | |2;audio-dft;185;186;185;184;187;185;185;186;185;184 07:39:02 INFO - PROCESS | 2544 | |3;audio-fft;70;83;83;209;73;81;81;89;132;56 07:39:02 INFO - PROCESS | 2544 | |4;audio-oscillator;93;93;143;93;124;135;132;80;78;161 07:39:02 INFO - PROCESS | 2544 | |5;imaging-gaussian-blur;88;84;88;85;87;84;89;86;87;85 07:39:02 INFO - PROCESS | 2544 | |6;imaging-darkroom;94;93;93;94;92;93;94;93;92;93 07:39:02 INFO - PROCESS | 2544 | |7;imaging-desaturate;85;106;136;84;83;84;83;85;87;83 07:39:02 INFO - PROCESS | 2544 | |8;json-parse-financial;60;64;62;62;63;65;62;78;58;56 07:39:02 INFO - PROCESS | 2544 | |9;json-stringify-tinderbox;61;65;69;72;73;73;67;66;67;67 07:39:02 INFO - PROCESS | 2544 | |10;stanford-crypto-aes;80;88;89;104;103;69;85;102;104;107 07:39:02 INFO - PROCESS | 2544 | |11;stanford-crypto-ccm;128;126;126;127;135;120;127;122;145;141 07:39:02 INFO - PROCESS | 2544 | |12;stanford-crypto-pbkdf2;164;163;164;164;160;163;168;162;163;177 07:39:02 INFO - PROCESS | 2544 | |13;stanford-crypto-sha256-iterative;67;68;67;66;68;66;66;67;66;67 07:39:02 INFO - PROCESS | 2544 | __end_tp_report 07:39:02 INFO - PROCESS | 2544 | __start_cc_report 07:39:02 INFO - PROCESS | 2544 | _x_x_mozilla_cycle_collect,1912 07:39:02 INFO - PROCESS | 2544 | __end_cc_report 07:39:02 INFO - PROCESS | 2544 | __startTimestamp1469111942944__endTimestamp 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | ------- Summary: start ------- 07:39:02 INFO - PROCESS | 2544 | Number of tests: 14 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#0] ai-astar Cycles:10 Average:114.20 Median:112.00 stddev:6.75 (6.0%) stddev-sans-first:7.11 07:39:02 INFO - PROCESS | 2544 | Values: 112.0 112.0 119.0 111.0 110.0 111.0 111.0 111.0 113.0 132.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:162.50 stddev:21.21 (13.1%) stddev-sans-first:22.09 07:39:02 INFO - PROCESS | 2544 | Values: 159.0 117.0 143.0 166.0 126.0 167.0 168.0 144.0 168.0 117.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.00 stddev:0.92 (0.5%) stddev-sans-first:0.97 07:39:02 INFO - PROCESS | 2544 | Values: 185.0 186.0 185.0 184.0 187.0 185.0 185.0 186.0 185.0 184.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#3] audio-fft Cycles:10 Average:95.70 Median:81.00 stddev:44.35 (54.8%) stddev-sans-first:46.06 07:39:02 INFO - PROCESS | 2544 | Values: 70.0 83.0 83.0 209.0 73.0 81.0 81.0 89.0 132.0 56.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#4] audio-oscillator Cycles:10 Average:113.20 Median:79.00 stddev:29.22 (37.0%) stddev-sans-first:30.06 07:39:02 INFO - PROCESS | 2544 | Values: 93.0 93.0 143.0 93.0 124.0 135.0 132.0 80.0 78.0 161.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:1.77 (2.0%) stddev-sans-first:1.76 07:39:02 INFO - PROCESS | 2544 | Values: 88.0 84.0 88.0 85.0 87.0 84.0 89.0 86.0 87.0 85.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 07:39:02 INFO - PROCESS | 2544 | Values: 94.0 93.0 93.0 94.0 92.0 93.0 94.0 93.0 92.0 93.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#7] imaging-desaturate Cycles:10 Average:91.60 Median:84.00 stddev:17.08 (20.3%) stddev-sans-first:17.94 07:39:02 INFO - PROCESS | 2544 | Values: 85.0 106.0 136.0 84.0 83.0 84.0 83.0 85.0 87.0 83.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:62.50 stddev:5.93 (9.5%) stddev-sans-first:6.18 07:39:02 INFO - PROCESS | 2544 | Values: 60.0 64.0 62.0 62.0 63.0 65.0 62.0 78.0 58.0 56.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:3.83 (5.6%) stddev-sans-first:3.11 07:39:02 INFO - PROCESS | 2544 | Values: 61.0 65.0 69.0 72.0 73.0 73.0 67.0 66.0 67.0 67.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:74.50 stddev:12.78 (17.1%) stddev-sans-first:12.64 07:39:02 INFO - PROCESS | 2544 | Values: 80.0 88.0 89.0 104.0 103.0 69.0 85.0 102.0 104.0 107.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:127.50 stddev:8.08 (6.3%) stddev-sans-first:8.55 07:39:02 INFO - PROCESS | 2544 | Values: 128.0 126.0 126.0 127.0 135.0 120.0 127.0 122.0 145.0 141.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:164.00 stddev:4.73 (2.9%) stddev-sans-first:5.01 07:39:02 INFO - PROCESS | 2544 | Values: 164.0 163.0 164.0 164.0 160.0 163.0 168.0 162.0 163.0 177.0 07:39:02 INFO - PROCESS | 2544 | 07:39:02 INFO - PROCESS | 2544 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 07:39:02 INFO - PROCESS | 2544 | Values: 67.0 68.0 67.0 66.0 68.0 66.0 66.0 67.0 66.0 67.0 07:39:02 INFO - PROCESS | 2544 | -------- Summary: end -------- 07:39:02 INFO - PROCESS | 2544 | 07:39:03 INFO - TEST-INFO | 2544: exit 0 07:39:03 INFO - TEST-OK | kraken | took 58305ms 07:39:03 INFO - SUITE-END | took 1171s 07:39:04 INFO - Completed test suite (00:19:31) 07:39:04 INFO - javascript benchmark 07:39:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.26512709005, 3509.631488693686, 3550.1834578047033, 3563.8752643657476, 3620.515588608671, 5814.418558144189, 5824.563157763168, 5836.824895253144, 5862.73617687204, 5876.4417380348905, 5874.823755287348, 5911.615744976573, 5928.762849486026, 5932.673702946337, 5947.999999999989, 5294.126469132598, 5331.6534425262425, 5334.973325133388, 5379.919301210485, 5434.755436005369, 5407.918881216765, 5431.538319242869, 5445.782168713266, 5448.564114870821, 5449.56403487722, 5313.282706834586, 5375.731213439332, 5409.891802163955, 5419.945800541984, 5432.158015507603, 5411.458854114577, 5431.864203394907, 5457.317835270591, 5468.671879687232, 5512.944870551283, 4891.926621100686, 5254.500822421864, 5331.760070796785, 5354.759035843396, 5366.865828354284, 5685.545156387479, 5728.598998070137, 5759.5968282220265, 5788.218590490272, 5820.0, 6265.154204182422, 6278.152449419361, 6288.591241569329, 6289.559730818844, 6305.180326557518, 6149.600275982047, 6171.783987560414, 6275.278342990523, 6279.686015699197, 6288.748450061992, 6016.839990252096, 6020.247469066367, 6069.969650151721, 6082.847928801771, 6085.2393450818645, 6405.48756099511, 6421.325760795143, 6422.967885160544, 6429.1320671709655, 6442.452391546677, 5122.436531981479, 6190.164327815777, 6262.2172228471445, 6310.842228944313, 6336.746530138835, 6289.465395441439, 6313.558050936482, 6315.179026726496, 6320.367963203643, 6334.461570766536, 6194.442500175006, 6259.186305780219, 6263.937360626335, 6282.277538083087, 6289.905651415233, 6190.969045154746, 6223.813285601439, 6260.342664020303, 6314.179156709598, 6321.525885558602, 5046.596272298208, 5077.416097148875, 5077.984403119391, 5085.313482679865, 5089.643724939218, 4562.498125206224, 4564.634829213722, 4570.040291538814, 4571.977140114278, 4606.746628935441, 5817.069268917037, 5901.7639294427745, 5929.199558059693, 5929.318128415288, 5937.732802023919, 6183.938160618426, 6253.093301471261, 6273.435390814849, 6281.937180628135, 6290.308066112724, 5890.204822349014, 5891.322497912709, 5912.083627037816, 5926.111083337448, 5944.108383742473, 4677.789499472532, 5449.591280653967, 5522.420145884705, 5526.889462210734, 5536.474034966672, 6415.390537898892, 6493.8701225976165, 6507.349265073455, 6560.475161987125, 6577.63822989721, 6292.622442653455, 6332.968335158294, 6358.586691865199, 6370.458511026614, 6510.251321098134, 6640.435562977201, 6649.368310010735, 6650.767223147167, 6654.035164901159, 6662.133922590032, 6187.597806142587, 6197.163382943425, 6239.064140378798, 6288.088227207121, 6301.6219026858535, 6318.684065796784, 6321.367863213642, 6346.904796427965, 6348.873022539616, 6358.427741503102, 6262.123302737711, 6265.279492858197, 6277.5605707600025, 6288.213973253343, 6296.874062518816, 6120.782376608402, 6159.384061593805, 6221.440070393686, 6265.122882796321, 6281.309056003744, 5075.949240507695, 6066.9696651518225, 6133.693315334304, 6165.260168779775, 6206.875862482815, 6118.051701986199, 6235.345288744798, 6273.215848018997, 6283.937160628335, 6299.685015749286, 6121.877562448815, 6178.41305076017, 6207.16203312547, 6215.0, 6221.2845522765465], "value": 5827.186718885826, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.8561202863198, 526.9802931327881, 531.9840404787856, 551.5477308606944, 596.4304089594438, 26534.0, 39833.60166398339, 39852.0, 40143.39784903221, 40175.0, 45199.32201016979, 45663.0, 45689.7715511422, 45793.77103114488, 45849.7707511462, 8977.281817454621, 9828.999999999982, 10055.0, 10057.497125143751, 10083.394996300209, 9424.0, 11878.524859005629, 12055.0, 12064.396780161002, 12144.878551214508, 11780.882191178065, 11877.524899004029, 11881.287122772617, 11884.108691848103, 11884.7623047539, 11707.824382634268, 11794.0, 11820.172587918805, 11825.763484730343, 11833.526658933632, 11642.417879106011, 11774.882251177463, 11779.646610601696, 12059.577914773028, 12060.517579296818, 41343.0, 41967.0, 41972.0, 41984.74045778631, 41988.37017444741, 3285.8204822462994, 3318.5354050432957, 3327.8336083195745, 3431.1422144463886, 3435.9828200859088, 28428.0, 28640.570391444144, 30175.396492070035, 30719.0, 30809.229769255722, 2783.5685468752376, 2783.5685468752376, 2828.1656911211244, 2883.1494709060876, 2899.289674029876, 514273.0, 515586.0, 516907.0, 517211.0, 517631.4118429421, 37218.069548260966, 37446.812765935996, 37575.436368454495, 62640.37359626345, 63623.681881590295, 29910.850445748067, 36240.81879590585, 36276.455853162224, 36417.90746277616, 36533.721319754215, 15736.213189340488, 15874.603134921488, 15882.44411445617, 15883.841161588236, 15912.92043539775, 12829.037822163375, 12989.090763646644, 13001.609951701465, 13026.739465210832, 13564.05051646395, 8302.916970830334, 8402.075771665111, 8460.8730869037, 8475.618597163142, 8493.490390576586, 3320.3027364253294, 3418.3676019936393, 3463.809490478048, 3487.773294735885, 3504.632013638582, 951.5955718819474, 1028.7222449938624, 1055.37205362809, 1088.2382332367217, 1107.617871834216, 29310.413791724048, 29662.851685741432, 29924.0, 30201.546976795365, 30986.535201971987, 1129.4409267412684, 1133.6882357351794, 1148.7472755993667, 1194.4147367789722, 1282.9037822163189, 12795.680107997188, 15467.922660386626, 15641.765373519178, 15802.288896999433, 15900.52298431049, 600054.0, 608103.0, 609234.0, 609365.0, 609422.0, 61704.38295617076, 63628.68185659135, 63753.681231593546, 63811.0, 63920.0, 1256.5225214418645, 1448.3482432905025, 1547.6981988512357, 1568.5608029751688, 1595.5532450913763, 28760.0, 29139.417211656073, 29691.55462668105, 30223.0, 31374.37251255008, 51226.74386628043, 51579.74210128925, 51679.0, 51758.0, 51865.0, 427828.0, 429450.0, 430149.8492507517, 430598.0, 430963.0, 24325.635115473637, 27856.582151268154, 28129.859350703115, 28438.0, 28452.0, 43411.0, 44777.104457910005, 45252.0, 45320.773396132805, 45664.54335456603, 36353.0, 36746.63253367432, 36901.815490922374, 37296.0, 42917.356239655805, 40854.591454086265, 41905.37141942934, 42211.3668294982, 42975.14049719051, 43607.34588981104, 39285.60714392934, 39984.00039999023, 40359.79820100881, 41523.58476415197, 41565.37651935284, 38874.4168837462, 39093.609063908996, 39255.41116883306, 39608.0, 40012.799936000134, 20668.066727423804, 27225.0, 27239.727602724513, 27262.318442039108, 27297.044603438786], "value": 19288.029749286787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.2486711485767, 416.49603979185184, 418.9162167566486, 423.30155243847645, 428.2826266004442, 20740.688889666668, 20850.791492085093, 21433.0, 22522.54954900901, 22793.886030569825, 22235.44411389716, 22465.775342246572, 22548.8872555637, 22922.885385573092, 22955.885220573873, 5895.233619629442, 6163.414475624809, 6221.191245138149, 6225.159603453521, 6225.937740622581, 4379.781010949456, 4505.887352816189, 4623.306504024406, 6157.907631385533, 6294.7482100715915, 6584.045313429549, 6898.75854345098, 6903.344182302699, 6913.239543650195, 6923.965380173092, 6533.281339052701, 6798.2182049064, 6817.250102488722, 6848.2809305023, 6890.2076261230095, 4063.6952228582677, 5755.280589926259, 5986.341502434729, 6009.1587177795145, 6018.337982821886, 26742.465150696877, 26754.464910701678, 27144.1856744298, 27147.914083436637, 27166.049188278317, 2080.6150862090412, 2296.253717541789, 2297.276357947258, 2470.0737223541173, 2777.472280266743, 14523.709525809425, 14771.852281477155, 14793.482228122071, 14840.851591484055, 14940.551783446514, 1531.5328824708458, 1795.425463851568, 1806.8735188536807, 1901.4010586665156, 1980.6137803128395, 115420.0, 122109.0, 124087.0, 124311.0, 126278.3686081573, 11923.880761192451, 12127.454264558117, 12145.878541214475, 12197.146199765932, 12292.754144917231, 15915.283812228477, 15947.0, 15963.962342447703, 15974.520764377086, 15977.121258330671, 7591.3547348475995, 9267.490288034089, 9418.858717119248, 9495.76260593477, 9551.188149007274, 9374.625014999323, 9389.793398551335, 9407.717768466957, 9461.148496635336, 9515.857262141073, 4842.564169224786, 4900.632452566, 4911.533404326655, 4916.557509824133, 4988.90022199554, 1969.8621096523107, 2043.9049973776998, 2062.8143467088034, 2085.7392825896763, 2093.2150443583655, 930.7161315798611, 981.3964411886639, 981.5141504955093, 1003.3377970539409, 1014.7919676466307, 17623.383181588582, 20429.489262768253, 20712.378628641163, 20829.58340833175, 21570.35288941334, 914.6798620482778, 968.1963969904962, 1003.4029752297517, 1012.4583347908833, 1073.0503504398664, 11209.775804484028, 11478.081753459703, 11525.020373268198, 11541.538338466535, 11567.88432115685, 632257.0, 633112.0, 639891.0, 642604.0, 652241.0, 113386.0, 128129.0, 131017.0, 132396.3380183093, 136630.0, 932.6362718539775, 1070.2668671959732, 1100.0979197058334, 1116.771061932302, 1118.9888101119047, 16310.755338670167, 18828.905855471185, 19327.51681207981, 19747.111379988222, 20012.49968750793, 47863.28205076857, 52711.20933186082, 52897.0, 52981.73509132584, 53622.73188634032, 75754.0, 75964.62017689877, 75970.0, 78297.60851195708, 80880.0, 8411.0, 8553.700620478254, 8554.401191916755, 8650.524221167896, 8752.444851575645, 12313.384330783247, 12321.260724356567, 12663.873361266269, 12765.170263932814, 12804.039697022574, 10618.09746171584, 10769.353838769699, 11124.165687573302, 11278.379689117177, 11306.434678266218, 10656.0, 10842.457877105955, 10847.891521085005, 11151.832722509007, 11221.326720396803, 8539.76173454858, 10992.450377481255, 11139.997400234019, 11230.101591872794, 11276.436178191221, 8302.792430189294, 8721.651133954825, 11472.541098355972, 11791.587294444653, 12010.879891201326, 10240.743981400525, 11081.722956926142, 11434.542618295174, 11630.767384652429, 11677.124215683687], "value": 10106.48310737985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.240997091483, 1605.5022942887701, 1633.730434478311, 1919.1076149590438, 2036.8676036057655, 8314.79213019674, 8984.685536006242, 9144.177024067832, 9153.633854645806, 9170.495622740755, 7304.561726296426, 9088.545572721354, 9110.635574577025, 9111.043340449256, 9115.99724030356, 2538.5557527432716, 2572.5498037843395, 2573.819832611718, 2575.0, 2576.1627471071884, 2486.6021436570154, 2580.225932220336, 2586.767190952814, 2586.793056555471, 2588.896444142232, 2533.873306334676, 2572.305477521068, 2574.1376638825923, 2575.87120643968, 2578.948421031578, 2536.264483299841, 2555.897764089434, 2573.1122762646855, 2583.7803786678155, 2593.8314009589317, 2500.462400583883, 2553.8978440862343, 2557.0666706652123, 2560.577504711739, 2562.513122506736, 7519.736809211706, 8716.866807315071, 9087.136722011399, 9124.817503649956, 9163.08369163085, 5634.549236061105, 5752.712364381806, 5799.971000145015, 5801.7099145043, 5809.622374545641, 3648.8175591220333, 3731.9626803731885, 3791.4502397152532, 3798.8480460781534, 3804.144067584799, 1030.2685093583564, 1050.8844027157006, 1053.9051485366354, 1065.1585247654343, 1088.7985722641258, 12519.12366134371, 12591.055670824633, 12605.684857878627, 12607.369631518479, 12633.431495582721, 3791.829367678461, 4739.431268247832, 4850.938351200725, 4855.635827312965, 4865.221564549655, 9719.951400243095, 9728.17310528613, 9747.3664211826, 9753.0, 9761.170300524534, 5552.639078459968, 5594.608377413542, 5618.943810561842, 5622.32532096151, 5629.971850140805, 4620.145273124483, 4725.10223057618, 4774.331593576902, 4778.092162489116, 5217.2695822584865, 3426.229098452878, 3721.5162028936065, 3751.531058617673, 4103.0, 4108.8356465741035, 1227.7728620205112, 1258.8741125887339, 1260.3446207971804, 1267.8985681145487, 1269.9111062225556, 862.6808081010066, 927.888653361601, 939.5114540438933, 947.0718695678274, 968.8498282766183, 5672.376038635747, 5826.65040097587, 6040.456358927718, 6054.061620448838, 6189.721462534197, 916.9220616247694, 919.3794188922451, 923.6582464488048, 954.2175416158822, 968.0561452583815, 3744.700423966076, 3999.140184860269, 4027.7381970172432, 4089.0, 4091.4067460218102, 10859.728506787393, 11208.831867521994, 11271.492782824793, 11432.199746017699, 11442.256253343507, 11253.831192532118, 11253.887461125283, 11254.606088786853, 11265.54937802495, 11285.0, 8051.5571643559, 8631.568421578895, 8699.739007829776, 8711.738647840575, 8720.258778003814, 6059.969700151471, 6066.908996364969, 6096.0, 6115.877682446415, 6169.81490555284, 9658.806823863624, 10109.696709098738, 10118.49407529606, 10339.327943683937, 10343.27597068198, 9849.60601575929, 10361.689149325532, 10408.583656653649, 10441.321314114559, 10442.582296708046, 7068.081149450744, 7221.638918054181, 7694.038245219348, 7865.842683146419, 7994.0, 8510.48937063778, 8617.69838055665, 8687.956560217159, 8709.782255443411, 8710.346723995599, 6445.677716114269, 7523.1348394935285, 7567.621618919142, 7591.164971852982, 7770.261825126604, 7464.925350746423, 7474.551526908403, 7508.962455187689, 7524.0, 7603.467757256939, 6950.4787140965645, 7015.0529678494795, 7017.05269788572, 7026.227115017242, 7030.683619237045, 4302.204092242945, 4945.455999840086, 4986.6010719143105, 5080.161773307363, 5197.246399272009, 5107.700887299894, 5115.74421278942, 5146.588272938231, 5173.456787037307, 5177.223416487557], "value": 4733.519429203858, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.3313373253493, 339.80461234790005, 343.94496880499116, 349.6503496503498, 351.28688761813527, 6591.538592298541, 6606.942889137733, 6608.173978252718, 6637.137172167618, 6650.5012124090645, 6587.044878492616, 6598.8020359389175, 6626.337366263371, 6641.833954151149, 6660.134182556261, 4741.834035808747, 4865.464798872121, 4866.707997520142, 4994.250862370637, 5051.9494805051845, 4443.4445694288215, 4610.492845786977, 5027.195648696209, 5034.446210916796, 5036.294918711384, 4968.031233909389, 4971.105201063807, 4982.252662100677, 4984.526469985346, 4992.251162325644, 4678.929816052762, 4800.15997200492, 4908.9263661045115, 4928.901421971576, 4956.677815941952, 4225.19721252961, 4242.957570424287, 4243.681723870691, 4255.744655320691, 4258.87223383299, 5527.834164975057, 6177.567570270083, 6386.329435409261, 6401.199850018747, 6507.2191337039385, 4985.501449854985, 5753.769849206027, 5915.704214789286, 5943.959807033795, 5949.137375080632, 5664.26364572603, 7165.283471652793, 7173.820654483628, 7183.856322873566, 7201.13586369639, 4345.261305578059, 4800.279958006292, 4812.903741925177, 4815.0610630926985, 4833.371661683958, 7465.738699145504, 7523.586202758846, 7527.247275272483, 7536.284053014955, 7539.811504712371, 4869.488703686062, 4886.60907127429, 4891.33966914462, 4895.216765317532, 4899.730514821719, 4954.1825598775795, 4963.60291176705, 4967.801287948441, 4974.278729584263, 4997.7251251180805, 5708.486236238676, 5922.526197904157, 5939.524838012949, 5942.940570594325, 5947.0, 7177.856442871113, 7204.783856484314, 7215.314545118205, 7216.60308683017, 7234.565926044349, 1685.7471379292958, 1727.5681079730068, 1729.723244280909, 1731.3940120957816, 1732.0040976438347, 1035.694470131313, 1056.0442799266675, 1106.1085543720328, 1113.3320007995137, 1136.3352438823215, 6170.81487555374, 6654.6672666366485, 6807.863842723118, 6815.114035175396, 6841.24746277919, 7457.403407727369, 7491.0, 7492.700291988368, 7496.212897645778, 7501.587412692245, 6769.458443324522, 6890.20762612306, 6945.51381403307, 6948.33990770876, 6950.826229344206, 3771.4342848572387, 3899.6880249579967, 3940.2907476654477, 3941.2511622791576, 3946.7631942083567, 7747.031621047369, 7839.080459770115, 7850.8429831403055, 7858.0963189232825, 7892.684292628345, 7673.961630191925, 7678.961605191938, 7703.268189521987, 7714.884276735854, 7720.3051725344985, 7806.0, 7816.257455541714, 7818.843623127505, 7822.687092516349, 7849.960750196441, 7212.459065570209, 7359.337659610446, 7463.589502577411, 7470.402367810453, 7477.177510473734, 7253.673584688596, 7322.3775979042375, 7324.670389832364, 7345.412367010519, 7350.228226036403, 6250.374962503895, 7017.05269788572, 7066.646667666699, 7996.160403157817, 7998.760037198894, 4899.632527560519, 4905.23968784839, 4909.803607855646, 4924.975375123101, 4927.950720492892, 7177.318154775288, 7454.888176677463, 7470.738524151629, 7473.663685134074, 7498.400127989638, 7187.993680884785, 7254.0207072046705, 7257.927420725937, 7268.563886166847, 7278.890816637649, 7202.495825292389, 7221.602811845399, 7225.819354516179, 7231.63841807918, 7242.6740796663225, 7080.858382832417, 7083.82290442743, 7085.751998680022, 7093.0, 7097.929020709933, 6895.10363652742, 7111.466640001917, 7151.7854464366155, 7157.284271572801, 7229.168645605822, 6765.560238584476, 6785.89821152693, 6911.516193866582, 6927.549709268881, 7021.789346319619], "value": 5276.995024682827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.3386482044829, 746.0674157303373, 766.9118051424081, 767.5279702982667, 781.2695130053401, 13092.6252743462, 15392.307346169422, 15786.605334866605, 15818.60453488662, 15820.971636843597, 11385.430728463565, 14632.634184145401, 14632.926835365835, 14647.780283295733, 14674.779878301808, 755.8412733326008, 787.6573690444646, 948.3882895532378, 971.9988411935717, 972.5915115651443, 955.5652178258911, 958.8705524754139, 961.6345788600322, 963.2871674960513, 963.8843338799319, 809.3686924199134, 1034.2243317511866, 1036.7719101797593, 1037.4968140451874, 1043.327054050141, 824.9463784853965, 825.0017478850598, 827.8261565071342, 1003.3428104591504, 1032.1278519650882, 771.2287712287713, 774.0749803984241, 774.2064384006383, 774.8527779721835, 777.2538363171362, 15308.464203752927, 15365.846341536553, 15367.538973830691, 15386.15376154311, 15417.074975501506, 12921.547745828944, 13179.868201318055, 13284.269365184911, 13308.866911330957, 13392.86607133926, 10241.027102425332, 11246.887531124667, 11343.262687925258, 11627.709307267385, 11729.941350293278, 3215.0, 3516.1209697575605, 3546.078019714867, 3611.6749492545796, 3666.2484190740834, 86322.56838715829, 88959.0, 92002.61996069997, 92764.53617731936, 93158.0, 9530.01961155195, 9766.560504777302, 9784.608615655436, 9910.603575856885, 10013.998600139928, 21816.45458863541, 21961.23135690275, 22079.33761987143, 22081.0, 22165.335039948826, 7626.847463050819, 7654.693812247448, 7772.65023073963, 7773.067231932205, 8013.599320033975, 4260.6378457830815, 4335.219660461147, 4387.934180987288, 4406.449193850769, 4616.8614941551805, 3185.2036990752313, 3766.9246615067545, 3843.3466310726685, 3844.231153769257, 3844.8462061517785, 682.0, 693.3724978894008, 704.2007321689919, 707.6214225389494, 713.5825542057954, 560.4871542538532, 561.4694114062172, 621.8196722950294, 622.2781573374954, 637.5951270942985, 7310.305520975498, 8013.599320034092, 8534.829303413897, 8573.18554737299, 8652.826943461221, 559.9836297120713, 563.712506621626, 601.9367966363557, 619.4177473175291, 626.3298270850238, 3966.167104907944, 3992.1017771001293, 4060.573639767841, 4062.7968601569805, 4123.237201117803, 82101.17898821055, 91749.16501669929, 92513.0, 92542.07457925334, 92546.0, 77301.6134919333, 79661.0, 79882.20117798864, 79928.60035699785, 82742.75885861716, 64927.701445970815, 66050.33949660441, 66325.6683716588, 66581.0, 67511.64976700439, 6565.376289252514, 7581.658825352762, 7633.122190948112, 7857.646405911633, 7901.802454938443, 51000.489995099575, 51024.72438189075, 51317.0, 52046.0, 52620.736896316805, 52152.0, 58020.83958320726, 67804.32195677981, 72754.27245727475, 73038.0, 10143.695689129338, 10216.693499195037, 10304.536295866554, 10416.0, 10457.895421045692, 10738.0, 10842.620508282173, 12126.878731212928, 12150.817737734118, 12819.487220511448, 8527.319554503028, 11404.315741055232, 11791.705207369885, 12159.696007599881, 12438.440270188044, 11170.832437513282, 11705.063594912557, 11764.764704706029, 11803.468843902217, 12080.093992950387, 11391.772164556829, 11509.94245028803, 11615.0, 11630.94184529072, 12079.51681932713, 9677.70966870995, 9783.047703576602, 10078.748031299276, 10153.492325383553, 10343.431111288952, 9778.462184579916, 10037.996200380196, 10038.247131465316, 10175.135113515435, 10290.0], "value": 7054.547123296473, "unit": "score"}], "name": "dromaeo_css", "value": 7648.394749381321, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 119.0, 111.0, 110.0, 111.0, 111.0, 111.0, 113.0, 132.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 117.0, 143.0, 166.0, 126.0, 167.0, 168.0, 144.0, 168.0, 117.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 185.0, 184.0, 187.0, 185.0, 185.0, 186.0, 185.0, 184.0], "value": 185.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 83.0, 83.0, 209.0, 73.0, 81.0, 81.0, 89.0, 132.0, 56.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 143.0, 93.0, 124.0, 135.0, 132.0, 80.0, 78.0, 161.0], "value": 113.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 85.0, 87.0, 84.0, 89.0, 86.0, 87.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 92.0, 93.0, 94.0, 93.0, 92.0, 93.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 106.0, 136.0, 84.0, 83.0, 84.0, 83.0, 85.0, 87.0, 83.0], "value": 91.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 62.0, 62.0, 63.0, 65.0, 62.0, 78.0, 58.0, 56.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 69.0, 72.0, 73.0, 73.0, 67.0, 66.0, 67.0, 67.0], "value": 68.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 89.0, 104.0, 103.0, 69.0, 85.0, 102.0, 104.0, 107.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 126.0, 127.0, 135.0, 120.0, 127.0, 122.0, 145.0, 141.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 164.0, 160.0, 163.0, 168.0, 162.0, 163.0, 177.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 68.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1512.2, "alertThreshold": 2.0}]} 07:39:04 INFO - Return code: 0 07:39:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:39:04 ERROR - # TBPL SUCCESS # 07:39:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:39:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:39:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:39:04 INFO - 2016-07-21 07:39:04.256 screenresolution[2548:31136] starting screenresolution argv=screenresolution get 07:39:04 INFO - 2016-07-21 07:39:04.258 screenresolution[2548:31136] Display 0: 1600x1200x32@60 07:39:04 INFO - 2016-07-21 07:39:04.264 screenresolution[2549:31139] starting screenresolution argv=screenresolution list 07:39:04 INFO - Available Modes on Display 0 07:39:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:39:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:39:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:39:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:39:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:39:04 INFO - Intel Iris: 07:39:04 INFO - Chipset Model: Intel Iris 07:39:04 INFO - Type: GPU 07:39:04 INFO - Bus: Built-In 07:39:04 INFO - VRAM (Dynamic, Max): 1536 MB 07:39:04 INFO - Vendor: Intel (0x8086) 07:39:04 INFO - Device ID: 0x0a2e 07:39:04 INFO - Revision ID: 0x0009 07:39:04 INFO - Displays: 07:39:04 INFO - Display: 07:39:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:39:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:39:04 INFO - Display Serial Number: 1600x1200 60 07:39:04 INFO - Main Display: Yes 07:39:04 INFO - Mirror: Off 07:39:04 INFO - Online: Yes 07:39:04 INFO - Rotation: Supported 07:39:04 INFO - Return code: 0 07:39:04 INFO - Running post-action listener: _resource_record_post_action 07:39:04 INFO - Running post-run listener: _resource_record_post_run 07:39:05 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 352256; Write bytes: 492427264; Read time: 3; Write time: 1516 07:39:05 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 185876992; Write bytes: 187602944; Read time: 17484; Write time: 403 07:39:05 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 352256; Write bytes: 294866944; Read time: 3; Write time: 1075 07:39:05 INFO - Running post-run listener: _upload_blobber_files 07:39:05 INFO - Blob upload gear active. 07:39:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:39:05 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:39:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:39:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:07 INFO - (blobuploader) - INFO - Done attempting. 07:39:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:39:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:39:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:08 INFO - (blobuploader) - INFO - Done attempting. 07:39:08 INFO - (blobuploader) - INFO - Iteration through files over. 07:39:08 INFO - Return code: 0 07:39:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:39:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:39:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d9ba1a66e7f30f8d79b95638106dc14e1849098f7603a4dbb204214eae2d24731f5e1dbdbf0bbdd8128d2dfeedd763d1366e6dd50ae77c4cf4cb0ef0c7f89b67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e50e07580672c1314b0101d35325a9e2881b19aebd477441ebe3d1137a22c7ab0c1dbbf5c5a8a4921a35998063dd38521a5f6d944a01ba4e5bda413fe2648f23"} 07:39:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:39:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:39:08 INFO - Contents: 07:39:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d9ba1a66e7f30f8d79b95638106dc14e1849098f7603a4dbb204214eae2d24731f5e1dbdbf0bbdd8128d2dfeedd763d1366e6dd50ae77c4cf4cb0ef0c7f89b67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e50e07580672c1314b0101d35325a9e2881b19aebd477441ebe3d1137a22c7ab0c1dbbf5c5a8a4921a35998063dd38521a5f6d944a01ba4e5bda413fe2648f23"} 07:39:08 INFO - Running post-run listener: copy_logs_to_upload_dir 07:39:08 INFO - Copying logs to upload dir... 07:39:08 INFO - mkdir: /builds/slave/test/build/upload/logs 07:39:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.597550 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-21 07:39:09.489354) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 07:39:09.492984) ========= 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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d9ba1a66e7f30f8d79b95638106dc14e1849098f7603a4dbb204214eae2d24731f5e1dbdbf0bbdd8128d2dfeedd763d1366e6dd50ae77c4cf4cb0ef0c7f89b67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e50e07580672c1314b0101d35325a9e2881b19aebd477441ebe3d1137a22c7ab0c1dbbf5c5a8a4921a35998063dd38521a5f6d944a01ba4e5bda413fe2648f23"} build_url:https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d9ba1a66e7f30f8d79b95638106dc14e1849098f7603a4dbb204214eae2d24731f5e1dbdbf0bbdd8128d2dfeedd763d1366e6dd50ae77c4cf4cb0ef0c7f89b67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e50e07580672c1314b0101d35325a9e2881b19aebd477441ebe3d1137a22c7ab0c1dbbf5c5a8a4921a35998063dd38521a5f6d944a01ba4e5bda413fe2648f23"}' ========= master_lag: 0.52 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 07:39:10.026947) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:39:10.027564) ========= 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.k4RDGw3iPX/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.aEYTDlQMZW/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005212 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:39:10.062689) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 07:39:10.065242) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 07:39:10.071731) ========= ========= Total master_lag: 1.19 =========