builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0239 starttime: 1466702911.88 results: success (0) buildid: 20160623083527 builduid: 1aadf1fea30f4f37b775e5900b844b27 revision: f403cf3a053abd6036932519b3b7214dbcb76c30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:31.880681) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:31.881106) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:31.881398) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:31.906871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:31.907201) ========= 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.T0ODMy8FJl/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.az5i1IlFgn/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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-06-23 10:28:31-- 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% 18.5M=0.001s 2016-06-23 10:28:32 (18.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110854 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:32.040190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:32.040619) ========= 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.T0ODMy8FJl/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.az5i1IlFgn/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.025618 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:32.088789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 10:28:32.089095) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f403cf3a053abd6036932519b3b7214dbcb76c30 --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 f403cf3a053abd6036932519b3b7214dbcb76c30 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.T0ODMy8FJl/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.az5i1IlFgn/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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-06-23 10:28:32,174 truncating revision to first 12 chars 2016-06-23 10:28:32,174 Setting DEBUG logging. 2016-06-23 10:28:32,174 attempt 1/10 2016-06-23 10:28:32,174 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f403cf3a053a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 10:28:33,199 unpacking tar archive at: mozilla-beta-f403cf3a053a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.287721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 10:28:33.400383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:33.400760) ========= script_repo_revision: f403cf3a053abd6036932519b3b7214dbcb76c30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:33.401279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:33.401582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 10:28:33.419120) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-23 10:28:33.419432) ========= /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.T0ODMy8FJl/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.az5i1IlFgn/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 10:28:33 INFO - MultiFileLogger online at 20160623 10:28:33 in /builds/slave/test 10:28:33 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 10:28:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:28:33 INFO - {'append_to_log': False, 10:28:33 INFO - 'base_work_dir': '/builds/slave/test', 10:28:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:28:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:28:33 INFO - 'branch': 'Mozilla-Beta', 10:28:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:28:33 INFO - 'config_files': ('talos/mac_config.py',), 10:28:33 INFO - 'default_actions': ('clobber', 10:28:33 INFO - 'read-buildbot-config', 10:28:33 INFO - 'download-and-extract', 10:28:33 INFO - 'populate-webroot', 10:28:33 INFO - 'create-virtualenv', 10:28:33 INFO - 'install', 10:28:33 INFO - 'run-tests'), 10:28:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:28:33 INFO - 'download_minidump_stackwalk': True, 10:28:33 INFO - 'download_symbols': 'ondemand', 10:28:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:28:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:28:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:28:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:28:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:28:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:28:33 INFO - 'installer_path': 'installer.exe', 10:28:33 INFO - 'log_level': 'info', 10:28:33 INFO - 'log_name': 'talos', 10:28:33 INFO - 'log_to_console': True, 10:28:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:28:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:28:33 INFO - 'opt_config_files': (), 10:28:33 INFO - 'pip_index': False, 10:28:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:28:33 INFO - 'cmd': ('bash', 10:28:33 INFO - '-c', 10:28:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:28:33 INFO - 'enabled': True, 10:28:33 INFO - 'halt_on_failure': False, 10:28:33 INFO - 'name': 'check_screen_resolution'},), 10:28:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:28:33 INFO - 'cmd': ('bash', 10:28:33 INFO - '-c', 10:28:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:28:33 INFO - 'enabled': True, 10:28:33 INFO - 'halt_on_failure': False, 10:28:33 INFO - 'name': 'check_screen_resolution'},), 10:28:33 INFO - 'run_cmd_checks_enabled': True, 10:28:33 INFO - 'sps_profile': False, 10:28:33 INFO - 'sps_profile_interval': 0, 10:28:33 INFO - 'suite': 'dromaeojs', 10:28:33 INFO - 'system_bits': '32', 10:28:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:28:33 INFO - 'title': 't-yosemite-r7-0239', 10:28:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:28:33 INFO - 'use_talos_json': True, 10:28:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:28:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:28:33 INFO - 'work_dir': 'build'} 10:28:33 INFO - ##### 10:28:33 INFO - ##### Running clobber step. 10:28:33 INFO - ##### 10:28:33 INFO - Running pre-action listener: _resource_record_pre_action 10:28:33 INFO - Running main action method: clobber 10:28:33 INFO - rmtree: /builds/slave/test/build 10:28:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:28:35 INFO - Running post-action listener: _resource_record_post_action 10:28:35 INFO - ##### 10:28:35 INFO - ##### Running read-buildbot-config step. 10:28:35 INFO - ##### 10:28:35 INFO - Running pre-action listener: _resource_record_pre_action 10:28:35 INFO - Running main action method: read_buildbot_config 10:28:35 INFO - Using buildbot properties: 10:28:35 INFO - { 10:28:35 INFO - "project": "", 10:28:35 INFO - "product": "firefox", 10:28:35 INFO - "script_repo_revision": "production", 10:28:35 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:28:35 INFO - "repository": "", 10:28:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:28:35 INFO - "buildid": "20160623083527", 10:28:35 INFO - "pgo_build": "False", 10:28:35 INFO - "basedir": "/builds/slave/test", 10:28:35 INFO - "buildnumber": 14, 10:28:35 INFO - "slavename": "t-yosemite-r7-0239", 10:28:35 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:28:35 INFO - "platform": "yosemite_r7", 10:28:35 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:28:35 INFO - "branch": "mozilla-beta", 10:28:35 INFO - "repo_path": "releases/mozilla-beta", 10:28:35 INFO - "revision": "f403cf3a053abd6036932519b3b7214dbcb76c30", 10:28:35 INFO - "stage_platform": "macosx64", 10:28:35 INFO - "builduid": "1aadf1fea30f4f37b775e5900b844b27", 10:28:35 INFO - "slavebuilddir": "test" 10:28:35 INFO - } 10:28:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 10:28:35 INFO - Running post-action listener: _resource_record_post_action 10:28:35 INFO - ##### 10:28:35 INFO - ##### Running download-and-extract step. 10:28:35 INFO - ##### 10:28:35 INFO - Running pre-action listener: _resource_record_pre_action 10:28:35 INFO - Running main action method: download_and_extract 10:28:35 INFO - mkdir: /builds/slave/test/build/tests 10:28:35 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')]} 10:28:35 INFO - https://queue.taskcluster.net/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:28:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 10:28:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 10:28:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/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 10:28:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/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 10:28:36 INFO - Downloaded 1165 bytes. 10:28:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 10:28:36 INFO - Using the following test package requirements: 10:28:36 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 10:28:36 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:28:36 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 10:28:36 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:28:36 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 10:28:36 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:28:36 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:28:36 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 10:28:36 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 10:28:36 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:28:36 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 10:28:36 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:28:36 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 10:28:36 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:28:36 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 10:28:36 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:28:36 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 10:28:36 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 10:28:36 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')]} 10:28:36 INFO - https://queue.taskcluster.net/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:28:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:28:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:28:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/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 10:28:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/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 10:28:38 INFO - Downloaded 18301147 bytes. 10:28:38 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'] 10:28:38 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 10:28:41 INFO - Return code: 0 10:28:41 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 10:28:41 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')]} 10:28:41 INFO - https://queue.taskcluster.net/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:28:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:28:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:28:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/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 10:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/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 10:28:42 INFO - Downloaded 18301147 bytes. 10:28:42 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'] 10:28:42 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 10:28:46 INFO - Return code: 0 10:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:28:46 INFO - https://queue.taskcluster.net/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:28:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 10:28:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 10:28:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/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 10:28:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/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 10:28:47 INFO - Downloaded 10840145 bytes. 10:28:47 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'] 10:28:47 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 10:28:47 INFO - Return code: 0 10:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:28:47 INFO - https://queue.taskcluster.net/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:28:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:28:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:28:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 10:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qkrn12wFRx20yEMlvdC0zQ/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 10:28:50 INFO - Downloaded 86250668 bytes. 10:28:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:28:50 INFO - mkdir: /builds/slave/test/properties 10:28:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:28:50 INFO - Writing to file /builds/slave/test/properties/build_url 10:28:50 INFO - Contents: 10:28:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:28:51 INFO - Running post-action listener: _resource_record_post_action 10:28:51 INFO - Running post-action listener: set_extra_try_arguments 10:28:51 INFO - ##### 10:28:51 INFO - ##### Running populate-webroot step. 10:28:51 INFO - ##### 10:28:51 INFO - Running pre-action listener: _resource_record_pre_action 10:28:51 INFO - Running main action method: populate_webroot 10:28:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:28:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:28:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:28:51 INFO - '--tppagecycles', 10:28:51 INFO - '7'], 10:28:51 INFO - 'tests': ['tsvgm']}}, 10:28:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:28:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:28:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:28:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:28:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:28:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:28:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:51 INFO - 'talos_options': ['--disable-e10s'], 10:28:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:28:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:28:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:51 INFO - 'talos_options': ['--disable-e10s'], 10:28:51 INFO - 'tests': ['damp', 'tps']}, 10:28:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:51 INFO - 'tests': ['damp', 'tps']}, 10:28:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:28:51 INFO - 'tests': ['dromaeo_dom']}, 10:28:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:28:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:28:51 INFO - 'tests': ['a11yr', 10:28:51 INFO - 'ts_paint', 10:28:51 INFO - 'tpaint', 10:28:51 INFO - 'sessionrestore', 10:28:51 INFO - 'sessionrestore_no_auto_restore', 10:28:51 INFO - 'tabpaint']}, 10:28:51 INFO - 'other-e10s': {'tests': ['a11yr', 10:28:51 INFO - 'ts_paint', 10:28:51 INFO - 'tpaint', 10:28:51 INFO - 'sessionrestore', 10:28:51 INFO - 'sessionrestore_no_auto_restore', 10:28:51 INFO - 'tabpaint']}, 10:28:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:28:51 INFO - 'ts_paint', 10:28:51 INFO - 'tpaint', 10:28:51 INFO - 'sessionrestore', 10:28:51 INFO - 'sessionrestore_no_auto_restore', 10:28:51 INFO - 'tabpaint']}, 10:28:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:28:51 INFO - 'ts_paint', 10:28:51 INFO - 'tpaint', 10:28:51 INFO - 'sessionrestore', 10:28:51 INFO - 'sessionrestore_no_auto_restore', 10:28:51 INFO - 'tabpaint']}, 10:28:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:28:51 INFO - 'tests': ['a11yr', 10:28:51 INFO - 'ts_paint', 10:28:51 INFO - 'tpaint', 10:28:51 INFO - 'sessionrestore', 10:28:51 INFO - 'sessionrestore_no_auto_restore', 10:28:51 INFO - 'tabpaint']}, 10:28:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:28:51 INFO - 'tests': ['a11yr', 10:28:51 INFO - 'ts_paint', 10:28:51 INFO - 'tpaint', 10:28:51 INFO - 'sessionrestore', 10:28:51 INFO - 'sessionrestore_no_auto_restore', 10:28:51 INFO - 'tabpaint']}, 10:28:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:28:51 INFO - 'tests': ['tsvgx', 10:28:51 INFO - 'tsvgr_opacity', 10:28:51 INFO - 'tart', 10:28:51 INFO - 'tscrollx', 10:28:51 INFO - 'cart']}, 10:28:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:28:51 INFO - 'tsvgr_opacity', 10:28:51 INFO - 'tart', 10:28:51 INFO - 'tscrollx', 10:28:51 INFO - 'cart']}, 10:28:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:51 INFO - 'talos_options': ['--disable-e10s'], 10:28:51 INFO - 'tests': ['tp5o']}, 10:28:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:51 INFO - 'tests': ['tp5o']}, 10:28:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:51 INFO - 'talos_options': ['--disable-e10s', 10:28:51 INFO - '--xperf_path', 10:28:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:28:51 INFO - 'tests': ['tp5n']}, 10:28:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:51 INFO - 'talos_options': ['--xperf_path', 10:28:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:28:51 INFO - 'tests': ['tp5n']}}, 10:28:51 INFO - 'talos.zip': {'path': '', 10:28:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:28:51 INFO - Running post-action listener: _resource_record_post_action 10:28:51 INFO - ##### 10:28:51 INFO - ##### Running create-virtualenv step. 10:28:51 INFO - ##### 10:28:51 INFO - Running pre-action listener: _resource_record_pre_action 10:28:51 INFO - Running main action method: create_virtualenv 10:28:51 INFO - Creating virtualenv /builds/slave/test/build/venv 10:28:51 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 10:28:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:28:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:28:51 INFO - Using real prefix '/tools/python27' 10:28:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:28:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:28:55 INFO - Installing pip.................done. 10:28:55 INFO - Return code: 0 10:28:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:28:55 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')]} 10:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:55 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')]} 10:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:55 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 0x10a1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab985b31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ee00>, '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 0x109f07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a099b20>, '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.T0ODMy8FJl/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.az5i1IlFgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 10:28:55 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 10:28:55 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 10:28:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0ODMy8FJl/Render', 10:28:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:55 INFO - 'HOME': '/Users/cltbld', 10:28:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:55 INFO - 'LOGNAME': 'cltbld', 10:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:55 INFO - 'MOZ_NO_REMOTE': '1', 10:28:55 INFO - 'NO_EM_RESTART': '1', 10:28:55 INFO - 'PAGER': '/bin/cat', 10:28:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:55 INFO - 'PWD': '/builds/slave/test', 10:28:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:55 INFO - 'SHELL': '/bin/bash', 10:28:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.az5i1IlFgn/Listeners', 10:28:55 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 10:28:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:55 INFO - 'USER': 'cltbld', 10:28:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:55 INFO - 'XPC_FLAGS': '0x0', 10:28:55 INFO - 'XPC_SERVICE_NAME': '0', 10:28:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:55 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 10:28:55 INFO - Cleaning up... 10:28:55 INFO - Return code: 0 10:28:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:28:55 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')]} 10:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:55 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')]} 10:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:55 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 0x10a1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab985b31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ee00>, '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 0x109f07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a099b20>, '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.T0ODMy8FJl/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.az5i1IlFgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 10:28:55 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 10:28:55 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 10:28:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0ODMy8FJl/Render', 10:28:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:55 INFO - 'HOME': '/Users/cltbld', 10:28:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:55 INFO - 'LOGNAME': 'cltbld', 10:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:55 INFO - 'MOZ_NO_REMOTE': '1', 10:28:55 INFO - 'NO_EM_RESTART': '1', 10:28:55 INFO - 'PAGER': '/bin/cat', 10:28:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:55 INFO - 'PWD': '/builds/slave/test', 10:28:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:55 INFO - 'SHELL': '/bin/bash', 10:28:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.az5i1IlFgn/Listeners', 10:28:55 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 10:28:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:55 INFO - 'USER': 'cltbld', 10:28:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:55 INFO - 'XPC_FLAGS': '0x0', 10:28:55 INFO - 'XPC_SERVICE_NAME': '0', 10:28:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:55 INFO - Downloading/unpacking psutil>=0.7.1 10:28:55 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 10:28:55 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 10:28:55 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 10:28:55 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 10:28:55 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 10:28:55 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 10:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:28:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:28:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:28:58 INFO - Installing collected packages: psutil 10:28:58 INFO - Running setup.py install for psutil 10:28:58 INFO - building 'psutil._psutil_osx' extension 10:28:58 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 10:28:59 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 10:28:59 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 10:28:59 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 10:28:59 INFO - building 'psutil._psutil_posix' extension 10:28:59 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 10:28:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:28:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:28:59 INFO - ^ 10:28:59 INFO - 1 warning generated. 10:28:59 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 10:28:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:28:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:29:00 INFO - Successfully installed psutil 10:29:00 INFO - Cleaning up... 10:29:00 INFO - Return code: 0 10:29:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:29: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')]} 10:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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')]} 10:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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', '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 0x10a1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab985b31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ee00>, '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 0x109f07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a099b20>, '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.T0ODMy8FJl/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.az5i1IlFgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 10:29: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:29: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 mozsystemmonitor==0.0.0 10:29:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0ODMy8FJl/Render', 10:29:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:00 INFO - 'HOME': '/Users/cltbld', 10:29:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:00 INFO - 'LOGNAME': 'cltbld', 10:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:00 INFO - 'MOZ_NO_REMOTE': '1', 10:29:00 INFO - 'NO_EM_RESTART': '1', 10:29:00 INFO - 'PAGER': '/bin/cat', 10:29:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:00 INFO - 'PWD': '/builds/slave/test', 10:29:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:00 INFO - 'SHELL': '/bin/bash', 10:29:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.az5i1IlFgn/Listeners', 10:29:00 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 10:29:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:00 INFO - 'USER': 'cltbld', 10:29:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:00 INFO - 'XPC_FLAGS': '0x0', 10:29:00 INFO - 'XPC_SERVICE_NAME': '0', 10:29:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:29:02 INFO - Installing collected packages: mozsystemmonitor 10:29:02 INFO - Running setup.py install for mozsystemmonitor 10:29:02 INFO - Successfully installed mozsystemmonitor 10:29:02 INFO - Cleaning up... 10:29:03 INFO - Return code: 0 10:29:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:29: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')]} 10:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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')]} 10:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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', '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 0x10a1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab985b31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ee00>, '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 0x109f07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a099b20>, '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.T0ODMy8FJl/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.az5i1IlFgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 10:29: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:29: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 blobuploader==1.2.4 10:29:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0ODMy8FJl/Render', 10:29:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:03 INFO - 'HOME': '/Users/cltbld', 10:29:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:03 INFO - 'LOGNAME': 'cltbld', 10:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:03 INFO - 'MOZ_NO_REMOTE': '1', 10:29:03 INFO - 'NO_EM_RESTART': '1', 10:29:03 INFO - 'PAGER': '/bin/cat', 10:29:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:03 INFO - 'PWD': '/builds/slave/test', 10:29:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:03 INFO - 'SHELL': '/bin/bash', 10:29:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.az5i1IlFgn/Listeners', 10:29:03 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 10:29:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:03 INFO - 'USER': 'cltbld', 10:29:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:03 INFO - 'XPC_FLAGS': '0x0', 10:29:03 INFO - 'XPC_SERVICE_NAME': '0', 10:29:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:03 INFO - Downloading/unpacking blobuploader==1.2.4 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:29:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:29:05 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 10:29:05 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 10:29:05 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 10:29:05 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 10:29:05 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 10:29:05 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 10:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:29:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29: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 10:29:06 INFO - Downloading docopt-0.6.1.tar.gz 10:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:29:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:29:07 INFO - Running setup.py install for blobuploader 10:29:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:29:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:29:07 INFO - Running setup.py install for requests 10:29:07 INFO - Running setup.py install for docopt 10:29:07 INFO - Successfully installed blobuploader requests docopt 10:29:07 INFO - Cleaning up... 10:29:07 INFO - Return code: 0 10:29:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:07 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 0x10a1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab985b31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ee00>, '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 0x109f07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a099b20>, '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.T0ODMy8FJl/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.az5i1IlFgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 10:29:07 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 10:29:07 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 10:29:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0ODMy8FJl/Render', 10:29:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:07 INFO - 'HOME': '/Users/cltbld', 10:29:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:07 INFO - 'LOGNAME': 'cltbld', 10:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:07 INFO - 'MOZ_NO_REMOTE': '1', 10:29:07 INFO - 'NO_EM_RESTART': '1', 10:29:07 INFO - 'PAGER': '/bin/cat', 10:29:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:07 INFO - 'PWD': '/builds/slave/test', 10:29:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:07 INFO - 'SHELL': '/bin/bash', 10:29:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.az5i1IlFgn/Listeners', 10:29:07 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 10:29:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:07 INFO - 'USER': 'cltbld', 10:29:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:07 INFO - 'XPC_FLAGS': '0x0', 10:29:07 INFO - 'XPC_SERVICE_NAME': '0', 10:29:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:08 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-9oprZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:08 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-E1NTm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:08 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-LbZUT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:08 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-UVyx4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:08 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-OIomXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:08 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-u8uBjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:08 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-YF_vqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:08 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-XSbWxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:08 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-93Vxnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:09 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-3pzeK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:09 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-yc4KoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:09 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-fkjQxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:09 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-PZ7_Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:09 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-kkwuQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:09 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-NicQpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:09 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-yiHUGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:09 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-XdqEG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:29:09 INFO - Running setup.py install for manifestparser 10:29:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:29:10 INFO - Running setup.py install for mozcrash 10:29:10 INFO - Running setup.py install for mozdebug 10:29:10 INFO - Running setup.py install for mozdevice 10:29:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:29:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:29:10 INFO - Running setup.py install for mozfile 10:29:10 INFO - Running setup.py install for mozhttpd 10:29:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:29:10 INFO - Running setup.py install for mozinfo 10:29:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:29:10 INFO - Running setup.py install for mozInstall 10:29:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:29:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:29:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:29:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:29:11 INFO - Running setup.py install for mozleak 10:29:11 INFO - Running setup.py install for mozlog 10:29:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:29:11 INFO - Running setup.py install for moznetwork 10:29:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:29:11 INFO - Running setup.py install for mozprocess 10:29:11 INFO - Running setup.py install for mozprofile 10:29:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:29:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:29:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:29:11 INFO - Running setup.py install for mozrunner 10:29:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:29:11 INFO - Running setup.py install for mozscreenshot 10:29:12 INFO - Running setup.py install for moztest 10:29:12 INFO - Running setup.py install for mozversion 10:29:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:29:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:29:12 INFO - Cleaning up... 10:29:12 INFO - Return code: 0 10:29:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:12 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 0x10a1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab985b31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ee00>, '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 0x109f07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a099b20>, '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.T0ODMy8FJl/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.az5i1IlFgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 10:29:12 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 10:29:12 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 10:29:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0ODMy8FJl/Render', 10:29:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:12 INFO - 'HOME': '/Users/cltbld', 10:29:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:12 INFO - 'LOGNAME': 'cltbld', 10:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:12 INFO - 'MOZ_NO_REMOTE': '1', 10:29:12 INFO - 'NO_EM_RESTART': '1', 10:29:12 INFO - 'PAGER': '/bin/cat', 10:29:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:12 INFO - 'PWD': '/builds/slave/test', 10:29:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:12 INFO - 'SHELL': '/bin/bash', 10:29:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.az5i1IlFgn/Listeners', 10:29:12 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 10:29:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:12 INFO - 'USER': 'cltbld', 10:29:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:12 INFO - 'XPC_FLAGS': '0x0', 10:29:12 INFO - 'XPC_SERVICE_NAME': '0', 10:29:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:12 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-igETN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29:12 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)) 10:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:12 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-JVASsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29:12 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)) 10:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:12 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-KLtotf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29:13 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)) 10:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-xIv8zD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29:13 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)) 10:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-AqAad_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29:13 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)) 10:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-0Eb50x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29:13 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)) 10:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-VaUrce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29:13 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)) 10:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-vCUFcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29:13 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)) 10:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-5YjuHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29:13 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)) 10:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-yUxkTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:13 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)) 10:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-LdANfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:13 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)) 10:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-gVTjlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:13 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)) 10:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-ex40VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29:14 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)) 10:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:14 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-5NxeWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29:14 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)) 10:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:14 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-I64qY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:14 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)) 10:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:14 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-wu0Mbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29:14 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)) 10:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:14 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-YdcKko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29:14 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)) 10:29:14 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)) 10:29:14 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)) 10:29:14 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)) 10:29:14 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)) 10:29:14 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)) 10:29:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:29:14 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 10:29:14 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 10:29:14 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 10:29:14 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 10:29:14 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 10:29:14 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 10:29:16 INFO - Downloading blessings-1.6.tar.gz 10:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:29:17 INFO - Installing collected packages: blessings 10:29:17 INFO - Running setup.py install for blessings 10:29:17 INFO - Successfully installed blessings 10:29:17 INFO - Cleaning up... 10:29:17 INFO - Return code: 0 10:29:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:17 INFO - Reading from file tmpfile_stdout 10:29:17 INFO - Current package versions: 10:29:17 INFO - blessings == 1.6 10:29:17 INFO - blobuploader == 1.2.4 10:29:17 INFO - docopt == 0.6.1 10:29:17 INFO - manifestparser == 1.1 10:29:17 INFO - mozInstall == 1.12 10:29:17 INFO - mozcrash == 0.17 10:29:17 INFO - mozdebug == 0.1 10:29:17 INFO - mozdevice == 0.48 10:29:17 INFO - mozfile == 1.2 10:29:17 INFO - mozhttpd == 0.7 10:29:17 INFO - mozinfo == 0.9 10:29:17 INFO - mozleak == 0.1 10:29:17 INFO - mozlog == 3.1 10:29:17 INFO - moznetwork == 0.27 10:29:17 INFO - mozprocess == 0.22 10:29:17 INFO - mozprofile == 0.28 10:29:17 INFO - mozrunner == 6.11 10:29:17 INFO - mozscreenshot == 0.1 10:29:17 INFO - mozsystemmonitor == 0.0 10:29:17 INFO - moztest == 0.7 10:29:17 INFO - mozversion == 1.4 10:29:17 INFO - psutil == 3.1.1 10:29:17 INFO - requests == 1.2.3 10:29:17 INFO - wsgiref == 0.1.2 10:29:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29: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')]} 10:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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')]} 10:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:17 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 0x10a1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab985b31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ee00>, '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 0x109f07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a099b20>, '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.T0ODMy8FJl/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.az5i1IlFgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 10:29:17 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 10:29:17 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 10:29:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0ODMy8FJl/Render', 10:29:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:17 INFO - 'HOME': '/Users/cltbld', 10:29:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:17 INFO - 'LOGNAME': 'cltbld', 10:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:17 INFO - 'MOZ_NO_REMOTE': '1', 10:29:17 INFO - 'NO_EM_RESTART': '1', 10:29:17 INFO - 'PAGER': '/bin/cat', 10:29:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:17 INFO - 'PWD': '/builds/slave/test', 10:29:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:17 INFO - 'SHELL': '/bin/bash', 10:29:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.az5i1IlFgn/Listeners', 10:29:17 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 10:29:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:17 INFO - 'USER': 'cltbld', 10:29:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:17 INFO - 'XPC_FLAGS': '0x0', 10:29:17 INFO - 'XPC_SERVICE_NAME': '0', 10:29:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:17 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)) 10:29:17 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)) 10:29:17 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)) 10:29:17 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)) 10:29:17 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)) 10:29:17 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)) 10:29:17 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)) 10:29:17 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)) 10:29:17 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)) 10:29:17 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)) 10:29:17 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)) 10:29:17 INFO - Cleaning up... 10:29:17 INFO - Return code: 0 10:29:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:29: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')]} 10:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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')]} 10:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:17 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 0x10a1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab985b31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ee00>, '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 0x109f07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a099b20>, '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.T0ODMy8FJl/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.az5i1IlFgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 10:29:17 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 10:29:17 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 10:29:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0ODMy8FJl/Render', 10:29:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:17 INFO - 'HOME': '/Users/cltbld', 10:29:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:17 INFO - 'LOGNAME': 'cltbld', 10:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:17 INFO - 'MOZ_NO_REMOTE': '1', 10:29:17 INFO - 'NO_EM_RESTART': '1', 10:29:17 INFO - 'PAGER': '/bin/cat', 10:29:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:17 INFO - 'PWD': '/builds/slave/test', 10:29:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:17 INFO - 'SHELL': '/bin/bash', 10:29:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.az5i1IlFgn/Listeners', 10:29:17 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 10:29:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:17 INFO - 'USER': 'cltbld', 10:29:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:17 INFO - 'XPC_FLAGS': '0x0', 10:29:17 INFO - 'XPC_SERVICE_NAME': '0', 10:29:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:18 INFO - Downloading/unpacking jsonschema 10:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:29:20 INFO - Downloading/unpacking functools32 (from jsonschema) 10:29:20 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 10:29:20 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 10:29:20 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 10:29:20 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 10:29:20 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 10:29:20 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 10:29:20 INFO - Downloading functools32-3.2.3-2.tar.gz 10:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:29:21 INFO - warning: no files found matching '*.txt' 10:29:21 INFO - no previously-included directories found matching 'build' 10:29:21 INFO - no previously-included directories found matching 'dist' 10:29:21 INFO - no previously-included directories found matching '.git*' 10:29:21 INFO - Installing collected packages: jsonschema, functools32 10:29:21 INFO - Running setup.py install for functools32 10:29:21 INFO - warning: no files found matching '*.txt' 10:29:21 INFO - no previously-included directories found matching 'build' 10:29:21 INFO - no previously-included directories found matching 'dist' 10:29:21 INFO - no previously-included directories found matching '.git*' 10:29:21 INFO - Successfully installed jsonschema functools32 10:29:21 INFO - Cleaning up... 10:29:21 INFO - Return code: 0 10:29:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab985b31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ee00>, '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 0x109f07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a099b20>, '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.T0ODMy8FJl/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.az5i1IlFgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 10:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:29:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0ODMy8FJl/Render', 10:29:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:21 INFO - 'HOME': '/Users/cltbld', 10:29:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:21 INFO - 'LOGNAME': 'cltbld', 10:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:21 INFO - 'MOZ_NO_REMOTE': '1', 10:29:21 INFO - 'NO_EM_RESTART': '1', 10:29:21 INFO - 'PAGER': '/bin/cat', 10:29:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:21 INFO - 'PWD': '/builds/slave/test', 10:29:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:21 INFO - 'SHELL': '/bin/bash', 10:29:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.az5i1IlFgn/Listeners', 10:29:21 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 10:29:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:21 INFO - 'USER': 'cltbld', 10:29:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:21 INFO - 'XPC_FLAGS': '0x0', 10:29:21 INFO - 'XPC_SERVICE_NAME': '0', 10:29:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:21 INFO - Downloading/unpacking flake8 10:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:29:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:29:24 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 10:29:24 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 10:29:24 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 10:29:24 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 10:29:24 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 10:29:24 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 10:29:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:29:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:29:24 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 10:29:24 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 10:29:24 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 10:29:24 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 10:29:24 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 10:29:24 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 10:29:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:29:24 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 10:29:24 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 10:29:24 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 10:29:24 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 10:29:24 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 10:29:24 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 10:29:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:29:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:29:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:29:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:29:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:29:25 INFO - no previously-included directories found matching 'docs/_build' 10:29:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:29:25 INFO - Running setup.py install for pep8 10:29:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:29:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:29:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:29:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:29:25 INFO - no previously-included directories found matching 'docs/_build' 10:29:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:29:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:29:25 INFO - Cleaning up... 10:29:25 INFO - Return code: 0 10:29:25 INFO - Running post-action listener: _resource_record_post_action 10:29:25 INFO - Running post-action listener: _start_resource_monitoring 10:29:25 INFO - Starting resource monitoring. 10:29:25 INFO - ##### 10:29:25 INFO - ##### Running install step. 10:29:25 INFO - ##### 10:29:25 INFO - Running pre-action listener: _resource_record_pre_action 10:29:25 INFO - Running main action method: install 10:29:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:26 INFO - Reading from file tmpfile_stdout 10:29:26 INFO - Detecting whether we're running mozinstall >=1.0... 10:29:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:29:26 INFO - Reading from file tmpfile_stdout 10:29:26 INFO - Output received: 10:29:26 INFO - Usage: mozinstall [options] installer 10:29:26 INFO - Options: 10:29:26 INFO - -h, --help show this help message and exit 10:29:26 INFO - -d DEST, --destination=DEST 10:29:26 INFO - Directory to install application into. [default: 10:29:26 INFO - "/builds/slave/test"] 10:29:26 INFO - --app=APP Application being installed. [default: firefox] 10:29:26 INFO - mkdir: /builds/slave/test/build/application 10:29:26 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'] 10:29:26 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 10:29:48 INFO - Reading from file tmpfile_stdout 10:29:48 INFO - Output received: 10:29:48 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:29:48 INFO - Running post-action listener: _resource_record_post_action 10:29:48 INFO - ##### 10:29:48 INFO - ##### Running run-tests step. 10:29:48 INFO - ##### 10:29:48 INFO - Running pre-action listener: _resource_record_pre_action 10:29:48 INFO - Running main action method: run_tests 10:29:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:29:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:29:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:29:48 INFO - 2016-06-23 10:29:48.028 screenresolution[1656:7521] starting screenresolution argv=screenresolution get 10:29:48 INFO - 2016-06-23 10:29:48.031 screenresolution[1656:7521] Display 0: 1600x1200x32@60 10:29:48 INFO - 2016-06-23 10:29:48.036 screenresolution[1657:7523] starting screenresolution argv=screenresolution list 10:29:48 INFO - Available Modes on Display 0 10:29:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:29:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:29:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:29:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:29:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:29:48 INFO - Intel Iris: 10:29:48 INFO - Chipset Model: Intel Iris 10:29:48 INFO - Type: GPU 10:29:48 INFO - Bus: Built-In 10:29:48 INFO - VRAM (Dynamic, Max): 1536 MB 10:29:48 INFO - Vendor: Intel (0x8086) 10:29:48 INFO - Device ID: 0x0a2e 10:29:48 INFO - Revision ID: 0x0009 10:29:48 INFO - Displays: 10:29:48 INFO - Display: 10:29:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:29:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:29:48 INFO - Display Serial Number: 1600x1200 60 10:29:48 INFO - Main Display: Yes 10:29:48 INFO - Mirror: Off 10:29:48 INFO - Online: Yes 10:29:48 INFO - Rotation: Supported 10:29:48 INFO - Return code: 0 10:29:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:29:48 INFO - Python 2.7.3 10:29:48 INFO - Return code: 0 10:29:48 INFO - grabbing minidump binary from tooltool 10:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:29:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ee00>, '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 0x109f07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a099b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:29:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:29:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:29:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:29:48 INFO - Return code: 0 10:29:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:29:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:29:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:29:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:29:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:29:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:29:49 INFO - Return code: 0 10:29:49 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/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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 10:29:49 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/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0239 --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 10:29:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0ODMy8FJl/Render', 10:29:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:49 INFO - 'HOME': '/Users/cltbld', 10:29:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:49 INFO - 'LOGNAME': 'cltbld', 10:29:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:29:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:49 INFO - 'MOZ_NO_REMOTE': '1', 10:29:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:29:49 INFO - 'NO_EM_RESTART': '1', 10:29:49 INFO - 'PAGER': '/bin/cat', 10:29:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:49 INFO - 'PWD': '/builds/slave/test', 10:29:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:29:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:49 INFO - 'SHELL': '/bin/bash', 10:29:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.az5i1IlFgn/Listeners', 10:29:49 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 10:29:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:49 INFO - 'USER': 'cltbld', 10:29:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:49 INFO - 'XPC_FLAGS': '0x0', 10:29:49 INFO - 'XPC_SERVICE_NAME': '0', 10:29:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:49 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/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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 10:29:49 INFO - mozversion application_buildid: 20160623083527 10:29:49 INFO - mozversion application_changeset: f403cf3a053abd6036932519b3b7214dbcb76c30 10:29:49 INFO - mozversion application_display_name: Firefox 10:29:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:29:49 INFO - mozversion application_name: Firefox 10:29:49 INFO - mozversion application_remotingname: firefox 10:29:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:29:49 INFO - mozversion application_vendor: Mozilla 10:29:49 INFO - mozversion application_version: 48.0 10:29:49 INFO - mozversion platform_buildid: 20160623083527 10:29:49 INFO - mozversion platform_changeset: f403cf3a053abd6036932519b3b7214dbcb76c30 10:29:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:29:49 INFO - mozversion platform_version: 48.0 10:29:49 INFO - using testdate: 1466702989 10:29:49 INFO - actual date: 1466702989 10:29:49 INFO - starting webserver on 'localhost:49285' 10:29:49 INFO - SUITE-START | Running 2 tests 10:29:49 INFO - TEST-START | dromaeo_css 10:29:49 INFO - operating with platform_type : mac_ 10:29:49 INFO - Initialising browser for dromaeo_css test... 10:29:49 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpKDNQ3e/profile http://localhost:49285/getInfo.html) 10:29:52 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 10:29:52 INFO - PROCESS | 1675 | colorDepth:24 10:29:52 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 10:29:52 INFO - PROCESS | 1675 | __metrics 10:29:52 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:29:52 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:29:52 INFO - TEST-INFO | 1675: exit 0 10:29:52 INFO - Browser initialized. 10:29:52 INFO - Running cycle 1/1 for dromaeo_css test... 10:29:52 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpKDNQ3e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:04 INFO - PROCESS | 1679 | RSS: Main: 160886784 10:30:04 INFO - PROCESS | 1679 | 10:30:56 INFO - PROCESS | 1679 | 1466703056073 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] 10:33:05 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49285/tests/dromaeo/cssquery-ext.html) 10:33:07 INFO - PROCESS | 1679 | RSS: Main: 266952704 10:33:07 INFO - PROCESS | 1679 | 10:36:09 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-ext.html (next: http://localhost:49285/tests/dromaeo/cssquery-jquery.html) 10:36:10 INFO - PROCESS | 1679 | RSS: Main: 308793344 10:36:10 INFO - PROCESS | 1679 | 10:39:12 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49285/tests/dromaeo/cssquery-mootools.html) 10:39:13 INFO - PROCESS | 1679 | RSS: Main: 310382592 10:39:13 INFO - PROCESS | 1679 | 10:42:15 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49285/tests/dromaeo/cssquery-prototype.html) 10:42:15 INFO - PROCESS | 1679 | RSS: Main: 306814976 10:42:15 INFO - PROCESS | 1679 | 10:45:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49285/tests/dromaeo/cssquery-yui.html) 10:45:19 INFO - PROCESS | 1679 | RSS: Main: 273616896 10:45:19 INFO - PROCESS | 1679 | 10:48:22 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-yui.html (next: http://localhost:49285/tests/dromaeo/cssquery-dojo.html) 10:48:22 INFO - PROCESS | 1679 | RSS: Main: 317898752 10:48:22 INFO - PROCESS | 1679 | 10:48:22 INFO - PROCESS | 1679 | __start_tp_report 10:48:22 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 10:48:22 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 10:48:22 INFO - PROCESS | 1679 | |i|pagename|runs| 10:48:22 INFO - PROCESS | 1679 | |0;dojo.html;3559.750817442779;3573.8213089345527;3612.825831604729;3624.8187590620464;3682.907927301817;5862.85342866428;5873.706314684259;5878.382769809173;5903.055511118222;5931.822045338641;5865.794697185599;5908.350081491032;5911.970440147804;5925.9925812611855;5929.051351783704;5225.790968361261;5294.92057619136;5350;5382.138857782736;5444.537214336786;4452.97773511132;5385.380681221671;5424.728763561826;5425.6202065855405;5438.755256013469;5304.814331498398;5349.866253343658;5382.2195781611645;5391.379991300992;5416.377116631598;5457.2359869618285;5474.343078830526;5491.28613280275;5492.231087647732;5501.394846566875;5164.741762911839;5277.393099793535;5358.839234822923;5408.215808707715;5423.864403389947;4749.715017098985;5742.483176514133;5823.767049318022;5862.267216597926;5884.999550076497;6328.430441260309;6335;6361.9045714314325;6371.872562548723;6374.936250637481;6144.525313924671;6264.21697287839;6298.748050077991;6316.399942005502;6321.620702757803;6066.481719018769;6079.300880398767;6084.785052679768;6089.634621922699;6114.755409783648;6440;6451.9354806452275;6452.516061295421;6457.870842583216;6483.675816209171;6113.938860611426;6208.689565521706;6309.716062777186;6336.1762970814425;6345.714442850082;6309.526785491106;6325.778597749057;6349.492040636738;6360.586561873556;6360.681965901779;6244.906326405107;6299.6850157491945;6302.338254483305;6313.589616674902;6326.2092238470195;6179.073139029181;6219.937800622027;6321.241451025906;6323.462505686976;6329.050642403677;5000.149974504343;5032.119379108714;5039.3952725672425;5054.620903432257;5060.468650791688;4564.292534657134;4569.063342014879;4571.565701258442;4573.748443835621;4660.1145782301255;5839.094940284178;5883.61756485827;5981.192539007266;6050.757969681252;6055;6274.814173557413;6317.684115794192;6318.71565779541;6318.8420289492215;6321.273053598803;5977.671228082497;5981.043033114681;5995.280566332068;6007.038873780174;6024.216851809324;5372.892542149213;5440.619156659075;5490.615656904059;5504.724763761796;5514.448555144453;6539.411452969255;6543.803685889431;6549.148610680676;6555.868882622416;6569.080328753883;6306.779262725782;6309.90535141964;6315.242170939517;6324.557280990287;6333.714982825876;6360.681965901779;6388.393102655426;6472.061551074974;6477.481801455967;6512.381323774234;6330.303666596578;6341.143945567289;6345.238571371465;6354.714037868214;6356.618602883842;6243.250809902659;6243.8126856194385;6247.625142491465;6313.210848643919;6325.715342809676;6161.691915404302;6279.152314437492;6291.653959032297;6292.119103325446;6321.241451025906;5162.793488260428;6296.716647750954;6300.149479820166;6310.716017779303;6354.269259035085;5800.477956983892;5902.1441890926435;6226.782062627786;6227.626342419288;6244.375562443719;6145.924463219008;6189.50483961273;6276.058591211355;6294.968525157528;6299.622022678654;6153.292371377349;6184.907226391698;6222.782202622887;6228.283747369111;6232 10:48:22 INFO - PROCESS | 1679 | |1;ext.html;490.7570752477524;555.1921953557575;555.547229008358;604.036561684114;619.5291578400414;28287.575686364697;30557.388852222943;39416;40327.39508907369;40469.19061618766;36857.81571092147;45057.620678449086;45388.54611453885;45530.317045244345;45542.77228613853;9039.096090390974;9705.563249653766;9921.900780992206;9929.503524823765;9957.153641940444;11855.347955862424;12120.93939530301;12122.878771212307;12150.817737733942;12166.939165304206;11795.705107372341;11863.050955923505;11874.28754274742;11876.821847672292;11879.227850189753;11870.287782733063;11896;11924.523019079226;11927.821082683766;11934.343611101385;10126.54430550627;11649.41752912351;11768.882311176863;11775.470103845262;12064.577739779153;42126.157476850596;42601.14797704059;42612.3608145878;42689.14621707548;42743.786281068395;3308.9172770680684;3333.4666453367586;3381.560397148355;3409.2840503494294;3439.914002149966;28904.27739306513;29255.853720731473;30221.395572088655;30914;30934;2769.9723002769915;2779.027340430853;2785.470760555488;2830.40561482089;2866.971330286712;461754;462412;463856;467233.6638316787;469107;37421.62578374236;38036;38131.42802857959;64857.02714459287;66013.00980485296;36829.63170368315;37004;37067.814660926524;37111.25777484489;37134.628653713655;16246.918765406097;16411.261493232832;16421.83578164227;16444.013359198485;16458.42395516151;12020.579279725167;12128.818067728991;12129.87870121305;12133.029357651367;13941.02412831092;8357.038940521796;8584.442011269248;8609.440386374865;8618.698345557876;8666.956665216634;3404.6425125361975;3458.5849698036395;3470.132466883279;3473.2706131712116;3496.860125594948;970.762278095434;1003.1473247739364;1048.1038711901367;1077.8275475923815;1099.741560733227;30040.54939175914;30273.545896811567;30599.79281596806;31380.686193137775;31443.52834707481;1114.053054903342;1116.5143162724241;1139.920205585601;1157.739508610556;1164.895159435655;15910.76133857993;16007.759883601755;16017.519474415787;16226;16302.60047281324;638671;647544;647801;650447;651649;55101.72449137729;63368.683156583924;64092.35907640864;64138.03792943016;64276;1415;1455.8398576156615;1494.4321157959905;1505.3376514333877;1537.5233677559993;29394.853025734734;29701;31285.843570782;31406.52890206603;31575;51514.74242628913;51739.74130129476;51873.740631296605;51918.480815192874;52610.736946315024;426545;440592;440986;441105;441180;23962;25011.749882500942;27917.58123628188;27918.30204244829;28582.85668573234;45769.54230457786;46209;46245.76877115593;47282.763586183224;47694.28458573055;30256.697433026267;37582;38152.236955261294;38356.80821595874;38930.221395572495;32625.836870815496;39571.406428903014;41132.58867411407;41239.381409278285;41861.953451163965;38695;38889.6111038886;39060;39910.60089399069;40470.59529404668;31734;32745.853895113556;32835.67164328326;32842.67157328492;32971.50542741813;23471.765282346958;24579.754202457745;24686.753132468446;25144.874275628506;25159.87420062888 10:48:22 INFO - PROCESS | 1679 | |2;jquery.html;397.42175135178314;413.8779060177246;417.847485667731;419.8068888311375;429.00470907494605;15851.524454266362;18940.337088201897;20874.060667269972;21560.02979865906;21786.89106554465;20959.6856047159;21217.151313947463;22079.33761987143;22089.558208835813;22100.668489972664;5720.370759216483;6113.449789518942;6224.502039836825;6227.501799856023;6241.968790156043;6046.54650901182;6182.536309776762;6182.84542886427;6197.16338294329;6203.348648391921;4358.498772641139;6469.83825404364;6781.864362712743;6785.491088168383;6795.286494918012;6482.546221764478;6729.057931889515;6753.864922701568;6757.763478278237;6768.492363072789;5901.085331773582;5919.911201331984;5946;5947.672877991708;5949.46454819064;22547.77452225473;27136.592951105747;27302.5904611431;27400.314992125157;27612.447751045067;2214.250741913886;2254.977450225493;2323.8605683659034;2785.958210626842;3020.6979302069835;15162.696746065018;15454.918155729103;15486.148261845594;15653.295601697951;16127.91936040324;1787.785465744119;1788.3561917709615;1871.504051426373;1876.9061546922599;1914.5883635018538;111296.4435177827;116258.41870790676;118966.40516797447;119341.40329298298;120303.59392812182;9188.219001384823;10825.56697732082;11762;11778.820918130174;11855.68814081246;13311.667208319675;13800.723985520233;13819.930900345435;14930.32813523394;14932.552023439313;8463;8728.345374096969;9290.860637090449;9400.529973501298;9427.858582121273;9493.240540756722;9513.857292140623;9538.330792111492;9597.040295970348;9603.231741460666;6895.827604309932;7011.0018644686015;7025.5784652919965;7036.894446583306;7037.612931288726;1602.1908935987485;1966.4395647240467;1981.7225588417632;1983.8115379038968;2009.9196032158843;1053;1053.6312290698347;1066.1950227578284;1068.033429746081;1085.8696956365286;20583.176672933216;21462.46343841385;21618.89190554037;22372.32883013512;22409.991550380273;1035.8756949166147;1042.3797840285017;1046.534292239946;1052.694598828563;1080.7622323088908;11121.88684150025;11757.412129393668;11978;11984.64046078619;12068.939655301667;641467;650127;653800;665375;667249;85322.57338713267;119224;119457;120825;121217;1047.7852040331713;1077.42357838556;1093.5079214353573;1095.3044816541394;1118.5246270335238;18945.86324820515;19335.226590936767;19504.414867553995;19546.706799398304;19594.942531034038;46257.537424626666;51698;53011.73494132505;54042.459575403744;54997.62505937384;63460.04809927762;73866.63066684632;75656.24343756492;76527.23472765424;76638;8096.271335579826;8305.626246818787;8392.370572207232;8531.23218910301;8848.380613357003;9384.624615015597;12091.093168012258;12374.319412432402;13013.414396351998;13430.597082087554;9028.683996060106;10472.895271047497;10784.299020563638;11492.023178029962;11569.88430115688;6240.875182496234;6897.965510172417;11017.228793984345;11149.777004460027;11230.494627741607;11599.304041757521;11711.76576468483;11902.940485297519;11934.462949167135;11961.461734222155;8453.36599755033;8470.872936905827;8478.618462169094;8610.956945215485;8790.824183516166;11281.435928203393;11538.480768365276;11723.531058757555;11846.229995050295;11875.931166195083 10:48:22 INFO - PROCESS | 1679 | |3;mootools.html;1477.8226612806466;1603.6391811842336;1620.5462470508255;1903.0009245146296;2024.5141166120136;8238;8430.704925327615;8436.915630843698;8757.386982911199;8923.687670931518;8817.691380801672;8842.115788421155;8929.866052009225;8961.731148065568;8977.102289771019;2550.362409397655;2560.423904621464;2563.269468201563;2563.9487210255784;2564.987175064122;2472.468419289852;2541.466292078666;2549.018627828281;2552.680914885639;2552.8723563821827;2527.936801579957;2535.366158460385;2549.9800079968068;2551.0306083688174;2551.872406379683;2512.6356678281545;2546.821722479427;2550.591905295144;2554.8850301736466;2558.0790915270486;2496.6255061740703;2526;2537.314924970248;2538.5811341128874;2542.987285063563;9000.954995224982;9056.13966673165;9071.183593476553;9085.545722713838;9092.77268068297;4774.976125119387;5554.638948468337;5585.078462053756;5713.685747283939;5740.856478588027;3618.782873027627;3680.6871415929677;3745.1198968242443;3748.4189950557707;3753.4369844523267;1042.7497400623795;1048.3081166430195;1074.9946250268777;1076.5855145768858;1095.7151140703395;12202.084843636763;12385.442655080453;12402;12437.315947622878;12455.190412623151;4896.485868983706;5005.224190250444;5065.113605119163;5093.312402825645;5147.897042059138;7916.168802275678;9380;9465.195458385977;9533.332666713402;9560.091791279818;5529.917051244234;5539.695316757537;5548.528375088082;5549.639273447213;5549.833504994856;4609;4753.31076993834;5041.319421878073;5147.485251474897;5151.974240128776;3962.5641179470235;3965.3457179565626;4037.394390841397;4059.4316795648633;4101.364288535282;1244.887960083597;1245.1532957588927;1251.3055254333933;1257.2393701810456;1270.1553466944563;877.806882485852;945.4941606240628;962.8988956159642;978.7210644966293;1022.4785359466725;5683.516901063374;5966.343702192756;6112.938870611237;6140.416660417253;6197.504199664016;475.3535192138689;479.85844175968174;487.24477060555995;488.57982135363557;494.1549949586248;3967.920641587152;4034.9798251008556;4056.7565946043333;4095.774732389747;4116.732412393185;10738.624148154933;11082.335059896432;11099.5560177592;11124.721881952853;11157.776844463066;10638.255322127377;10886.782264354826;10903.400312982862;11062.391568463812;11087.778244435067;8337.791555211168;8429.4942303462;8518.78703032429;8533.317334613215;8598.269147122439;5874.823755287348;5970.9701451492465;5975.25309336333;6032.426919442646;6117.265928088658;9495.525223738647;9538.23694104484;9544.42733435996;9679.806403872024;9762.56068476906;9454.763630909283;9899.554520046471;9908.207343412365;10027.699169024942;10092.697219083439;6730.394264516217;6967;7118.644067796693;7594.278543538355;7728.497647653109;8388.874166887379;8435.789105272417;8469.788255293666;8469.957650211709;8484.278836298983;7421.666025028779;7513.737019204302;7571.188279438178;7674.9232507674205;7758.262965018314;7433.665485053078;7455.701771929279;7511.211322811027;7615.771526854203;7618.5809780462605;7102.254263302279;7169.032180655545;7175.497715160098;7194.712211511481;7197.568145911262;4974.651774375759;5013.598912087097;5063.746812659426;5121.769520371667;5183.974080129575;5038.823641172541;5048.772805223847;5107.821226257063;5141.8687888664435;5307.044731948286 10:48:22 INFO - PROCESS | 1679 | |4;prototype.html;329.9554560134382;335.8085891042107;341.8717980757216;346.3505926388021;348.2304107921493;6615.867682646344;6650.634215118166;6703;6705.4300384467315;6736.461083113351;5243.86890327742;6613;6655.301193374698;6662.500312476559;6669.399754022137;4717.811287548494;4851.781669824866;4860.951390486085;4927.162382394984;4937.358143441347;4886.584640305578;4962.057209130272;4969.254611808222;4971.204607262839;4974.502549745014;4892.266160075981;4907.803687852482;4927.3348098006845;4932;4965.0566392385335;4737.242041273397;4802.687825291345;4946.455889852114;4959.479254678243;4964.255361695738;4255.829766809355;4255.978565144374;4258.5954334338185;4268.338407546804;4274.166537525184;6349;6395.360463953614;6412.4549413299455;6433.710483028275;6439.903401448982;5891.116332550109;5894.852628684274;5910.852228694274;5911.231539899829;5915.970420147914;6734.3602357775935;7123.536970096979;7127.358537731629;7128;7141.035960145366;4754.786034628415;4756.500567440404;4780.904381912343;4787.0904528139545;4798.49615790344;7345.816354591178;7453.664585093629;7460.761771468592;7468.813279667997;7478.476506644592;4861.756912154378;4874.731889746098;4888.364512613338;4891.364122664031;4903.583195428429;4964.776585053682;4967.4784147664695;4968.850934471971;4969.428515720666;4972.726500042532;5549.056660367747;5866.530677545871;5879.3826648202175;5888.970555147197;5899.233099697012;6944.861102777916;6982.47631427645;6993.405560527311;7004.649767511706;7015.123109611299;1696.6691495158325;1724.2499512711759;1727.7494763259258;1728.559217399555;1732.9740053899202;1056.7041228456044;1103.8951299626522;1112.1269803204445;1130.553431394611;1139.3790384240608;6446.357807838556;6547.5416720830035;6701.095352127498;6721.22705888829;6729.4279986200745;7392.928025436282;7396.149442814038;7397.297256760599;7418.666160022704;7424.665890034961;6682.966585167043;6702.631355275409;6705.798826035227;6711.6979735912;6722.731090756412;3846;3890.7081968851885;3895.668868146183;3900.3759398496104;3900.76595404271;7414.221506741822;7674.386049116058;7686.538807671557;7702;7759.534427934229;5729.856753581111;6805.183377994574;6931.792046238621;7602.771916842504;7636.923630763732;7691.1924247954275;7715.845683086419;7720.266574675396;7722.073351197892;7725.266099720518;7060.399866011241;7354.742584009534;7377.446691498267;7384.889226661497;7386.409087273113;5758.309002919509;7260;7262.128544574473;7264.34620884123;7290.05229320185;7749.845003099794;7752.0697516298405;7766.689332426639;7772.37820974332;7779;4652.906941861076;4690.835820746258;4698.177818881613;4699.976500117477;4704.976475117739;7046.753363632249;7341.9632901837285;7354.117505899327;7364.3003914628025;7370.557766534025;6234.376562343729;6669.666066786565;7097.7160913562875;7102.538335008208;7118.822029449305;7048.964755176191;7106.324899134574;7110.786676399716;7117.1459424869345;7124.821879453055;6946.479014074066;6957.756478523227;6967.79096627102;6972.26791186918;6984.371406573433;6814;7081.150261968391;7108;7128.4653650977425;7129.857402852018;6708.6981085850275;6868.862622747617;6922.473297246368;6952.270011648704;7006.2643422439905 10:48:22 INFO - PROCESS | 1679 | |5;yui.html;715.9749408770692;735.8601865645524;770.5107256891872;778.140155128583;788.2314743125453;14729.779053314209;15142.015768975009;15152.621184470367;15161.924190379046;15168.696626067485;14119.647008824759;14290.92854535726;14308.35612397442;14309.785353219684;14318.92840535796;763.4770182425057;774.8682723936917;933.0855761353878;955.5365647660878;961.3510880155902;935.2704890185666;944.2823454174842;949.2548349545608;950.0119875329649;950.1543626172677;1019.1541020952628;1025.523131743739;1025.7948410317929;1027.8715160604925;1028.1312291114034;826.4627991805345;994.4033579852103;1017.7760892603616;1020.3214862116683;1022.9693109206736;755.1844008470838;755.994527278718;757.8257000889827;758.4311766175368;758.7571976967373;15186.468473603481;15208.239588020666;15242.618934526614;15243.847561524464;15257.23713814316;12693.555725549562;12774.041946854024;12859.292738899358;12956.287404192766;13006.86993130066;10248;10267.211132475644;10441.686749397455;10467.633632822815;10590.835008149097;3575.606683264839;3576.678098971105;3711.9443208351895;3727.6458736419995;3854.209886973164;79169.20830791733;79823.6008819958;79841.60079199566;79976.99999999942;80546.19453805445;9546;9619.711408657751;9702.708918732309;9754.804903901882;9954;17851;21992;22203.888980554995;22224.777752222595;22271.777282227293;6522.869542609121;7602.049743782028;7636.732714354971;7903.644336004893;7976.481528700616;4197.286461301525;4268.850590229389;4290.206311832321;4338.067315527177;4441.800118994588;3827.559830619459;3904.1801221743754;3921.235359105004;3921.6666583340166;3929.8821035368983;677.3362105136994;696.4045740891465;699.3635791429774;721.1814590439784;740.4964624055693;435.7951762671539;524.6484855147061;576.8932747441737;582.5659883386819;640.4108220437209;8122;8469.957650211709;8475.406721529434;8483.066862645104;8615.353848461391;574.2247965246967;617.8053913017385;620.4044117647019;621.0994058615026;625.0686477149015;3949.5063117110362;3963.36586146221;4030.7380020298588;4058.9797051014557;4152.937705934413;97709;99074;99775;100482.49758751159;100527.49736251272;81017.18982810214;81446;82127.58936205281;84145.57927210325;84586;66034.66982665056;68708;68757.65621171962;68842;71013.60877521048;7802.375809935305;7984.20157984197;8071.273585377344;8074.273315401642;8120.254605569231;50092.749536252086;50733.7316567074;51476.97046059133;51524.742376287875;51782.22326665178;67257.66371168113;72082;72266.63866680843;72306;73241;10074.647387341407;10205.13256373187;10412.895871041193;10495.580176792842;10761.730956726144;9524;10781.299215551278;11018.559257629606;11464.770704586028;11603.941980290045;10525.157987361146;10749.355038697704;10806;10889.074428673335;10943.945280273867;8518.957405212934;10548.472576370998;10703.250772445854;10732.947746310456;10778.191635627516;10445.634402795866;10482.21383396233;10539.998700123477;10589.364638121737;10769.299995500267;8950.641974321215;9140.314476414163;9205.815883682422;9383.718488445358;9492.905070949479;9117.225035872025;9134.269258459175;9199.632014719336;9234.769130771785;9292.860607091034 10:48:22 INFO - PROCESS | 1679 | __end_tp_report 10:48:22 INFO - PROCESS | 1679 | __start_cc_report 10:48:22 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1126 10:48:22 INFO - PROCESS | 1679 | __end_cc_report 10:48:22 INFO - PROCESS | 1679 | __startTimestamp1466704102329__endTimestamp 10:48:22 INFO - PROCESS | 1679 | 10:48:22 INFO - PROCESS | 1679 | ------- Summary: start ------- 10:48:22 INFO - PROCESS | 1679 | Number of tests: 6 10:48:22 INFO - PROCESS | 1679 | 10:48:22 INFO - PROCESS | 1679 | [#0] dojo.html Cycles:165 Average:5887.27 Median:6161.69 stddev:637.15 (10.3%) stddev-sans-first:612.39 10:48:22 INFO - PROCESS | 1679 | Values: 3559.8 3573.8 3612.8 3624.8 3682.9 5862.9 5873.7 5878.4 5903.1 5931.8 5865.8 5908.4 5912.0 5926.0 5929.1 5225.8 5294.9 5350.0 5382.1 5444.5 4453.0 5385.4 5424.7 5425.6 5438.8 5304.8 5349.9 5382.2 5391.4 5416.4 5457.2 5474.3 5491.3 5492.2 5501.4 5164.7 5277.4 5358.8 5408.2 5423.9 4749.7 5742.5 5823.8 5862.3 5885.0 6328.4 6335.0 6361.9 6371.9 6374.9 6144.5 6264.2 6298.7 6316.4 6321.6 6066.5 6079.3 6084.8 6089.6 6114.8 6440.0 6451.9 6452.5 6457.9 6483.7 6113.9 6208.7 6309.7 6336.2 6345.7 6309.5 6325.8 6349.5 6360.6 6360.7 6244.9 6299.7 6302.3 6313.6 6326.2 6179.1 6219.9 6321.2 6323.5 6329.1 5000.1 5032.1 5039.4 5054.6 5060.5 4564.3 4569.1 4571.6 4573.7 4660.1 5839.1 5883.6 5981.2 6050.8 6055.0 6274.8 6317.7 6318.7 6318.8 6321.3 5977.7 5981.0 5995.3 6007.0 6024.2 5372.9 5440.6 5490.6 5504.7 5514.4 6539.4 6543.8 6549.1 6555.9 6569.1 6306.8 6309.9 6315.2 6324.6 6333.7 6360.7 6388.4 6472.1 6477.5 6512.4 6330.3 6341.1 6345.2 6354.7 6356.6 6243.3 6243.8 6247.6 6313.2 6325.7 6161.7 6279.2 6291.7 6292.1 6321.2 5162.8 6296.7 6300.1 6310.7 6354.3 5800.5 5902.1 6226.8 6227.6 6244.4 6145.9 6189.5 6276.1 6295.0 6299.6 6153.3 6184.9 6222.8 6228.3 6232.0 10:48:22 INFO - PROCESS | 1679 | 10:48:22 INFO - PROCESS | 1679 | [#1] ext.html Cycles:180 Average:64835.17 Median:3393.10 stddev:140278.78 (4134.2%) stddev-sans-first:140589.11 10:48:22 INFO - PROCESS | 1679 | Values: 490.8 555.2 555.5 604.0 619.5 28287.6 30557.4 39416.0 40327.4 40469.2 36857.8 45057.6 45388.5 45530.3 45542.8 9039.1 9705.6 9921.9 9929.5 9957.2 11855.3 12120.9 12122.9 12150.8 12166.9 11795.7 11863.1 11874.3 11876.8 11879.2 11870.3 11896.0 11924.5 11927.8 11934.3 10126.5 11649.4 11768.9 11775.5 12064.6 42126.2 42601.1 42612.4 42689.1 42743.8 3308.9 3333.5 3381.6 3409.3 3439.9 28904.3 29255.9 30221.4 30914.0 30934.0 2770.0 2779.0 2785.5 2830.4 2867.0 461754.0 462412.0 463856.0 467233.7 469107.0 37421.6 38036.0 38131.4 64857.0 66013.0 36829.6 37004.0 37067.8 37111.3 37134.6 16246.9 16411.3 16421.8 16444.0 16458.4 12020.6 12128.8 12129.9 12133.0 13941.0 8357.0 8584.4 8609.4 8618.7 8667.0 3404.6 3458.6 3470.1 3473.3 3496.9 970.8 1003.1 1048.1 1077.8 1099.7 30040.5 30273.5 30599.8 31380.7 31443.5 1114.1 1116.5 1139.9 1157.7 1164.9 15910.8 16007.8 16017.5 16226.0 16302.6 638671.0 647544.0 647801.0 650447.0 651649.0 55101.7 63368.7 64092.4 64138.0 64276.0 1415.0 1455.8 1494.4 1505.3 1537.5 29394.9 29701.0 31285.8 31406.5 31575.0 51514.7 51739.7 51873.7 51918.5 52610.7 426545.0 440592.0 440986.0 441105.0 441180.0 23962.0 25011.7 27917.6 27918.3 28582.9 45769.5 46209.0 46245.8 47282.8 47694.3 30256.7 37582.0 38152.2 38356.8 38930.2 32625.8 39571.4 41132.6 41239.4 41862.0 38695.0 38889.6 39060.0 39910.6 40470.6 31734.0 32745.9 32835.7 32842.7 32971.5 23471.8 24579.8 24686.8 25144.9 25159.9 10:48:22 INFO - PROCESS | 1679 | 10:48:22 INFO - PROCESS | 1679 | [#2] jquery.html Cycles:180 Average:36444.34 Median:22095.11 stddev:108479.97 (491.0%) stddev-sans-first:108750.52 10:48:22 INFO - PROCESS | 1679 | Values: 397.4 413.9 417.8 419.8 429.0 15851.5 18940.3 20874.1 21560.0 21786.9 20959.7 21217.2 22079.3 22089.6 22100.7 5720.4 6113.4 6224.5 6227.5 6242.0 6046.5 6182.5 6182.8 6197.2 6203.3 4358.5 6469.8 6781.9 6785.5 6795.3 6482.5 6729.1 6753.9 6757.8 6768.5 5901.1 5919.9 5946.0 5947.7 5949.5 22547.8 27136.6 27302.6 27400.3 27612.4 2214.3 2255.0 2323.9 2786.0 3020.7 15162.7 15454.9 15486.1 15653.3 16127.9 1787.8 1788.4 1871.5 1876.9 1914.6 111296.4 116258.4 118966.4 119341.4 120303.6 9188.2 10825.6 11762.0 11778.8 11855.7 13311.7 13800.7 13819.9 14930.3 14932.6 8463.0 8728.3 9290.9 9400.5 9427.9 9493.2 9513.9 9538.3 9597.0 9603.2 6895.8 7011.0 7025.6 7036.9 7037.6 1602.2 1966.4 1981.7 1983.8 2009.9 1053.0 1053.6 1066.2 1068.0 1085.9 20583.2 21462.5 21618.9 22372.3 22410.0 1035.9 1042.4 1046.5 1052.7 1080.8 11121.9 11757.4 11978.0 11984.6 12068.9 641467.0 650127.0 653800.0 665375.0 667249.0 85322.6 119224.0 119457.0 120825.0 121217.0 1047.8 1077.4 1093.5 1095.3 1118.5 18945.9 19335.2 19504.4 19546.7 19594.9 46257.5 51698.0 53011.7 54042.5 54997.6 63460.0 73866.6 75656.2 76527.2 76638.0 8096.3 8305.6 8392.4 8531.2 8848.4 9384.6 12091.1 12374.3 13013.4 13430.6 9028.7 10472.9 10784.3 11492.0 11569.9 6240.9 6898.0 11017.2 11149.8 11230.5 11599.3 11711.8 11902.9 11934.5 11961.5 8453.4 8470.9 8478.6 8611.0 8790.8 11281.4 11538.5 11723.5 11846.2 11875.9 10:48:22 INFO - PROCESS | 1679 | 10:48:22 INFO - PROCESS | 1679 | [#3] mootools.html Cycles:180 Average:5809.89 Median:5100.57 stddev:3215.40 (63.0%) stddev-sans-first:3207.94 10:48:22 INFO - PROCESS | 1679 | Values: 1477.8 1603.6 1620.5 1903.0 2024.5 8238.0 8430.7 8436.9 8757.4 8923.7 8817.7 8842.1 8929.9 8961.7 8977.1 2550.4 2560.4 2563.3 2563.9 2565.0 2472.5 2541.5 2549.0 2552.7 2552.9 2527.9 2535.4 2550.0 2551.0 2551.9 2512.6 2546.8 2550.6 2554.9 2558.1 2496.6 2526.0 2537.3 2538.6 2543.0 9001.0 9056.1 9071.2 9085.5 9092.8 4775.0 5554.6 5585.1 5713.7 5740.9 3618.8 3680.7 3745.1 3748.4 3753.4 1042.7 1048.3 1075.0 1076.6 1095.7 12202.1 12385.4 12402.0 12437.3 12455.2 4896.5 5005.2 5065.1 5093.3 5147.9 7916.2 9380.0 9465.2 9533.3 9560.1 5529.9 5539.7 5548.5 5549.6 5549.8 4609.0 4753.3 5041.3 5147.5 5152.0 3962.6 3965.3 4037.4 4059.4 4101.4 1244.9 1245.2 1251.3 1257.2 1270.2 877.8 945.5 962.9 978.7 1022.5 5683.5 5966.3 6112.9 6140.4 6197.5 475.4 479.9 487.2 488.6 494.2 3967.9 4035.0 4056.8 4095.8 4116.7 10738.6 11082.3 11099.6 11124.7 11157.8 10638.3 10886.8 10903.4 11062.4 11087.8 8337.8 8429.5 8518.8 8533.3 8598.3 5874.8 5971.0 5975.3 6032.4 6117.3 9495.5 9538.2 9544.4 9679.8 9762.6 9454.8 9899.6 9908.2 10027.7 10092.7 6730.4 6967.0 7118.6 7594.3 7728.5 8388.9 8435.8 8469.8 8470.0 8484.3 7421.7 7513.7 7571.2 7674.9 7758.3 7433.7 7455.7 7511.2 7615.8 7618.6 7102.3 7169.0 7175.5 7194.7 7197.6 4974.7 5013.6 5063.7 5121.8 5184.0 5038.8 5048.8 5107.8 5141.9 5307.0 10:48:22 INFO - PROCESS | 1679 | 10:48:22 INFO - PROCESS | 1679 | [#4] prototype.html Cycles:180 Average:5837.63 Median:6665.95 stddev:1824.35 (27.4%) stddev-sans-first:1782.02 10:48:22 INFO - PROCESS | 1679 | Values: 330.0 335.8 341.9 346.4 348.2 6615.9 6650.6 6703.0 6705.4 6736.5 5243.9 6613.0 6655.3 6662.5 6669.4 4717.8 4851.8 4861.0 4927.2 4937.4 4886.6 4962.1 4969.3 4971.2 4974.5 4892.3 4907.8 4927.3 4932.0 4965.1 4737.2 4802.7 4946.5 4959.5 4964.3 4255.8 4256.0 4258.6 4268.3 4274.2 6349.0 6395.4 6412.5 6433.7 6439.9 5891.1 5894.9 5910.9 5911.2 5916.0 6734.4 7123.5 7127.4 7128.0 7141.0 4754.8 4756.5 4780.9 4787.1 4798.5 7345.8 7453.7 7460.8 7468.8 7478.5 4861.8 4874.7 4888.4 4891.4 4903.6 4964.8 4967.5 4968.9 4969.4 4972.7 5549.1 5866.5 5879.4 5889.0 5899.2 6944.9 6982.5 6993.4 7004.6 7015.1 1696.7 1724.2 1727.7 1728.6 1733.0 1056.7 1103.9 1112.1 1130.6 1139.4 6446.4 6547.5 6701.1 6721.2 6729.4 7392.9 7396.1 7397.3 7418.7 7424.7 6683.0 6702.6 6705.8 6711.7 6722.7 3846.0 3890.7 3895.7 3900.4 3900.8 7414.2 7674.4 7686.5 7702.0 7759.5 5729.9 6805.2 6931.8 7602.8 7636.9 7691.2 7715.8 7720.3 7722.1 7725.3 7060.4 7354.7 7377.4 7384.9 7386.4 5758.3 7260.0 7262.1 7264.3 7290.1 7749.8 7752.1 7766.7 7772.4 7779.0 4652.9 4690.8 4698.2 4700.0 4705.0 7046.8 7342.0 7354.1 7364.3 7370.6 6234.4 6669.7 7097.7 7102.5 7118.8 7049.0 7106.3 7110.8 7117.1 7124.8 6946.5 6957.8 6967.8 6972.3 6984.4 6814.0 7081.2 7108.0 7128.5 7129.9 6708.7 6868.9 6922.5 6952.3 7006.3 10:48:22 INFO - PROCESS | 1679 | 10:48:22 INFO - PROCESS | 1679 | [#5] yui.html Cycles:180 Average:18626.16 Median:575.56 stddev:26714.32 (4641.5%) stddev-sans-first:26755.41 10:48:22 INFO - PROCESS | 1679 | Values: 716.0 735.9 770.5 778.1 788.2 14729.8 15142.0 15152.6 15161.9 15168.7 14119.6 14290.9 14308.4 14309.8 14318.9 763.5 774.9 933.1 955.5 961.4 935.3 944.3 949.3 950.0 950.2 1019.2 1025.5 1025.8 1027.9 1028.1 826.5 994.4 1017.8 1020.3 1023.0 755.2 756.0 757.8 758.4 758.8 15186.5 15208.2 15242.6 15243.8 15257.2 12693.6 12774.0 12859.3 12956.3 13006.9 10248.0 10267.2 10441.7 10467.6 10590.8 3575.6 3576.7 3711.9 3727.6 3854.2 79169.2 79823.6 79841.6 79977.0 80546.2 9546.0 9619.7 9702.7 9754.8 9954.0 17851.0 21992.0 22203.9 22224.8 22271.8 6522.9 7602.0 7636.7 7903.6 7976.5 4197.3 4268.9 4290.2 4338.1 4441.8 3827.6 3904.2 3921.2 3921.7 3929.9 677.3 696.4 699.4 721.2 740.5 435.8 524.6 576.9 582.6 640.4 8122.0 8470.0 8475.4 8483.1 8615.4 574.2 617.8 620.4 621.1 625.1 3949.5 3963.4 4030.7 4059.0 4152.9 97709.0 99074.0 99775.0 100482.5 100527.5 81017.2 81446.0 82127.6 84145.6 84586.0 66034.7 68708.0 68757.7 68842.0 71013.6 7802.4 7984.2 8071.3 8074.3 8120.3 50092.7 50733.7 51477.0 51524.7 51782.2 67257.7 72082.0 72266.6 72306.0 73241.0 10074.6 10205.1 10412.9 10495.6 10761.7 9524.0 10781.3 11018.6 11464.8 11603.9 10525.2 10749.4 10806.0 10889.1 10943.9 8519.0 10548.5 10703.3 10732.9 10778.2 10445.6 10482.2 10540.0 10589.4 10769.3 8950.6 9140.3 9205.8 9383.7 9492.9 9117.2 9134.3 9199.6 9234.8 9292.9 10:48:22 INFO - PROCESS | 1679 | -------- Summary: end -------- 10:48:22 INFO - PROCESS | 1679 | 10:48:22 INFO - TEST-INFO | 1679: exit 0 10:48:22 INFO - TEST-OK | dromaeo_css | took 1113192ms 10:48:22 INFO - TEST-START | kraken 10:48:22 INFO - operating with platform_type : mac_ 10:48:22 INFO - Initialising browser for kraken test... 10:48:22 INFO - TEST-INFO | started process 1801 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmp6FiOwg/profile http://localhost:49285/getInfo.html) 10:48:25 INFO - PROCESS | 1801 | __metrics Screen width/height:1600/1200 10:48:25 INFO - PROCESS | 1801 | colorDepth:24 10:48:25 INFO - PROCESS | 1801 | Browser inner width/height: 1024/689 10:48:25 INFO - PROCESS | 1801 | __metrics 10:48:25 INFO - PROCESS | 1801 | 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" 10:48:25 ERROR - PROCESS | 1801 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:48:25 INFO - TEST-INFO | 1801: exit 0 10:48:25 INFO - Browser initialized. 10:48:25 INFO - Running cycle 1/1 for kraken test... 10:48:25 INFO - TEST-INFO | started process 1804 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmp6FiOwg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:48:37 INFO - PROCESS | 1804 | RSS: Main: 160956416 10:48:37 INFO - PROCESS | 1804 | 10:48:40 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-beat-detection) 10:48:41 INFO - PROCESS | 1804 | RSS: Main: 223215616 10:48:41 INFO - PROCESS | 1804 | 10:48:43 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-dft) 10:48:44 INFO - PROCESS | 1804 | RSS: Main: 239149056 10:48:44 INFO - PROCESS | 1804 | 10:48:47 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-fft) 10:48:48 INFO - PROCESS | 1804 | RSS: Main: 325947392 10:48:48 INFO - PROCESS | 1804 | 10:48:50 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-oscillator) 10:48:50 INFO - PROCESS | 1804 | RSS: Main: 229642240 10:48:50 INFO - PROCESS | 1804 | 10:48:53 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:48:53 INFO - PROCESS | 1804 | RSS: Main: 231481344 10:48:53 INFO - PROCESS | 1804 | 10:48:56 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-darkroom) 10:48:57 INFO - PROCESS | 1804 | RSS: Main: 269361152 10:48:57 INFO - PROCESS | 1804 | 10:48:59 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-desaturate) 10:49:00 INFO - PROCESS | 1804 | RSS: Main: 268693504 10:49:00 INFO - PROCESS | 1804 | 10:49:03 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49285/tests/kraken/driver.html?testName=json-parse-financial) 10:49:03 INFO - PROCESS | 1804 | RSS: Main: 267698176 10:49:03 INFO - PROCESS | 1804 | 10:49:05 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:49:05 INFO - PROCESS | 1804 | RSS: Main: 259936256 10:49:05 INFO - PROCESS | 1804 | 10:49:07 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:49:08 INFO - PROCESS | 1804 | RSS: Main: 266981376 10:49:08 INFO - PROCESS | 1804 | 10:49:10 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:49:11 INFO - PROCESS | 1804 | RSS: Main: 270524416 10:49:11 INFO - PROCESS | 1804 | 10:49:13 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:49:14 INFO - PROCESS | 1804 | RSS: Main: 277463040 10:49:14 INFO - PROCESS | 1804 | 10:49:17 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:49:18 INFO - PROCESS | 1804 | RSS: Main: 274571264 10:49:18 INFO - PROCESS | 1804 | 10:49:19 INFO - PROCESS | 1804 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49285/tests/kraken/driver.html?testName=ai-astar) 10:49:20 INFO - PROCESS | 1804 | RSS: Main: 335441920 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | __start_tp_report 10:49:20 INFO - PROCESS | 1804 | _x_x_mozilla_page_load 10:49:20 INFO - PROCESS | 1804 | _x_x_mozilla_page_load_details 10:49:20 INFO - PROCESS | 1804 | |i|pagename|runs| 10:49:20 INFO - PROCESS | 1804 | |0;ai-astar;114;113;120;112;112;111;113;114;113;136 10:49:20 INFO - PROCESS | 1804 | |1;audio-beat-detection;154;119;143;161;116;133;118;155;154;117 10:49:20 INFO - PROCESS | 1804 | |2;audio-dft;185;185;185;196;257;246;183;186;182;185 10:49:20 INFO - PROCESS | 1804 | |3;audio-fft;70;80;73;155;56;55;59;66;133;79 10:49:20 INFO - PROCESS | 1804 | |4;audio-oscillator;91;92;137;79;84;94;122;78;77;127 10:49:20 INFO - PROCESS | 1804 | |5;imaging-gaussian-blur;89;85;89;86;88;85;89;86;88;84 10:49:20 INFO - PROCESS | 1804 | |6;imaging-darkroom;93;94;108;147;94;94;94;94;95;93 10:49:20 INFO - PROCESS | 1804 | |7;imaging-desaturate;83;86;85;87;83;84;85;86;84;83 10:49:20 INFO - PROCESS | 1804 | |8;json-parse-financial;57;63;62;62;61;63;64;76;58;56 10:49:20 INFO - PROCESS | 1804 | |9;json-stringify-tinderbox;56;59;57;68;68;75;68;66;66;66 10:49:20 INFO - PROCESS | 1804 | |10;stanford-crypto-aes;79;79;78;79;80;78;79;79;81;84 10:49:20 INFO - PROCESS | 1804 | |11;stanford-crypto-ccm;127;126;126;128;144;138;145;137;143;159 10:49:20 INFO - PROCESS | 1804 | |12;stanford-crypto-pbkdf2;164;162;164;160;168;210;208;163;161;161 10:49:20 INFO - PROCESS | 1804 | |13;stanford-crypto-sha256-iterative;68;66;67;67;67;67;73;92;93;91 10:49:20 INFO - PROCESS | 1804 | __end_tp_report 10:49:20 INFO - PROCESS | 1804 | __start_cc_report 10:49:20 INFO - PROCESS | 1804 | _x_x_mozilla_cycle_collect,1908 10:49:20 INFO - PROCESS | 1804 | __end_cc_report 10:49:20 INFO - PROCESS | 1804 | __startTimestamp1466704160042__endTimestamp 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | ------- Summary: start ------- 10:49:20 INFO - PROCESS | 1804 | Number of tests: 14 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#0] ai-astar Cycles:10 Average:115.80 Median:113.50 stddev:7.51 (6.6%) stddev-sans-first:7.94 10:49:20 INFO - PROCESS | 1804 | Values: 114.0 113.0 120.0 112.0 112.0 111.0 113.0 114.0 113.0 136.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:148.50 stddev:18.43 (12.4%) stddev-sans-first:18.49 10:49:20 INFO - PROCESS | 1804 | Values: 154.0 119.0 143.0 161.0 116.0 133.0 118.0 155.0 154.0 117.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#2] audio-dft Cycles:10 Average:199.00 Median:185.50 stddev:28.05 (15.1%) stddev-sans-first:29.29 10:49:20 INFO - PROCESS | 1804 | Values: 185.0 185.0 185.0 196.0 257.0 246.0 183.0 186.0 182.0 185.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#3] audio-fft Cycles:10 Average:82.60 Median:68.00 stddev:33.92 (49.9%) stddev-sans-first:35.67 10:49:20 INFO - PROCESS | 1804 | Values: 70.0 80.0 73.0 155.0 56.0 55.0 59.0 66.0 133.0 79.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:81.50 stddev:22.20 (27.2%) stddev-sans-first:23.40 10:49:20 INFO - PROCESS | 1804 | Values: 91.0 92.0 137.0 79.0 84.0 94.0 122.0 78.0 77.0 127.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:88.00 stddev:1.91 (2.2%) stddev-sans-first:1.87 10:49:20 INFO - PROCESS | 1804 | Values: 89.0 85.0 89.0 86.0 88.0 85.0 89.0 86.0 88.0 84.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#6] imaging-darkroom Cycles:10 Average:100.60 Median:94.00 stddev:16.91 (18.0%) stddev-sans-first:17.71 10:49:20 INFO - PROCESS | 1804 | Values: 93.0 94.0 108.0 147.0 94.0 94.0 94.0 94.0 95.0 93.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.43 (1.7%) stddev-sans-first:1.39 10:49:20 INFO - PROCESS | 1804 | Values: 83.0 86.0 85.0 87.0 83.0 84.0 85.0 86.0 84.0 83.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.50 stddev:5.57 (8.9%) stddev-sans-first:5.59 10:49:20 INFO - PROCESS | 1804 | Values: 57.0 63.0 62.0 62.0 61.0 63.0 64.0 76.0 58.0 56.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:67.00 stddev:5.88 (8.8%) stddev-sans-first:5.28 10:49:20 INFO - PROCESS | 1804 | Values: 56.0 59.0 57.0 68.0 68.0 75.0 68.0 66.0 66.0 66.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:1.78 (2.2%) stddev-sans-first:1.87 10:49:20 INFO - PROCESS | 1804 | Values: 79.0 79.0 78.0 79.0 80.0 78.0 79.0 79.0 81.0 84.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:140.50 stddev:10.83 (7.7%) stddev-sans-first:10.83 10:49:20 INFO - PROCESS | 1804 | Values: 127.0 126.0 126.0 128.0 144.0 138.0 145.0 137.0 143.0 159.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:164.00 stddev:19.58 (11.9%) stddev-sans-first:20.55 10:49:20 INFO - PROCESS | 1804 | Values: 164.0 162.0 164.0 160.0 168.0 210.0 208.0 163.0 161.0 161.0 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - PROCESS | 1804 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:70.50 stddev:11.83 (16.8%) stddev-sans-first:12.26 10:49:20 INFO - PROCESS | 1804 | Values: 68.0 66.0 67.0 67.0 67.0 67.0 73.0 92.0 93.0 91.0 10:49:20 INFO - PROCESS | 1804 | -------- Summary: end -------- 10:49:20 INFO - PROCESS | 1804 | 10:49:20 INFO - TEST-INFO | 1804: exit 0 10:49:20 INFO - TEST-OK | kraken | took 57911ms 10:49:20 INFO - SUITE-END | took 1171s 10:49:21 INFO - Completed test suite (00:19:31) 10:49:21 INFO - javascript benchmark 10:49:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3559.750817442779, 3573.8213089345527, 3612.825831604729, 3624.8187590620464, 3682.907927301817, 5862.85342866428, 5873.706314684259, 5878.382769809173, 5903.055511118222, 5931.822045338641, 5865.794697185599, 5908.350081491032, 5911.970440147804, 5925.9925812611855, 5929.051351783704, 5225.790968361261, 5294.92057619136, 5350.0, 5382.138857782736, 5444.537214336786, 4452.97773511132, 5385.380681221671, 5424.728763561826, 5425.6202065855405, 5438.755256013469, 5304.814331498398, 5349.866253343658, 5382.2195781611645, 5391.379991300992, 5416.377116631598, 5457.2359869618285, 5474.343078830526, 5491.28613280275, 5492.231087647732, 5501.394846566875, 5164.741762911839, 5277.393099793535, 5358.839234822923, 5408.215808707715, 5423.864403389947, 4749.715017098985, 5742.483176514133, 5823.767049318022, 5862.267216597926, 5884.999550076497, 6328.430441260309, 6335.0, 6361.9045714314325, 6371.872562548723, 6374.936250637481, 6144.525313924671, 6264.21697287839, 6298.748050077991, 6316.399942005502, 6321.620702757803, 6066.481719018769, 6079.300880398767, 6084.785052679768, 6089.634621922699, 6114.755409783648, 6440.0, 6451.9354806452275, 6452.516061295421, 6457.870842583216, 6483.675816209171, 6113.938860611426, 6208.689565521706, 6309.716062777186, 6336.1762970814425, 6345.714442850082, 6309.526785491106, 6325.778597749057, 6349.492040636738, 6360.586561873556, 6360.681965901779, 6244.906326405107, 6299.6850157491945, 6302.338254483305, 6313.589616674902, 6326.2092238470195, 6179.073139029181, 6219.937800622027, 6321.241451025906, 6323.462505686976, 6329.050642403677, 5000.149974504343, 5032.119379108714, 5039.3952725672425, 5054.620903432257, 5060.468650791688, 4564.292534657134, 4569.063342014879, 4571.565701258442, 4573.748443835621, 4660.1145782301255, 5839.094940284178, 5883.61756485827, 5981.192539007266, 6050.757969681252, 6055.0, 6274.814173557413, 6317.684115794192, 6318.71565779541, 6318.8420289492215, 6321.273053598803, 5977.671228082497, 5981.043033114681, 5995.280566332068, 6007.038873780174, 6024.216851809324, 5372.892542149213, 5440.619156659075, 5490.615656904059, 5504.724763761796, 5514.448555144453, 6539.411452969255, 6543.803685889431, 6549.148610680676, 6555.868882622416, 6569.080328753883, 6306.779262725782, 6309.90535141964, 6315.242170939517, 6324.557280990287, 6333.714982825876, 6360.681965901779, 6388.393102655426, 6472.061551074974, 6477.481801455967, 6512.381323774234, 6330.303666596578, 6341.143945567289, 6345.238571371465, 6354.714037868214, 6356.618602883842, 6243.250809902659, 6243.8126856194385, 6247.625142491465, 6313.210848643919, 6325.715342809676, 6161.691915404302, 6279.152314437492, 6291.653959032297, 6292.119103325446, 6321.241451025906, 5162.793488260428, 6296.716647750954, 6300.149479820166, 6310.716017779303, 6354.269259035085, 5800.477956983892, 5902.1441890926435, 6226.782062627786, 6227.626342419288, 6244.375562443719, 6145.924463219008, 6189.50483961273, 6276.058591211355, 6294.968525157528, 6299.622022678654, 6153.292371377349, 6184.907226391698, 6222.782202622887, 6228.283747369111, 6232.0], "value": 5849.080972594905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.7570752477524, 555.1921953557575, 555.547229008358, 604.036561684114, 619.5291578400414, 28287.575686364697, 30557.388852222943, 39416.0, 40327.39508907369, 40469.19061618766, 36857.81571092147, 45057.620678449086, 45388.54611453885, 45530.317045244345, 45542.77228613853, 9039.096090390974, 9705.563249653766, 9921.900780992206, 9929.503524823765, 9957.153641940444, 11855.347955862424, 12120.93939530301, 12122.878771212307, 12150.817737733942, 12166.939165304206, 11795.705107372341, 11863.050955923505, 11874.28754274742, 11876.821847672292, 11879.227850189753, 11870.287782733063, 11896.0, 11924.523019079226, 11927.821082683766, 11934.343611101385, 10126.54430550627, 11649.41752912351, 11768.882311176863, 11775.470103845262, 12064.577739779153, 42126.157476850596, 42601.14797704059, 42612.3608145878, 42689.14621707548, 42743.786281068395, 3308.9172770680684, 3333.4666453367586, 3381.560397148355, 3409.2840503494294, 3439.914002149966, 28904.27739306513, 29255.853720731473, 30221.395572088655, 30914.0, 30934.0, 2769.9723002769915, 2779.027340430853, 2785.470760555488, 2830.40561482089, 2866.971330286712, 461754.0, 462412.0, 463856.0, 467233.6638316787, 469107.0, 37421.62578374236, 38036.0, 38131.42802857959, 64857.02714459287, 66013.00980485296, 36829.63170368315, 37004.0, 37067.814660926524, 37111.25777484489, 37134.628653713655, 16246.918765406097, 16411.261493232832, 16421.83578164227, 16444.013359198485, 16458.42395516151, 12020.579279725167, 12128.818067728991, 12129.87870121305, 12133.029357651367, 13941.02412831092, 8357.038940521796, 8584.442011269248, 8609.440386374865, 8618.698345557876, 8666.956665216634, 3404.6425125361975, 3458.5849698036395, 3470.132466883279, 3473.2706131712116, 3496.860125594948, 970.762278095434, 1003.1473247739364, 1048.1038711901367, 1077.8275475923815, 1099.741560733227, 30040.54939175914, 30273.545896811567, 30599.79281596806, 31380.686193137775, 31443.52834707481, 1114.053054903342, 1116.5143162724241, 1139.920205585601, 1157.739508610556, 1164.895159435655, 15910.76133857993, 16007.759883601755, 16017.519474415787, 16226.0, 16302.60047281324, 638671.0, 647544.0, 647801.0, 650447.0, 651649.0, 55101.72449137729, 63368.683156583924, 64092.35907640864, 64138.03792943016, 64276.0, 1415.0, 1455.8398576156615, 1494.4321157959905, 1505.3376514333877, 1537.5233677559993, 29394.853025734734, 29701.0, 31285.843570782, 31406.52890206603, 31575.0, 51514.74242628913, 51739.74130129476, 51873.740631296605, 51918.480815192874, 52610.736946315024, 426545.0, 440592.0, 440986.0, 441105.0, 441180.0, 23962.0, 25011.749882500942, 27917.58123628188, 27918.30204244829, 28582.85668573234, 45769.54230457786, 46209.0, 46245.76877115593, 47282.763586183224, 47694.28458573055, 30256.697433026267, 37582.0, 38152.236955261294, 38356.80821595874, 38930.221395572495, 32625.836870815496, 39571.406428903014, 41132.58867411407, 41239.381409278285, 41861.953451163965, 38695.0, 38889.6111038886, 39060.0, 39910.60089399069, 40470.59529404668, 31734.0, 32745.853895113556, 32835.67164328326, 32842.67157328492, 32971.50542741813, 23471.765282346958, 24579.754202457745, 24686.753132468446, 25144.874275628506, 25159.87420062888], "value": 19151.12485671623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.42175135178314, 413.8779060177246, 417.847485667731, 419.8068888311375, 429.00470907494605, 15851.524454266362, 18940.337088201897, 20874.060667269972, 21560.02979865906, 21786.89106554465, 20959.6856047159, 21217.151313947463, 22079.33761987143, 22089.558208835813, 22100.668489972664, 5720.370759216483, 6113.449789518942, 6224.502039836825, 6227.501799856023, 6241.968790156043, 6046.54650901182, 6182.536309776762, 6182.84542886427, 6197.16338294329, 6203.348648391921, 4358.498772641139, 6469.83825404364, 6781.864362712743, 6785.491088168383, 6795.286494918012, 6482.546221764478, 6729.057931889515, 6753.864922701568, 6757.763478278237, 6768.492363072789, 5901.085331773582, 5919.911201331984, 5946.0, 5947.672877991708, 5949.46454819064, 22547.77452225473, 27136.592951105747, 27302.5904611431, 27400.314992125157, 27612.447751045067, 2214.250741913886, 2254.977450225493, 2323.8605683659034, 2785.958210626842, 3020.6979302069835, 15162.696746065018, 15454.918155729103, 15486.148261845594, 15653.295601697951, 16127.91936040324, 1787.785465744119, 1788.3561917709615, 1871.504051426373, 1876.9061546922599, 1914.5883635018538, 111296.4435177827, 116258.41870790676, 118966.40516797447, 119341.40329298298, 120303.59392812182, 9188.219001384823, 10825.56697732082, 11762.0, 11778.820918130174, 11855.68814081246, 13311.667208319675, 13800.723985520233, 13819.930900345435, 14930.32813523394, 14932.552023439313, 8463.0, 8728.345374096969, 9290.860637090449, 9400.529973501298, 9427.858582121273, 9493.240540756722, 9513.857292140623, 9538.330792111492, 9597.040295970348, 9603.231741460666, 6895.827604309932, 7011.0018644686015, 7025.5784652919965, 7036.894446583306, 7037.612931288726, 1602.1908935987485, 1966.4395647240467, 1981.7225588417632, 1983.8115379038968, 2009.9196032158843, 1053.0, 1053.6312290698347, 1066.1950227578284, 1068.033429746081, 1085.8696956365286, 20583.176672933216, 21462.46343841385, 21618.89190554037, 22372.32883013512, 22409.991550380273, 1035.8756949166147, 1042.3797840285017, 1046.534292239946, 1052.694598828563, 1080.7622323088908, 11121.88684150025, 11757.412129393668, 11978.0, 11984.64046078619, 12068.939655301667, 641467.0, 650127.0, 653800.0, 665375.0, 667249.0, 85322.57338713267, 119224.0, 119457.0, 120825.0, 121217.0, 1047.7852040331713, 1077.42357838556, 1093.5079214353573, 1095.3044816541394, 1118.5246270335238, 18945.86324820515, 19335.226590936767, 19504.414867553995, 19546.706799398304, 19594.942531034038, 46257.537424626666, 51698.0, 53011.73494132505, 54042.459575403744, 54997.62505937384, 63460.04809927762, 73866.63066684632, 75656.24343756492, 76527.23472765424, 76638.0, 8096.271335579826, 8305.626246818787, 8392.370572207232, 8531.23218910301, 8848.380613357003, 9384.624615015597, 12091.093168012258, 12374.319412432402, 13013.414396351998, 13430.597082087554, 9028.683996060106, 10472.895271047497, 10784.299020563638, 11492.023178029962, 11569.88430115688, 6240.875182496234, 6897.965510172417, 11017.228793984345, 11149.777004460027, 11230.494627741607, 11599.304041757521, 11711.76576468483, 11902.940485297519, 11934.462949167135, 11961.461734222155, 8453.36599755033, 8470.872936905827, 8478.618462169094, 8610.956945215485, 8790.824183516166, 11281.435928203393, 11538.480768365276, 11723.531058757555, 11846.229995050295, 11875.931166195083], "value": 10090.83119373028, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.8226612806466, 1603.6391811842336, 1620.5462470508255, 1903.0009245146296, 2024.5141166120136, 8238.0, 8430.704925327615, 8436.915630843698, 8757.386982911199, 8923.687670931518, 8817.691380801672, 8842.115788421155, 8929.866052009225, 8961.731148065568, 8977.102289771019, 2550.362409397655, 2560.423904621464, 2563.269468201563, 2563.9487210255784, 2564.987175064122, 2472.468419289852, 2541.466292078666, 2549.018627828281, 2552.680914885639, 2552.8723563821827, 2527.936801579957, 2535.366158460385, 2549.9800079968068, 2551.0306083688174, 2551.872406379683, 2512.6356678281545, 2546.821722479427, 2550.591905295144, 2554.8850301736466, 2558.0790915270486, 2496.6255061740703, 2526.0, 2537.314924970248, 2538.5811341128874, 2542.987285063563, 9000.954995224982, 9056.13966673165, 9071.183593476553, 9085.545722713838, 9092.77268068297, 4774.976125119387, 5554.638948468337, 5585.078462053756, 5713.685747283939, 5740.856478588027, 3618.782873027627, 3680.6871415929677, 3745.1198968242443, 3748.4189950557707, 3753.4369844523267, 1042.7497400623795, 1048.3081166430195, 1074.9946250268777, 1076.5855145768858, 1095.7151140703395, 12202.084843636763, 12385.442655080453, 12402.0, 12437.315947622878, 12455.190412623151, 4896.485868983706, 5005.224190250444, 5065.113605119163, 5093.312402825645, 5147.897042059138, 7916.168802275678, 9380.0, 9465.195458385977, 9533.332666713402, 9560.091791279818, 5529.917051244234, 5539.695316757537, 5548.528375088082, 5549.639273447213, 5549.833504994856, 4609.0, 4753.31076993834, 5041.319421878073, 5147.485251474897, 5151.974240128776, 3962.5641179470235, 3965.3457179565626, 4037.394390841397, 4059.4316795648633, 4101.364288535282, 1244.887960083597, 1245.1532957588927, 1251.3055254333933, 1257.2393701810456, 1270.1553466944563, 877.806882485852, 945.4941606240628, 962.8988956159642, 978.7210644966293, 1022.4785359466725, 5683.516901063374, 5966.343702192756, 6112.938870611237, 6140.416660417253, 6197.504199664016, 475.3535192138689, 479.85844175968174, 487.24477060555995, 488.57982135363557, 494.1549949586248, 3967.920641587152, 4034.9798251008556, 4056.7565946043333, 4095.774732389747, 4116.732412393185, 10738.624148154933, 11082.335059896432, 11099.5560177592, 11124.721881952853, 11157.776844463066, 10638.255322127377, 10886.782264354826, 10903.400312982862, 11062.391568463812, 11087.778244435067, 8337.791555211168, 8429.4942303462, 8518.78703032429, 8533.317334613215, 8598.269147122439, 5874.823755287348, 5970.9701451492465, 5975.25309336333, 6032.426919442646, 6117.265928088658, 9495.525223738647, 9538.23694104484, 9544.42733435996, 9679.806403872024, 9762.56068476906, 9454.763630909283, 9899.554520046471, 9908.207343412365, 10027.699169024942, 10092.697219083439, 6730.394264516217, 6967.0, 7118.644067796693, 7594.278543538355, 7728.497647653109, 8388.874166887379, 8435.789105272417, 8469.788255293666, 8469.957650211709, 8484.278836298983, 7421.666025028779, 7513.737019204302, 7571.188279438178, 7674.9232507674205, 7758.262965018314, 7433.665485053078, 7455.701771929279, 7511.211322811027, 7615.771526854203, 7618.5809780462605, 7102.254263302279, 7169.032180655545, 7175.497715160098, 7194.712211511481, 7197.568145911262, 4974.651774375759, 5013.598912087097, 5063.746812659426, 5121.769520371667, 5183.974080129575, 5038.823641172541, 5048.772805223847, 5107.821226257063, 5141.8687888664435, 5307.044731948286], "value": 4632.648944815476, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.9554560134382, 335.8085891042107, 341.8717980757216, 346.3505926388021, 348.2304107921493, 6615.867682646344, 6650.634215118166, 6703.0, 6705.4300384467315, 6736.461083113351, 5243.86890327742, 6613.0, 6655.301193374698, 6662.500312476559, 6669.399754022137, 4717.811287548494, 4851.781669824866, 4860.951390486085, 4927.162382394984, 4937.358143441347, 4886.584640305578, 4962.057209130272, 4969.254611808222, 4971.204607262839, 4974.502549745014, 4892.266160075981, 4907.803687852482, 4927.3348098006845, 4932.0, 4965.0566392385335, 4737.242041273397, 4802.687825291345, 4946.455889852114, 4959.479254678243, 4964.255361695738, 4255.829766809355, 4255.978565144374, 4258.5954334338185, 4268.338407546804, 4274.166537525184, 6349.0, 6395.360463953614, 6412.4549413299455, 6433.710483028275, 6439.903401448982, 5891.116332550109, 5894.852628684274, 5910.852228694274, 5911.231539899829, 5915.970420147914, 6734.3602357775935, 7123.536970096979, 7127.358537731629, 7128.0, 7141.035960145366, 4754.786034628415, 4756.500567440404, 4780.904381912343, 4787.0904528139545, 4798.49615790344, 7345.816354591178, 7453.664585093629, 7460.761771468592, 7468.813279667997, 7478.476506644592, 4861.756912154378, 4874.731889746098, 4888.364512613338, 4891.364122664031, 4903.583195428429, 4964.776585053682, 4967.4784147664695, 4968.850934471971, 4969.428515720666, 4972.726500042532, 5549.056660367747, 5866.530677545871, 5879.3826648202175, 5888.970555147197, 5899.233099697012, 6944.861102777916, 6982.47631427645, 6993.405560527311, 7004.649767511706, 7015.123109611299, 1696.6691495158325, 1724.2499512711759, 1727.7494763259258, 1728.559217399555, 1732.9740053899202, 1056.7041228456044, 1103.8951299626522, 1112.1269803204445, 1130.553431394611, 1139.3790384240608, 6446.357807838556, 6547.5416720830035, 6701.095352127498, 6721.22705888829, 6729.4279986200745, 7392.928025436282, 7396.149442814038, 7397.297256760599, 7418.666160022704, 7424.665890034961, 6682.966585167043, 6702.631355275409, 6705.798826035227, 6711.6979735912, 6722.731090756412, 3846.0, 3890.7081968851885, 3895.668868146183, 3900.3759398496104, 3900.76595404271, 7414.221506741822, 7674.386049116058, 7686.538807671557, 7702.0, 7759.534427934229, 5729.856753581111, 6805.183377994574, 6931.792046238621, 7602.771916842504, 7636.923630763732, 7691.1924247954275, 7715.845683086419, 7720.266574675396, 7722.073351197892, 7725.266099720518, 7060.399866011241, 7354.742584009534, 7377.446691498267, 7384.889226661497, 7386.409087273113, 5758.309002919509, 7260.0, 7262.128544574473, 7264.34620884123, 7290.05229320185, 7749.845003099794, 7752.0697516298405, 7766.689332426639, 7772.37820974332, 7779.0, 4652.906941861076, 4690.835820746258, 4698.177818881613, 4699.976500117477, 4704.976475117739, 7046.753363632249, 7341.9632901837285, 7354.117505899327, 7364.3003914628025, 7370.557766534025, 6234.376562343729, 6669.666066786565, 7097.7160913562875, 7102.538335008208, 7118.822029449305, 7048.964755176191, 7106.324899134574, 7110.786676399716, 7117.1459424869345, 7124.821879453055, 6946.479014074066, 6957.756478523227, 6967.79096627102, 6972.26791186918, 6984.371406573433, 6814.0, 7081.150261968391, 7108.0, 7128.4653650977425, 7129.857402852018, 6708.6981085850275, 6868.862622747617, 6922.473297246368, 6952.270011648704, 7006.2643422439905], "value": 5232.313418801098, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.9749408770692, 735.8601865645524, 770.5107256891872, 778.140155128583, 788.2314743125453, 14729.779053314209, 15142.015768975009, 15152.621184470367, 15161.924190379046, 15168.696626067485, 14119.647008824759, 14290.92854535726, 14308.35612397442, 14309.785353219684, 14318.92840535796, 763.4770182425057, 774.8682723936917, 933.0855761353878, 955.5365647660878, 961.3510880155902, 935.2704890185666, 944.2823454174842, 949.2548349545608, 950.0119875329649, 950.1543626172677, 1019.1541020952628, 1025.523131743739, 1025.7948410317929, 1027.8715160604925, 1028.1312291114034, 826.4627991805345, 994.4033579852103, 1017.7760892603616, 1020.3214862116683, 1022.9693109206736, 755.1844008470838, 755.994527278718, 757.8257000889827, 758.4311766175368, 758.7571976967373, 15186.468473603481, 15208.239588020666, 15242.618934526614, 15243.847561524464, 15257.23713814316, 12693.555725549562, 12774.041946854024, 12859.292738899358, 12956.287404192766, 13006.86993130066, 10248.0, 10267.211132475644, 10441.686749397455, 10467.633632822815, 10590.835008149097, 3575.606683264839, 3576.678098971105, 3711.9443208351895, 3727.6458736419995, 3854.209886973164, 79169.20830791733, 79823.6008819958, 79841.60079199566, 79976.99999999942, 80546.19453805445, 9546.0, 9619.711408657751, 9702.708918732309, 9754.804903901882, 9954.0, 17851.0, 21992.0, 22203.888980554995, 22224.777752222595, 22271.777282227293, 6522.869542609121, 7602.049743782028, 7636.732714354971, 7903.644336004893, 7976.481528700616, 4197.286461301525, 4268.850590229389, 4290.206311832321, 4338.067315527177, 4441.800118994588, 3827.559830619459, 3904.1801221743754, 3921.235359105004, 3921.6666583340166, 3929.8821035368983, 677.3362105136994, 696.4045740891465, 699.3635791429774, 721.1814590439784, 740.4964624055693, 435.7951762671539, 524.6484855147061, 576.8932747441737, 582.5659883386819, 640.4108220437209, 8122.0, 8469.957650211709, 8475.406721529434, 8483.066862645104, 8615.353848461391, 574.2247965246967, 617.8053913017385, 620.4044117647019, 621.0994058615026, 625.0686477149015, 3949.5063117110362, 3963.36586146221, 4030.7380020298588, 4058.9797051014557, 4152.937705934413, 97709.0, 99074.0, 99775.0, 100482.49758751159, 100527.49736251272, 81017.18982810214, 81446.0, 82127.58936205281, 84145.57927210325, 84586.0, 66034.66982665056, 68708.0, 68757.65621171962, 68842.0, 71013.60877521048, 7802.375809935305, 7984.20157984197, 8071.273585377344, 8074.273315401642, 8120.254605569231, 50092.749536252086, 50733.7316567074, 51476.97046059133, 51524.742376287875, 51782.22326665178, 67257.66371168113, 72082.0, 72266.63866680843, 72306.0, 73241.0, 10074.647387341407, 10205.13256373187, 10412.895871041193, 10495.580176792842, 10761.730956726144, 9524.0, 10781.299215551278, 11018.559257629606, 11464.770704586028, 11603.941980290045, 10525.157987361146, 10749.355038697704, 10806.0, 10889.074428673335, 10943.945280273867, 8518.957405212934, 10548.472576370998, 10703.250772445854, 10732.947746310456, 10778.191635627516, 10445.634402795866, 10482.21383396233, 10539.998700123477, 10589.364638121737, 10769.299995500267, 8950.641974321215, 9140.314476414163, 9205.815883682422, 9383.718488445358, 9492.905070949479, 9117.225035872025, 9134.269258459175, 9199.632014719336, 9234.769130771785, 9292.860607091034], "value": 6984.360105888606, "unit": "score"}], "name": "dromaeo_css", "value": 7591.2922183587325, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 120.0, 112.0, 112.0, 111.0, 113.0, 114.0, 113.0, 136.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 119.0, 143.0, 161.0, 116.0, 133.0, 118.0, 155.0, 154.0, 117.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 185.0, 196.0, 257.0, 246.0, 183.0, 186.0, 182.0, 185.0], "value": 199.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 80.0, 73.0, 155.0, 56.0, 55.0, 59.0, 66.0, 133.0, 79.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 137.0, 79.0, 84.0, 94.0, 122.0, 78.0, 77.0, 127.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 86.0, 88.0, 85.0, 89.0, 86.0, 88.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 108.0, 147.0, 94.0, 94.0, 94.0, 94.0, 95.0, 93.0], "value": 100.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 85.0, 87.0, 83.0, 84.0, 85.0, 86.0, 84.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 62.0, 62.0, 61.0, 63.0, 64.0, 76.0, 58.0, 56.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 57.0, 68.0, 68.0, 75.0, 68.0, 66.0, 66.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 80.0, 78.0, 79.0, 79.0, 81.0, 84.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 126.0, 128.0, 144.0, 138.0, 145.0, 137.0, 143.0, 159.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 160.0, 168.0, 210.0, 208.0, 163.0, 161.0, 161.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 67.0, 67.0, 73.0, 92.0, 93.0, 91.0], "value": 75.1, "unit": "score"}], "name": "kraken", "value": 1495.7999999999997, "alertThreshold": 2.0}]} 10:49:21 INFO - Return code: 0 10:49:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:49:21 ERROR - # TBPL SUCCESS # 10:49:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:49:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:49:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:49:21 INFO - 2016-06-23 10:49:21.312 screenresolution[1814:9978] starting screenresolution argv=screenresolution get 10:49:21 INFO - 2016-06-23 10:49:21.314 screenresolution[1814:9978] Display 0: 1600x1200x32@60 10:49:21 INFO - 2016-06-23 10:49:21.320 screenresolution[1815:9981] starting screenresolution argv=screenresolution list 10:49:21 INFO - Available Modes on Display 0 10:49:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:49:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:49:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:49:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:49:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:49:21 INFO - Intel Iris: 10:49:21 INFO - Chipset Model: Intel Iris 10:49:21 INFO - Type: GPU 10:49:21 INFO - Bus: Built-In 10:49:21 INFO - VRAM (Dynamic, Max): 1536 MB 10:49:21 INFO - Vendor: Intel (0x8086) 10:49:21 INFO - Device ID: 0x0a2e 10:49:21 INFO - Revision ID: 0x0009 10:49:21 INFO - Displays: 10:49:21 INFO - Display: 10:49:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:49:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:49:21 INFO - Display Serial Number: 1600x1200 60 10:49:21 INFO - Main Display: Yes 10:49:21 INFO - Mirror: Off 10:49:21 INFO - Online: Yes 10:49:21 INFO - Rotation: Supported 10:49:21 INFO - Return code: 0 10:49:21 INFO - Running post-action listener: _resource_record_post_action 10:49:21 INFO - Running post-run listener: _resource_record_post_run 10:49:22 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 36775424; Write bytes: 497990144; Read time: 241; Write time: 1617 10:49:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193436160; Write bytes: 188553216; Read time: 17506; Write time: 433 10:49:22 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 34960896; Write bytes: 299696640; Read time: 225; Write time: 1150 10:49:22 INFO - Running post-run listener: _upload_blobber_files 10:49:22 INFO - Blob upload gear active. 10:49:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:49:22 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 10:49:22 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'] 10:49:22 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 10:49:23 INFO - (blobuploader) - INFO - Open directory for files ... 10:49:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:49:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:49:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:23 INFO - (blobuploader) - INFO - Done attempting. 10:49:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:49:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:49:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:24 INFO - (blobuploader) - INFO - Done attempting. 10:49:24 INFO - (blobuploader) - INFO - Iteration through files over. 10:49:24 INFO - Return code: 0 10:49:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:49:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:49:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb304e2e085097c58d9a724fdeb907e41123ca474e8eeb3abd496d69f5c4362513b84e63a6beaaf85dc0853c31897f97dbb3103857ea1e4d86b74e675ed6b0f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c78dcbd73fc74431b45629c298511c8f14da9b7c361c0808fbfc03bf8be06a19513e676fb49a34bd8fccfcf6411ad325cf8b88c5237008a33ffe99bb1da9a4b"} 10:49:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:49:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:49:24 INFO - Contents: 10:49:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb304e2e085097c58d9a724fdeb907e41123ca474e8eeb3abd496d69f5c4362513b84e63a6beaaf85dc0853c31897f97dbb3103857ea1e4d86b74e675ed6b0f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c78dcbd73fc74431b45629c298511c8f14da9b7c361c0808fbfc03bf8be06a19513e676fb49a34bd8fccfcf6411ad325cf8b88c5237008a33ffe99bb1da9a4b"} 10:49:24 INFO - Running post-run listener: copy_logs_to_upload_dir 10:49:24 INFO - Copying logs to upload dir... 10:49:24 INFO - mkdir: /builds/slave/test/build/upload/logs 10:49:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.496358 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-23 10:49:24.970553) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:49:24.974742) ========= 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.T0ODMy8FJl/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.az5i1IlFgn/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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/bb304e2e085097c58d9a724fdeb907e41123ca474e8eeb3abd496d69f5c4362513b84e63a6beaaf85dc0853c31897f97dbb3103857ea1e4d86b74e675ed6b0f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c78dcbd73fc74431b45629c298511c8f14da9b7c361c0808fbfc03bf8be06a19513e676fb49a34bd8fccfcf6411ad325cf8b88c5237008a33ffe99bb1da9a4b"} build_url:https://queue.taskcluster.net/v1/task/Qkrn12wFRx20yEMlvdC0zQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/Qkrn12wFRx20yEMlvdC0zQ/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/bb304e2e085097c58d9a724fdeb907e41123ca474e8eeb3abd496d69f5c4362513b84e63a6beaaf85dc0853c31897f97dbb3103857ea1e4d86b74e675ed6b0f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c78dcbd73fc74431b45629c298511c8f14da9b7c361c0808fbfc03bf8be06a19513e676fb49a34bd8fccfcf6411ad325cf8b88c5237008a33ffe99bb1da9a4b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:49:25.010657) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:49:25.010997) ========= 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.T0ODMy8FJl/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.az5i1IlFgn/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.005096 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:49:25.059206) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:49:25.059513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:49:25.059832) ========= ========= Total master_lag: 0.19 =========