builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0159 starttime: 1463145867.43 results: success (0) buildid: 20160513041937 builduid: 8cc8e7f6a55d4b3da4a46c0d62493492 revision: 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.430559) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.430991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.431293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.532393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.532650) ========= 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.2fvnfC0ysv/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.2dma7yznnw/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-05-13 06:24:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-05-13 06:24:27 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163946 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.727533) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.727800) ========= 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.2fvnfC0ysv/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.2dma7yznnw/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.027880 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.808260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-13 06:24:27.808555) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 --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 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2fvnfC0ysv/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.2dma7yznnw/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-05-13 06:24:27,905 truncating revision to first 12 chars 2016-05-13 06:24:27,905 Setting DEBUG logging. 2016-05-13 06:24:27,905 attempt 1/10 2016-05-13 06:24:27,905 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3e9245c2bfaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 06:24:30,231 unpacking tar archive at: mozilla-beta-3e9245c2bfaa/testing/mozharness/ program finished with exit code 0 elapsedTime=2.582931 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-13 06:24:30.429950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:30.430264) ========= script_repo_revision: 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:30.430657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:30.430958) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:31.221362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2016-05-13 06:24:31.221733) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.2fvnfC0ysv/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.2dma7yznnw/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 06:24:31 INFO - MultiFileLogger online at 20160513 06:24:31 in /builds/slave/test 06:24:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:24:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:24:31 INFO - {'append_to_log': False, 06:24:31 INFO - 'base_work_dir': '/builds/slave/test', 06:24:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:24:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:24:31 INFO - 'branch': 'Mozilla-Beta', 06:24:31 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:31 INFO - 'config_files': ('talos/mac_config.py',), 06:24:31 INFO - 'default_actions': ('clobber', 06:24:31 INFO - 'read-buildbot-config', 06:24:31 INFO - 'download-and-extract', 06:24:31 INFO - 'populate-webroot', 06:24:31 INFO - 'create-virtualenv', 06:24:31 INFO - 'install', 06:24:31 INFO - 'run-tests'), 06:24:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:24:31 INFO - 'download_minidump_stackwalk': True, 06:24:31 INFO - 'download_symbols': 'ondemand', 06:24:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:24:31 INFO - 'tooltool.py': '/tools/tooltool.py', 06:24:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:24:31 INFO - '/tools/misc-python/virtualenv.py')}, 06:24:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:24:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:24:31 INFO - 'installer_path': 'installer.exe', 06:24:31 INFO - 'log_level': 'info', 06:24:31 INFO - 'log_name': 'talos', 06:24:31 INFO - 'log_to_console': True, 06:24:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:24:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:24:31 INFO - 'opt_config_files': (), 06:24:31 INFO - 'pip_index': False, 06:24:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:24:31 INFO - 'cmd': ('bash', 06:24:31 INFO - '-c', 06:24:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:24:31 INFO - 'enabled': True, 06:24:31 INFO - 'halt_on_failure': False, 06:24:31 INFO - 'name': 'check_screen_resolution'},), 06:24:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:24:31 INFO - 'cmd': ('bash', 06:24:31 INFO - '-c', 06:24:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:24:31 INFO - 'enabled': True, 06:24:31 INFO - 'halt_on_failure': False, 06:24:31 INFO - 'name': 'check_screen_resolution'},), 06:24:31 INFO - 'run_cmd_checks_enabled': True, 06:24:31 INFO - 'sps_profile': False, 06:24:31 INFO - 'sps_profile_interval': 0, 06:24:31 INFO - 'suite': 'dromaeojs-e10s', 06:24:31 INFO - 'system_bits': '32', 06:24:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:24:31 INFO - 'title': 't-yosemite-r7-0159', 06:24:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:24:31 INFO - 'use_talos_json': True, 06:24:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:24:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:31 INFO - 'work_dir': 'build'} 06:24:31 INFO - ##### 06:24:31 INFO - ##### Running clobber step. 06:24:31 INFO - ##### 06:24:31 INFO - Running pre-action listener: _resource_record_pre_action 06:24:31 INFO - Running main action method: clobber 06:24:31 INFO - rmtree: /builds/slave/test/build 06:24:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:24:33 INFO - Running post-action listener: _resource_record_post_action 06:24:33 INFO - ##### 06:24:33 INFO - ##### Running read-buildbot-config step. 06:24:33 INFO - ##### 06:24:33 INFO - Running pre-action listener: _resource_record_pre_action 06:24:33 INFO - Running main action method: read_buildbot_config 06:24:33 INFO - Using buildbot properties: 06:24:33 INFO - { 06:24:33 INFO - "project": "", 06:24:33 INFO - "product": "firefox", 06:24:33 INFO - "script_repo_revision": "production", 06:24:33 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 06:24:33 INFO - "repository": "", 06:24:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 06:24:33 INFO - "buildid": "20160513041937", 06:24:33 INFO - "pgo_build": "False", 06:24:33 INFO - "basedir": "/builds/slave/test", 06:24:33 INFO - "buildnumber": 4, 06:24:33 INFO - "slavename": "t-yosemite-r7-0159", 06:24:33 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:24:33 INFO - "platform": "yosemite_r7", 06:24:33 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:24:33 INFO - "branch": "mozilla-beta", 06:24:33 INFO - "repo_path": "releases/mozilla-beta", 06:24:33 INFO - "revision": "3e9245c2bfaa9089cd3cc9e691159c091eb21e28", 06:24:33 INFO - "stage_platform": "macosx64", 06:24:33 INFO - "builduid": "8cc8e7f6a55d4b3da4a46c0d62493492", 06:24:33 INFO - "slavebuilddir": "test" 06:24:33 INFO - } 06:24:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 06:24:33 INFO - Running post-action listener: _resource_record_post_action 06:24:33 INFO - ##### 06:24:33 INFO - ##### Running download-and-extract step. 06:24:33 INFO - ##### 06:24:33 INFO - Running pre-action listener: _resource_record_pre_action 06:24:33 INFO - Running main action method: download_and_extract 06:24:33 INFO - mkdir: /builds/slave/test/build/tests 06:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:24:33 INFO - https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:24:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:24:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:24:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 06:25:03 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json: timed out 06:25:03 INFO - retry: attempt #1 caught exception: timed out 06:25:03 INFO - retry: Failed, sleeping 30 seconds before retrying 06:25:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #2 06:25:35 INFO - Downloaded 1241 bytes. 06:25:35 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:25:35 INFO - Using the following test package requirements: 06:25:35 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:25:35 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:25:35 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 06:25:35 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:25:35 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 06:25:35 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:25:35 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:25:35 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 06:25:35 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:25:35 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:25:35 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 06:25:35 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:25:35 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 06:25:35 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:25:35 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 06:25:35 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:25:35 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:25:35 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 06:25:35 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 06:25: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')]} 06:25:35 INFO - https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:25:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:25:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:25:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:25:36 INFO - Downloaded 17747491 bytes. 06:25:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:25:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:25:39 INFO - Return code: 0 06:25:39 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:25:39 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')]} 06:25:39 INFO - https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:25:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:25:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:25:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:25:41 INFO - Downloaded 17747491 bytes. 06:25:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:25:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:25:45 INFO - Return code: 0 06:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:45 INFO - https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:25:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:25:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:25:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 06:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 06:25:46 INFO - Downloaded 10845194 bytes. 06:25:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:25:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:25:46 INFO - Return code: 0 06:25: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')]} 06:25:46 INFO - https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 06:25:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:25:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:25:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 06:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 06:25:49 INFO - Downloaded 88270161 bytes. 06:25:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:25:49 INFO - mkdir: /builds/slave/test/properties 06:25:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:25:49 INFO - Writing to file /builds/slave/test/properties/build_url 06:25:49 INFO - Contents: 06:25:49 INFO - build_url:https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:25:50 INFO - Running post-action listener: _resource_record_post_action 06:25:50 INFO - Running post-action listener: set_extra_try_arguments 06:25:50 INFO - ##### 06:25:50 INFO - ##### Running populate-webroot step. 06:25:50 INFO - ##### 06:25:50 INFO - Running pre-action listener: _resource_record_pre_action 06:25:50 INFO - Running main action method: populate_webroot 06:25:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:25:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:25:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:25:50 INFO - '--tppagecycles', 06:25:50 INFO - '7'], 06:25:50 INFO - 'tests': ['tsvgm']}}, 06:25:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:25:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:25:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:25:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:25:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:25:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:25:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:25:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:50 INFO - 'talos_options': ['--e10s'], 06:25:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:25:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:50 INFO - 'tests': ['damp', 'tps']}, 06:25:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:50 INFO - 'talos_options': ['--e10s'], 06:25:50 INFO - 'tests': ['damp', 'tps']}, 06:25:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:25:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:25:50 INFO - 'other': {'tests': ['a11yr', 06:25:50 INFO - 'ts_paint', 06:25:50 INFO - 'tpaint', 06:25:50 INFO - 'sessionrestore', 06:25:50 INFO - 'sessionrestore_no_auto_restore', 06:25:50 INFO - 'tabpaint']}, 06:25:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:25:50 INFO - 'tests': ['a11yr', 06:25:50 INFO - 'ts_paint', 06:25:50 INFO - 'tpaint', 06:25:50 INFO - 'sessionrestore', 06:25:50 INFO - 'sessionrestore_no_auto_restore', 06:25:50 INFO - 'tabpaint']}, 06:25:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:25:50 INFO - 'tests': ['a11yr', 06:25:50 INFO - 'ts_paint', 06:25:50 INFO - 'tpaint', 06:25:50 INFO - 'sessionrestore', 06:25:50 INFO - 'sessionrestore_no_auto_restore', 06:25:50 INFO - 'tabpaint']}, 06:25:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:25:50 INFO - 'tests': ['a11yr', 06:25:50 INFO - 'ts_paint', 06:25:50 INFO - 'tpaint', 06:25:50 INFO - 'sessionrestore', 06:25:50 INFO - 'sessionrestore_no_auto_restore', 06:25:50 INFO - 'tabpaint']}, 06:25:50 INFO - 'other_l64': {'tests': ['a11yr', 06:25:50 INFO - 'ts_paint', 06:25:50 INFO - 'tpaint', 06:25:50 INFO - 'sessionrestore', 06:25:50 INFO - 'sessionrestore_no_auto_restore', 06:25:50 INFO - 'tabpaint']}, 06:25:50 INFO - 'other_nol64': {'tests': ['a11yr', 06:25:50 INFO - 'ts_paint', 06:25:50 INFO - 'tpaint', 06:25:50 INFO - 'sessionrestore', 06:25:50 INFO - 'sessionrestore_no_auto_restore', 06:25:50 INFO - 'tabpaint']}, 06:25:50 INFO - 'svgr': {'tests': ['tsvgx', 06:25:50 INFO - 'tsvgr_opacity', 06:25:50 INFO - 'tart', 06:25:50 INFO - 'tscrollx', 06:25:50 INFO - 'cart']}, 06:25:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:25:50 INFO - 'tests': ['tsvgx', 06:25:50 INFO - 'tsvgr_opacity', 06:25:50 INFO - 'tart', 06:25:50 INFO - 'tscrollx', 06:25:50 INFO - 'cart']}, 06:25:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:50 INFO - 'tests': ['tp5o']}, 06:25:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:50 INFO - 'talos_options': ['--e10s'], 06:25:50 INFO - 'tests': ['tp5o']}, 06:25:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:50 INFO - 'talos_options': ['--xperf_path', 06:25:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:25:50 INFO - 'tests': ['tp5n']}, 06:25:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:50 INFO - 'talos_options': ['--e10s', 06:25:50 INFO - '--xperf_path', 06:25:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:25:50 INFO - 'tests': ['tp5n']}}, 06:25:50 INFO - 'talos.zip': {'path': '', 06:25:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:25:50 INFO - Running post-action listener: _resource_record_post_action 06:25:50 INFO - ##### 06:25:50 INFO - ##### Running create-virtualenv step. 06:25:50 INFO - ##### 06:25:50 INFO - Running pre-action listener: _resource_record_pre_action 06:25:50 INFO - Running main action method: create_virtualenv 06:25:50 INFO - Creating virtualenv /builds/slave/test/build/venv 06:25:50 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 06:25:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:25:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:25:50 INFO - Using real prefix '/tools/python27' 06:25:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:25:51 INFO - Installing distribute.............................................................................................................................................................................................done. 06:25:54 INFO - Installing pip.................done. 06:25:54 INFO - Return code: 0 06:25:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89a493d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3d30>, '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 0x10d827db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bab20>, '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.2fvnfC0ysv/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.2dma7yznnw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 06:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:25:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fvnfC0ysv/Render', 06:25:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:54 INFO - 'HOME': '/Users/cltbld', 06:25:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:54 INFO - 'LOGNAME': 'cltbld', 06:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:54 INFO - 'MOZ_NO_REMOTE': '1', 06:25:54 INFO - 'NO_EM_RESTART': '1', 06:25:54 INFO - 'PAGER': '/bin/cat', 06:25:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:54 INFO - 'PWD': '/builds/slave/test', 06:25:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:54 INFO - 'SHELL': '/bin/bash', 06:25:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dma7yznnw/Listeners', 06:25:54 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 06:25:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:54 INFO - 'USER': 'cltbld', 06:25:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:54 INFO - 'XPC_FLAGS': '0x0', 06:25:54 INFO - 'XPC_SERVICE_NAME': '0', 06:25:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:54 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 06:25:54 INFO - Cleaning up... 06:25:54 INFO - Return code: 0 06:25:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10db1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89a493d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3d30>, '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 0x10d827db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bab20>, '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.2fvnfC0ysv/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.2dma7yznnw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 06:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:25:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fvnfC0ysv/Render', 06:25:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:54 INFO - 'HOME': '/Users/cltbld', 06:25:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:54 INFO - 'LOGNAME': 'cltbld', 06:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:54 INFO - 'MOZ_NO_REMOTE': '1', 06:25:54 INFO - 'NO_EM_RESTART': '1', 06:25:54 INFO - 'PAGER': '/bin/cat', 06:25:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:54 INFO - 'PWD': '/builds/slave/test', 06:25:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:54 INFO - 'SHELL': '/bin/bash', 06:25:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dma7yznnw/Listeners', 06:25:54 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 06:25:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:54 INFO - 'USER': 'cltbld', 06:25:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:54 INFO - 'XPC_FLAGS': '0x0', 06:25:54 INFO - 'XPC_SERVICE_NAME': '0', 06:25:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:54 INFO - Downloading/unpacking psutil>=0.7.1 06:25:54 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 06:25:54 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 06:25:54 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 06:25:54 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 06:25:54 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 06:25:54 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 06:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:25:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:57 INFO - Installing collected packages: psutil 06:25:57 INFO - Running setup.py install for psutil 06:25:57 INFO - building 'psutil._psutil_osx' extension 06:25:57 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 06:25: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:25: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:25:58 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 06:25:58 INFO - building 'psutil._psutil_posix' extension 06:25:58 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 06:25:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:25:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:25:58 INFO - ^ 06:25:58 INFO - 1 warning generated. 06:25:58 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 06:25:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:59 INFO - Successfully installed psutil 06:25:59 INFO - Cleaning up... 06:25:59 INFO - Return code: 0 06:25:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:59 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 0x10db1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89a493d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3d30>, '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 0x10d827db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bab20>, '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.2fvnfC0ysv/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.2dma7yznnw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 06:25:59 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 06:25:59 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 06:25:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fvnfC0ysv/Render', 06:25:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:59 INFO - 'HOME': '/Users/cltbld', 06:25:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:59 INFO - 'LOGNAME': 'cltbld', 06:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:59 INFO - 'MOZ_NO_REMOTE': '1', 06:25:59 INFO - 'NO_EM_RESTART': '1', 06:25:59 INFO - 'PAGER': '/bin/cat', 06:25:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:59 INFO - 'PWD': '/builds/slave/test', 06:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:59 INFO - 'SHELL': '/bin/bash', 06:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dma7yznnw/Listeners', 06:25:59 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 06:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:59 INFO - 'USER': 'cltbld', 06:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:59 INFO - 'XPC_FLAGS': '0x0', 06:25:59 INFO - 'XPC_SERVICE_NAME': '0', 06:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:25:59 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 06:25:59 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 06:25:59 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 06:25:59 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 06:25:59 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 06:25:59 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 06:26:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:26:01 INFO - Installing collected packages: mozsystemmonitor 06:26:01 INFO - Running setup.py install for mozsystemmonitor 06:26:01 INFO - Successfully installed mozsystemmonitor 06:26:01 INFO - Cleaning up... 06:26:02 INFO - Return code: 0 06:26:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10db1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89a493d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3d30>, '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 0x10d827db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bab20>, '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.2fvnfC0ysv/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.2dma7yznnw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 06:26:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fvnfC0ysv/Render', 06:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:02 INFO - 'HOME': '/Users/cltbld', 06:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:02 INFO - 'LOGNAME': 'cltbld', 06:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:02 INFO - 'MOZ_NO_REMOTE': '1', 06:26:02 INFO - 'NO_EM_RESTART': '1', 06:26:02 INFO - 'PAGER': '/bin/cat', 06:26:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:02 INFO - 'PWD': '/builds/slave/test', 06:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:02 INFO - 'SHELL': '/bin/bash', 06:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dma7yznnw/Listeners', 06:26:02 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 06:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:02 INFO - 'USER': 'cltbld', 06:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:02 INFO - 'XPC_FLAGS': '0x0', 06:26:02 INFO - 'XPC_SERVICE_NAME': '0', 06:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:02 INFO - Downloading/unpacking blobuploader==1.2.4 06:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:04 INFO - Downloading blobuploader-1.2.4.tar.gz 06:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:26:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:26:04 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 06:26:04 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 06:26:04 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 06:26:04 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 06:26:04 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 06:26:04 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 06:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:26:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:26: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 06:26: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 06:26: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 06:26: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 06:26: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 06:26: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 06:26:05 INFO - Downloading docopt-0.6.1.tar.gz 06:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:26:05 INFO - Installing collected packages: blobuploader, requests, docopt 06:26:05 INFO - Running setup.py install for blobuploader 06:26:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:26:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:26:06 INFO - Running setup.py install for requests 06:26:06 INFO - Running setup.py install for docopt 06:26:06 INFO - Successfully installed blobuploader requests docopt 06:26:06 INFO - Cleaning up... 06:26:06 INFO - Return code: 0 06:26:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:06 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 0x10db1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89a493d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3d30>, '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 0x10d827db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bab20>, '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.2fvnfC0ysv/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.2dma7yznnw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 06:26:06 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 06:26:06 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 06:26:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fvnfC0ysv/Render', 06:26:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:06 INFO - 'HOME': '/Users/cltbld', 06:26:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:06 INFO - 'LOGNAME': 'cltbld', 06:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:06 INFO - 'MOZ_NO_REMOTE': '1', 06:26:06 INFO - 'NO_EM_RESTART': '1', 06:26:06 INFO - 'PAGER': '/bin/cat', 06:26:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:06 INFO - 'PWD': '/builds/slave/test', 06:26:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:06 INFO - 'SHELL': '/bin/bash', 06:26:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dma7yznnw/Listeners', 06:26:06 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 06:26:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:06 INFO - 'USER': 'cltbld', 06:26:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:06 INFO - 'XPC_FLAGS': '0x0', 06:26:06 INFO - 'XPC_SERVICE_NAME': '0', 06:26:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:26:07 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-s39OgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:26:07 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-hIf66M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:26:07 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-LzGbIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:26:07 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-UngZRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:26:07 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-oCiepJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:26:07 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-OyDref-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:26:07 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-bjWHnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:26:07 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-G5od7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:26:07 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-sNgmf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:26:08 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-PbLBfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:26:08 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-0YDV5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:26:08 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Z3fPK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:26:08 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-gSGAgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:26:08 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Oc80Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:26:08 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-JaEOhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:26:08 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-EUpMGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:26:08 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Z1LODa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:26:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:26:08 INFO - Running setup.py install for manifestparser 06:26:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:26:09 INFO - Running setup.py install for mozcrash 06:26:09 INFO - Running setup.py install for mozdebug 06:26:09 INFO - Running setup.py install for mozdevice 06:26:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:26:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:26:09 INFO - Running setup.py install for mozfile 06:26:09 INFO - Running setup.py install for mozhttpd 06:26:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:26:09 INFO - Running setup.py install for mozinfo 06:26:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:26:09 INFO - Running setup.py install for mozInstall 06:26:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:26:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:26:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:26:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:26:10 INFO - Running setup.py install for mozleak 06:26:10 INFO - Running setup.py install for mozlog 06:26:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:26:10 INFO - Running setup.py install for moznetwork 06:26:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:26:10 INFO - Running setup.py install for mozprocess 06:26:10 INFO - Running setup.py install for mozprofile 06:26:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:26:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:26:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:26:10 INFO - Running setup.py install for mozrunner 06:26:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:26:11 INFO - Running setup.py install for mozscreenshot 06:26:11 INFO - Running setup.py install for moztest 06:26:11 INFO - Running setup.py install for mozversion 06:26:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:26:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:26:11 INFO - Cleaning up... 06:26:11 INFO - Return code: 0 06:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:26:11 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')]} 06:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:11 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')]} 06:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:11 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 0x10db1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89a493d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3d30>, '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 0x10d827db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bab20>, '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.2fvnfC0ysv/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.2dma7yznnw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 06:26:11 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 06:26:11 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 06:26:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fvnfC0ysv/Render', 06:26:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:11 INFO - 'HOME': '/Users/cltbld', 06:26:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:11 INFO - 'LOGNAME': 'cltbld', 06:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:11 INFO - 'MOZ_NO_REMOTE': '1', 06:26:11 INFO - 'NO_EM_RESTART': '1', 06:26:11 INFO - 'PAGER': '/bin/cat', 06:26:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:11 INFO - 'PWD': '/builds/slave/test', 06:26:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:11 INFO - 'SHELL': '/bin/bash', 06:26:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dma7yznnw/Listeners', 06:26:11 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 06:26:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:11 INFO - 'USER': 'cltbld', 06:26:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:11 INFO - 'XPC_FLAGS': '0x0', 06:26:11 INFO - 'XPC_SERVICE_NAME': '0', 06:26:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:26:11 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Zi9n4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:26:11 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)) 06:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:26:11 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-HhA4yR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:26:11 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)) 06:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:26:11 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-w9s9wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:26:12 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)) 06:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:26:12 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ix5NNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:26:12 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)) 06:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:26:12 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-G8jzhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:26:12 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)) 06:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:26:12 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-wa1uiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:26:12 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)) 06:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:26:12 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-xucd_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:26:12 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)) 06:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:26:12 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-I4goCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:26:12 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)) 06:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:26:12 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-cfhxgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:26:12 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)) 06:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:26:12 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-TK0i_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:26:12 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)) 06:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:26:12 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-taV3pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:26:12 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)) 06:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:26:12 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-qu5dr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:26:12 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)) 06:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:26:13 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Op0SDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:26:13 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)) 06:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:26:13 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-qoMWl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:26:13 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)) 06:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:26:13 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-HCXzdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:26:13 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)) 06:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:26:13 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-3IJ5mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:26:13 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)) 06:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:26:13 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-_EbqUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:26:13 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)) 06:26:13 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)) 06:26:13 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)) 06:26:13 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)) 06:26:13 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)) 06:26:13 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)) 06:26:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:15 INFO - Downloading blessings-1.6.tar.gz 06:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:26:16 INFO - Installing collected packages: blessings 06:26:16 INFO - Running setup.py install for blessings 06:26:16 INFO - Successfully installed blessings 06:26:16 INFO - Cleaning up... 06:26:16 INFO - Return code: 0 06:26:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:26:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:26:16 INFO - Reading from file tmpfile_stdout 06:26:16 INFO - Current package versions: 06:26:16 INFO - blessings == 1.6 06:26:16 INFO - blobuploader == 1.2.4 06:26:16 INFO - docopt == 0.6.1 06:26:16 INFO - manifestparser == 1.1 06:26:16 INFO - mozInstall == 1.12 06:26:16 INFO - mozcrash == 0.17 06:26:16 INFO - mozdebug == 0.1 06:26:16 INFO - mozdevice == 0.48 06:26:16 INFO - mozfile == 1.2 06:26:16 INFO - mozhttpd == 0.7 06:26:16 INFO - mozinfo == 0.9 06:26:16 INFO - mozleak == 0.1 06:26:16 INFO - mozlog == 3.1 06:26:16 INFO - moznetwork == 0.27 06:26:16 INFO - mozprocess == 0.22 06:26:16 INFO - mozprofile == 0.28 06:26:16 INFO - mozrunner == 6.11 06:26:16 INFO - mozscreenshot == 0.1 06:26:16 INFO - mozsystemmonitor == 0.0 06:26:16 INFO - moztest == 0.7 06:26:16 INFO - mozversion == 1.4 06:26:16 INFO - psutil == 3.1.1 06:26:16 INFO - requests == 1.2.3 06:26:16 INFO - wsgiref == 0.1.2 06:26:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:26:16 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')]} 06:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:16 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')]} 06:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:16 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 0x10db1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89a493d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3d30>, '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 0x10d827db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bab20>, '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.2fvnfC0ysv/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.2dma7yznnw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 06:26:16 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 06:26:16 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 06:26:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fvnfC0ysv/Render', 06:26:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:16 INFO - 'HOME': '/Users/cltbld', 06:26:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:16 INFO - 'LOGNAME': 'cltbld', 06:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:16 INFO - 'MOZ_NO_REMOTE': '1', 06:26:16 INFO - 'NO_EM_RESTART': '1', 06:26:16 INFO - 'PAGER': '/bin/cat', 06:26:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:16 INFO - 'PWD': '/builds/slave/test', 06:26:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:16 INFO - 'SHELL': '/bin/bash', 06:26:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dma7yznnw/Listeners', 06:26:16 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 06:26:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:16 INFO - 'USER': 'cltbld', 06:26:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:16 INFO - 'XPC_FLAGS': '0x0', 06:26:16 INFO - 'XPC_SERVICE_NAME': '0', 06:26:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:16 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)) 06:26:16 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)) 06:26:16 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)) 06:26:16 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)) 06:26:16 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)) 06:26:16 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)) 06:26:16 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)) 06:26:16 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)) 06:26:16 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)) 06:26:16 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)) 06:26:16 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)) 06:26:16 INFO - Cleaning up... 06:26:16 INFO - Return code: 0 06:26:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:26:16 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')]} 06:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:16 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')]} 06:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:16 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 0x10db1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89a493d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3d30>, '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 0x10d827db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bab20>, '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.2fvnfC0ysv/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.2dma7yznnw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 06:26:16 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 06:26:16 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 06:26:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fvnfC0ysv/Render', 06:26:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:16 INFO - 'HOME': '/Users/cltbld', 06:26:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:16 INFO - 'LOGNAME': 'cltbld', 06:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:16 INFO - 'MOZ_NO_REMOTE': '1', 06:26:16 INFO - 'NO_EM_RESTART': '1', 06:26:16 INFO - 'PAGER': '/bin/cat', 06:26:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:16 INFO - 'PWD': '/builds/slave/test', 06:26:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:16 INFO - 'SHELL': '/bin/bash', 06:26:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dma7yznnw/Listeners', 06:26:16 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 06:26:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:16 INFO - 'USER': 'cltbld', 06:26:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:16 INFO - 'XPC_FLAGS': '0x0', 06:26:16 INFO - 'XPC_SERVICE_NAME': '0', 06:26:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:17 INFO - Downloading/unpacking jsonschema 06:26:17 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 06:26:17 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 06:26:17 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 06:26:17 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 06:26:17 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 06:26:17 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 06:26:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:26:19 INFO - Downloading/unpacking functools32 (from jsonschema) 06:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:19 INFO - Downloading functools32-3.2.3-2.tar.gz 06:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:26:19 INFO - warning: no files found matching '*.txt' 06:26:19 INFO - no previously-included directories found matching 'build' 06:26:19 INFO - no previously-included directories found matching 'dist' 06:26:19 INFO - no previously-included directories found matching '.git*' 06:26:19 INFO - Installing collected packages: jsonschema, functools32 06:26:20 INFO - Running setup.py install for functools32 06:26:20 INFO - warning: no files found matching '*.txt' 06:26:20 INFO - no previously-included directories found matching 'build' 06:26:20 INFO - no previously-included directories found matching 'dist' 06:26:20 INFO - no previously-included directories found matching '.git*' 06:26:20 INFO - Successfully installed jsonschema functools32 06:26:20 INFO - Cleaning up... 06:26:20 INFO - Return code: 0 06:26:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:26:20 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')]} 06:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:20 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')]} 06:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:20 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 0x10db1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89a493d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3d30>, '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 0x10d827db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bab20>, '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.2fvnfC0ysv/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.2dma7yznnw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 06:26:20 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 06:26:20 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 06:26:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fvnfC0ysv/Render', 06:26:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:20 INFO - 'HOME': '/Users/cltbld', 06:26:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:20 INFO - 'LOGNAME': 'cltbld', 06:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:20 INFO - 'MOZ_NO_REMOTE': '1', 06:26:20 INFO - 'NO_EM_RESTART': '1', 06:26:20 INFO - 'PAGER': '/bin/cat', 06:26:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:20 INFO - 'PWD': '/builds/slave/test', 06:26:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:20 INFO - 'SHELL': '/bin/bash', 06:26:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dma7yznnw/Listeners', 06:26:20 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 06:26:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:20 INFO - 'USER': 'cltbld', 06:26:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:20 INFO - 'XPC_FLAGS': '0x0', 06:26:20 INFO - 'XPC_SERVICE_NAME': '0', 06:26:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:20 INFO - Downloading/unpacking flake8 06:26: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 06:26: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 06:26: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 06:26: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 06:26: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 06:26: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 06:26:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:26:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:26:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:26:23 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 06:26:23 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 06:26:23 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 06:26:23 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 06:26:23 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 06:26:23 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 06:26:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:26:23 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 06:26:23 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 06:26:23 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 06:26:23 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 06:26:23 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 06:26:23 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 06:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:26:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:26:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:26:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:26:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:26:24 INFO - no previously-included directories found matching 'docs/_build' 06:26:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:26:24 INFO - Running setup.py install for pep8 06:26:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:26:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:26:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:26:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:26:24 INFO - no previously-included directories found matching 'docs/_build' 06:26:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:26:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:26:24 INFO - Cleaning up... 06:26:24 INFO - Return code: 0 06:26:24 INFO - Running post-action listener: _resource_record_post_action 06:26:24 INFO - Running post-action listener: _start_resource_monitoring 06:26:24 INFO - Starting resource monitoring. 06:26:24 INFO - ##### 06:26:24 INFO - ##### Running install step. 06:26:24 INFO - ##### 06:26:24 INFO - Running pre-action listener: _resource_record_pre_action 06:26:24 INFO - Running main action method: install 06:26:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:26:25 INFO - Reading from file tmpfile_stdout 06:26:25 INFO - Detecting whether we're running mozinstall >=1.0... 06:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:26:25 INFO - Reading from file tmpfile_stdout 06:26:25 INFO - Output received: 06:26:25 INFO - Usage: mozinstall [options] installer 06:26:25 INFO - Options: 06:26:25 INFO - -h, --help show this help message and exit 06:26:25 INFO - -d DEST, --destination=DEST 06:26:25 INFO - Directory to install application into. [default: 06:26:25 INFO - "/builds/slave/test"] 06:26:25 INFO - --app=APP Application being installed. [default: firefox] 06:26:25 INFO - mkdir: /builds/slave/test/build/application 06:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:26:47 INFO - Reading from file tmpfile_stdout 06:26:47 INFO - Output received: 06:26:47 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:26:47 INFO - Running post-action listener: _resource_record_post_action 06:26:47 INFO - ##### 06:26:47 INFO - ##### Running run-tests step. 06:26:47 INFO - ##### 06:26:47 INFO - Running pre-action listener: _resource_record_pre_action 06:26:47 INFO - Running main action method: run_tests 06:26:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:26:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:26:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:26:47 INFO - 2016-05-13 06:26:47.574 screenresolution[1650:8067] starting screenresolution argv=screenresolution get 06:26:47 INFO - 2016-05-13 06:26:47.577 screenresolution[1650:8067] Display 0: 1600x1200x32@60 06:26:47 INFO - 2016-05-13 06:26:47.582 screenresolution[1651:8069] starting screenresolution argv=screenresolution list 06:26:47 INFO - Available Modes on Display 0 06:26:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:26:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:26:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:26:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:26:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:26:47 INFO - Intel Iris: 06:26:47 INFO - Chipset Model: Intel Iris 06:26:47 INFO - Type: GPU 06:26:47 INFO - Bus: Built-In 06:26:47 INFO - VRAM (Dynamic, Max): 1536 MB 06:26:47 INFO - Vendor: Intel (0x8086) 06:26:47 INFO - Device ID: 0x0a2e 06:26:47 INFO - Revision ID: 0x0009 06:26:47 INFO - Displays: 06:26:47 INFO - Display: 06:26:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:26:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:26:47 INFO - Display Serial Number: 1600x1200 60 06:26:47 INFO - Main Display: Yes 06:26:47 INFO - Mirror: Off 06:26:47 INFO - Online: Yes 06:26:47 INFO - Rotation: Supported 06:26:47 INFO - Return code: 0 06:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:26:47 INFO - Python 2.7.3 06:26:47 INFO - Return code: 0 06:26:47 INFO - grabbing minidump binary from tooltool 06:26: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')]} 06:26:47 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 0x10d9c3d30>, '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 0x10d827db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:26:47 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 06:26:47 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 06:26:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:26:47 INFO - Return code: 0 06:26:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:26:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:26:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:26:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:26:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:26:49 INFO - Return code: 0 06:26: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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:26: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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0159 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fvnfC0ysv/Render', 06:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:49 INFO - 'HOME': '/Users/cltbld', 06:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:49 INFO - 'LOGNAME': 'cltbld', 06:26:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:26:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:49 INFO - 'MOZ_NO_REMOTE': '1', 06:26:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:26:49 INFO - 'NO_EM_RESTART': '1', 06:26:49 INFO - 'PAGER': '/bin/cat', 06:26:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:49 INFO - 'PWD': '/builds/slave/test', 06:26:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:49 INFO - 'SHELL': '/bin/bash', 06:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dma7yznnw/Listeners', 06:26:49 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 06:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:49 INFO - 'USER': 'cltbld', 06:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:49 INFO - 'XPC_FLAGS': '0x0', 06:26:49 INFO - 'XPC_SERVICE_NAME': '0', 06:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26: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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:26:49 INFO - mozversion application_buildid: 20160513041937 06:26:49 INFO - mozversion application_changeset: 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 06:26:49 INFO - mozversion application_display_name: Firefox 06:26:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:26:49 INFO - mozversion application_name: Firefox 06:26:49 INFO - mozversion application_remotingname: firefox 06:26:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:26:49 INFO - mozversion application_vendor: Mozilla 06:26:49 INFO - mozversion application_version: 47.0 06:26:49 INFO - mozversion platform_buildid: 20160513041937 06:26:49 INFO - mozversion platform_changeset: 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 06:26:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:26:49 INFO - mozversion platform_version: 47.0 06:26:49 INFO - using testdate: 1463146009 06:26:49 INFO - actual date: 1463146009 06:26:49 INFO - starting webserver on 'localhost:49271' 06:26:49 INFO - SUITE-START | Running 2 tests 06:26:49 INFO - TEST-START | dromaeo_css 06:26:49 INFO - operating with platform_type : mac_ 06:26:49 INFO - Initialising browser for dromaeo_css test... 06:26:49 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmp7uLq5g/profile http://localhost:49271/getInfo.html) 06:26:52 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 06:26:52 INFO - PROCESS | 1669 | colorDepth:24 06:26:52 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 06:26:52 INFO - PROCESS | 1669 | __metrics 06:26:52 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 06:26:52 INFO - TEST-INFO | 1669: exit 0 06:26:52 INFO - Browser initialized. 06:26:52 INFO - Running cycle 1/1 for dromaeo_css test... 06:26:52 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmp7uLq5g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:27:04 INFO - PROCESS | 1674 | RSS: Main: 167956480 06:27:04 INFO - PROCESS | 1674 | 06:27:54 INFO - PROCESS | 1674 | 1463146074235 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] 06:30:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 06:30:06 INFO - PROCESS | 1674 | RSS: Main: 178536448 06:30:06 INFO - PROCESS | 1674 | 06:33:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 06:33:08 INFO - PROCESS | 1674 | RSS: Main: 189763584 06:33:08 INFO - PROCESS | 1674 | 06:36:10 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 06:36:11 INFO - PROCESS | 1674 | RSS: Main: 191614976 06:36:11 INFO - PROCESS | 1674 | 06:39:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 06:39:13 INFO - PROCESS | 1674 | RSS: Main: 195211264 06:39:13 INFO - PROCESS | 1674 | 06:42:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 06:42:16 INFO - PROCESS | 1674 | RSS: Main: 194301952 06:42:16 INFO - PROCESS | 1674 | 06:45:18 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 06:45:18 INFO - PROCESS | 1674 | RSS: Main: 199704576 06:45:18 INFO - PROCESS | 1674 | 06:45:18 INFO - PROCESS | 1674 | __start_tp_report 06:45:18 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 06:45:18 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 06:45:18 INFO - PROCESS | 1674 | |i|pagename|runs| 06:45:18 INFO - PROCESS | 1674 | |0;dojo.html;3181.3319202967377;3638;3654.17780999275;3658.7438879278443;3687.336279469696;6016.2479690038745;6045.365236650155;6073.969630151849;6083.878322433548;6101.237345331833;5998.190244317016;6062.696865156736;6086.269647642289;6086.72609732562;6100.725467353968;5408.864778380553;5488.396276409591;5496.835094947138;5516.282883225175;5558.749856256458;5388.703621300827;5500.944990550083;5524.917126243109;5536.335639723239;5541;5481.75332110056;5482.23248745176;5511.118221084627;5514.696691681956;5543.918935807519;5455.427180146107;5506.063969125238;5519.834404967857;5554.944450555483;5594.468525490072;5385.811496597639;5486.725663716798;5490.835274941758;5491.7254137292975;5510.090835012218;4706.29405589161;5877.529797616223;6015.3383127855905;6038.788642397495;6051.485623721989;6293.685315734241;6301.180846489973;6358.300586935434;6360.968195158995;6375.139356186948;6322.74709011639;6400.391962763577;6409.903851442232;6444.838879028015;6456.741730330781;5667.518260947865;5819.010768169337;6194.194754681907;6195.008798592248;6221.377862213788;6531.3142120077655;6576.375244351874;6585.506087043491;6610.206775187008;6621.86756264872;6266.655333956585;6269.122322874801;6283.96858015707;6285.842853928597;6344.429001389897;6300.054991751183;6356.745730170834;6414.935850641434;6442.323556026643;6464.321246269168;6290.0879372491645;6312.652804095727;6327.746890124344;6345.96827015862;6375.840603984845;6302.968485157545;6307.463865571386;6348.079528468346;6352.237731472161;6384.425401713868;4995.975020124876;5028.371453568304;5052.7726252318735;5095.0574143783515;5130.692158470503;4527.298268768346;4562.634989200856;4572.748498832596;4579.702319349231;4590.05903789729;6152.600080994721;6153.753849845956;6162.383761623802;6164.969175154096;6175.69121543921;6268.592541484789;6290.370962903673;6316.210473690789;6322.525810564226;6323.494120470351;6122.081687746873;6172.814815555541;6201.658908759971;6203.069539569101;6228.750849966042;4741.454732705714;5674.375818659944;5689.829305120853;5699.971500142556;5712.143178523254;6437.967810160919;6498.220213574401;6581.638009909501;6615.140031795836;6687.899681504781;6412.487001039813;6464.644444555594;6468.514861385321;6477.1579694639395;6478.352164783484;6628.337166283526;6678.131842860591;6684.331566843472;6694.062831203538;6701.229358623821;6195.628262304276;6309.211348581427;6337;6370.4903607712195;6377.681115944277;6405.903911441239;6410.967945160244;6426.485881129592;6437.613743175424;6472.126262954441;6159.72281247336;6263.530235232284;6277.748890044347;6281.214848143982;6282.465990390685;6184.165137706532;6215.44061034491;6231.2522497298805;6237.438630523275;6286.18279623646;6098.512119030555;6232.283287422005;6259.530535209787;6266.811995640138;6299.716512756845;6153.507719382349;6162.537809664203;6229.345918678655;6271.686415679106;6294.464970477561;6153.507719382528;6247;6255.24937007562;6258.780942666985;6273 06:45:18 INFO - PROCESS | 1674 | |1;ext.html;505.8760603652106;528.4240178205755;588.299923091521;631.2929518938788;634.8381162803486;38912.80543597282;39789.40315895257;39795.801020994855;39816.800915995416;39930.40104398436;40936;41430.96422589437;42037.57962420375;42229.577704222946;42262.15475690484;9764.218862491001;9970.15253703436;9991.150752186037;10008.249381296395;10012.349197302188;9771.560279787427;9860;9873.259505537078;9924.354916930413;9939;9875.851862222073;9887.307888447776;9932.205423566133;9945.801083978316;9967.252456065824;8597.226249637532;8738.213560779528;9849.60601575936;9903.851442228372;9926.503674816302;9869.753256168582;9939.453330066915;9961.601535938555;9988.45063521506;10001.399916005063;34682.65317346819;40236.59763402358;40446;40546.59453405458;40607.78176654705;2698.743619356158;3408.909149072273;3431.4166591679473;3502.1944952660774;3524.488949102366;27477.587836182473;28363.57454638182;28968.710312896812;29302.413951720846;29315.853420732972;2847.9003234886886;2848.1170837040377;2856.5429531274895;2885.2354126156583;2946.3076177098364;320011;321534;322568;322948;324133;48348.75825620849;48942.51057489379;67298.32701673018;68476.97284540736;68621.97067043999;47889.5211047892;48951;49077;49145.75427122913;49171.77070573193;17220.483385498454;17619.383321583682;17797.911010444866;17830.19764110618;17837.197326120357;14019.71960560783;14030.649233769032;14038.71922561543;14251.287435628177;14284.857151428561;15480.458183963507;15640.4525841595;15645.452409165624;15657.843421565867;15685.764713529306;6365.713542890581;6417.262014868256;6442.35576442352;6453.225612926479;6464.870702586016;978.496074521622;991.3655260633201;1019.5564929255797;1073.307716522854;1085.7068591480256;23735.881320593286;29283.121506354844;29365.853170734008;29524.557131643043;30021;1040.6773900090845;1087.7443800706828;1115.6151127860876;1135.5798354608849;1166.7141550320225;12482.375881205904;15254.389824406899;15326;15490.380384784708;15556.299966501534;539669;539741;542584;543986;545941;66301.6684916582;66727.66636166789;66774;66936.66531667311;67061.99407008899;1337.6455239361576;1339.6516905604612;1528.2664321125922;1536.2779493637972;1568.5686436230128;29662.961796337026;29948.251293717833;30134.09597712072;30713;30881;51733;51881.7405912968;52536.73731631317;52565.7371713139;52638.73680631573;414476.92761537206;414555;415965;419328;421004;34375;35919.28161436809;35921;36023.639763603074;36375.63624363722;47614.76192619015;47632;48263.75868120637;49414.50585494099;49764.502354977434;39146;39180.804095979336;39680.809575712774;40075.59924400835;40272;32262.516062258615;35554.8222258887;35674.10814729652;38962;39488;31727.365452690356;38015.04962375963;39242.82271531859;39312.41031384589;39779.40330894981;33862.492062618585;34290.48564271588;34986;35094.473582895764;35262.11844703903;24690.01239950382;25145.622815658146;26305.4738905217;26410.471790563697;26513.469730605666 06:45:18 INFO - PROCESS | 1674 | |2;jquery.html;356.25898131885674;368.6663569469631;379.50664136622385;381.50023469255297;382.9157585331228;19900.50248743782;20604.89697551512;21342.35972920811;21870.781292187094;21948;21679.241226557035;21683.13267469299;21755.782442175572;21958.780412195913;21989.890050549726;5680.573956953224;5718.456746609076;5920.763169473237;5928.347881733006;5938.257717785277;5763;5813.622114562561;5842.47417732404;5856.32652244993;5886.499647529944;5514.145307477327;5808.651480911138;5835.533157347402;5838.562107841907;5860.531157507389;5708.1437784332265;5733.827985160431;5742.310922689283;5780.393058728815;5810.157527158581;5021.974890125526;5095.490450954912;5099.311592934943;5105.795768169269;5110.7955681773055;13390.933045334808;13845.861541384658;13984.580462586138;14020.369083391271;14043.929780351033;2138.689889965962;2156.1914282144194;2191.1564047841694;2219.933401997943;2248.5952528544854;10559.26085174038;11724.88275117255;13716.519921802788;15099.320530576151;15228;1611.8710503159837;1776.8134345893754;1801.4775715042754;1806.8825526340877;1861.4415675297491;97306.5134674322;99121.0087899119;100506.49746751219;101626.49186754093;102256.48871755668;11645.65063048093;11699.122565807598;11775;11790.823137652942;11908.106891983136;14278.500252491112;14309.141451512942;14393.568192954228;14484.986050976331;14512.274386280644;9095.363324567217;9145.3598248122;9154.084591540792;9181.035991220826;9262.44425334482;7538.434617403716;9263.536823158815;9368.391054581567;9435.386699864486;9473.573689184002;4534.58356425654;4558.133954548625;4607.861764147081;4631.698939568984;4634.930476042862;1962.8135327143898;1983.48429408352;1983.930562430337;1998.5902889907534;2023.5447024419389;895.2793001633618;964.1130160252584;985.8077674853478;1031.3966329697062;1033.3851358441716;20436.38690839277;20677.483062923548;20747.896260518603;21035.8948205258;21107.26124585632;961.624966263158;1015.2994433840627;1033.7440010387415;1067.7490789664423;1067.962621308266;10283;10531.631392901212;10845.969632884864;11293.943530282297;11318.773624527463;652330;671539;685931;691173;700120;92735;107308;112911.4354428239;122344.38827805805;123459;986.2800155886243;1000.5547531348626;1004.924630652704;1013.2147585621202;1039.8076355874036;18598.349057782914;18772.342967996054;18833.71749423787;18967.90516047411;19440.90279548593;39519.61681341139;48546.30087946905;50965;52797.738837759905;53634;72110;72621.63689181731;74011.25988740259;74244;74369;8025.117237104031;8186.345092392713;8223.09545949957;8305.169483051888;8312.418130731032;9599.280053995839;10912.508937097691;12747.61757147287;13160.802587960996;13358.332083395986;11463.541458341573;11832.940835295769;11907.642770716893;11968.820467693165;12027.097967652286;11338.716532086764;11732.41337933117;11732.70668233301;11886.108541859569;12171.573994910135;11773.47019384147;12057;12094.879051209375;12185.817212741993;12362.690932726753;8098;8333.54148037491;8360;8432.915670843213;8513.31893448535;8812.779680508038;11252.26860254081;12058.397080146133;12124.211926224767;12199.87800122023 06:45:18 INFO - PROCESS | 1674 | |3;mootools.html;1636.3863551168313;1637.3696126991108;1965.6854903215487;2047.9590408191846;2081.438011736832;7394.149672787631;8331.583420828965;8925.41984770991;9262.166405023547;9284.675036373728;8899.599518021689;9059.909400905988;9084.318676099287;9190.678326258583;9231;2609.321576390138;2625.12058460416;2634.4072583668712;2636.6440530528325;2638;2342.6954495915506;2421.648860915166;2622.5541657918106;2632.9605055924176;2646.6427032350675;2430.6961629796274;2589.2102908612865;2595.896164153441;2619.358257226982;2633.0915834037323;2583.9095631652895;2593.209071233264;2594.8962041518316;2599.6490473785984;2623.9475210495684;2539.136693524211;2552.5915853463357;2583.1992082454312;2584.715681275058;2590.831595946276;7936.920630793676;8010.5994700264755;8687.869681954775;9137.223336016446;9138.908610913872;5132.307138536287;5676.2620859288445;5765;5798.884022319572;5807.419258074201;3524.400851855165;3638.7089032877307;3679;3772.1512659651635;3785.5646600641003;1076.4725284610483;1091.6233899304727;1095.058249905081;1127.1940562497853;1134.5064896769932;11842.289462632183;12193.695157621041;12222.938885305606;12240.877591224064;12286.447109880077;4545.772711364485;4753.287006948985;5032.144535428986;5101.719405432663;5137.17805151174;10151.64469243573;10295.970402959794;10448.947755261328;10463.006014428616;10491.475426228659;5664.688442135722;5720.599558030898;5755.8561035974435;5780.161876527964;5798.710064496759;4677.204875171229;5117.360329958755;5193.350831146106;5205.765740541609;5219.5041471060185;4155.729877558009;4172.561881002512;4187.413762073312;4198.03445207604;4209.536950935395;1271.3516106785605;1317.5388613985028;1318.3605951113702;1372.3824279074456;1390.8887289016855;1201.2072032458536;1379.7447472217673;1446.2696338349067;1462.6343414146463;1471.2055490035475;8341.582920853933;8367.205115514016;8374;8541.017782954916;8580.65677372898;542.6066102076043;551.239289780109;552.2158534880399;554.273901189435;558.3857756467934;6212.689365531705;6220.720067596969;6361.173047503888;6366.681665916685;6506.446952009038;10809.78380432387;11066.28069175501;11069.280496767846;11118.888811111947;11148.944255278671;10673.733156671145;10929.344239345664;10962.342259464458;10979.231453798158;11096.445177741241;8672.956635216784;8684.478931264144;8730.257928076184;8773.605187766565;8889.599968001456;7960.402969777174;8123.350131989545;8147.144549822184;8191.017077950684;8219;9593.904060959301;9878;9898.653547125816;9916.355436896578;10023;10013.499325033865;10100.797984040131;10158.847617285894;10180.643677471253;10301.124404425707;7532.7740167795055;7661.808454788452;7819.882701759592;7829.7259595913865;7930.127685954425;8569.14308569163;8612.009618893908;8636.481811091355;8719.782005449915;8723;7569.280918312751;7579.583122928292;7617.542947423172;7716.189800070912;7820.139784623801;7499.212582678741;7543.358814500829;7545.396368290633;7633.885491717518;7660.425468089804;7966.203379661987;7993.6802527898235;8049.51702897828;8058.597070146587;8080.2727754502375;7187.209406965125;7315.670794814139;7315.817104572216;7327.74352897646;7332.340089391981;7339.559626422431;7345;7421.8144546386775;7468.9626551866895;7490.662920168496 06:45:18 INFO - PROCESS | 1674 | |4;prototype.html;332.6673326673327;340.8057407277851;341.3207716643878;347.5950517646941;349.77090006046035;6991.091158149434;6991.82520436988;6997.510174287802;7001.6849241784175;7020.964895175523;6908.309169083089;6911.412529934962;6930.618815965133;7028.472864535155;7035.050268213789;3656.542932133483;3791.810409479529;4276.700630955835;5166.483351664822;5274.947250527493;4139.668826493888;5151.948480515184;5154.407243167027;5182.611304152185;5184.688918664873;5120.487951204887;5131.332926719521;5132.589392848582;5137.486251374851;5147.81982630608;4074.653654439376;5148.948510514903;5208.739563021833;5212.947870521284;5218.452062533436;3649.981750091259;4482.148391805546;4497.9100417991785;4506.414166158378;4517.390152329426;6462.903056454157;6684.298148694365;6742.662866856637;6743.35938085881;6775.661216939134;5885;5942.435468630473;5947.613405128653;5955.493783028448;5991.820245392645;7552.66013029415;7557;7559.63926493231;7572.053493313336;7575.09098908129;4866.562009419134;4875.439324477695;4883.902321953577;4887.095887260833;4891.6820406673805;7197.532160409557;7935.285824275785;8003.839923201562;8023.518588884685;8028.638711258008;4797.808087676453;4870.512948705101;4871.878203044881;4892.804287828518;4921.532454416824;4937.5556199942175;4953.603711703127;4962.379702537183;4964.925526117111;4966.404031516241;5906.527477801766;5927.229460170151;5939.46544810969;5950.018246989285;5956.940430595725;7448.888266676005;7456.515326503868;7461.328480436787;7550.093988721279;7589.241075892367;1691.7462380642755;1721.6298495823457;1735.3058776489506;1748.991255043742;1749.9650006999789;1090.7218659241842;1105.7512059786484;1107.2802678259036;1109.3732041396586;1109.872364678056;7101;7180.030695855992;7184.533005354635;7191.352778249982;7194.064771579661;7758.573278469626;7790.610469476504;7793.610319484003;7810.297073263434;7821.139674635786;6175.505959523227;7133.643317834088;7133.82165445868;7134.571925684476;7138.107736532934;4008.118213992917;4115.753054816661;4139.586041395896;4155.085881106213;4169.708120431601;8025.2777250047775;8156.5513896735065;8196.237808871121;8200.179982001871;8204.876926846102;6484.448821850101;8081.15147909461;8087.716929907543;8098.392620553482;8105.918940810634;8139.83720325602;8157.714479993172;8167.224113709188;8177.550234737147;8200.548969806718;7565.621718913922;7814.101378341336;7833.92166078332;7837.804054898673;7842;7569.432292577969;7612.352949999091;7635.809104772425;7637.159912409519;7662.233776622294;7695.461317707706;8109.310708589836;8109.986251718535;8138.552379618941;8150.510969341858;4054.716169868081;4965.081459929925;4974.5771609413605;4977.104121258209;4978.327925730125;7486.438517111347;7633.809154771176;7844.6077696113825;7870.29167374939;7871.85858050568;6384.776532821329;7496.400287977058;7512.248775122444;7540.9622951884885;7550.093988721389;5746.5402767779315;7207.531510452013;7499.962500187464;7519.097708275042;7537.530181614533;6627.668616569249;6810.8637827244165;7109.82225444368;7347.33873951347;7352.96323518379;7416.406687465098;7495.8500829982;7495.887561686688;7537.321641052332;7552.886706699294;5880.882382352414;6187.938120618916;7322.267773222635;7328.157261914948;7349.448791340564 06:45:18 INFO - PROCESS | 1674 | |5;yui.html;723.8190452386903;781.3436713160944;788.3693045563548;794.3645083932854;800.4836880212263;15406.152661603608;15564;15589.454369097084;15647.608809779747;15720.528384148465;14617.12297262165;14618.561443156696;14625.634359141;14665.56003319902;14672.706545869076;794.8291117409756;980.632262901412;980.6469670918464;990.6730778842965;1010.4240582867768;984.9310548261625;988.1896844587441;998.7652901568125;1001.1340190734999;1003.7390278527599;1037.1806273044324;1040.8802987656402;1043.8329867221246;1044.660485342263;1045.3100953370777;990.8018396320765;994.721477986165;1034.1468288661883;1035.3425574760045;1041.6927006533053;741.7774667599698;752.5447104501752;781.249999999995;781.4607920534813;784.4077721320367;15396.538103856903;15816.209189540477;15820.525384238492;15867.285972131282;15918.840811591852;13275.734485310337;13279.73440531184;13307.534236301779;13356.799648005288;13434.596962091153;10411.635592754294;10463.372197668165;10500.947495262475;10521.78956420875;10723.731906702316;3619.94570081449;3620.4388319810473;3643.453481977698;3698.6301369863068;3726.4224045273027;82738.17261827365;84097;84974;86146;87145.25709485839;9744.95127524372;9812.705618831447;9851.261155413373;9856.45789481571;10124.69625911224;22669.319920402413;22982.770172298064;23060.76939230586;23096.191633292754;23360.883195583912;7550.3582195514;7686.500377475558;7696.999390079254;7708.614569271514;7984.441089123706;3468.9132771680406;4168.895777605584;4211.1998720243055;4285.400043993844;4349.869503914888;3696.482492451059;3703.851845926187;3718.219173973496;3743.887683369503;3747.8126093695205;635.5138319185827;660.4254298760013;660.6894759463045;664.4651055900047;666.4501786026451;559.4712996218616;579.2325169150891;590.6721769418015;629.3014753623474;630.2216762298558;8116.2695357418115;8363.832723345498;8388.161183881562;8526.957365213135;8683.218510333974;553.4686700767309;600.7356763024343;607.6354187487473;611.7338957553478;620.9348018457997;3973.5430425501436;4026.9528325430497;4030.496187976503;4054.8175332110127;4222.641075508616;89830;90588;92796.07203927875;92936.60595090943;92987;83019.5849020751;83210;83359.58320208482;83502;83704.58147709223;52183;71688.7740051699;71951;72192.63903680448;72309.27690723131;7089.255628158969;7545.962270188614;7918.089419716576;8117;8193;47663.52336476591;49970.500294996586;50525;51120.72198195075;51766.22350664818;47123.52876471329;63144.36855631568;72466.27533724596;72808.27191728014;73275;10453.059224669816;10671.839922401325;10796.514156862802;10849.07782838436;10954.890451095387;11299.943500282447;11455.942720286344;11492.253003554742;11505.96768087364;11620.593279235187;9231.953840230755;10245.641402550875;10497.790044199226;10704.30422022566;10919.617813376493;10531;10624.150067994697;10655.946720266349;10665.520051597852;11338.206325557461;10396.636117735843;10403.687889363331;10463.947680261854;10505.737356566147;10552.736181595214;8855.291576673979;9005.14451127142;9068.546572671208;9260;9409.247260219303;8983.326250531367;9058.411203271766;9100.22648074921;9138.954305228432;9198.356115071882 06:45:18 INFO - PROCESS | 1674 | __end_tp_report 06:45:18 INFO - PROCESS | 1674 | __start_cc_report 06:45:18 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,354 06:45:18 INFO - PROCESS | 1674 | __end_cc_report 06:45:18 INFO - PROCESS | 1674 | __startTimestamp1463147118630__endTimestamp 06:45:18 INFO - PROCESS | 1674 | 06:45:18 INFO - PROCESS | 1674 | ------- Summary: start ------- 06:45:18 INFO - PROCESS | 1674 | Number of tests: 6 06:45:18 INFO - PROCESS | 1674 | 06:45:18 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5971.00 Median:6228.75 stddev:648.02 (10.4%) stddev-sans-first:611.94 06:45:18 INFO - PROCESS | 1674 | Values: 3181.3 3638.0 3654.2 3658.7 3687.3 6016.2 6045.4 6074.0 6083.9 6101.2 5998.2 6062.7 6086.3 6086.7 6100.7 5408.9 5488.4 5496.8 5516.3 5558.7 5388.7 5500.9 5524.9 5536.3 5541.0 5481.8 5482.2 5511.1 5514.7 5543.9 5455.4 5506.1 5519.8 5554.9 5594.5 5385.8 5486.7 5490.8 5491.7 5510.1 4706.3 5877.5 6015.3 6038.8 6051.5 6293.7 6301.2 6358.3 6361.0 6375.1 6322.7 6400.4 6409.9 6444.8 6456.7 5667.5 5819.0 6194.2 6195.0 6221.4 6531.3 6576.4 6585.5 6610.2 6621.9 6266.7 6269.1 6284.0 6285.8 6344.4 6300.1 6356.7 6414.9 6442.3 6464.3 6290.1 6312.7 6327.7 6346.0 6375.8 6303.0 6307.5 6348.1 6352.2 6384.4 4996.0 5028.4 5052.8 5095.1 5130.7 4527.3 4562.6 4572.7 4579.7 4590.1 6152.6 6153.8 6162.4 6165.0 6175.7 6268.6 6290.4 6316.2 6322.5 6323.5 6122.1 6172.8 6201.7 6203.1 6228.8 4741.5 5674.4 5689.8 5700.0 5712.1 6438.0 6498.2 6581.6 6615.1 6687.9 6412.5 6464.6 6468.5 6477.2 6478.4 6628.3 6678.1 6684.3 6694.1 6701.2 6195.6 6309.2 6337.0 6370.5 6377.7 6405.9 6411.0 6426.5 6437.6 6472.1 6159.7 6263.5 6277.7 6281.2 6282.5 6184.2 6215.4 6231.3 6237.4 6286.2 6098.5 6232.3 6259.5 6266.8 6299.7 6153.5 6162.5 6229.3 6271.7 6294.5 6153.5 6247.0 6255.2 6258.8 6273.0 06:45:18 INFO - PROCESS | 1674 | 06:45:18 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:58459.77 Median:39211.81 stddev:115916.39 (295.6%) stddev-sans-first:116159.90 06:45:18 INFO - PROCESS | 1674 | Values: 505.9 528.4 588.3 631.3 634.8 38912.8 39789.4 39795.8 39816.8 39930.4 40936.0 41431.0 42037.6 42229.6 42262.2 9764.2 9970.2 9991.2 10008.2 10012.3 9771.6 9860.0 9873.3 9924.4 9939.0 9875.9 9887.3 9932.2 9945.8 9967.3 8597.2 8738.2 9849.6 9903.9 9926.5 9869.8 9939.5 9961.6 9988.5 10001.4 34682.7 40236.6 40446.0 40546.6 40607.8 2698.7 3408.9 3431.4 3502.2 3524.5 27477.6 28363.6 28968.7 29302.4 29315.9 2847.9 2848.1 2856.5 2885.2 2946.3 320011.0 321534.0 322568.0 322948.0 324133.0 48348.8 48942.5 67298.3 68477.0 68622.0 47889.5 48951.0 49077.0 49145.8 49171.8 17220.5 17619.4 17797.9 17830.2 17837.2 14019.7 14030.6 14038.7 14251.3 14284.9 15480.5 15640.5 15645.5 15657.8 15685.8 6365.7 6417.3 6442.4 6453.2 6464.9 978.5 991.4 1019.6 1073.3 1085.7 23735.9 29283.1 29365.9 29524.6 30021.0 1040.7 1087.7 1115.6 1135.6 1166.7 12482.4 15254.4 15326.0 15490.4 15556.3 539669.0 539741.0 542584.0 543986.0 545941.0 66301.7 66727.7 66774.0 66936.7 67062.0 1337.6 1339.7 1528.3 1536.3 1568.6 29663.0 29948.3 30134.1 30713.0 30881.0 51733.0 51881.7 52536.7 52565.7 52638.7 414476.9 414555.0 415965.0 419328.0 421004.0 34375.0 35919.3 35921.0 36023.6 36375.6 47614.8 47632.0 48263.8 49414.5 49764.5 39146.0 39180.8 39680.8 40075.6 40272.0 32262.5 35554.8 35674.1 38962.0 39488.0 31727.4 38015.0 39242.8 39312.4 39779.4 33862.5 34290.5 34986.0 35094.5 35262.1 24690.0 25145.6 26305.5 26410.5 26513.5 06:45:18 INFO - PROCESS | 1674 | 06:45:18 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:36039.49 Median:21681.19 stddev:112171.68 (517.4%) stddev-sans-first:112454.35 06:45:18 INFO - PROCESS | 1674 | Values: 356.3 368.7 379.5 381.5 382.9 19900.5 20604.9 21342.4 21870.8 21948.0 21679.2 21683.1 21755.8 21958.8 21989.9 5680.6 5718.5 5920.8 5928.3 5938.3 5763.0 5813.6 5842.5 5856.3 5886.5 5514.1 5808.7 5835.5 5838.6 5860.5 5708.1 5733.8 5742.3 5780.4 5810.2 5022.0 5095.5 5099.3 5105.8 5110.8 13390.9 13845.9 13984.6 14020.4 14043.9 2138.7 2156.2 2191.2 2219.9 2248.6 10559.3 11724.9 13716.5 15099.3 15228.0 1611.9 1776.8 1801.5 1806.9 1861.4 97306.5 99121.0 100506.5 101626.5 102256.5 11645.7 11699.1 11775.0 11790.8 11908.1 14278.5 14309.1 14393.6 14485.0 14512.3 9095.4 9145.4 9154.1 9181.0 9262.4 7538.4 9263.5 9368.4 9435.4 9473.6 4534.6 4558.1 4607.9 4631.7 4634.9 1962.8 1983.5 1983.9 1998.6 2023.5 895.3 964.1 985.8 1031.4 1033.4 20436.4 20677.5 20747.9 21035.9 21107.3 961.6 1015.3 1033.7 1067.7 1068.0 10283.0 10531.6 10846.0 11293.9 11318.8 652330.0 671539.0 685931.0 691173.0 700120.0 92735.0 107308.0 112911.4 122344.4 123459.0 986.3 1000.6 1004.9 1013.2 1039.8 18598.3 18772.3 18833.7 18967.9 19440.9 39519.6 48546.3 50965.0 52797.7 53634.0 72110.0 72621.6 74011.3 74244.0 74369.0 8025.1 8186.3 8223.1 8305.2 8312.4 9599.3 10912.5 12747.6 13160.8 13358.3 11463.5 11832.9 11907.6 11968.8 12027.1 11338.7 11732.4 11732.7 11886.1 12171.6 11773.5 12057.0 12094.9 12185.8 12362.7 8098.0 8333.5 8360.0 8432.9 8513.3 8812.8 11252.3 12058.4 12124.2 12199.9 06:45:18 INFO - PROCESS | 1674 | 06:45:18 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:6257.35 Median:5212.63 stddev:3280.43 (62.9%) stddev-sans-first:3271.25 06:45:18 INFO - PROCESS | 1674 | Values: 1636.4 1637.4 1965.7 2048.0 2081.4 7394.1 8331.6 8925.4 9262.2 9284.7 8899.6 9059.9 9084.3 9190.7 9231.0 2609.3 2625.1 2634.4 2636.6 2638.0 2342.7 2421.6 2622.6 2633.0 2646.6 2430.7 2589.2 2595.9 2619.4 2633.1 2583.9 2593.2 2594.9 2599.6 2623.9 2539.1 2552.6 2583.2 2584.7 2590.8 7936.9 8010.6 8687.9 9137.2 9138.9 5132.3 5676.3 5765.0 5798.9 5807.4 3524.4 3638.7 3679.0 3772.2 3785.6 1076.5 1091.6 1095.1 1127.2 1134.5 11842.3 12193.7 12222.9 12240.9 12286.4 4545.8 4753.3 5032.1 5101.7 5137.2 10151.6 10296.0 10448.9 10463.0 10491.5 5664.7 5720.6 5755.9 5780.2 5798.7 4677.2 5117.4 5193.4 5205.8 5219.5 4155.7 4172.6 4187.4 4198.0 4209.5 1271.4 1317.5 1318.4 1372.4 1390.9 1201.2 1379.7 1446.3 1462.6 1471.2 8341.6 8367.2 8374.0 8541.0 8580.7 542.6 551.2 552.2 554.3 558.4 6212.7 6220.7 6361.2 6366.7 6506.4 10809.8 11066.3 11069.3 11118.9 11148.9 10673.7 10929.3 10962.3 10979.2 11096.4 8673.0 8684.5 8730.3 8773.6 8889.6 7960.4 8123.4 8147.1 8191.0 8219.0 9593.9 9878.0 9898.7 9916.4 10023.0 10013.5 10100.8 10158.8 10180.6 10301.1 7532.8 7661.8 7819.9 7829.7 7930.1 8569.1 8612.0 8636.5 8719.8 8723.0 7569.3 7579.6 7617.5 7716.2 7820.1 7499.2 7543.4 7545.4 7633.9 7660.4 7966.2 7993.7 8049.5 8058.6 8080.3 7187.2 7315.7 7315.8 7327.7 7332.3 7339.6 7345.0 7421.8 7469.0 7490.7 06:45:18 INFO - PROCESS | 1674 | 06:45:18 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:6083.49 Median:6960.85 stddev:1992.20 (28.6%) stddev-sans-first:1950.47 06:45:18 INFO - PROCESS | 1674 | Values: 332.7 340.8 341.3 347.6 349.8 6991.1 6991.8 6997.5 7001.7 7021.0 6908.3 6911.4 6930.6 7028.5 7035.1 3656.5 3791.8 4276.7 5166.5 5274.9 4139.7 5151.9 5154.4 5182.6 5184.7 5120.5 5131.3 5132.6 5137.5 5147.8 4074.7 5148.9 5208.7 5212.9 5218.5 3650.0 4482.1 4497.9 4506.4 4517.4 6462.9 6684.3 6742.7 6743.4 6775.7 5885.0 5942.4 5947.6 5955.5 5991.8 7552.7 7557.0 7559.6 7572.1 7575.1 4866.6 4875.4 4883.9 4887.1 4891.7 7197.5 7935.3 8003.8 8023.5 8028.6 4797.8 4870.5 4871.9 4892.8 4921.5 4937.6 4953.6 4962.4 4964.9 4966.4 5906.5 5927.2 5939.5 5950.0 5956.9 7448.9 7456.5 7461.3 7550.1 7589.2 1691.7 1721.6 1735.3 1749.0 1750.0 1090.7 1105.8 1107.3 1109.4 1109.9 7101.0 7180.0 7184.5 7191.4 7194.1 7758.6 7790.6 7793.6 7810.3 7821.1 6175.5 7133.6 7133.8 7134.6 7138.1 4008.1 4115.8 4139.6 4155.1 4169.7 8025.3 8156.6 8196.2 8200.2 8204.9 6484.4 8081.2 8087.7 8098.4 8105.9 8139.8 8157.7 8167.2 8177.6 8200.5 7565.6 7814.1 7833.9 7837.8 7842.0 7569.4 7612.4 7635.8 7637.2 7662.2 7695.5 8109.3 8110.0 8138.6 8150.5 4054.7 4965.1 4974.6 4977.1 4978.3 7486.4 7633.8 7844.6 7870.3 7871.9 6384.8 7496.4 7512.2 7541.0 7550.1 5746.5 7207.5 7500.0 7519.1 7537.5 6627.7 6810.9 7109.8 7347.3 7353.0 7416.4 7495.9 7495.9 7537.3 7552.9 5880.9 6187.9 7322.3 7328.2 7349.4 06:45:18 INFO - PROCESS | 1674 | 06:45:18 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18495.79 Median:51443.47 stddev:26197.10 (50.9%) stddev-sans-first:26236.60 06:45:18 INFO - PROCESS | 1674 | Values: 723.8 781.3 788.4 794.4 800.5 15406.2 15564.0 15589.5 15647.6 15720.5 14617.1 14618.6 14625.6 14665.6 14672.7 794.8 980.6 980.6 990.7 1010.4 984.9 988.2 998.8 1001.1 1003.7 1037.2 1040.9 1043.8 1044.7 1045.3 990.8 994.7 1034.1 1035.3 1041.7 741.8 752.5 781.2 781.5 784.4 15396.5 15816.2 15820.5 15867.3 15918.8 13275.7 13279.7 13307.5 13356.8 13434.6 10411.6 10463.4 10500.9 10521.8 10723.7 3619.9 3620.4 3643.5 3698.6 3726.4 82738.2 84097.0 84974.0 86146.0 87145.3 9745.0 9812.7 9851.3 9856.5 10124.7 22669.3 22982.8 23060.8 23096.2 23360.9 7550.4 7686.5 7697.0 7708.6 7984.4 3468.9 4168.9 4211.2 4285.4 4349.9 3696.5 3703.9 3718.2 3743.9 3747.8 635.5 660.4 660.7 664.5 666.5 559.5 579.2 590.7 629.3 630.2 8116.3 8363.8 8388.2 8527.0 8683.2 553.5 600.7 607.6 611.7 620.9 3973.5 4027.0 4030.5 4054.8 4222.6 89830.0 90588.0 92796.1 92936.6 92987.0 83019.6 83210.0 83359.6 83502.0 83704.6 52183.0 71688.8 71951.0 72192.6 72309.3 7089.3 7546.0 7918.1 8117.0 8193.0 47663.5 49970.5 50525.0 51120.7 51766.2 47123.5 63144.4 72466.3 72808.3 73275.0 10453.1 10671.8 10796.5 10849.1 10954.9 11299.9 11455.9 11492.3 11506.0 11620.6 9232.0 10245.6 10497.8 10704.3 10919.6 10531.0 10624.2 10655.9 10665.5 11338.2 10396.6 10403.7 10463.9 10505.7 10552.7 8855.3 9005.1 9068.5 9260.0 9409.2 8983.3 9058.4 9100.2 9139.0 9198.4 06:45:18 INFO - PROCESS | 1674 | -------- Summary: end -------- 06:45:18 INFO - PROCESS | 1674 | 06:45:19 INFO - TEST-INFO | 1674: exit 0 06:45:19 INFO - TEST-OK | dromaeo_css | took 1109823ms 06:45:19 INFO - TEST-START | kraken 06:45:19 INFO - operating with platform_type : mac_ 06:45:19 INFO - Initialising browser for kraken test... 06:45:19 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpTJVMS6/profile http://localhost:49271/getInfo.html) 06:45:21 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 06:45:21 INFO - PROCESS | 1682 | colorDepth:24 06:45:21 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 06:45:21 INFO - PROCESS | 1682 | __metrics 06:45:21 ERROR - PROCESS | 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 06:45:22 INFO - TEST-INFO | 1682: exit 0 06:45:22 INFO - Browser initialized. 06:45:22 INFO - Running cycle 1/1 for kraken test... 06:45:22 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpTJVMS6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:34 INFO - PROCESS | 1686 | RSS: Main: 168046592 06:45:34 INFO - PROCESS | 1686 | 06:45:36 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 06:45:37 INFO - PROCESS | 1686 | RSS: Main: 179802112 06:45:37 INFO - PROCESS | 1686 | 06:45:39 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 06:45:40 INFO - PROCESS | 1686 | RSS: Main: 189218816 06:45:40 INFO - PROCESS | 1686 | 06:45:43 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 06:45:44 INFO - PROCESS | 1686 | RSS: Main: 192806912 06:45:44 INFO - PROCESS | 1686 | 06:45:46 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 06:45:46 INFO - PROCESS | 1686 | RSS: Main: 193327104 06:45:46 INFO - PROCESS | 1686 | 06:45:48 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:45:49 INFO - PROCESS | 1686 | RSS: Main: 193015808 06:45:49 INFO - PROCESS | 1686 | 06:45:52 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 06:45:52 INFO - PROCESS | 1686 | RSS: Main: 193327104 06:45:52 INFO - PROCESS | 1686 | 06:45:55 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 06:45:56 INFO - PROCESS | 1686 | RSS: Main: 194551808 06:45:56 INFO - PROCESS | 1686 | 06:45:59 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 06:45:59 INFO - PROCESS | 1686 | RSS: Main: 194674688 06:45:59 INFO - PROCESS | 1686 | 06:46:01 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:46:02 INFO - PROCESS | 1686 | RSS: Main: 194228224 06:46:02 INFO - PROCESS | 1686 | 06:46:03 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:46:04 INFO - PROCESS | 1686 | RSS: Main: 194306048 06:46:04 INFO - PROCESS | 1686 | 06:46:06 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:46:07 INFO - PROCESS | 1686 | RSS: Main: 194519040 06:46:07 INFO - PROCESS | 1686 | 06:46:09 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:46:10 INFO - PROCESS | 1686 | RSS: Main: 194596864 06:46:10 INFO - PROCESS | 1686 | 06:46:12 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:46:13 INFO - PROCESS | 1686 | RSS: Main: 194715648 06:46:13 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 06:46:15 INFO - PROCESS | 1686 | RSS: Main: 196415488 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | __start_tp_report 06:46:15 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 06:46:15 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 06:46:15 INFO - PROCESS | 1686 | |i|pagename|runs| 06:46:15 INFO - PROCESS | 1686 | |0;ai-astar;114;110;115;116;116;129;112;114;115;116 06:46:15 INFO - PROCESS | 1686 | |1;audio-beat-detection;152;118;155;150;199;178;146;150;145;121 06:46:15 INFO - PROCESS | 1686 | |2;audio-dft;190;190;196;195;197;196;196;193;195;193 06:46:15 INFO - PROCESS | 1686 | |3;audio-fft;73;62;70;107;56;58;65;89;157;82 06:46:15 INFO - PROCESS | 1686 | |4;audio-oscillator;87;78;120;78;81;82;114;73;67;135 06:46:15 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;90;88;90;87;89;100;134;117;89;89 06:46:15 INFO - PROCESS | 1686 | |6;imaging-darkroom;96;96;95;95;95;95;95;96;93;95 06:46:15 INFO - PROCESS | 1686 | |7;imaging-desaturate;90;152;146;127;91;106;132;96;124;152 06:46:15 INFO - PROCESS | 1686 | |8;json-parse-financial;56;58;56;58;59;59;59;59;54;58 06:46:15 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;65;69;65;79;71;75;67;65;66;65 06:46:15 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;81;81;73;70;69;86;96;103;107;113 06:46:15 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;136;133;113;133;117;108;145;124;135;143 06:46:15 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;136;140;136;136;133;134;140;136;136;135 06:46:15 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;67;65;64;63;81;98;99;79;68;67 06:46:15 INFO - PROCESS | 1686 | __end_tp_report 06:46:15 INFO - PROCESS | 1686 | __start_cc_report 06:46:15 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,898 06:46:15 INFO - PROCESS | 1686 | __end_cc_report 06:46:15 INFO - PROCESS | 1686 | __startTimestamp1463147175477__endTimestamp 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | ------- Summary: start ------- 06:46:15 INFO - PROCESS | 1686 | Number of tests: 14 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:115.70 Median:115.50 stddev:5.06 (4.4%) stddev-sans-first:5.33 06:46:15 INFO - PROCESS | 1686 | Values: 114.0 110.0 115.0 116.0 116.0 129.0 112.0 114.0 115.0 116.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:151.00 stddev:23.81 (15.8%) stddev-sans-first:25.25 06:46:15 INFO - PROCESS | 1686 | Values: 152.0 118.0 155.0 150.0 199.0 178.0 146.0 150.0 145.0 121.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:194.10 Median:195.50 stddev:2.51 (1.3%) stddev-sans-first:2.19 06:46:15 INFO - PROCESS | 1686 | Values: 190.0 190.0 196.0 195.0 197.0 196.0 196.0 193.0 195.0 193.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:81.90 Median:67.50 stddev:30.67 (45.4%) stddev-sans-first:32.36 06:46:15 INFO - PROCESS | 1686 | Values: 73.0 62.0 70.0 107.0 56.0 58.0 65.0 89.0 157.0 82.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:78.00 stddev:22.95 (29.4%) stddev-sans-first:24.28 06:46:15 INFO - PROCESS | 1686 | Values: 87.0 78.0 120.0 78.0 81.0 82.0 114.0 73.0 67.0 135.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:97.30 Median:89.00 stddev:15.80 (17.8%) stddev-sans-first:16.54 06:46:15 INFO - PROCESS | 1686 | Values: 90.0 88.0 90.0 87.0 89.0 100.0 134.0 117.0 89.0 89.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 06:46:15 INFO - PROCESS | 1686 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 93.0 95.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:121.60 Median:152.00 stddev:24.54 (16.1%) stddev-sans-first:23.21 06:46:15 INFO - PROCESS | 1686 | Values: 90.0 152.0 146.0 127.0 91.0 106.0 132.0 96.0 124.0 152.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.50 stddev:1.71 (2.9%) stddev-sans-first:1.72 06:46:15 INFO - PROCESS | 1686 | Values: 56.0 58.0 56.0 58.0 59.0 59.0 59.0 59.0 54.0 58.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.00 stddev:4.90 (7.2%) stddev-sans-first:5.01 06:46:15 INFO - PROCESS | 1686 | Values: 65.0 69.0 65.0 79.0 71.0 75.0 67.0 65.0 66.0 65.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:77.00 stddev:15.94 (20.7%) stddev-sans-first:16.71 06:46:15 INFO - PROCESS | 1686 | Values: 81.0 81.0 73.0 70.0 69.0 86.0 96.0 103.0 107.0 113.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:134.00 stddev:12.62 (9.4%) stddev-sans-first:13.11 06:46:15 INFO - PROCESS | 1686 | Values: 136.0 133.0 113.0 133.0 117.0 108.0 145.0 124.0 135.0 143.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.20 Median:136.00 stddev:2.25 (1.7%) stddev-sans-first:2.39 06:46:15 INFO - PROCESS | 1686 | Values: 136.0 140.0 136.0 136.0 133.0 134.0 140.0 136.0 136.0 135.0 06:46:15 INFO - PROCESS | 1686 | 06:46:15 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:73.50 stddev:13.74 (18.7%) stddev-sans-first:14.26 06:46:15 INFO - PROCESS | 1686 | Values: 67.0 65.0 64.0 63.0 81.0 98.0 99.0 79.0 68.0 67.0 06:46:15 INFO - PROCESS | 1686 | -------- Summary: end -------- 06:46:15 INFO - PROCESS | 1686 | 06:46:16 INFO - TEST-INFO | 1686: exit 0 06:46:16 INFO - TEST-OK | kraken | took 57024ms 06:46:16 INFO - SUITE-END | took 1166s 06:46:16 INFO - Completed test suite (00:19:27) 06:46:16 INFO - javascript benchmark 06:46:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3181.3319202967377, 3638.0, 3654.17780999275, 3658.7438879278443, 3687.336279469696, 6016.2479690038745, 6045.365236650155, 6073.969630151849, 6083.878322433548, 6101.237345331833, 5998.190244317016, 6062.696865156736, 6086.269647642289, 6086.72609732562, 6100.725467353968, 5408.864778380553, 5488.396276409591, 5496.835094947138, 5516.282883225175, 5558.749856256458, 5388.703621300827, 5500.944990550083, 5524.917126243109, 5536.335639723239, 5541.0, 5481.75332110056, 5482.23248745176, 5511.118221084627, 5514.696691681956, 5543.918935807519, 5455.427180146107, 5506.063969125238, 5519.834404967857, 5554.944450555483, 5594.468525490072, 5385.811496597639, 5486.725663716798, 5490.835274941758, 5491.7254137292975, 5510.090835012218, 4706.29405589161, 5877.529797616223, 6015.3383127855905, 6038.788642397495, 6051.485623721989, 6293.685315734241, 6301.180846489973, 6358.300586935434, 6360.968195158995, 6375.139356186948, 6322.74709011639, 6400.391962763577, 6409.903851442232, 6444.838879028015, 6456.741730330781, 5667.518260947865, 5819.010768169337, 6194.194754681907, 6195.008798592248, 6221.377862213788, 6531.3142120077655, 6576.375244351874, 6585.506087043491, 6610.206775187008, 6621.86756264872, 6266.655333956585, 6269.122322874801, 6283.96858015707, 6285.842853928597, 6344.429001389897, 6300.054991751183, 6356.745730170834, 6414.935850641434, 6442.323556026643, 6464.321246269168, 6290.0879372491645, 6312.652804095727, 6327.746890124344, 6345.96827015862, 6375.840603984845, 6302.968485157545, 6307.463865571386, 6348.079528468346, 6352.237731472161, 6384.425401713868, 4995.975020124876, 5028.371453568304, 5052.7726252318735, 5095.0574143783515, 5130.692158470503, 4527.298268768346, 4562.634989200856, 4572.748498832596, 4579.702319349231, 4590.05903789729, 6152.600080994721, 6153.753849845956, 6162.383761623802, 6164.969175154096, 6175.69121543921, 6268.592541484789, 6290.370962903673, 6316.210473690789, 6322.525810564226, 6323.494120470351, 6122.081687746873, 6172.814815555541, 6201.658908759971, 6203.069539569101, 6228.750849966042, 4741.454732705714, 5674.375818659944, 5689.829305120853, 5699.971500142556, 5712.143178523254, 6437.967810160919, 6498.220213574401, 6581.638009909501, 6615.140031795836, 6687.899681504781, 6412.487001039813, 6464.644444555594, 6468.514861385321, 6477.1579694639395, 6478.352164783484, 6628.337166283526, 6678.131842860591, 6684.331566843472, 6694.062831203538, 6701.229358623821, 6195.628262304276, 6309.211348581427, 6337.0, 6370.4903607712195, 6377.681115944277, 6405.903911441239, 6410.967945160244, 6426.485881129592, 6437.613743175424, 6472.126262954441, 6159.72281247336, 6263.530235232284, 6277.748890044347, 6281.214848143982, 6282.465990390685, 6184.165137706532, 6215.44061034491, 6231.2522497298805, 6237.438630523275, 6286.18279623646, 6098.512119030555, 6232.283287422005, 6259.530535209787, 6266.811995640138, 6299.716512756845, 6153.507719382349, 6162.537809664203, 6229.345918678655, 6271.686415679106, 6294.464970477561, 6153.507719382528, 6247.0, 6255.24937007562, 6258.780942666985, 6273.0], "unit": "score", "name": "dojo.html", "value": 5930.904198598806}, {"lowerIsBetter": false, "replicates": [505.8760603652106, 528.4240178205755, 588.299923091521, 631.2929518938788, 634.8381162803486, 38912.80543597282, 39789.40315895257, 39795.801020994855, 39816.800915995416, 39930.40104398436, 40936.0, 41430.96422589437, 42037.57962420375, 42229.577704222946, 42262.15475690484, 9764.218862491001, 9970.15253703436, 9991.150752186037, 10008.249381296395, 10012.349197302188, 9771.560279787427, 9860.0, 9873.259505537078, 9924.354916930413, 9939.0, 9875.851862222073, 9887.307888447776, 9932.205423566133, 9945.801083978316, 9967.252456065824, 8597.226249637532, 8738.213560779528, 9849.60601575936, 9903.851442228372, 9926.503674816302, 9869.753256168582, 9939.453330066915, 9961.601535938555, 9988.45063521506, 10001.399916005063, 34682.65317346819, 40236.59763402358, 40446.0, 40546.59453405458, 40607.78176654705, 2698.743619356158, 3408.909149072273, 3431.4166591679473, 3502.1944952660774, 3524.488949102366, 27477.587836182473, 28363.57454638182, 28968.710312896812, 29302.413951720846, 29315.853420732972, 2847.9003234886886, 2848.1170837040377, 2856.5429531274895, 2885.2354126156583, 2946.3076177098364, 320011.0, 321534.0, 322568.0, 322948.0, 324133.0, 48348.75825620849, 48942.51057489379, 67298.32701673018, 68476.97284540736, 68621.97067043999, 47889.5211047892, 48951.0, 49077.0, 49145.75427122913, 49171.77070573193, 17220.483385498454, 17619.383321583682, 17797.911010444866, 17830.19764110618, 17837.197326120357, 14019.71960560783, 14030.649233769032, 14038.71922561543, 14251.287435628177, 14284.857151428561, 15480.458183963507, 15640.4525841595, 15645.452409165624, 15657.843421565867, 15685.764713529306, 6365.713542890581, 6417.262014868256, 6442.35576442352, 6453.225612926479, 6464.870702586016, 978.496074521622, 991.3655260633201, 1019.5564929255797, 1073.307716522854, 1085.7068591480256, 23735.881320593286, 29283.121506354844, 29365.853170734008, 29524.557131643043, 30021.0, 1040.6773900090845, 1087.7443800706828, 1115.6151127860876, 1135.5798354608849, 1166.7141550320225, 12482.375881205904, 15254.389824406899, 15326.0, 15490.380384784708, 15556.299966501534, 539669.0, 539741.0, 542584.0, 543986.0, 545941.0, 66301.6684916582, 66727.66636166789, 66774.0, 66936.66531667311, 67061.99407008899, 1337.6455239361576, 1339.6516905604612, 1528.2664321125922, 1536.2779493637972, 1568.5686436230128, 29662.961796337026, 29948.251293717833, 30134.09597712072, 30713.0, 30881.0, 51733.0, 51881.7405912968, 52536.73731631317, 52565.7371713139, 52638.73680631573, 414476.92761537206, 414555.0, 415965.0, 419328.0, 421004.0, 34375.0, 35919.28161436809, 35921.0, 36023.639763603074, 36375.63624363722, 47614.76192619015, 47632.0, 48263.75868120637, 49414.50585494099, 49764.502354977434, 39146.0, 39180.804095979336, 39680.809575712774, 40075.59924400835, 40272.0, 32262.516062258615, 35554.8222258887, 35674.10814729652, 38962.0, 39488.0, 31727.365452690356, 38015.04962375963, 39242.82271531859, 39312.41031384589, 39779.40330894981, 33862.492062618585, 34290.48564271588, 34986.0, 35094.473582895764, 35262.11844703903, 24690.01239950382, 25145.622815658146, 26305.4738905217, 26410.471790563697, 26513.469730605666], "unit": "score", "name": "ext.html", "value": 19575.440741218736}, {"lowerIsBetter": false, "replicates": [356.25898131885674, 368.6663569469631, 379.50664136622385, 381.50023469255297, 382.9157585331228, 19900.50248743782, 20604.89697551512, 21342.35972920811, 21870.781292187094, 21948.0, 21679.241226557035, 21683.13267469299, 21755.782442175572, 21958.780412195913, 21989.890050549726, 5680.573956953224, 5718.456746609076, 5920.763169473237, 5928.347881733006, 5938.257717785277, 5763.0, 5813.622114562561, 5842.47417732404, 5856.32652244993, 5886.499647529944, 5514.145307477327, 5808.651480911138, 5835.533157347402, 5838.562107841907, 5860.531157507389, 5708.1437784332265, 5733.827985160431, 5742.310922689283, 5780.393058728815, 5810.157527158581, 5021.974890125526, 5095.490450954912, 5099.311592934943, 5105.795768169269, 5110.7955681773055, 13390.933045334808, 13845.861541384658, 13984.580462586138, 14020.369083391271, 14043.929780351033, 2138.689889965962, 2156.1914282144194, 2191.1564047841694, 2219.933401997943, 2248.5952528544854, 10559.26085174038, 11724.88275117255, 13716.519921802788, 15099.320530576151, 15228.0, 1611.8710503159837, 1776.8134345893754, 1801.4775715042754, 1806.8825526340877, 1861.4415675297491, 97306.5134674322, 99121.0087899119, 100506.49746751219, 101626.49186754093, 102256.48871755668, 11645.65063048093, 11699.122565807598, 11775.0, 11790.823137652942, 11908.106891983136, 14278.500252491112, 14309.141451512942, 14393.568192954228, 14484.986050976331, 14512.274386280644, 9095.363324567217, 9145.3598248122, 9154.084591540792, 9181.035991220826, 9262.44425334482, 7538.434617403716, 9263.536823158815, 9368.391054581567, 9435.386699864486, 9473.573689184002, 4534.58356425654, 4558.133954548625, 4607.861764147081, 4631.698939568984, 4634.930476042862, 1962.8135327143898, 1983.48429408352, 1983.930562430337, 1998.5902889907534, 2023.5447024419389, 895.2793001633618, 964.1130160252584, 985.8077674853478, 1031.3966329697062, 1033.3851358441716, 20436.38690839277, 20677.483062923548, 20747.896260518603, 21035.8948205258, 21107.26124585632, 961.624966263158, 1015.2994433840627, 1033.7440010387415, 1067.7490789664423, 1067.962621308266, 10283.0, 10531.631392901212, 10845.969632884864, 11293.943530282297, 11318.773624527463, 652330.0, 671539.0, 685931.0, 691173.0, 700120.0, 92735.0, 107308.0, 112911.4354428239, 122344.38827805805, 123459.0, 986.2800155886243, 1000.5547531348626, 1004.924630652704, 1013.2147585621202, 1039.8076355874036, 18598.349057782914, 18772.342967996054, 18833.71749423787, 18967.90516047411, 19440.90279548593, 39519.61681341139, 48546.30087946905, 50965.0, 52797.738837759905, 53634.0, 72110.0, 72621.63689181731, 74011.25988740259, 74244.0, 74369.0, 8025.117237104031, 8186.345092392713, 8223.09545949957, 8305.169483051888, 8312.418130731032, 9599.280053995839, 10912.508937097691, 12747.61757147287, 13160.802587960996, 13358.332083395986, 11463.541458341573, 11832.940835295769, 11907.642770716893, 11968.820467693165, 12027.097967652286, 11338.716532086764, 11732.41337933117, 11732.70668233301, 11886.108541859569, 12171.573994910135, 11773.47019384147, 12057.0, 12094.879051209375, 12185.817212741993, 12362.690932726753, 8098.0, 8333.54148037491, 8360.0, 8432.915670843213, 8513.31893448535, 8812.779680508038, 11252.26860254081, 12058.397080146133, 12124.211926224767, 12199.87800122023], "unit": "score", "name": "jquery.html", "value": 9519.56230662916}, {"lowerIsBetter": false, "replicates": [1636.3863551168313, 1637.3696126991108, 1965.6854903215487, 2047.9590408191846, 2081.438011736832, 7394.149672787631, 8331.583420828965, 8925.41984770991, 9262.166405023547, 9284.675036373728, 8899.599518021689, 9059.909400905988, 9084.318676099287, 9190.678326258583, 9231.0, 2609.321576390138, 2625.12058460416, 2634.4072583668712, 2636.6440530528325, 2638.0, 2342.6954495915506, 2421.648860915166, 2622.5541657918106, 2632.9605055924176, 2646.6427032350675, 2430.6961629796274, 2589.2102908612865, 2595.896164153441, 2619.358257226982, 2633.0915834037323, 2583.9095631652895, 2593.209071233264, 2594.8962041518316, 2599.6490473785984, 2623.9475210495684, 2539.136693524211, 2552.5915853463357, 2583.1992082454312, 2584.715681275058, 2590.831595946276, 7936.920630793676, 8010.5994700264755, 8687.869681954775, 9137.223336016446, 9138.908610913872, 5132.307138536287, 5676.2620859288445, 5765.0, 5798.884022319572, 5807.419258074201, 3524.400851855165, 3638.7089032877307, 3679.0, 3772.1512659651635, 3785.5646600641003, 1076.4725284610483, 1091.6233899304727, 1095.058249905081, 1127.1940562497853, 1134.5064896769932, 11842.289462632183, 12193.695157621041, 12222.938885305606, 12240.877591224064, 12286.447109880077, 4545.772711364485, 4753.287006948985, 5032.144535428986, 5101.719405432663, 5137.17805151174, 10151.64469243573, 10295.970402959794, 10448.947755261328, 10463.006014428616, 10491.475426228659, 5664.688442135722, 5720.599558030898, 5755.8561035974435, 5780.161876527964, 5798.710064496759, 4677.204875171229, 5117.360329958755, 5193.350831146106, 5205.765740541609, 5219.5041471060185, 4155.729877558009, 4172.561881002512, 4187.413762073312, 4198.03445207604, 4209.536950935395, 1271.3516106785605, 1317.5388613985028, 1318.3605951113702, 1372.3824279074456, 1390.8887289016855, 1201.2072032458536, 1379.7447472217673, 1446.2696338349067, 1462.6343414146463, 1471.2055490035475, 8341.582920853933, 8367.205115514016, 8374.0, 8541.017782954916, 8580.65677372898, 542.6066102076043, 551.239289780109, 552.2158534880399, 554.273901189435, 558.3857756467934, 6212.689365531705, 6220.720067596969, 6361.173047503888, 6366.681665916685, 6506.446952009038, 10809.78380432387, 11066.28069175501, 11069.280496767846, 11118.888811111947, 11148.944255278671, 10673.733156671145, 10929.344239345664, 10962.342259464458, 10979.231453798158, 11096.445177741241, 8672.956635216784, 8684.478931264144, 8730.257928076184, 8773.605187766565, 8889.599968001456, 7960.402969777174, 8123.350131989545, 8147.144549822184, 8191.017077950684, 8219.0, 9593.904060959301, 9878.0, 9898.653547125816, 9916.355436896578, 10023.0, 10013.499325033865, 10100.797984040131, 10158.847617285894, 10180.643677471253, 10301.124404425707, 7532.7740167795055, 7661.808454788452, 7819.882701759592, 7829.7259595913865, 7930.127685954425, 8569.14308569163, 8612.009618893908, 8636.481811091355, 8719.782005449915, 8723.0, 7569.280918312751, 7579.583122928292, 7617.542947423172, 7716.189800070912, 7820.139784623801, 7499.212582678741, 7543.358814500829, 7545.396368290633, 7633.885491717518, 7660.425468089804, 7966.203379661987, 7993.6802527898235, 8049.51702897828, 8058.597070146587, 8080.2727754502375, 7187.209406965125, 7315.670794814139, 7315.817104572216, 7327.74352897646, 7332.340089391981, 7339.559626422431, 7345.0, 7421.8144546386775, 7468.9626551866895, 7490.662920168496], "unit": "score", "name": "mootools.html", "value": 5044.605045246673}, {"lowerIsBetter": false, "replicates": [332.6673326673327, 340.8057407277851, 341.3207716643878, 347.5950517646941, 349.77090006046035, 6991.091158149434, 6991.82520436988, 6997.510174287802, 7001.6849241784175, 7020.964895175523, 6908.309169083089, 6911.412529934962, 6930.618815965133, 7028.472864535155, 7035.050268213789, 3656.542932133483, 3791.810409479529, 4276.700630955835, 5166.483351664822, 5274.947250527493, 4139.668826493888, 5151.948480515184, 5154.407243167027, 5182.611304152185, 5184.688918664873, 5120.487951204887, 5131.332926719521, 5132.589392848582, 5137.486251374851, 5147.81982630608, 4074.653654439376, 5148.948510514903, 5208.739563021833, 5212.947870521284, 5218.452062533436, 3649.981750091259, 4482.148391805546, 4497.9100417991785, 4506.414166158378, 4517.390152329426, 6462.903056454157, 6684.298148694365, 6742.662866856637, 6743.35938085881, 6775.661216939134, 5885.0, 5942.435468630473, 5947.613405128653, 5955.493783028448, 5991.820245392645, 7552.66013029415, 7557.0, 7559.63926493231, 7572.053493313336, 7575.09098908129, 4866.562009419134, 4875.439324477695, 4883.902321953577, 4887.095887260833, 4891.6820406673805, 7197.532160409557, 7935.285824275785, 8003.839923201562, 8023.518588884685, 8028.638711258008, 4797.808087676453, 4870.512948705101, 4871.878203044881, 4892.804287828518, 4921.532454416824, 4937.5556199942175, 4953.603711703127, 4962.379702537183, 4964.925526117111, 4966.404031516241, 5906.527477801766, 5927.229460170151, 5939.46544810969, 5950.018246989285, 5956.940430595725, 7448.888266676005, 7456.515326503868, 7461.328480436787, 7550.093988721279, 7589.241075892367, 1691.7462380642755, 1721.6298495823457, 1735.3058776489506, 1748.991255043742, 1749.9650006999789, 1090.7218659241842, 1105.7512059786484, 1107.2802678259036, 1109.3732041396586, 1109.872364678056, 7101.0, 7180.030695855992, 7184.533005354635, 7191.352778249982, 7194.064771579661, 7758.573278469626, 7790.610469476504, 7793.610319484003, 7810.297073263434, 7821.139674635786, 6175.505959523227, 7133.643317834088, 7133.82165445868, 7134.571925684476, 7138.107736532934, 4008.118213992917, 4115.753054816661, 4139.586041395896, 4155.085881106213, 4169.708120431601, 8025.2777250047775, 8156.5513896735065, 8196.237808871121, 8200.179982001871, 8204.876926846102, 6484.448821850101, 8081.15147909461, 8087.716929907543, 8098.392620553482, 8105.918940810634, 8139.83720325602, 8157.714479993172, 8167.224113709188, 8177.550234737147, 8200.548969806718, 7565.621718913922, 7814.101378341336, 7833.92166078332, 7837.804054898673, 7842.0, 7569.432292577969, 7612.352949999091, 7635.809104772425, 7637.159912409519, 7662.233776622294, 7695.461317707706, 8109.310708589836, 8109.986251718535, 8138.552379618941, 8150.510969341858, 4054.716169868081, 4965.081459929925, 4974.5771609413605, 4977.104121258209, 4978.327925730125, 7486.438517111347, 7633.809154771176, 7844.6077696113825, 7870.29167374939, 7871.85858050568, 6384.776532821329, 7496.400287977058, 7512.248775122444, 7540.9622951884885, 7550.093988721389, 5746.5402767779315, 7207.531510452013, 7499.962500187464, 7519.097708275042, 7537.530181614533, 6627.668616569249, 6810.8637827244165, 7109.82225444368, 7347.33873951347, 7352.96323518379, 7416.406687465098, 7495.8500829982, 7495.887561686688, 7537.321641052332, 7552.886706699294, 5880.882382352414, 6187.938120618916, 7322.267773222635, 7328.157261914948, 7349.448791340564], "unit": "score", "name": "prototype.html", "value": 5418.345764956985}, {"lowerIsBetter": false, "replicates": [723.8190452386903, 781.3436713160944, 788.3693045563548, 794.3645083932854, 800.4836880212263, 15406.152661603608, 15564.0, 15589.454369097084, 15647.608809779747, 15720.528384148465, 14617.12297262165, 14618.561443156696, 14625.634359141, 14665.56003319902, 14672.706545869076, 794.8291117409756, 980.632262901412, 980.6469670918464, 990.6730778842965, 1010.4240582867768, 984.9310548261625, 988.1896844587441, 998.7652901568125, 1001.1340190734999, 1003.7390278527599, 1037.1806273044324, 1040.8802987656402, 1043.8329867221246, 1044.660485342263, 1045.3100953370777, 990.8018396320765, 994.721477986165, 1034.1468288661883, 1035.3425574760045, 1041.6927006533053, 741.7774667599698, 752.5447104501752, 781.249999999995, 781.4607920534813, 784.4077721320367, 15396.538103856903, 15816.209189540477, 15820.525384238492, 15867.285972131282, 15918.840811591852, 13275.734485310337, 13279.73440531184, 13307.534236301779, 13356.799648005288, 13434.596962091153, 10411.635592754294, 10463.372197668165, 10500.947495262475, 10521.78956420875, 10723.731906702316, 3619.94570081449, 3620.4388319810473, 3643.453481977698, 3698.6301369863068, 3726.4224045273027, 82738.17261827365, 84097.0, 84974.0, 86146.0, 87145.25709485839, 9744.95127524372, 9812.705618831447, 9851.261155413373, 9856.45789481571, 10124.69625911224, 22669.319920402413, 22982.770172298064, 23060.76939230586, 23096.191633292754, 23360.883195583912, 7550.3582195514, 7686.500377475558, 7696.999390079254, 7708.614569271514, 7984.441089123706, 3468.9132771680406, 4168.895777605584, 4211.1998720243055, 4285.400043993844, 4349.869503914888, 3696.482492451059, 3703.851845926187, 3718.219173973496, 3743.887683369503, 3747.8126093695205, 635.5138319185827, 660.4254298760013, 660.6894759463045, 664.4651055900047, 666.4501786026451, 559.4712996218616, 579.2325169150891, 590.6721769418015, 629.3014753623474, 630.2216762298558, 8116.2695357418115, 8363.832723345498, 8388.161183881562, 8526.957365213135, 8683.218510333974, 553.4686700767309, 600.7356763024343, 607.6354187487473, 611.7338957553478, 620.9348018457997, 3973.5430425501436, 4026.9528325430497, 4030.496187976503, 4054.8175332110127, 4222.641075508616, 89830.0, 90588.0, 92796.07203927875, 92936.60595090943, 92987.0, 83019.5849020751, 83210.0, 83359.58320208482, 83502.0, 83704.58147709223, 52183.0, 71688.7740051699, 71951.0, 72192.63903680448, 72309.27690723131, 7089.255628158969, 7545.962270188614, 7918.089419716576, 8117.0, 8193.0, 47663.52336476591, 49970.500294996586, 50525.0, 51120.72198195075, 51766.22350664818, 47123.52876471329, 63144.36855631568, 72466.27533724596, 72808.27191728014, 73275.0, 10453.059224669816, 10671.839922401325, 10796.514156862802, 10849.07782838436, 10954.890451095387, 11299.943500282447, 11455.942720286344, 11492.253003554742, 11505.96768087364, 11620.593279235187, 9231.953840230755, 10245.641402550875, 10497.790044199226, 10704.30422022566, 10919.617813376493, 10531.0, 10624.150067994697, 10655.946720266349, 10665.520051597852, 11338.206325557461, 10396.636117735843, 10403.687889363331, 10463.947680261854, 10505.737356566147, 10552.736181595214, 8855.291576673979, 9005.14451127142, 9068.546572671208, 9260.0, 9409.247260219303, 8983.326250531367, 9058.411203271766, 9100.22648074921, 9138.954305228432, 9198.356115071882], "unit": "score", "name": "yui.html", "value": 7040.718114014289}], "name": "dromaeo_css", "value": 7726.1890062876655}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 115.0, 116.0, 116.0, 129.0, 112.0, 114.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.7}, {"lowerIsBetter": true, "replicates": [152.0, 118.0, 155.0, 150.0, 199.0, 178.0, 146.0, 150.0, 145.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [190.0, 190.0, 196.0, 195.0, 197.0, 196.0, 196.0, 193.0, 195.0, 193.0], "unit": "score", "name": "audio-dft", "value": 194.1}, {"lowerIsBetter": true, "replicates": [73.0, 62.0, 70.0, 107.0, 56.0, 58.0, 65.0, 89.0, 157.0, 82.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [87.0, 78.0, 120.0, 78.0, 81.0, 82.0, 114.0, 73.0, 67.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 91.5}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 90.0, 87.0, 89.0, 100.0, 134.0, 117.0, 89.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 93.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.1}, {"lowerIsBetter": true, "replicates": [90.0, 152.0, 146.0, 127.0, 91.0, 106.0, 132.0, 96.0, 124.0, 152.0], "unit": "score", "name": "imaging-desaturate", "value": 121.6}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 56.0, 58.0, 59.0, 59.0, 59.0, 59.0, 54.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 65.0, 79.0, 71.0, 75.0, 67.0, 65.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 73.0, 70.0, 69.0, 86.0, 96.0, 103.0, 107.0, 113.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.9}, {"lowerIsBetter": true, "replicates": [136.0, 133.0, 113.0, 133.0, 117.0, 108.0, 145.0, 124.0, 135.0, 143.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.7}, {"lowerIsBetter": true, "replicates": [136.0, 140.0, 136.0, 136.0, 133.0, 134.0, 140.0, 136.0, 136.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.2}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 64.0, 63.0, 81.0, 98.0, 99.0, 79.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.1}], "name": "kraken", "value": 1502.8000000000002}]} 06:46:16 INFO - Return code: 0 06:46:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:46:16 ERROR - # TBPL SUCCESS # 06:46:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:46:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:46:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:46:16 INFO - 2016-05-13 06:46:16.777 screenresolution[1691:10877] starting screenresolution argv=screenresolution get 06:46:16 INFO - 2016-05-13 06:46:16.780 screenresolution[1691:10877] Display 0: 1600x1200x32@60 06:46:16 INFO - 2016-05-13 06:46:16.786 screenresolution[1692:10880] starting screenresolution argv=screenresolution list 06:46:16 INFO - Available Modes on Display 0 06:46:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:46:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:46:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:46:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:46:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:46:17 INFO - Intel Iris: 06:46:17 INFO - Chipset Model: Intel Iris 06:46:17 INFO - Type: GPU 06:46:17 INFO - Bus: Built-In 06:46:17 INFO - VRAM (Dynamic, Max): 1536 MB 06:46:17 INFO - Vendor: Intel (0x8086) 06:46:17 INFO - Device ID: 0x0a2e 06:46:17 INFO - Revision ID: 0x0009 06:46:17 INFO - Displays: 06:46:17 INFO - Display: 06:46:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:46:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:46:17 INFO - Display Serial Number: 1600x1200 60 06:46:17 INFO - Main Display: Yes 06:46:17 INFO - Mirror: Off 06:46:17 INFO - Online: Yes 06:46:17 INFO - Rotation: Supported 06:46:17 INFO - Return code: 0 06:46:17 INFO - Running post-action listener: _resource_record_post_action 06:46:17 INFO - Running post-run listener: _resource_record_post_run 06:46:18 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 32153088; Write bytes: 512538112; Read time: 328; Write time: 1815 06:46:18 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 197474816; Write bytes: 197886464; Read time: 18006; Write time: 425 06:46:18 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 31231488; Write bytes: 304694272; Read time: 309; Write time: 1361 06:46:18 INFO - Running post-run listener: _upload_blobber_files 06:46:18 INFO - Blob upload gear active. 06:46:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:46:18 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 06:46:18 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'] 06:46:18 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 06:46:18 INFO - (blobuploader) - INFO - Open directory for files ... 06:46:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:46:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:46:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:19 INFO - (blobuploader) - INFO - Done attempting. 06:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:46:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:20 INFO - (blobuploader) - INFO - Done attempting. 06:46:20 INFO - (blobuploader) - INFO - Iteration through files over. 06:46:20 INFO - Return code: 0 06:46:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:46:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:46:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f3cf7d7f16da4039919ada20a66c2048b9c163437f553182d2dc9795929ff81b15390f764a03f0bbd8c9e0b10bc47ec7b53fadb19cc20420ed105d0151be6e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5817afe47d2e8742ae6a7ffffc6b5b975e704c524f7b85743763f83e48bb58cea992bb6c507172d76d28754e43df5b42ed4a2b9cd100c74c83cea6a4688c7b53"} 06:46:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:46:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:46:20 INFO - Contents: 06:46:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f3cf7d7f16da4039919ada20a66c2048b9c163437f553182d2dc9795929ff81b15390f764a03f0bbd8c9e0b10bc47ec7b53fadb19cc20420ed105d0151be6e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5817afe47d2e8742ae6a7ffffc6b5b975e704c524f7b85743763f83e48bb58cea992bb6c507172d76d28754e43df5b42ed4a2b9cd100c74c83cea6a4688c7b53"} 06:46:20 INFO - Running post-run listener: copy_logs_to_upload_dir 06:46:20 INFO - Copying logs to upload dir... 06:46:20 INFO - mkdir: /builds/slave/test/build/upload/logs 06:46:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1309.461658 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2016-05-13 06:46:20.720319) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 06:46:20.723482) ========= 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.2fvnfC0ysv/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.2dma7yznnw/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f3cf7d7f16da4039919ada20a66c2048b9c163437f553182d2dc9795929ff81b15390f764a03f0bbd8c9e0b10bc47ec7b53fadb19cc20420ed105d0151be6e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5817afe47d2e8742ae6a7ffffc6b5b975e704c524f7b85743763f83e48bb58cea992bb6c507172d76d28754e43df5b42ed4a2b9cd100c74c83cea6a4688c7b53"} build_url:https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f3cf7d7f16da4039919ada20a66c2048b9c163437f553182d2dc9795929ff81b15390f764a03f0bbd8c9e0b10bc47ec7b53fadb19cc20420ed105d0151be6e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5817afe47d2e8742ae6a7ffffc6b5b975e704c524f7b85743763f83e48bb58cea992bb6c507172d76d28754e43df5b42ed4a2b9cd100c74c83cea6a4688c7b53"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 06:46:20.751451) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:46:20.751815) ========= 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.2fvnfC0ysv/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.2dma7yznnw/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005250 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:46:20.802825) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 06:46:20.803571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 06:46:20.804334) ========= ========= Total master_lag: 0.22 =========