builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0167 starttime: 1462963106.3 results: success (0) buildid: 20160510170209 builduid: 8ec55d59aa8b4e91b360aca0ab4b190b revision: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:26.297226) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:26.297676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:26.297938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:26.317817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:26.318315) ========= 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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-11 03:38:26-- 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% 46.3M=0s 2016-05-11 03:38:26 (46.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125787 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:26.461337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:26.461641) ========= 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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.035992 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:26.512742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 03:38:26.513108) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f6940851d82da2fb15ab510cff1a8e0c9ce6a49b --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 f6940851d82da2fb15ab510cff1a8e0c9ce6a49b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ed1QoZ8FDx/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.J8W6coqMy6/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-11 03:38:26,596 truncating revision to first 12 chars 2016-05-11 03:38:26,596 Setting DEBUG logging. 2016-05-11 03:38:26,596 attempt 1/10 2016-05-11 03:38:26,596 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f6940851d82d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 03:38:27,534 unpacking tar archive at: mozilla-beta-f6940851d82d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.193753 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 03:38:27.723674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:27.723985) ========= script_repo_revision: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:27.724368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:27.724622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:27.738268) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-11 03:38:27.738738) ========= /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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:38:27 INFO - MultiFileLogger online at 20160511 03:38:27 in /builds/slave/test 03:38:27 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 03:38:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:38:27 INFO - {'append_to_log': False, 03:38:27 INFO - 'base_work_dir': '/builds/slave/test', 03:38:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:38:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:38:27 INFO - 'branch': 'Mozilla-Beta', 03:38:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:38:27 INFO - 'config_files': ('talos/mac_config.py',), 03:38:27 INFO - 'default_actions': ('clobber', 03:38:27 INFO - 'read-buildbot-config', 03:38:27 INFO - 'download-and-extract', 03:38:27 INFO - 'populate-webroot', 03:38:27 INFO - 'create-virtualenv', 03:38:27 INFO - 'install', 03:38:27 INFO - 'run-tests'), 03:38:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:38:27 INFO - 'download_minidump_stackwalk': True, 03:38:27 INFO - 'download_symbols': 'ondemand', 03:38:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:38:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:38:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:38:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:38:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:38:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:38:27 INFO - 'installer_path': 'installer.exe', 03:38:27 INFO - 'log_level': 'info', 03:38:27 INFO - 'log_name': 'talos', 03:38:27 INFO - 'log_to_console': True, 03:38:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:38:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:38:27 INFO - 'opt_config_files': (), 03:38:27 INFO - 'pip_index': False, 03:38:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:38:27 INFO - 'cmd': ('bash', 03:38:27 INFO - '-c', 03:38:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:38:27 INFO - 'enabled': True, 03:38:27 INFO - 'halt_on_failure': False, 03:38:27 INFO - 'name': 'check_screen_resolution'},), 03:38:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:38:27 INFO - 'cmd': ('bash', 03:38:27 INFO - '-c', 03:38:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:38:27 INFO - 'enabled': True, 03:38:27 INFO - 'halt_on_failure': False, 03:38:27 INFO - 'name': 'check_screen_resolution'},), 03:38:27 INFO - 'run_cmd_checks_enabled': True, 03:38:27 INFO - 'sps_profile': False, 03:38:27 INFO - 'sps_profile_interval': 0, 03:38:27 INFO - 'suite': 'dromaeojs-e10s', 03:38:27 INFO - 'system_bits': '32', 03:38:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:38:27 INFO - 'title': 't-yosemite-r7-0167', 03:38:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:38:27 INFO - 'use_talos_json': True, 03:38:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:38:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:38:27 INFO - 'work_dir': 'build'} 03:38:27 INFO - ##### 03:38:27 INFO - ##### Running clobber step. 03:38:27 INFO - ##### 03:38:27 INFO - Running pre-action listener: _resource_record_pre_action 03:38:27 INFO - Running main action method: clobber 03:38:27 INFO - rmtree: /builds/slave/test/build 03:38:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:38:29 INFO - Running post-action listener: _resource_record_post_action 03:38:29 INFO - ##### 03:38:29 INFO - ##### Running read-buildbot-config step. 03:38:29 INFO - ##### 03:38:29 INFO - Running pre-action listener: _resource_record_pre_action 03:38:29 INFO - Running main action method: read_buildbot_config 03:38:29 INFO - Using buildbot properties: 03:38:29 INFO - { 03:38:29 INFO - "project": "", 03:38:29 INFO - "product": "firefox", 03:38:29 INFO - "script_repo_revision": "production", 03:38:29 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 03:38:29 INFO - "repository": "", 03:38:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 03:38:29 INFO - "buildid": "20160510170209", 03:38:29 INFO - "pgo_build": "False", 03:38:29 INFO - "basedir": "/builds/slave/test", 03:38:29 INFO - "buildnumber": 3, 03:38:29 INFO - "slavename": "t-yosemite-r7-0167", 03:38:29 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:38:29 INFO - "platform": "yosemite_r7", 03:38:29 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 03:38:29 INFO - "branch": "mozilla-beta", 03:38:29 INFO - "repo_path": "releases/mozilla-beta", 03:38:29 INFO - "revision": "f6940851d82da2fb15ab510cff1a8e0c9ce6a49b", 03:38:29 INFO - "stage_platform": "macosx64", 03:38:29 INFO - "builduid": "8ec55d59aa8b4e91b360aca0ab4b190b", 03:38:29 INFO - "slavebuilddir": "test" 03:38:29 INFO - } 03:38:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 03:38:29 INFO - Running post-action listener: _resource_record_post_action 03:38:29 INFO - ##### 03:38:29 INFO - ##### Running download-and-extract step. 03:38:29 INFO - ##### 03:38:29 INFO - Running pre-action listener: _resource_record_pre_action 03:38:29 INFO - Running main action method: download_and_extract 03:38:29 INFO - mkdir: /builds/slave/test/build/tests 03:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:29 INFO - https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:38:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 03:38:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 03:38:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/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 03:38:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/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 03:38:31 INFO - Downloaded 1241 bytes. 03:38:31 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 03:38:31 INFO - Using the following test package requirements: 03:38:31 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 03:38:31 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:31 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 03:38:31 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:31 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 03:38:31 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 03:38:31 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:31 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 03:38:31 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 03:38:31 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:31 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 03:38:31 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:31 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 03:38:31 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:31 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 03:38:31 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 03:38:31 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:31 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 03:38:31 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 03:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:31 INFO - https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:38:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 03:38:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 03:38:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/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 03:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/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 03:38:32 INFO - Downloaded 17747453 bytes. 03:38:32 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'] 03:38:32 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 03:38:35 INFO - Return code: 0 03:38:35 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 03:38: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')]} 03:38:35 INFO - https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:38:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 03:38:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 03:38:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/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 03:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/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 03:38:38 INFO - Downloaded 17747453 bytes. 03:38:38 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'] 03:38:38 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 03:38:42 INFO - Return code: 0 03:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:42 INFO - https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:38:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 03:38:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 03:38:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/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 03:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/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 03:38:43 INFO - Downloaded 10845194 bytes. 03:38:43 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'] 03:38:43 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 03:38:43 INFO - Return code: 0 03:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:38:43 INFO - https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 03:38:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 03:38:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 03:38:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 03:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/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 03:38:46 INFO - Downloaded 88362263 bytes. 03:38:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 03:38:46 INFO - mkdir: /builds/slave/test/properties 03:38:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:38:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:38:46 INFO - Contents: 03:38:46 INFO - build_url:https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 03:38:47 INFO - Running post-action listener: _resource_record_post_action 03:38:47 INFO - Running post-action listener: set_extra_try_arguments 03:38:47 INFO - ##### 03:38:47 INFO - ##### Running populate-webroot step. 03:38:47 INFO - ##### 03:38:47 INFO - Running pre-action listener: _resource_record_pre_action 03:38:47 INFO - Running main action method: populate_webroot 03:38:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:38:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:38:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:38:47 INFO - '--tppagecycles', 03:38:47 INFO - '7'], 03:38:47 INFO - 'tests': ['tsvgm']}}, 03:38:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:38:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:38:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:38:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:38:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:38:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:38:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:47 INFO - 'talos_options': ['--e10s'], 03:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:47 INFO - 'tests': ['damp', 'tps']}, 03:38:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:47 INFO - 'talos_options': ['--e10s'], 03:38:47 INFO - 'tests': ['damp', 'tps']}, 03:38:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:38:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:38:47 INFO - 'other': {'tests': ['a11yr', 03:38:47 INFO - 'ts_paint', 03:38:47 INFO - 'tpaint', 03:38:47 INFO - 'sessionrestore', 03:38:47 INFO - 'sessionrestore_no_auto_restore', 03:38:47 INFO - 'tabpaint']}, 03:38:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:38:47 INFO - 'tests': ['a11yr', 03:38:47 INFO - 'ts_paint', 03:38:47 INFO - 'tpaint', 03:38:47 INFO - 'sessionrestore', 03:38:47 INFO - 'sessionrestore_no_auto_restore', 03:38:47 INFO - 'tabpaint']}, 03:38:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:38:47 INFO - 'tests': ['a11yr', 03:38:47 INFO - 'ts_paint', 03:38:47 INFO - 'tpaint', 03:38:47 INFO - 'sessionrestore', 03:38:47 INFO - 'sessionrestore_no_auto_restore', 03:38:47 INFO - 'tabpaint']}, 03:38:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:38:47 INFO - 'tests': ['a11yr', 03:38:47 INFO - 'ts_paint', 03:38:47 INFO - 'tpaint', 03:38:47 INFO - 'sessionrestore', 03:38:47 INFO - 'sessionrestore_no_auto_restore', 03:38:47 INFO - 'tabpaint']}, 03:38:47 INFO - 'other_l64': {'tests': ['a11yr', 03:38:47 INFO - 'ts_paint', 03:38:47 INFO - 'tpaint', 03:38:47 INFO - 'sessionrestore', 03:38:47 INFO - 'sessionrestore_no_auto_restore', 03:38:47 INFO - 'tabpaint']}, 03:38:47 INFO - 'other_nol64': {'tests': ['a11yr', 03:38:47 INFO - 'ts_paint', 03:38:47 INFO - 'tpaint', 03:38:47 INFO - 'sessionrestore', 03:38:47 INFO - 'sessionrestore_no_auto_restore', 03:38:47 INFO - 'tabpaint']}, 03:38:47 INFO - 'svgr': {'tests': ['tsvgx', 03:38:47 INFO - 'tsvgr_opacity', 03:38:47 INFO - 'tart', 03:38:47 INFO - 'tscrollx', 03:38:47 INFO - 'cart']}, 03:38:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:38:47 INFO - 'tests': ['tsvgx', 03:38:47 INFO - 'tsvgr_opacity', 03:38:47 INFO - 'tart', 03:38:47 INFO - 'tscrollx', 03:38:47 INFO - 'cart']}, 03:38:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:47 INFO - 'tests': ['tp5o']}, 03:38:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:47 INFO - 'talos_options': ['--e10s'], 03:38:47 INFO - 'tests': ['tp5o']}, 03:38:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:47 INFO - 'talos_options': ['--xperf_path', 03:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:47 INFO - 'tests': ['tp5n']}, 03:38:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:47 INFO - 'talos_options': ['--e10s', 03:38:47 INFO - '--xperf_path', 03:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:47 INFO - 'tests': ['tp5n']}}, 03:38:47 INFO - 'talos.zip': {'path': '', 03:38:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:38:47 INFO - Running post-action listener: _resource_record_post_action 03:38:47 INFO - ##### 03:38:47 INFO - ##### Running create-virtualenv step. 03:38:47 INFO - ##### 03:38:47 INFO - Running pre-action listener: _resource_record_pre_action 03:38:47 INFO - Running main action method: create_virtualenv 03:38:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:38:47 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 03:38:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:38:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:38:48 INFO - Using real prefix '/tools/python27' 03:38:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:38:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:38:51 INFO - Installing pip.................done. 03:38:51 INFO - Return code: 0 03:38:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:38:51 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')]} 03:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:51 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')]} 03:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:51 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 0x10b8cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada1300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b772d30>, '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 0x10b5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b769b20>, '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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:38:51 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 03:38:51 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 03:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ed1QoZ8FDx/Render', 03:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:51 INFO - 'HOME': '/Users/cltbld', 03:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:51 INFO - 'LOGNAME': 'cltbld', 03:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:51 INFO - 'MOZ_NO_REMOTE': '1', 03:38:51 INFO - 'NO_EM_RESTART': '1', 03:38:51 INFO - 'PAGER': '/bin/cat', 03:38:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:51 INFO - 'PWD': '/builds/slave/test', 03:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:51 INFO - 'SHELL': '/bin/bash', 03:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J8W6coqMy6/Listeners', 03:38:51 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:51 INFO - 'USER': 'cltbld', 03:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:51 INFO - 'XPC_FLAGS': '0x0', 03:38:51 INFO - 'XPC_SERVICE_NAME': '0', 03:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:52 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 03:38:52 INFO - Cleaning up... 03:38:52 INFO - Return code: 0 03:38:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:52 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 0x10b8cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada1300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b772d30>, '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 0x10b5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b769b20>, '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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:38:52 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 03:38:52 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 03:38:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ed1QoZ8FDx/Render', 03:38:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:52 INFO - 'HOME': '/Users/cltbld', 03:38:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:52 INFO - 'LOGNAME': 'cltbld', 03:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:52 INFO - 'MOZ_NO_REMOTE': '1', 03:38:52 INFO - 'NO_EM_RESTART': '1', 03:38:52 INFO - 'PAGER': '/bin/cat', 03:38:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:52 INFO - 'PWD': '/builds/slave/test', 03:38:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:52 INFO - 'SHELL': '/bin/bash', 03:38:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J8W6coqMy6/Listeners', 03:38:52 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:38:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:52 INFO - 'USER': 'cltbld', 03:38:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:52 INFO - 'XPC_FLAGS': '0x0', 03:38:52 INFO - 'XPC_SERVICE_NAME': '0', 03:38:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:52 INFO - Downloading/unpacking psutil>=0.7.1 03:38:52 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 03:38:52 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 03:38:52 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 03:38:52 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 03:38:52 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 03:38:52 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 03:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:38:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:55 INFO - Installing collected packages: psutil 03:38:55 INFO - Running setup.py install for psutil 03:38:55 INFO - building 'psutil._psutil_osx' extension 03:38:55 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 03:38:55 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 03:38:56 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 03:38:56 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 03:38:56 INFO - building 'psutil._psutil_posix' extension 03:38:56 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 03:38:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:38:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:38:56 INFO - ^ 03:38:56 INFO - 1 warning generated. 03:38:56 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 03:38:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:56 INFO - Successfully installed psutil 03:38:56 INFO - Cleaning up... 03:38:56 INFO - Return code: 0 03:38:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:38:56 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')]} 03:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:56 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')]} 03:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:56 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 0x10b8cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada1300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b772d30>, '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 0x10b5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b769b20>, '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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:38:56 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 03:38:56 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 03:38:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ed1QoZ8FDx/Render', 03:38:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:56 INFO - 'HOME': '/Users/cltbld', 03:38:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:56 INFO - 'LOGNAME': 'cltbld', 03:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:56 INFO - 'MOZ_NO_REMOTE': '1', 03:38:56 INFO - 'NO_EM_RESTART': '1', 03:38:56 INFO - 'PAGER': '/bin/cat', 03:38:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:56 INFO - 'PWD': '/builds/slave/test', 03:38:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:56 INFO - 'SHELL': '/bin/bash', 03:38:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J8W6coqMy6/Listeners', 03:38:56 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:38:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:56 INFO - 'USER': 'cltbld', 03:38:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:56 INFO - 'XPC_FLAGS': '0x0', 03:38:56 INFO - 'XPC_SERVICE_NAME': '0', 03:38:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:38:59 INFO - Installing collected packages: mozsystemmonitor 03:38:59 INFO - Running setup.py install for mozsystemmonitor 03:38:59 INFO - Successfully installed mozsystemmonitor 03:38:59 INFO - Cleaning up... 03:38:59 INFO - Return code: 0 03:38:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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', '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 0x10b8cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada1300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b772d30>, '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 0x10b5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b769b20>, '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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:38: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 blobuploader==1.2.4 03:38:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ed1QoZ8FDx/Render', 03:38:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:59 INFO - 'HOME': '/Users/cltbld', 03:38:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:59 INFO - 'LOGNAME': 'cltbld', 03:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:59 INFO - 'MOZ_NO_REMOTE': '1', 03:38:59 INFO - 'NO_EM_RESTART': '1', 03:38:59 INFO - 'PAGER': '/bin/cat', 03:38:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:59 INFO - 'PWD': '/builds/slave/test', 03:38:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:59 INFO - 'SHELL': '/bin/bash', 03:38:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J8W6coqMy6/Listeners', 03:38:59 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:38:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:59 INFO - 'USER': 'cltbld', 03:38:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:59 INFO - 'XPC_FLAGS': '0x0', 03:38:59 INFO - 'XPC_SERVICE_NAME': '0', 03:38:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:39:02 INFO - Downloading blobuploader-1.2.4.tar.gz 03:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:39:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:39:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:03 INFO - Downloading docopt-0.6.1.tar.gz 03:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:39:03 INFO - Installing collected packages: blobuploader, requests, docopt 03:39:03 INFO - Running setup.py install for blobuploader 03:39:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:39:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:39:03 INFO - Running setup.py install for requests 03:39:04 INFO - Running setup.py install for docopt 03:39:04 INFO - Successfully installed blobuploader requests docopt 03:39:04 INFO - Cleaning up... 03:39:04 INFO - Return code: 0 03:39:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:04 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')]} 03:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:04 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')]} 03:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:04 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 0x10b8cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada1300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b772d30>, '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 0x10b5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b769b20>, '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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:39:04 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 03:39:04 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 03:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ed1QoZ8FDx/Render', 03:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:04 INFO - 'HOME': '/Users/cltbld', 03:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:04 INFO - 'LOGNAME': 'cltbld', 03:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:04 INFO - 'MOZ_NO_REMOTE': '1', 03:39:04 INFO - 'NO_EM_RESTART': '1', 03:39:04 INFO - 'PAGER': '/bin/cat', 03:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:04 INFO - 'PWD': '/builds/slave/test', 03:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:04 INFO - 'SHELL': '/bin/bash', 03:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J8W6coqMy6/Listeners', 03:39:04 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:04 INFO - 'USER': 'cltbld', 03:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:04 INFO - 'XPC_FLAGS': '0x0', 03:39:04 INFO - 'XPC_SERVICE_NAME': '0', 03:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:04 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-jmQEPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:04 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-uxjgA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:04 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-nrzQ2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:04 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-uxZOAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-gzA0u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-66bCdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Vm7XBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-HxXglV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-D6x6RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-k2_lHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Os_Ewm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-pmAPoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-yRVuXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-sAplh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-0TC4AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-lVIYwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Ot1dkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:39:06 INFO - Running setup.py install for manifestparser 03:39:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:39:06 INFO - Running setup.py install for mozcrash 03:39:06 INFO - Running setup.py install for mozdebug 03:39:06 INFO - Running setup.py install for mozdevice 03:39:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:39:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:39:06 INFO - Running setup.py install for mozfile 03:39:07 INFO - Running setup.py install for mozhttpd 03:39:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:39:07 INFO - Running setup.py install for mozinfo 03:39:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:39:07 INFO - Running setup.py install for mozInstall 03:39:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:39:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:39:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:39:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:39:07 INFO - Running setup.py install for mozleak 03:39:07 INFO - Running setup.py install for mozlog 03:39:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:39:07 INFO - Running setup.py install for moznetwork 03:39:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:39:08 INFO - Running setup.py install for mozprocess 03:39:08 INFO - Running setup.py install for mozprofile 03:39:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:39:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:39:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:39:08 INFO - Running setup.py install for mozrunner 03:39:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:39:08 INFO - Running setup.py install for mozscreenshot 03:39:08 INFO - Running setup.py install for moztest 03:39:08 INFO - Running setup.py install for mozversion 03:39:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:39:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:39:08 INFO - Cleaning up... 03:39:08 INFO - Return code: 0 03:39:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:08 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')]} 03:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:08 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')]} 03:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:08 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 0x10b8cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada1300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b772d30>, '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 0x10b5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b769b20>, '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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:39:08 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 03:39:08 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 03:39:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ed1QoZ8FDx/Render', 03:39:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:08 INFO - 'HOME': '/Users/cltbld', 03:39:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:08 INFO - 'LOGNAME': 'cltbld', 03:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:08 INFO - 'MOZ_NO_REMOTE': '1', 03:39:08 INFO - 'NO_EM_RESTART': '1', 03:39:08 INFO - 'PAGER': '/bin/cat', 03:39:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:08 INFO - 'PWD': '/builds/slave/test', 03:39:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:08 INFO - 'SHELL': '/bin/bash', 03:39:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J8W6coqMy6/Listeners', 03:39:08 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:39:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:08 INFO - 'USER': 'cltbld', 03:39:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:08 INFO - 'XPC_FLAGS': '0x0', 03:39:08 INFO - 'XPC_SERVICE_NAME': '0', 03:39:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:09 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-4zA0tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39:09 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)) 03:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:09 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-VwtPoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39:09 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)) 03:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:09 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-8dFhfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39:09 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)) 03:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:09 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-0DIQZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39:09 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)) 03:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:09 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-mzHgIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39:09 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)) 03:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:09 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-u0HAes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39:09 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)) 03:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:09 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-9O3in3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39:09 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)) 03:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:09 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ujZ6rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:10 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)) 03:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:10 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-wbQ8gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:10 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)) 03:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:10 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-MaU6sD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:10 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)) 03:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:10 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-PSiSPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39:10 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)) 03:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:10 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-f9npSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39:10 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)) 03:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:10 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-IWENQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39:10 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)) 03:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:10 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-aTMT7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39:10 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)) 03:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:10 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-avAsNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:10 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)) 03:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:10 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-uLXv0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39:10 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)) 03:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:10 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-dJwySm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39:10 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)) 03:39:10 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)) 03:39:10 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)) 03:39:10 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)) 03:39:10 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)) 03:39:10 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)) 03:39:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:39:10 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 03:39:10 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 03:39:10 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 03:39:10 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 03:39:10 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 03:39:10 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 03:39:13 INFO - Downloading blessings-1.6.tar.gz 03:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:39:13 INFO - Installing collected packages: blessings 03:39:13 INFO - Running setup.py install for blessings 03:39:13 INFO - Successfully installed blessings 03:39:13 INFO - Cleaning up... 03:39:13 INFO - Return code: 0 03:39:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:13 INFO - Reading from file tmpfile_stdout 03:39:13 INFO - Current package versions: 03:39:13 INFO - blessings == 1.6 03:39:13 INFO - blobuploader == 1.2.4 03:39:13 INFO - docopt == 0.6.1 03:39:13 INFO - manifestparser == 1.1 03:39:13 INFO - mozInstall == 1.12 03:39:13 INFO - mozcrash == 0.17 03:39:13 INFO - mozdebug == 0.1 03:39:13 INFO - mozdevice == 0.48 03:39:13 INFO - mozfile == 1.2 03:39:13 INFO - mozhttpd == 0.7 03:39:13 INFO - mozinfo == 0.9 03:39:13 INFO - mozleak == 0.1 03:39:13 INFO - mozlog == 3.1 03:39:13 INFO - moznetwork == 0.27 03:39:13 INFO - mozprocess == 0.22 03:39:13 INFO - mozprofile == 0.28 03:39:13 INFO - mozrunner == 6.11 03:39:13 INFO - mozscreenshot == 0.1 03:39:13 INFO - mozsystemmonitor == 0.0 03:39:13 INFO - moztest == 0.7 03:39:13 INFO - mozversion == 1.4 03:39:13 INFO - psutil == 3.1.1 03:39:13 INFO - requests == 1.2.3 03:39:13 INFO - wsgiref == 0.1.2 03:39:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:13 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')]} 03:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:13 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')]} 03:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:13 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 0x10b8cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada1300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b772d30>, '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 0x10b5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b769b20>, '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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:39:13 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 03:39:13 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 03:39:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ed1QoZ8FDx/Render', 03:39:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:13 INFO - 'HOME': '/Users/cltbld', 03:39:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:13 INFO - 'LOGNAME': 'cltbld', 03:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:13 INFO - 'MOZ_NO_REMOTE': '1', 03:39:13 INFO - 'NO_EM_RESTART': '1', 03:39:13 INFO - 'PAGER': '/bin/cat', 03:39:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:13 INFO - 'PWD': '/builds/slave/test', 03:39:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:13 INFO - 'SHELL': '/bin/bash', 03:39:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J8W6coqMy6/Listeners', 03:39:13 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:39:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:13 INFO - 'USER': 'cltbld', 03:39:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:13 INFO - 'XPC_FLAGS': '0x0', 03:39:13 INFO - 'XPC_SERVICE_NAME': '0', 03:39:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:14 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)) 03:39:14 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)) 03:39:14 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)) 03:39:14 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)) 03:39:14 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)) 03:39:14 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)) 03:39:14 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)) 03:39:14 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)) 03:39:14 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)) 03:39:14 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)) 03:39:14 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)) 03:39:14 INFO - Cleaning up... 03:39:14 INFO - Return code: 0 03:39:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:39:14 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')]} 03:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:14 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')]} 03:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:14 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 0x10b8cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada1300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b772d30>, '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 0x10b5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b769b20>, '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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:39:14 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 03:39:14 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 03:39:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ed1QoZ8FDx/Render', 03:39:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:14 INFO - 'HOME': '/Users/cltbld', 03:39:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:14 INFO - 'LOGNAME': 'cltbld', 03:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:14 INFO - 'MOZ_NO_REMOTE': '1', 03:39:14 INFO - 'NO_EM_RESTART': '1', 03:39:14 INFO - 'PAGER': '/bin/cat', 03:39:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:14 INFO - 'PWD': '/builds/slave/test', 03:39:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:14 INFO - 'SHELL': '/bin/bash', 03:39:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J8W6coqMy6/Listeners', 03:39:14 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:39:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:14 INFO - 'USER': 'cltbld', 03:39:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:14 INFO - 'XPC_FLAGS': '0x0', 03:39:14 INFO - 'XPC_SERVICE_NAME': '0', 03:39:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:14 INFO - Downloading/unpacking jsonschema 03:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:39:17 INFO - Downloading/unpacking functools32 (from jsonschema) 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39:17 INFO - Downloading functools32-3.2.3-2.tar.gz 03:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:39:17 INFO - warning: no files found matching '*.txt' 03:39:17 INFO - no previously-included directories found matching 'build' 03:39:17 INFO - no previously-included directories found matching 'dist' 03:39:17 INFO - no previously-included directories found matching '.git*' 03:39:17 INFO - Installing collected packages: jsonschema, functools32 03:39:17 INFO - Running setup.py install for functools32 03:39:17 INFO - warning: no files found matching '*.txt' 03:39:17 INFO - no previously-included directories found matching 'build' 03:39:17 INFO - no previously-included directories found matching 'dist' 03:39:17 INFO - no previously-included directories found matching '.git*' 03:39:17 INFO - Successfully installed jsonschema functools32 03:39:17 INFO - Cleaning up... 03:39:17 INFO - Return code: 0 03:39:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada1300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b772d30>, '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 0x10b5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b769b20>, '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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ed1QoZ8FDx/Render', 03:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:17 INFO - 'HOME': '/Users/cltbld', 03:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:17 INFO - 'LOGNAME': 'cltbld', 03:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:17 INFO - 'MOZ_NO_REMOTE': '1', 03:39:17 INFO - 'NO_EM_RESTART': '1', 03:39:17 INFO - 'PAGER': '/bin/cat', 03:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:17 INFO - 'PWD': '/builds/slave/test', 03:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:17 INFO - 'SHELL': '/bin/bash', 03:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J8W6coqMy6/Listeners', 03:39:17 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:17 INFO - 'USER': 'cltbld', 03:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:17 INFO - 'XPC_FLAGS': '0x0', 03:39:17 INFO - 'XPC_SERVICE_NAME': '0', 03:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:18 INFO - Downloading/unpacking flake8 03:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:39:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:39:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:39:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:39:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:39:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:39:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:39:22 INFO - no previously-included directories found matching 'docs/_build' 03:39:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:39:22 INFO - Running setup.py install for pep8 03:39:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:39:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:39:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:39:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:39:22 INFO - no previously-included directories found matching 'docs/_build' 03:39:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:39:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:39:22 INFO - Cleaning up... 03:39:22 INFO - Return code: 0 03:39:22 INFO - Running post-action listener: _resource_record_post_action 03:39:22 INFO - Running post-action listener: _start_resource_monitoring 03:39:22 INFO - Starting resource monitoring. 03:39:22 INFO - ##### 03:39:22 INFO - ##### Running install step. 03:39:22 INFO - ##### 03:39:22 INFO - Running pre-action listener: _resource_record_pre_action 03:39:22 INFO - Running main action method: install 03:39:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:22 INFO - Reading from file tmpfile_stdout 03:39:22 INFO - Detecting whether we're running mozinstall >=1.0... 03:39:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:39:22 INFO - Reading from file tmpfile_stdout 03:39:22 INFO - Output received: 03:39:22 INFO - Usage: mozinstall [options] installer 03:39:22 INFO - Options: 03:39:22 INFO - -h, --help show this help message and exit 03:39:22 INFO - -d DEST, --destination=DEST 03:39:22 INFO - Directory to install application into. [default: 03:39:22 INFO - "/builds/slave/test"] 03:39:22 INFO - --app=APP Application being installed. [default: firefox] 03:39:22 INFO - mkdir: /builds/slave/test/build/application 03:39:22 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'] 03:39:22 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 03:39:45 INFO - Reading from file tmpfile_stdout 03:39:45 INFO - Output received: 03:39:45 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 03:39:45 INFO - Running post-action listener: _resource_record_post_action 03:39:45 INFO - ##### 03:39:45 INFO - ##### Running run-tests step. 03:39:45 INFO - ##### 03:39:45 INFO - Running pre-action listener: _resource_record_pre_action 03:39:45 INFO - Running main action method: run_tests 03:39:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:39:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:39:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:39:45 INFO - 2016-05-11 03:39:45.581 screenresolution[1641:7712] starting screenresolution argv=screenresolution get 03:39:45 INFO - 2016-05-11 03:39:45.583 screenresolution[1641:7712] Display 0: 1600x1200x32@60 03:39:45 INFO - 2016-05-11 03:39:45.589 screenresolution[1642:7715] starting screenresolution argv=screenresolution list 03:39:45 INFO - Available Modes on Display 0 03:39:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:39:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:39:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:39:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:39:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:39:45 INFO - Intel Iris: 03:39:45 INFO - Chipset Model: Intel Iris 03:39:45 INFO - Type: GPU 03:39:45 INFO - Bus: Built-In 03:39:45 INFO - VRAM (Dynamic, Max): 1536 MB 03:39:45 INFO - Vendor: Intel (0x8086) 03:39:45 INFO - Device ID: 0x0a2e 03:39:45 INFO - Revision ID: 0x0009 03:39:45 INFO - Displays: 03:39:45 INFO - Display: 03:39:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:39:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:39:45 INFO - Display Serial Number: 1600x1200 60 03:39:45 INFO - Main Display: Yes 03:39:45 INFO - Mirror: Off 03:39:45 INFO - Online: Yes 03:39:45 INFO - Rotation: Supported 03:39:45 INFO - Return code: 0 03:39:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:39:45 INFO - Python 2.7.3 03:39:45 INFO - Return code: 0 03:39:45 INFO - grabbing minidump binary from tooltool 03:39: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')]} 03:39:45 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 0x10b772d30>, '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 0x10b5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b769b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:39:45 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 03:39:45 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 03:39:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:39:45 INFO - Return code: 0 03:39:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:39:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:39:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:39:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:39:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:39:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:39:47 INFO - Return code: 0 03:39:47 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/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 03:39:47 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/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0167 --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 03:39:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ed1QoZ8FDx/Render', 03:39:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:47 INFO - 'HOME': '/Users/cltbld', 03:39:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:47 INFO - 'LOGNAME': 'cltbld', 03:39:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:39:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:47 INFO - 'MOZ_NO_REMOTE': '1', 03:39:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:39:47 INFO - 'NO_EM_RESTART': '1', 03:39:47 INFO - 'PAGER': '/bin/cat', 03:39:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:47 INFO - 'PWD': '/builds/slave/test', 03:39:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:39:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:47 INFO - 'SHELL': '/bin/bash', 03:39:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J8W6coqMy6/Listeners', 03:39:47 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:39:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:47 INFO - 'USER': 'cltbld', 03:39:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:47 INFO - 'XPC_FLAGS': '0x0', 03:39:47 INFO - 'XPC_SERVICE_NAME': '0', 03:39:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:47 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/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 03:39:47 INFO - mozversion application_buildid: 20160510170209 03:39:47 INFO - mozversion application_changeset: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b 03:39:47 INFO - mozversion application_display_name: Firefox 03:39:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:39:47 INFO - mozversion application_name: Firefox 03:39:47 INFO - mozversion application_remotingname: firefox 03:39:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:39:47 INFO - mozversion application_vendor: Mozilla 03:39:47 INFO - mozversion application_version: 47.0 03:39:47 INFO - mozversion platform_buildid: 20160510170209 03:39:47 INFO - mozversion platform_changeset: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b 03:39:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:39:47 INFO - mozversion platform_version: 47.0 03:39:47 INFO - using testdate: 1462963187 03:39:47 INFO - actual date: 1462963187 03:39:47 INFO - starting webserver on 'localhost:49275' 03:39:47 INFO - SUITE-START | Running 2 tests 03:39:47 INFO - TEST-START | dromaeo_css 03:39:47 INFO - operating with platform_type : mac_ 03:39:47 INFO - Initialising browser for dromaeo_css test... 03:39:47 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpIoDjvb/profile http://localhost:49275/getInfo.html) 03:39:50 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 03:39:50 INFO - PROCESS | 1660 | colorDepth:24 03:39:50 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 03:39:50 INFO - PROCESS | 1660 | __metrics 03:39:50 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:39:50 INFO - TEST-INFO | 1660: exit 0 03:39:50 INFO - Browser initialized. 03:39:50 INFO - Running cycle 1/1 for dromaeo_css test... 03:39:50 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpIoDjvb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:02 INFO - PROCESS | 1664 | RSS: Main: 168026112 03:40:02 INFO - PROCESS | 1664 | 03:40:52 INFO - PROCESS | 1664 | 1462963252211 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] 03:43:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 03:43:04 INFO - PROCESS | 1664 | RSS: Main: 178417664 03:43:04 INFO - PROCESS | 1664 | 03:46:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 03:46:07 INFO - PROCESS | 1664 | RSS: Main: 189804544 03:46:07 INFO - PROCESS | 1664 | 03:49:09 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 03:49:09 INFO - PROCESS | 1664 | RSS: Main: 191401984 03:49:09 INFO - PROCESS | 1664 | 03:52:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:52:11 INFO - PROCESS | 1664 | RSS: Main: 195538944 03:52:11 INFO - PROCESS | 1664 | 03:55:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:55:15 INFO - PROCESS | 1664 | RSS: Main: 194240512 03:55:15 INFO - PROCESS | 1664 | 03:58:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 03:58:17 INFO - PROCESS | 1664 | RSS: Main: 199782400 03:58:17 INFO - PROCESS | 1664 | 03:58:17 INFO - PROCESS | 1664 | __start_tp_report 03:58:17 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 03:58:17 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 03:58:17 INFO - PROCESS | 1664 | |i|pagename|runs| 03:58:17 INFO - PROCESS | 1664 | |0;dojo.html;3533.7173026157902;3676.0809797550596;3697.2051009033084;3731.235096805154;3738.140227747618;5986.042233242682;6028;6030.427109424598;6059.939400605993;6097.420745029221;6005.519558435315;6017.699115044241;6079.5136389088875;6088.634681919088;6102.17620621216;5344.625876188668;5428.565714742811;5471;5523.696196709179;5570.777168913239;5353.732313384335;5453.64551304166;5463.31708536433;5540.113581826909;5568.972155139219;5230.476952304777;5479.315085614298;5489.780408783644;5497.065498865202;5503.871706300219;4887.315775791392;5422.186671999192;5534.308211473566;5534.723263836792;5573.526250268732;5272.209168624699;5373.113436283009;5394.083005889008;5439.782408703687;5477.04151773442;5684.147377893308;5858.8242352729485;5869.236999190078;5902.8819423611285;5927.436893495111;6126.395534290289;6220.409061139185;6264.5301602380005;6279.026750853625;6279.466245369149;6253.749850005995;6333.271673757531;6336.841578960517;6354.968225158891;6382.297947225801;6101.389861013863;6120.724567394478;6121.571489995702;6131.294901086343;6141.938580614226;5202.271681964528;6420.908445564265;6467.32093130224;6475.384838440341;6481.773137940244;6190.50475961922;6259.937400626027;6277.8744425111245;6280.9685951569945;6282.277538083087;6282.591631543935;6305.96847015762;6307.24313082433;6310.2743184534365;6312.589681670676;6108.797423689751;6173.290071641729;6216.191895053614;6250.468710159687;6279.277883043417;6145.385461453819;6147.231596050494;6203.720832562545;6241.407066328691;6277.748890044439;5106.693598384035;5117.385913690307;5121.3854337479;5122.667026643257;5133.897322053538;4420.668449866273;4427.180971520214;4555.498895121534;4579.564941330568;4616.492185859553;5027.321311622957;6111.6333020018055;6129.389354848322;6136.29432615255;6150.938490615036;6314.400131987454;6365.108884756138;6368.64972426521;6387.297397286295;6404.967975160094;5969.940300597025;6020.458158765732;6126.509879209652;6145.770845830852;6151.692415379213;5624.465675760796;5629.887402252014;5632.295963004624;5645.1532270159805;5645.5483561314995;6637.037629543785;6650.135482387453;6678;6682.966585167043;6686.130802995774;6183.752649894134;6296.937030629635;6327.810165695037;6350.936490635035;6372.235331760218;5840.182374467493;6374.266959299554;6627.569208001464;6655.367740064686;6681.899771503528;6153.538484613761;6272.6236425814595;6331.873362532816;6339.714712837841;6344.143540622142;6301.747930082745;6345;6380.170577825039;6408.711607977745;6409.679516024274;6221.191245138103;6228.906566401598;6239.407256310643;6259.718312676032;6266.060090986389;6136.519078024374;6194.659293738708;6242.500599951902;6248.562600617913;6263.6241825490615;5959.374265702038;6077.817665470043;6144.56988010835;6276.623402595859;6289.433950944437;6189.752409903554;6243.531735119794;6268.122462855295;6282.434580887742;6283.497320214463;6148.354422785722;6170.167027451236;6242.219722534684;6250.406211409909;6255.749770009331 03:58:17 INFO - PROCESS | 1664 | |1;ext.html;466.1143826729214;523.4242333433224;531.9893602127958;585.5403508246028;667.1060778556733;36444;41345.79327103364;41357.379639305436;41445.37831932523;41577.58422415775;44708.88227794307;44981.55018449823;45151.09697806042;45183;45643;9954.900450995488;10167.288289819715;10200.13298869597;10203.234757393187;10234.48827558619;7859.449838511307;9921.603135874557;9938.204943604494;10094.545745441474;10131.392116472998;9945.602175912954;10001.199904007663;10015.248856335804;10095.596176152945;10122.29143959923;10006.849897251546;10068.848967265498;10086.9495652522;10122.59509619618;10137;10005.19958403326;10022.398656080659;10055.648052318207;10151.187904967584;10162.796744065152;33572.66427335744;42129.73610791681;42359.788201059106;42433.57566424327;42495.36256956148;3049.634043914722;3378.6959173674486;3388.2376465295356;3441.3117376524547;3600.819959002066;30325;30611.540826887616;31033.22416939572;31133.598988045367;32586.674133258603;2821.7037211092743;2852.885884564615;2880.9711902880913;2892.811967222145;2925.13708456006;514109.42945285037;515499;519253.9999999962;520683;522321;50898.98202036013;68973.65513172503;69386;69537.65231173913;69630.3036969634;49844;49868.753281167534;50066.49933500691;50108;50215;17412.12939353027;17529;17550.38573649942;17882.642347152985;17887.463376098738;14007.509737159151;14231.85768142326;14258.215798130996;14314.427422902967;14339.569812905629;15658;15703.764443533357;15734.763978540332;15748.291326890318;15897.443589474313;6617.669116544153;6708.83227919306;6710.731570737214;6714.362135597111;6718.832029199211;960.7934294126796;1006.3307900246255;1027.2860362048455;1173.747644256489;1174.2836869509592;30958.690413096032;31018.914337998063;31209.21976950549;31459;31700.365992680017;1057.4078516031047;1169.7309618787556;1173.4191575170346;1197.2756482328066;1211.8485189351331;14207.005509614435;15486.457973971083;15525.767113493306;15733.763993540106;15924.442644507386;455664;459166;460061;463949;466731;64919.70160596856;65091;65447;65476.67261663757;65754;1539.2534620708948;1550.4263422533734;1569.1448160752418;1586.4050980882168;1592.4824432059627;27262.90948362043;30842.84578577093;31155.844220778752;31167.68832311648;31667;55634;55635;55747.163792542335;56206.71896640491;56311;482842;485812;489735;491643;491686;35111;36447.81776091208;36503.81748091349;36508.634913651586;37302.8134859324;48581.5141848577;48801.5119848797;49651.51045468497;49685.50314496809;50853.745731271105;39326.41010384789;40254.39618405668;40520.79739601401;40961.1807763849;40975.385369218886;34445.021368374444;39301.60698393094;39827.40258896061;40078.99802504961;40601.59398405978;33127.50308745419;33373.66626333706;39078.023049423995;39083.80458097691;40460;29602;32907.50638740469;34526.82736586402;34762.82618586992;35005.47491787574;20841;22046;25213;25646.487070258863;25903.35241618899 03:58:17 INFO - PROCESS | 1664 | |2;jquery.html;318.8087147711374;354.3851417790134;372.3223732806292;388.32625394939777;389.13029379337195;20056.997150142488;20365.694514582276;20796.42938796605;20882.582348353022;21137.788622113774;21110.366688999315;21681.783182168172;21839.78160218397;21982.560348793053;21995.780042199574;5795.594308398414;6075.848103797396;6103.054026625858;6109.633421994695;6122.938770612303;5707.229524014268;6030.306514750816;6071.848203794896;6071.848203794918;6077.513798896078;5890.469857712805;5989.371116032819;5996.19051428056;6007.128966299884;6019.277686677583;5739.933623895395;5926.585139040269;6002.819915402523;6009.519238460913;6018.097285407181;5111.872203194913;5122.743862806882;5140.768665410065;5170.896582068338;5217.139172036609;25304.367390815194;25684.101056462932;25910.222693319232;26077.087301944342;26161.869190653924;2193.309107631107;2287.1880482428664;2412.6501657259773;2446.4862378900452;2874.5113330733825;15298.311575978996;15343;15356.232188390648;15357.692846143127;15573.610659733484;1667.25807015878;1803.9098045097692;1815.464437990796;1869.6354210928873;1897.3643829317057;91343.62984555171;93270.0672993275;95898;96330;97255.51372243093;10452.738681533023;10670;10763.677089687166;10845.83731244032;11030.944845275722;13232.139910905953;13312.733745325038;13316;13331.066825322328;13377.53178638743;8706.782330441789;8925.821483570293;9004.41471304363;9077.546122693839;9138.17756401927;9384.953075234716;9395.20140788027;9423.293253006052;9463.384879982917;9481;5222.791088356499;6106.816795496142;6268.968655156787;6270.7805226816845;6293.842653933597;1600.4798440506881;1860.8604354673453;1876.0338425710497;1916.5879335942839;1931.884086954787;879.8900137482815;1009.4448053570507;1023.1814548361281;1043.5512729526376;1134.6028889888637;20850.95745212733;21425.67861482079;21712.891435542722;21867.03196712272;21919.890400547894;1050.3172937590475;1134.7617000430002;1142.651491295163;1155.7226265696172;1183.8401815754935;11550;11643.88356116445;11812;11824.881751182551;11839;547054.9119798449;617868;620004;633262;644968;94979;98667;98953.50523247337;98986;103241;1122.2480937771875;1128.774245150973;1135.8864113588575;1138.510440510572;1147.6958605969426;14977.775333370226;17981;18832.7175092371;19195.61608767789;19328.93690847017;44245;45449;46412.53587464217;48140.518594813606;48499.75750121227;65200.67399662971;65981.67009165116;66089.33910660831;66692;66805.66597166983;7905.762827114966;7981.600919954095;8006.479578827358;8194.180581941759;8275.917240827515;7477.738279160203;10436.269461137648;11788;13422.328883555978;13688.863111368759;11439;11497.54009839597;11915.940420297842;11929.940350298193;12008.159428840247;11385.430728463709;11477.253978491372;11542.422878856192;11718.88281117178;11725.296482211095;11210.831837522606;11433.885661143615;11715.589954351557;12137.757244854876;12227.388630568614;8335.666573337;8358.916410835815;8367.205115514016;8384;8554.828903421772;8734.301255899385;10937.453127343442;11688.532458701897;11777.882221177679;11933.28400295985 03:58:17 INFO - PROCESS | 1664 | |3;mootools.html;1641.1958140511151;1649.5216387247694;2031.9796802031976;2113.852030357875;2150.612889679859;8300.667973281077;8884.689035883745;9054.954725226373;9361.344705870591;9385.812283754321;8839;8887;8997.415168014075;8999.685011024616;9006.234470070036;2581.083715281081;2582.5996970469605;2626.8423894566386;2627.3825650972008;2629.631851540776;2279.555486680098;2607.556715358394;2671.4389978104623;2671.7862570994275;2672.532306846304;2432.74456182101;2566.4995325911455;2611.8694065296754;2642.7753640940446;2651.4697060587864;2601.2716439396904;2630.7109516336955;2633.920982370513;2638.4195476995033;2662.680478342592;2594.455164415475;2620.358012286983;2623.3966187776728;2672.812903096784;2686.9731302687114;9036.954815225947;9045.819083618291;9104.180623743829;9143.771405714844;9183.724488265363;5803.21656576361;5883.294004719418;5960.850978725566;5981.970090149565;5993.310769261503;3641.7814931104217;3725.1059745660846;3780.7542509736777;3792.90517737056;3795.8671446499516;1077.49357801833;1081.2647399768155;1085.5277954089995;1107.8892110788938;1126.0428635659705;12111.152219344649;12178.51285948561;12278.508859645694;12324.568640097554;12382.938085309606;5141.485851414904;5170.97414512925;5226.660267082628;5238.2404551340605;5256.842294731164;10691.625793097204;10748.462576871125;10773.569057237622;10774.461276936121;10862.511186996604;5694.231278777312;5696.060150075191;5801.622894511843;5833.212516310328;5910.172575839386;4633.652476064309;5034;5146.970605878839;5160.329157209614;5241.0828105081455;4124.05146816234;4162.604552567501;4213.5154457237195;4242.00312926462;4251.914961700749;1384.3770303363526;1412.3432603839265;1421.0905020786704;1425.3942074618246;1426.721789251086;1156.1733360647177;1172.3434876469205;1398.6713122416427;1454.8472410396755;1470.7058588282387;8323.5005899645;8434.662613495515;8515.914840851636;8673.609687564074;8686.826263474695;549.7306319903219;552.8838943821843;561.166667498764;562.8846086552329;563.2199403825731;6322.683865806691;6364.427201551883;6376.489880809524;6381.074744162163;6413.422791948747;10975.670729878117;11090.445477726244;11256.887431125748;11339.659810205707;11349.773004539862;9545.379550329206;10819.729506762395;10826.700795904542;11016.449177541092;11403.771924561463;8693.608787604446;8764.21122099014;8781.780455488537;8784.868226976601;8881.023087460375;8034.8393032137865;8189.181081891763;8249.752507424786;8299.128591497805;8329.3336533076;8418.747437576883;9692.127708505986;9880.654177103766;10042.196624270187;10060.0945914868;10063.547140378847;10178.847317290098;10286;10306.278560500694;10371.222158338305;7794.337481313925;7796;7876.09424916119;7936.166702496154;7959.403044771781;8401.369897257853;8403.789905252417;8544.18830211129;8558.78603034929;8595.05454400003;7466.887996680162;7524.17234104259;7584.54492730438;7602.8099297518;7880.763577092696;7342.9632851835395;7399.59302238382;7451.254874512722;7489.325960663348;7555.6399848025685;7923.207679232261;7983.72056978003;7992.920070799218;8001.159878212704;8018.879716804369;7189.784306470814;7214.170370407471;7277.126744790447;7286.307800758919;7290.1251849776245;7362.852742945218;7365.079365079365;7385.8153546161775;7407.888881666671;7417.147028091623 03:58:17 INFO - PROCESS | 1664 | |4;prototype.html;345.40072973391165;347.19277679395395;351.1694841699382;351.7291685402242;353.32875498890246;6778.051072849805;6825.829354266146;6832.077669514614;6845.144356955387;6857.76560219161;6074.724307895347;6765.661716914159;6796.388325050744;6841;6865.897011544831;4641.419822522184;4826.1795494765975;4935.062338155739;5044.394672639289;5061.721605311706;4988.575971042447;4996.500349965011;5035.1188542005;5039.143345631233;5044.672096313746;4947.332110165135;4965.751712414365;5002.649814512985;5067.265246539249;5071.695698258098;4368.847090351855;5072.26452164436;5074.391073071237;5075.416327122372;5092.541671249568;4363.738175709436;4368.737875727435;4373.562643735601;4379.036611945398;4383.473983122046;6228.5017198624;6471.708773105222;6553.279139294674;6576.145101136822;6577.144971153767;5882.735276912549;5886.381929897385;5903.291605007384;5922.466977972003;5933.61431506955;7323.670434830446;7324.597147156905;7330.193678695339;7331.926680733178;7349.816254593625;4729.55069268419;4739.668223224376;4747.52524747526;4749.762511874393;4757.452892917324;6126.479249263863;7524.209957954391;7662.1571627120975;7730.420218483636;7754.069511658637;3889.4749208857006;4688.4373875134515;4817.9036419272115;4830;4837;4878.609711223094;4905.632077594123;4907.141250281186;4909.901801963941;4912.557869791736;5871.618344807659;5899.321578018497;5899.557533185029;5902.291724992942;5912.935671579157;6335.904961425582;7325.267473252632;7357.448191385561;7357.52176108562;7369.1525474570035;1375.8761711446018;1701.6171361443824;1701.6851882401547;1706.1128213329;1707.2658756734475;1048.6120135549895;1078.2883297024084;1086.5979587552497;1087.152021423291;1088.1131877519797;6905.240423553405;6921.238663746984;6942.965285173542;6952.930470695228;6959.721611135498;7504.437167212481;7516.887246691304;7549.282818132268;7559.508631939017;7570.091589009354;6886.8622627547165;6907.723691052302;6946.652667366611;6952.2352541220425;6975.197852246955;3975.151554527101;3985.70107241958;3992.3412636915164;3992.6007399259843;4000.3799411091327;6627.304133066055;6783.389494945479;7769.494982826098;7779.416543759241;8001.279884810395;5554.91667624986;7555.395568354518;7797.337226335711;7847.372210223169;7864.9606751965875;7475;8036.236557527026;8041;8062.475939063942;8062.637181326854;7402.9629851850395;7672.506435408403;7699.422543309162;7708.49894756839;7720.150783413932;7477.289657482531;7550.056242969629;7554.411654464086;7565.4325925556905;7569.962150189434;7900.525968441912;8025.9598702006115;8027.478213916077;8042.87935680977;8050.677972881019;4986.252062190701;5046.949530504648;5050.823221187241;5056.115179843439;5062.114130027304;7290.526115802456;7407.59258240802;7522.285382888617;7559.28186822251;7573.697052117854;6806.706725722097;7347.118345798538;7377.372923301579;7381.963090184515;7408.814779630552;6031.703183815325;6593.439557637463;7054.894176587252;7370.557766534025;7370.852582948204;6842.418394436529;7178.210396856237;7192.244814294424;7212.4230061596;7214.855702885808;7273.309035641606;7285.052943117361;7349.154847192642;7353.610076724979;7382.077240344957;7146.642667866482;7157.749478768218;7173.569585824867;7181.245969173162;7190.06529151207 03:58:17 INFO - PROCESS | 1664 | |5;yui.html;679.7722762874437;695.7460526907677;805.8630032894408;807.3097501636101;822.8683410654295;15421.306041228143;15619;15662.451814186492;15672.608184795386;15685.372585096597;14384.921130915198;14465.855341446582;14556;14567.854321456782;14581.708365832677;798.6805277888833;961.7547525381018;991.6083147156887;1012.7620009297846;1015.3704703084098;1009.9799202805183;1011.4285428732743;1012.2913960227833;1013.7921726046143;1015.2791518022213;1056.392574269794;1057.5399701130034;1068.631322193842;1076.0745758647597;1080.3733834376044;1020.9642662506851;1054.0618849224197;1069.802086613975;1070.0369667299415;1070.7055559721061;794.0590400375573;803.0764620686199;804.2118723650855;804.7746630943345;808.4906508899355;15187.924060379737;15499.225038748018;15644.608884777972;15801.841981580152;15821.683566328724;13127.015473839405;13129.934350328283;13202.207867527979;13368.933155334258;13375.063745537816;10394.272400931937;10399.376037437778;10429.426381549012;10432.84350734732;10748.408837513934;3620.330238905811;3624.8187590620364;3648.5621725392857;3651.3427583035045;3881.7282790204695;83407;86248.56875715643;86442.13557864404;86837.56581217116;87148;9826.115649591571;9961.950190249003;10066.144377727975;10160.034796694303;10299.403592443183;23032.65451018236;23166.7683323168;23281.83590820452;23282;23289.417764556023;7635.809104772425;7773.067231932205;7808.687652493837;7923.445358824943;7976.920230797734;3503.9488153554344;3818.4272359145793;3993.6206060424215;4102.364133559303;4157.417961485395;3693.556773187181;3704.7221458390727;3739.0091625719206;3757.680597149273;3760.2667479841716;615.7690865925279;636.0872148466965;659.4921910129174;681.2404169351237;690.5373399822131;575.7581815637442;597.6025942748024;602.3193791016212;627.9403456671608;629.4429429954523;7746.767596972099;8571.82856342882;8634.784130396665;8647;8690.695825646199;585.7861880413618;590.9290885093816;593.6141508019736;608.1296281551072;615.2094558492316;3909.882703518899;4044.5550989391145;4058.817353219112;4097.836086556505;4184.309588917856;92596.14807703943;95019;97644;97645;97869;84591;84851.5757421209;85086.14913850906;85454.00910968086;86500.5674971621;72471.63764181145;73228;74979.62510187524;75389;76529.17354132382;7967.442279040411;8158.836823263383;8199.385046121446;8301.169883011891;8378.120297368932;50833.23750143677;51204.231936521726;52347;53560.732196338766;55310;51242;67491;68977.65511172613;71513.28486715275;71817;9122.859642544681;10321.372483936484;10414.531346089292;10672.35965842021;10729.9463502682;11309.943450282695;11316.37759923212;11353.48909299067;11442.656720298404;11498.597549085742;10330.586776528855;10717.464126793786;10734.302270352402;10933.125349972142;10994.725131871768;10761.677149685522;10847.891521085005;11013.504392302206;11040.00639942409;11483.36841473727;10406.427646479517;10559.841602375816;10672.679819605424;10875.531803206466;10906.781864362827;9288.11762882525;9402.059794020817;9492.335536512377;9513.857292140485;9619.759506012406;9200.723978280663;9241.491717955578;9300.534973251175;9385.765355865884;9405.576749046446 03:58:17 INFO - PROCESS | 1664 | __end_tp_report 03:58:17 INFO - PROCESS | 1664 | __start_cc_report 03:58:17 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,350 03:58:17 INFO - PROCESS | 1664 | __end_cc_report 03:58:17 INFO - PROCESS | 1664 | __startTimestamp1462964297342__endTimestamp 03:58:17 INFO - PROCESS | 1664 | 03:58:17 INFO - PROCESS | 1664 | ------- Summary: start ------- 03:58:17 INFO - PROCESS | 1664 | Number of tests: 6 03:58:17 INFO - PROCESS | 1664 | 03:58:17 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5922.40 Median:6147.23 stddev:616.50 (10.0%) stddev-sans-first:589.22 03:58:17 INFO - PROCESS | 1664 | Values: 3533.7 3676.1 3697.2 3731.2 3738.1 5986.0 6028.0 6030.4 6059.9 6097.4 6005.5 6017.7 6079.5 6088.6 6102.2 5344.6 5428.6 5471.0 5523.7 5570.8 5353.7 5453.6 5463.3 5540.1 5569.0 5230.5 5479.3 5489.8 5497.1 5503.9 4887.3 5422.2 5534.3 5534.7 5573.5 5272.2 5373.1 5394.1 5439.8 5477.0 5684.1 5858.8 5869.2 5902.9 5927.4 6126.4 6220.4 6264.5 6279.0 6279.5 6253.7 6333.3 6336.8 6355.0 6382.3 6101.4 6120.7 6121.6 6131.3 6141.9 5202.3 6420.9 6467.3 6475.4 6481.8 6190.5 6259.9 6277.9 6281.0 6282.3 6282.6 6306.0 6307.2 6310.3 6312.6 6108.8 6173.3 6216.2 6250.5 6279.3 6145.4 6147.2 6203.7 6241.4 6277.7 5106.7 5117.4 5121.4 5122.7 5133.9 4420.7 4427.2 4555.5 4579.6 4616.5 5027.3 6111.6 6129.4 6136.3 6150.9 6314.4 6365.1 6368.6 6387.3 6405.0 5969.9 6020.5 6126.5 6145.8 6151.7 5624.5 5629.9 5632.3 5645.2 5645.5 6637.0 6650.1 6678.0 6683.0 6686.1 6183.8 6296.9 6327.8 6350.9 6372.2 5840.2 6374.3 6627.6 6655.4 6681.9 6153.5 6272.6 6331.9 6339.7 6344.1 6301.7 6345.0 6380.2 6408.7 6409.7 6221.2 6228.9 6239.4 6259.7 6266.1 6136.5 6194.7 6242.5 6248.6 6263.6 5959.4 6077.8 6144.6 6276.6 6289.4 6189.8 6243.5 6268.1 6282.4 6283.5 6148.4 6170.2 6242.2 6250.4 6255.7 03:58:17 INFO - PROCESS | 1664 | 03:58:17 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:64263.28 Median:34884.15 stddev:130022.21 (372.7%) stddev-sans-first:130298.73 03:58:17 INFO - PROCESS | 1664 | Values: 466.1 523.4 532.0 585.5 667.1 36444.0 41345.8 41357.4 41445.4 41577.6 44708.9 44981.6 45151.1 45183.0 45643.0 9954.9 10167.3 10200.1 10203.2 10234.5 7859.4 9921.6 9938.2 10094.5 10131.4 9945.6 10001.2 10015.2 10095.6 10122.3 10006.8 10068.8 10086.9 10122.6 10137.0 10005.2 10022.4 10055.6 10151.2 10162.8 33572.7 42129.7 42359.8 42433.6 42495.4 3049.6 3378.7 3388.2 3441.3 3600.8 30325.0 30611.5 31033.2 31133.6 32586.7 2821.7 2852.9 2881.0 2892.8 2925.1 514109.4 515499.0 519254.0 520683.0 522321.0 50899.0 68973.7 69386.0 69537.7 69630.3 49844.0 49868.8 50066.5 50108.0 50215.0 17412.1 17529.0 17550.4 17882.6 17887.5 14007.5 14231.9 14258.2 14314.4 14339.6 15658.0 15703.8 15734.8 15748.3 15897.4 6617.7 6708.8 6710.7 6714.4 6718.8 960.8 1006.3 1027.3 1173.7 1174.3 30958.7 31018.9 31209.2 31459.0 31700.4 1057.4 1169.7 1173.4 1197.3 1211.8 14207.0 15486.5 15525.8 15733.8 15924.4 455664.0 459166.0 460061.0 463949.0 466731.0 64919.7 65091.0 65447.0 65476.7 65754.0 1539.3 1550.4 1569.1 1586.4 1592.5 27262.9 30842.8 31155.8 31167.7 31667.0 55634.0 55635.0 55747.2 56206.7 56311.0 482842.0 485812.0 489735.0 491643.0 491686.0 35111.0 36447.8 36503.8 36508.6 37302.8 48581.5 48801.5 49651.5 49685.5 50853.7 39326.4 40254.4 40520.8 40961.2 40975.4 34445.0 39301.6 39827.4 40079.0 40601.6 33127.5 33373.7 39078.0 39083.8 40460.0 29602.0 32907.5 34526.8 34762.8 35005.5 20841.0 22046.0 25213.0 25646.5 25903.4 03:58:17 INFO - PROCESS | 1664 | 03:58:17 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:33759.01 Median:2429.57 stddev:100976.30 (4156.1%) stddev-sans-first:101228.34 03:58:17 INFO - PROCESS | 1664 | Values: 318.8 354.4 372.3 388.3 389.1 20057.0 20365.7 20796.4 20882.6 21137.8 21110.4 21681.8 21839.8 21982.6 21995.8 5795.6 6075.8 6103.1 6109.6 6122.9 5707.2 6030.3 6071.8 6071.8 6077.5 5890.5 5989.4 5996.2 6007.1 6019.3 5739.9 5926.6 6002.8 6009.5 6018.1 5111.9 5122.7 5140.8 5170.9 5217.1 25304.4 25684.1 25910.2 26077.1 26161.9 2193.3 2287.2 2412.7 2446.5 2874.5 15298.3 15343.0 15356.2 15357.7 15573.6 1667.3 1803.9 1815.5 1869.6 1897.4 91343.6 93270.1 95898.0 96330.0 97255.5 10452.7 10670.0 10763.7 10845.8 11030.9 13232.1 13312.7 13316.0 13331.1 13377.5 8706.8 8925.8 9004.4 9077.5 9138.2 9385.0 9395.2 9423.3 9463.4 9481.0 5222.8 6106.8 6269.0 6270.8 6293.8 1600.5 1860.9 1876.0 1916.6 1931.9 879.9 1009.4 1023.2 1043.6 1134.6 20851.0 21425.7 21712.9 21867.0 21919.9 1050.3 1134.8 1142.7 1155.7 1183.8 11550.0 11643.9 11812.0 11824.9 11839.0 547054.9 617868.0 620004.0 633262.0 644968.0 94979.0 98667.0 98953.5 98986.0 103241.0 1122.2 1128.8 1135.9 1138.5 1147.7 14977.8 17981.0 18832.7 19195.6 19328.9 44245.0 45449.0 46412.5 48140.5 48499.8 65200.7 65981.7 66089.3 66692.0 66805.7 7905.8 7981.6 8006.5 8194.2 8275.9 7477.7 10436.3 11788.0 13422.3 13688.9 11439.0 11497.5 11915.9 11929.9 12008.2 11385.4 11477.3 11542.4 11718.9 11725.3 11210.8 11433.9 11715.6 12137.8 12227.4 8335.7 8358.9 8367.2 8384.0 8554.8 8734.3 10937.5 11688.5 11777.9 11933.3 03:58:17 INFO - PROCESS | 1664 | 03:58:17 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:6307.77 Median:2903.29 stddev:3296.75 (113.6%) stddev-sans-first:3287.33 03:58:17 INFO - PROCESS | 1664 | Values: 1641.2 1649.5 2032.0 2113.9 2150.6 8300.7 8884.7 9055.0 9361.3 9385.8 8839.0 8887.0 8997.4 8999.7 9006.2 2581.1 2582.6 2626.8 2627.4 2629.6 2279.6 2607.6 2671.4 2671.8 2672.5 2432.7 2566.5 2611.9 2642.8 2651.5 2601.3 2630.7 2633.9 2638.4 2662.7 2594.5 2620.4 2623.4 2672.8 2687.0 9037.0 9045.8 9104.2 9143.8 9183.7 5803.2 5883.3 5960.9 5982.0 5993.3 3641.8 3725.1 3780.8 3792.9 3795.9 1077.5 1081.3 1085.5 1107.9 1126.0 12111.2 12178.5 12278.5 12324.6 12382.9 5141.5 5171.0 5226.7 5238.2 5256.8 10691.6 10748.5 10773.6 10774.5 10862.5 5694.2 5696.1 5801.6 5833.2 5910.2 4633.7 5034.0 5147.0 5160.3 5241.1 4124.1 4162.6 4213.5 4242.0 4251.9 1384.4 1412.3 1421.1 1425.4 1426.7 1156.2 1172.3 1398.7 1454.8 1470.7 8323.5 8434.7 8515.9 8673.6 8686.8 549.7 552.9 561.2 562.9 563.2 6322.7 6364.4 6376.5 6381.1 6413.4 10975.7 11090.4 11256.9 11339.7 11349.8 9545.4 10819.7 10826.7 11016.4 11403.8 8693.6 8764.2 8781.8 8784.9 8881.0 8034.8 8189.2 8249.8 8299.1 8329.3 8418.7 9692.1 9880.7 10042.2 10060.1 10063.5 10178.8 10286.0 10306.3 10371.2 7794.3 7796.0 7876.1 7936.2 7959.4 8401.4 8403.8 8544.2 8558.8 8595.1 7466.9 7524.2 7584.5 7602.8 7880.8 7343.0 7399.6 7451.3 7489.3 7555.6 7923.2 7983.7 7992.9 8001.2 8018.9 7189.8 7214.2 7277.1 7286.3 7290.1 7362.9 7365.1 7385.8 7407.9 7417.1 03:58:17 INFO - PROCESS | 1664 | 03:58:17 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5964.51 Median:6801.55 stddev:1906.52 (28.0%) stddev-sans-first:1864.63 03:58:17 INFO - PROCESS | 1664 | Values: 345.4 347.2 351.2 351.7 353.3 6778.1 6825.8 6832.1 6845.1 6857.8 6074.7 6765.7 6796.4 6841.0 6865.9 4641.4 4826.2 4935.1 5044.4 5061.7 4988.6 4996.5 5035.1 5039.1 5044.7 4947.3 4965.8 5002.6 5067.3 5071.7 4368.8 5072.3 5074.4 5075.4 5092.5 4363.7 4368.7 4373.6 4379.0 4383.5 6228.5 6471.7 6553.3 6576.1 6577.1 5882.7 5886.4 5903.3 5922.5 5933.6 7323.7 7324.6 7330.2 7331.9 7349.8 4729.6 4739.7 4747.5 4749.8 4757.5 6126.5 7524.2 7662.2 7730.4 7754.1 3889.5 4688.4 4817.9 4830.0 4837.0 4878.6 4905.6 4907.1 4909.9 4912.6 5871.6 5899.3 5899.6 5902.3 5912.9 6335.9 7325.3 7357.4 7357.5 7369.2 1375.9 1701.6 1701.7 1706.1 1707.3 1048.6 1078.3 1086.6 1087.2 1088.1 6905.2 6921.2 6943.0 6952.9 6959.7 7504.4 7516.9 7549.3 7559.5 7570.1 6886.9 6907.7 6946.7 6952.2 6975.2 3975.2 3985.7 3992.3 3992.6 4000.4 6627.3 6783.4 7769.5 7779.4 8001.3 5554.9 7555.4 7797.3 7847.4 7865.0 7475.0 8036.2 8041.0 8062.5 8062.6 7403.0 7672.5 7699.4 7708.5 7720.2 7477.3 7550.1 7554.4 7565.4 7570.0 7900.5 8026.0 8027.5 8042.9 8050.7 4986.3 5046.9 5050.8 5056.1 5062.1 7290.5 7407.6 7522.3 7559.3 7573.7 6806.7 7347.1 7377.4 7382.0 7408.8 6031.7 6593.4 7054.9 7370.6 7370.9 6842.4 7178.2 7192.2 7212.4 7214.9 7273.3 7285.1 7349.2 7353.6 7382.1 7146.6 7157.7 7173.6 7181.2 7190.1 03:58:17 INFO - PROCESS | 1664 | 03:58:17 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18994.78 Median:4100.10 stddev:27135.81 (661.8%) stddev-sans-first:27177.08 03:58:17 INFO - PROCESS | 1664 | Values: 679.8 695.7 805.9 807.3 822.9 15421.3 15619.0 15662.5 15672.6 15685.4 14384.9 14465.9 14556.0 14567.9 14581.7 798.7 961.8 991.6 1012.8 1015.4 1010.0 1011.4 1012.3 1013.8 1015.3 1056.4 1057.5 1068.6 1076.1 1080.4 1021.0 1054.1 1069.8 1070.0 1070.7 794.1 803.1 804.2 804.8 808.5 15187.9 15499.2 15644.6 15801.8 15821.7 13127.0 13129.9 13202.2 13368.9 13375.1 10394.3 10399.4 10429.4 10432.8 10748.4 3620.3 3624.8 3648.6 3651.3 3881.7 83407.0 86248.6 86442.1 86837.6 87148.0 9826.1 9962.0 10066.1 10160.0 10299.4 23032.7 23166.8 23281.8 23282.0 23289.4 7635.8 7773.1 7808.7 7923.4 7976.9 3503.9 3818.4 3993.6 4102.4 4157.4 3693.6 3704.7 3739.0 3757.7 3760.3 615.8 636.1 659.5 681.2 690.5 575.8 597.6 602.3 627.9 629.4 7746.8 8571.8 8634.8 8647.0 8690.7 585.8 590.9 593.6 608.1 615.2 3909.9 4044.6 4058.8 4097.8 4184.3 92596.1 95019.0 97644.0 97645.0 97869.0 84591.0 84851.6 85086.1 85454.0 86500.6 72471.6 73228.0 74979.6 75389.0 76529.2 7967.4 8158.8 8199.4 8301.2 8378.1 50833.2 51204.2 52347.0 53560.7 55310.0 51242.0 67491.0 68977.7 71513.3 71817.0 9122.9 10321.4 10414.5 10672.4 10729.9 11309.9 11316.4 11353.5 11442.7 11498.6 10330.6 10717.5 10734.3 10933.1 10994.7 10761.7 10847.9 11013.5 11040.0 11483.4 10406.4 10559.8 10672.7 10875.5 10906.8 9288.1 9402.1 9492.3 9513.9 9619.8 9200.7 9241.5 9300.5 9385.8 9405.6 03:58:17 INFO - PROCESS | 1664 | -------- Summary: end -------- 03:58:17 INFO - PROCESS | 1664 | 03:58:17 INFO - TEST-INFO | 1664: exit 0 03:58:17 INFO - TEST-OK | dromaeo_css | took 1110515ms 03:58:17 INFO - TEST-START | kraken 03:58:17 INFO - operating with platform_type : mac_ 03:58:17 INFO - Initialising browser for kraken test... 03:58:17 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpZlfFEX/profile http://localhost:49275/getInfo.html) 03:58:20 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 03:58:20 INFO - PROCESS | 1677 | colorDepth:24 03:58:20 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 03:58:20 INFO - PROCESS | 1677 | __metrics 03:58:20 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:58:20 INFO - TEST-INFO | 1677: exit 0 03:58:20 INFO - Browser initialized. 03:58:20 INFO - Running cycle 1/1 for kraken test... 03:58:20 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpZlfFEX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:32 INFO - PROCESS | 1681 | RSS: Main: 167981056 03:58:32 INFO - PROCESS | 1681 | 03:58:35 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 03:58:36 INFO - PROCESS | 1681 | RSS: Main: 179802112 03:58:36 INFO - PROCESS | 1681 | 03:58:38 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 03:58:39 INFO - PROCESS | 1681 | RSS: Main: 188690432 03:58:39 INFO - PROCESS | 1681 | 03:58:43 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 03:58:43 INFO - PROCESS | 1681 | RSS: Main: 191188992 03:58:43 INFO - PROCESS | 1681 | 03:58:45 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 03:58:46 INFO - PROCESS | 1681 | RSS: Main: 193347584 03:58:46 INFO - PROCESS | 1681 | 03:58:48 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:58:48 INFO - PROCESS | 1681 | RSS: Main: 194007040 03:58:48 INFO - PROCESS | 1681 | 03:58:51 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 03:58:52 INFO - PROCESS | 1681 | RSS: Main: 194543616 03:58:52 INFO - PROCESS | 1681 | 03:58:55 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 03:58:55 INFO - PROCESS | 1681 | RSS: Main: 194195456 03:58:55 INFO - PROCESS | 1681 | 03:58:58 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 03:58:59 INFO - PROCESS | 1681 | RSS: Main: 194297856 03:58:59 INFO - PROCESS | 1681 | 03:59:01 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:59:01 INFO - PROCESS | 1681 | RSS: Main: 194789376 03:59:01 INFO - PROCESS | 1681 | 03:59:03 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:59:04 INFO - PROCESS | 1681 | RSS: Main: 194125824 03:59:04 INFO - PROCESS | 1681 | 03:59:06 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:59:07 INFO - PROCESS | 1681 | RSS: Main: 194191360 03:59:07 INFO - PROCESS | 1681 | 03:59:09 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:59:10 INFO - PROCESS | 1681 | RSS: Main: 194490368 03:59:10 INFO - PROCESS | 1681 | 03:59:12 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:59:13 INFO - PROCESS | 1681 | RSS: Main: 194351104 03:59:13 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 03:59:15 INFO - PROCESS | 1681 | RSS: Main: 196243456 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | __start_tp_report 03:59:15 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 03:59:15 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 03:59:15 INFO - PROCESS | 1681 | |i|pagename|runs| 03:59:15 INFO - PROCESS | 1681 | |0;ai-astar;155;159;165;115;116;130;113;117;116;116 03:59:15 INFO - PROCESS | 1681 | |1;audio-beat-detection;147;115;161;146;106;174;148;138;146;152 03:59:15 INFO - PROCESS | 1681 | |2;audio-dft;193;273;196;270;245;185;272;277;190;282 03:59:15 INFO - PROCESS | 1681 | |3;audio-fft;66;74;77;113;51;66;82;87;117;75 03:59:15 INFO - PROCESS | 1681 | |4;audio-oscillator;83;75;118;65;81;68;133;114;65;140 03:59:15 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;135;87;90;87;90;87;90;91;91;86 03:59:15 INFO - PROCESS | 1681 | |6;imaging-darkroom;109;123;95;97;109;95;95;95;110;149 03:59:15 INFO - PROCESS | 1681 | |7;imaging-desaturate;91;95;92;89;121;146;97;145;143;100 03:59:15 INFO - PROCESS | 1681 | |8;json-parse-financial;56;57;55;83;88;86;87;87;56;57 03:59:15 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;66;80;95;68;97;85;76;92;86;82 03:59:15 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;82;81;83;99;110;70;68;103;71;74 03:59:15 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;119;130;131;134;120;128;131;116;133;119 03:59:15 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;108;149;119;152;122;154;170;171;160;136 03:59:15 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;68;64;68;66;67;68;71;98;96;90 03:59:15 INFO - PROCESS | 1681 | __end_tp_report 03:59:15 INFO - PROCESS | 1681 | __start_cc_report 03:59:15 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,876 03:59:15 INFO - PROCESS | 1681 | __end_cc_report 03:59:15 INFO - PROCESS | 1681 | __startTimestamp1462964355324__endTimestamp 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | ------- Summary: start ------- 03:59:15 INFO - PROCESS | 1681 | Number of tests: 14 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:130.20 Median:123.50 stddev:20.98 (17.0%) stddev-sans-first:20.24 03:59:15 INFO - PROCESS | 1681 | Values: 155.0 159.0 165.0 115.0 116.0 130.0 113.0 117.0 116.0 116.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:147.50 stddev:20.01 (13.6%) stddev-sans-first:21.17 03:59:15 INFO - PROCESS | 1681 | Values: 147.0 115.0 161.0 146.0 106.0 174.0 148.0 138.0 146.0 152.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:238.30 Median:271.00 stddev:41.92 (15.5%) stddev-sans-first:41.13 03:59:15 INFO - PROCESS | 1681 | Values: 193.0 273.0 196.0 270.0 245.0 185.0 272.0 277.0 190.0 282.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:80.80 Median:74.50 stddev:20.57 (27.6%) stddev-sans-first:21.11 03:59:15 INFO - PROCESS | 1681 | Values: 66.0 74.0 77.0 113.0 51.0 66.0 82.0 87.0 117.0 75.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:66.50 stddev:29.10 (43.8%) stddev-sans-first:30.58 03:59:15 INFO - PROCESS | 1681 | Values: 83.0 75.0 118.0 65.0 81.0 68.0 133.0 114.0 65.0 140.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:90.00 stddev:14.74 (16.4%) stddev-sans-first:1.99 03:59:15 INFO - PROCESS | 1681 | Values: 135.0 87.0 90.0 87.0 90.0 87.0 90.0 91.0 91.0 86.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:107.70 Median:95.00 stddev:17.35 (18.3%) stddev-sans-first:18.39 03:59:15 INFO - PROCESS | 1681 | Values: 109.0 123.0 95.0 97.0 109.0 95.0 95.0 95.0 110.0 149.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:111.90 Median:90.00 stddev:24.30 (27.0%) stddev-sans-first:24.57 03:59:15 INFO - PROCESS | 1681 | Values: 91.0 95.0 92.0 89.0 121.0 146.0 97.0 145.0 143.0 100.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:84.50 stddev:15.87 (18.8%) stddev-sans-first:15.85 03:59:15 INFO - PROCESS | 1681 | Values: 56.0 57.0 55.0 83.0 88.0 86.0 87.0 87.0 56.0 57.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:82.70 Median:85.50 stddev:10.57 (12.4%) stddev-sans-first:9.33 03:59:15 INFO - PROCESS | 1681 | Values: 66.0 80.0 95.0 68.0 97.0 85.0 76.0 92.0 86.0 82.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:77.50 stddev:14.90 (19.2%) stddev-sans-first:15.78 03:59:15 INFO - PROCESS | 1681 | Values: 82.0 81.0 83.0 99.0 110.0 70.0 68.0 103.0 71.0 74.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:130.50 stddev:6.81 (5.2%) stddev-sans-first:6.72 03:59:15 INFO - PROCESS | 1681 | Values: 119.0 130.0 131.0 134.0 120.0 128.0 131.0 116.0 133.0 119.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:153.00 stddev:21.91 (14.3%) stddev-sans-first:18.94 03:59:15 INFO - PROCESS | 1681 | Values: 108.0 149.0 119.0 152.0 122.0 154.0 170.0 171.0 160.0 136.0 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:69.50 stddev:13.42 (19.3%) stddev-sans-first:13.95 03:59:15 INFO - PROCESS | 1681 | Values: 68.0 64.0 68.0 66.0 67.0 68.0 71.0 98.0 96.0 90.0 03:59:15 INFO - PROCESS | 1681 | -------- Summary: end -------- 03:59:15 INFO - PROCESS | 1681 | 03:59:15 INFO - TEST-INFO | 1681: exit 0 03:59:16 INFO - TEST-OK | kraken | took 58172ms 03:59:16 INFO - SUITE-END | took 1168s 03:59:16 INFO - Completed test suite (00:19:29) 03:59:16 INFO - javascript benchmark 03:59:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3533.7173026157902, 3676.0809797550596, 3697.2051009033084, 3731.235096805154, 3738.140227747618, 5986.042233242682, 6028.0, 6030.427109424598, 6059.939400605993, 6097.420745029221, 6005.519558435315, 6017.699115044241, 6079.5136389088875, 6088.634681919088, 6102.17620621216, 5344.625876188668, 5428.565714742811, 5471.0, 5523.696196709179, 5570.777168913239, 5353.732313384335, 5453.64551304166, 5463.31708536433, 5540.113581826909, 5568.972155139219, 5230.476952304777, 5479.315085614298, 5489.780408783644, 5497.065498865202, 5503.871706300219, 4887.315775791392, 5422.186671999192, 5534.308211473566, 5534.723263836792, 5573.526250268732, 5272.209168624699, 5373.113436283009, 5394.083005889008, 5439.782408703687, 5477.04151773442, 5684.147377893308, 5858.8242352729485, 5869.236999190078, 5902.8819423611285, 5927.436893495111, 6126.395534290289, 6220.409061139185, 6264.5301602380005, 6279.026750853625, 6279.466245369149, 6253.749850005995, 6333.271673757531, 6336.841578960517, 6354.968225158891, 6382.297947225801, 6101.389861013863, 6120.724567394478, 6121.571489995702, 6131.294901086343, 6141.938580614226, 5202.271681964528, 6420.908445564265, 6467.32093130224, 6475.384838440341, 6481.773137940244, 6190.50475961922, 6259.937400626027, 6277.8744425111245, 6280.9685951569945, 6282.277538083087, 6282.591631543935, 6305.96847015762, 6307.24313082433, 6310.2743184534365, 6312.589681670676, 6108.797423689751, 6173.290071641729, 6216.191895053614, 6250.468710159687, 6279.277883043417, 6145.385461453819, 6147.231596050494, 6203.720832562545, 6241.407066328691, 6277.748890044439, 5106.693598384035, 5117.385913690307, 5121.3854337479, 5122.667026643257, 5133.897322053538, 4420.668449866273, 4427.180971520214, 4555.498895121534, 4579.564941330568, 4616.492185859553, 5027.321311622957, 6111.6333020018055, 6129.389354848322, 6136.29432615255, 6150.938490615036, 6314.400131987454, 6365.108884756138, 6368.64972426521, 6387.297397286295, 6404.967975160094, 5969.940300597025, 6020.458158765732, 6126.509879209652, 6145.770845830852, 6151.692415379213, 5624.465675760796, 5629.887402252014, 5632.295963004624, 5645.1532270159805, 5645.5483561314995, 6637.037629543785, 6650.135482387453, 6678.0, 6682.966585167043, 6686.130802995774, 6183.752649894134, 6296.937030629635, 6327.810165695037, 6350.936490635035, 6372.235331760218, 5840.182374467493, 6374.266959299554, 6627.569208001464, 6655.367740064686, 6681.899771503528, 6153.538484613761, 6272.6236425814595, 6331.873362532816, 6339.714712837841, 6344.143540622142, 6301.747930082745, 6345.0, 6380.170577825039, 6408.711607977745, 6409.679516024274, 6221.191245138103, 6228.906566401598, 6239.407256310643, 6259.718312676032, 6266.060090986389, 6136.519078024374, 6194.659293738708, 6242.500599951902, 6248.562600617913, 6263.6241825490615, 5959.374265702038, 6077.817665470043, 6144.56988010835, 6276.623402595859, 6289.433950944437, 6189.752409903554, 6243.531735119794, 6268.122462855295, 6282.434580887742, 6283.497320214463, 6148.354422785722, 6170.167027451236, 6242.219722534684, 6250.406211409909, 6255.749770009331], "unit": "score", "name": "dojo.html", "value": 5886.855272447929}, {"lowerIsBetter": false, "replicates": [466.1143826729214, 523.4242333433224, 531.9893602127958, 585.5403508246028, 667.1060778556733, 36444.0, 41345.79327103364, 41357.379639305436, 41445.37831932523, 41577.58422415775, 44708.88227794307, 44981.55018449823, 45151.09697806042, 45183.0, 45643.0, 9954.900450995488, 10167.288289819715, 10200.13298869597, 10203.234757393187, 10234.48827558619, 7859.449838511307, 9921.603135874557, 9938.204943604494, 10094.545745441474, 10131.392116472998, 9945.602175912954, 10001.199904007663, 10015.248856335804, 10095.596176152945, 10122.29143959923, 10006.849897251546, 10068.848967265498, 10086.9495652522, 10122.59509619618, 10137.0, 10005.19958403326, 10022.398656080659, 10055.648052318207, 10151.187904967584, 10162.796744065152, 33572.66427335744, 42129.73610791681, 42359.788201059106, 42433.57566424327, 42495.36256956148, 3049.634043914722, 3378.6959173674486, 3388.2376465295356, 3441.3117376524547, 3600.819959002066, 30325.0, 30611.540826887616, 31033.22416939572, 31133.598988045367, 32586.674133258603, 2821.7037211092743, 2852.885884564615, 2880.9711902880913, 2892.811967222145, 2925.13708456006, 514109.42945285037, 515499.0, 519253.9999999962, 520683.0, 522321.0, 50898.98202036013, 68973.65513172503, 69386.0, 69537.65231173913, 69630.3036969634, 49844.0, 49868.753281167534, 50066.49933500691, 50108.0, 50215.0, 17412.12939353027, 17529.0, 17550.38573649942, 17882.642347152985, 17887.463376098738, 14007.509737159151, 14231.85768142326, 14258.215798130996, 14314.427422902967, 14339.569812905629, 15658.0, 15703.764443533357, 15734.763978540332, 15748.291326890318, 15897.443589474313, 6617.669116544153, 6708.83227919306, 6710.731570737214, 6714.362135597111, 6718.832029199211, 960.7934294126796, 1006.3307900246255, 1027.2860362048455, 1173.747644256489, 1174.2836869509592, 30958.690413096032, 31018.914337998063, 31209.21976950549, 31459.0, 31700.365992680017, 1057.4078516031047, 1169.7309618787556, 1173.4191575170346, 1197.2756482328066, 1211.8485189351331, 14207.005509614435, 15486.457973971083, 15525.767113493306, 15733.763993540106, 15924.442644507386, 455664.0, 459166.0, 460061.0, 463949.0, 466731.0, 64919.70160596856, 65091.0, 65447.0, 65476.67261663757, 65754.0, 1539.2534620708948, 1550.4263422533734, 1569.1448160752418, 1586.4050980882168, 1592.4824432059627, 27262.90948362043, 30842.84578577093, 31155.844220778752, 31167.68832311648, 31667.0, 55634.0, 55635.0, 55747.163792542335, 56206.71896640491, 56311.0, 482842.0, 485812.0, 489735.0, 491643.0, 491686.0, 35111.0, 36447.81776091208, 36503.81748091349, 36508.634913651586, 37302.8134859324, 48581.5141848577, 48801.5119848797, 49651.51045468497, 49685.50314496809, 50853.745731271105, 39326.41010384789, 40254.39618405668, 40520.79739601401, 40961.1807763849, 40975.385369218886, 34445.021368374444, 39301.60698393094, 39827.40258896061, 40078.99802504961, 40601.59398405978, 33127.50308745419, 33373.66626333706, 39078.023049423995, 39083.80458097691, 40460.0, 29602.0, 32907.50638740469, 34526.82736586402, 34762.82618586992, 35005.47491787574, 20841.0, 22046.0, 25213.0, 25646.487070258863, 25903.35241618899], "unit": "score", "name": "ext.html", "value": 20259.02223678669}, {"lowerIsBetter": false, "replicates": [318.8087147711374, 354.3851417790134, 372.3223732806292, 388.32625394939777, 389.13029379337195, 20056.997150142488, 20365.694514582276, 20796.42938796605, 20882.582348353022, 21137.788622113774, 21110.366688999315, 21681.783182168172, 21839.78160218397, 21982.560348793053, 21995.780042199574, 5795.594308398414, 6075.848103797396, 6103.054026625858, 6109.633421994695, 6122.938770612303, 5707.229524014268, 6030.306514750816, 6071.848203794896, 6071.848203794918, 6077.513798896078, 5890.469857712805, 5989.371116032819, 5996.19051428056, 6007.128966299884, 6019.277686677583, 5739.933623895395, 5926.585139040269, 6002.819915402523, 6009.519238460913, 6018.097285407181, 5111.872203194913, 5122.743862806882, 5140.768665410065, 5170.896582068338, 5217.139172036609, 25304.367390815194, 25684.101056462932, 25910.222693319232, 26077.087301944342, 26161.869190653924, 2193.309107631107, 2287.1880482428664, 2412.6501657259773, 2446.4862378900452, 2874.5113330733825, 15298.311575978996, 15343.0, 15356.232188390648, 15357.692846143127, 15573.610659733484, 1667.25807015878, 1803.9098045097692, 1815.464437990796, 1869.6354210928873, 1897.3643829317057, 91343.62984555171, 93270.0672993275, 95898.0, 96330.0, 97255.51372243093, 10452.738681533023, 10670.0, 10763.677089687166, 10845.83731244032, 11030.944845275722, 13232.139910905953, 13312.733745325038, 13316.0, 13331.066825322328, 13377.53178638743, 8706.782330441789, 8925.821483570293, 9004.41471304363, 9077.546122693839, 9138.17756401927, 9384.953075234716, 9395.20140788027, 9423.293253006052, 9463.384879982917, 9481.0, 5222.791088356499, 6106.816795496142, 6268.968655156787, 6270.7805226816845, 6293.842653933597, 1600.4798440506881, 1860.8604354673453, 1876.0338425710497, 1916.5879335942839, 1931.884086954787, 879.8900137482815, 1009.4448053570507, 1023.1814548361281, 1043.5512729526376, 1134.6028889888637, 20850.95745212733, 21425.67861482079, 21712.891435542722, 21867.03196712272, 21919.890400547894, 1050.3172937590475, 1134.7617000430002, 1142.651491295163, 1155.7226265696172, 1183.8401815754935, 11550.0, 11643.88356116445, 11812.0, 11824.881751182551, 11839.0, 547054.9119798449, 617868.0, 620004.0, 633262.0, 644968.0, 94979.0, 98667.0, 98953.50523247337, 98986.0, 103241.0, 1122.2480937771875, 1128.774245150973, 1135.8864113588575, 1138.510440510572, 1147.6958605969426, 14977.775333370226, 17981.0, 18832.7175092371, 19195.61608767789, 19328.93690847017, 44245.0, 45449.0, 46412.53587464217, 48140.518594813606, 48499.75750121227, 65200.67399662971, 65981.67009165116, 66089.33910660831, 66692.0, 66805.66597166983, 7905.762827114966, 7981.600919954095, 8006.479578827358, 8194.180581941759, 8275.917240827515, 7477.738279160203, 10436.269461137648, 11788.0, 13422.328883555978, 13688.863111368759, 11439.0, 11497.54009839597, 11915.940420297842, 11929.940350298193, 12008.159428840247, 11385.430728463709, 11477.253978491372, 11542.422878856192, 11718.88281117178, 11725.296482211095, 11210.831837522606, 11433.885661143615, 11715.589954351557, 12137.757244854876, 12227.388630568614, 8335.666573337, 8358.916410835815, 8367.205115514016, 8384.0, 8554.828903421772, 8734.301255899385, 10937.453127343442, 11688.532458701897, 11777.882221177679, 11933.28400295985], "unit": "score", "name": "jquery.html", "value": 9726.991333826316}, {"lowerIsBetter": false, "replicates": [1641.1958140511151, 1649.5216387247694, 2031.9796802031976, 2113.852030357875, 2150.612889679859, 8300.667973281077, 8884.689035883745, 9054.954725226373, 9361.344705870591, 9385.812283754321, 8839.0, 8887.0, 8997.415168014075, 8999.685011024616, 9006.234470070036, 2581.083715281081, 2582.5996970469605, 2626.8423894566386, 2627.3825650972008, 2629.631851540776, 2279.555486680098, 2607.556715358394, 2671.4389978104623, 2671.7862570994275, 2672.532306846304, 2432.74456182101, 2566.4995325911455, 2611.8694065296754, 2642.7753640940446, 2651.4697060587864, 2601.2716439396904, 2630.7109516336955, 2633.920982370513, 2638.4195476995033, 2662.680478342592, 2594.455164415475, 2620.358012286983, 2623.3966187776728, 2672.812903096784, 2686.9731302687114, 9036.954815225947, 9045.819083618291, 9104.180623743829, 9143.771405714844, 9183.724488265363, 5803.21656576361, 5883.294004719418, 5960.850978725566, 5981.970090149565, 5993.310769261503, 3641.7814931104217, 3725.1059745660846, 3780.7542509736777, 3792.90517737056, 3795.8671446499516, 1077.49357801833, 1081.2647399768155, 1085.5277954089995, 1107.8892110788938, 1126.0428635659705, 12111.152219344649, 12178.51285948561, 12278.508859645694, 12324.568640097554, 12382.938085309606, 5141.485851414904, 5170.97414512925, 5226.660267082628, 5238.2404551340605, 5256.842294731164, 10691.625793097204, 10748.462576871125, 10773.569057237622, 10774.461276936121, 10862.511186996604, 5694.231278777312, 5696.060150075191, 5801.622894511843, 5833.212516310328, 5910.172575839386, 4633.652476064309, 5034.0, 5146.970605878839, 5160.329157209614, 5241.0828105081455, 4124.05146816234, 4162.604552567501, 4213.5154457237195, 4242.00312926462, 4251.914961700749, 1384.3770303363526, 1412.3432603839265, 1421.0905020786704, 1425.3942074618246, 1426.721789251086, 1156.1733360647177, 1172.3434876469205, 1398.6713122416427, 1454.8472410396755, 1470.7058588282387, 8323.5005899645, 8434.662613495515, 8515.914840851636, 8673.609687564074, 8686.826263474695, 549.7306319903219, 552.8838943821843, 561.166667498764, 562.8846086552329, 563.2199403825731, 6322.683865806691, 6364.427201551883, 6376.489880809524, 6381.074744162163, 6413.422791948747, 10975.670729878117, 11090.445477726244, 11256.887431125748, 11339.659810205707, 11349.773004539862, 9545.379550329206, 10819.729506762395, 10826.700795904542, 11016.449177541092, 11403.771924561463, 8693.608787604446, 8764.21122099014, 8781.780455488537, 8784.868226976601, 8881.023087460375, 8034.8393032137865, 8189.181081891763, 8249.752507424786, 8299.128591497805, 8329.3336533076, 8418.747437576883, 9692.127708505986, 9880.654177103766, 10042.196624270187, 10060.0945914868, 10063.547140378847, 10178.847317290098, 10286.0, 10306.278560500694, 10371.222158338305, 7794.337481313925, 7796.0, 7876.09424916119, 7936.166702496154, 7959.403044771781, 8401.369897257853, 8403.789905252417, 8544.18830211129, 8558.78603034929, 8595.05454400003, 7466.887996680162, 7524.17234104259, 7584.54492730438, 7602.8099297518, 7880.763577092696, 7342.9632851835395, 7399.59302238382, 7451.254874512722, 7489.325960663348, 7555.6399848025685, 7923.207679232261, 7983.72056978003, 7992.920070799218, 8001.159878212704, 8018.879716804369, 7189.784306470814, 7214.170370407471, 7277.126744790447, 7286.307800758919, 7290.1251849776245, 7362.852742945218, 7365.079365079365, 7385.8153546161775, 7407.888881666671, 7417.147028091623], "unit": "score", "name": "mootools.html", "value": 5089.543919294623}, {"lowerIsBetter": false, "replicates": [345.40072973391165, 347.19277679395395, 351.1694841699382, 351.7291685402242, 353.32875498890246, 6778.051072849805, 6825.829354266146, 6832.077669514614, 6845.144356955387, 6857.76560219161, 6074.724307895347, 6765.661716914159, 6796.388325050744, 6841.0, 6865.897011544831, 4641.419822522184, 4826.1795494765975, 4935.062338155739, 5044.394672639289, 5061.721605311706, 4988.575971042447, 4996.500349965011, 5035.1188542005, 5039.143345631233, 5044.672096313746, 4947.332110165135, 4965.751712414365, 5002.649814512985, 5067.265246539249, 5071.695698258098, 4368.847090351855, 5072.26452164436, 5074.391073071237, 5075.416327122372, 5092.541671249568, 4363.738175709436, 4368.737875727435, 4373.562643735601, 4379.036611945398, 4383.473983122046, 6228.5017198624, 6471.708773105222, 6553.279139294674, 6576.145101136822, 6577.144971153767, 5882.735276912549, 5886.381929897385, 5903.291605007384, 5922.466977972003, 5933.61431506955, 7323.670434830446, 7324.597147156905, 7330.193678695339, 7331.926680733178, 7349.816254593625, 4729.55069268419, 4739.668223224376, 4747.52524747526, 4749.762511874393, 4757.452892917324, 6126.479249263863, 7524.209957954391, 7662.1571627120975, 7730.420218483636, 7754.069511658637, 3889.4749208857006, 4688.4373875134515, 4817.9036419272115, 4830.0, 4837.0, 4878.609711223094, 4905.632077594123, 4907.141250281186, 4909.901801963941, 4912.557869791736, 5871.618344807659, 5899.321578018497, 5899.557533185029, 5902.291724992942, 5912.935671579157, 6335.904961425582, 7325.267473252632, 7357.448191385561, 7357.52176108562, 7369.1525474570035, 1375.8761711446018, 1701.6171361443824, 1701.6851882401547, 1706.1128213329, 1707.2658756734475, 1048.6120135549895, 1078.2883297024084, 1086.5979587552497, 1087.152021423291, 1088.1131877519797, 6905.240423553405, 6921.238663746984, 6942.965285173542, 6952.930470695228, 6959.721611135498, 7504.437167212481, 7516.887246691304, 7549.282818132268, 7559.508631939017, 7570.091589009354, 6886.8622627547165, 6907.723691052302, 6946.652667366611, 6952.2352541220425, 6975.197852246955, 3975.151554527101, 3985.70107241958, 3992.3412636915164, 3992.6007399259843, 4000.3799411091327, 6627.304133066055, 6783.389494945479, 7769.494982826098, 7779.416543759241, 8001.279884810395, 5554.91667624986, 7555.395568354518, 7797.337226335711, 7847.372210223169, 7864.9606751965875, 7475.0, 8036.236557527026, 8041.0, 8062.475939063942, 8062.637181326854, 7402.9629851850395, 7672.506435408403, 7699.422543309162, 7708.49894756839, 7720.150783413932, 7477.289657482531, 7550.056242969629, 7554.411654464086, 7565.4325925556905, 7569.962150189434, 7900.525968441912, 8025.9598702006115, 8027.478213916077, 8042.87935680977, 8050.677972881019, 4986.252062190701, 5046.949530504648, 5050.823221187241, 5056.115179843439, 5062.114130027304, 7290.526115802456, 7407.59258240802, 7522.285382888617, 7559.28186822251, 7573.697052117854, 6806.706725722097, 7347.118345798538, 7377.372923301579, 7381.963090184515, 7408.814779630552, 6031.703183815325, 6593.439557637463, 7054.894176587252, 7370.557766534025, 7370.852582948204, 6842.418394436529, 7178.210396856237, 7192.244814294424, 7212.4230061596, 7214.855702885808, 7273.309035641606, 7285.052943117361, 7349.154847192642, 7353.610076724979, 7382.077240344957, 7146.642667866482, 7157.749478768218, 7173.569585824867, 7181.245969173162, 7190.06529151207], "unit": "score", "name": "prototype.html", "value": 5326.6512602752155}, {"lowerIsBetter": false, "replicates": [679.7722762874437, 695.7460526907677, 805.8630032894408, 807.3097501636101, 822.8683410654295, 15421.306041228143, 15619.0, 15662.451814186492, 15672.608184795386, 15685.372585096597, 14384.921130915198, 14465.855341446582, 14556.0, 14567.854321456782, 14581.708365832677, 798.6805277888833, 961.7547525381018, 991.6083147156887, 1012.7620009297846, 1015.3704703084098, 1009.9799202805183, 1011.4285428732743, 1012.2913960227833, 1013.7921726046143, 1015.2791518022213, 1056.392574269794, 1057.5399701130034, 1068.631322193842, 1076.0745758647597, 1080.3733834376044, 1020.9642662506851, 1054.0618849224197, 1069.802086613975, 1070.0369667299415, 1070.7055559721061, 794.0590400375573, 803.0764620686199, 804.2118723650855, 804.7746630943345, 808.4906508899355, 15187.924060379737, 15499.225038748018, 15644.608884777972, 15801.841981580152, 15821.683566328724, 13127.015473839405, 13129.934350328283, 13202.207867527979, 13368.933155334258, 13375.063745537816, 10394.272400931937, 10399.376037437778, 10429.426381549012, 10432.84350734732, 10748.408837513934, 3620.330238905811, 3624.8187590620364, 3648.5621725392857, 3651.3427583035045, 3881.7282790204695, 83407.0, 86248.56875715643, 86442.13557864404, 86837.56581217116, 87148.0, 9826.115649591571, 9961.950190249003, 10066.144377727975, 10160.034796694303, 10299.403592443183, 23032.65451018236, 23166.7683323168, 23281.83590820452, 23282.0, 23289.417764556023, 7635.809104772425, 7773.067231932205, 7808.687652493837, 7923.445358824943, 7976.920230797734, 3503.9488153554344, 3818.4272359145793, 3993.6206060424215, 4102.364133559303, 4157.417961485395, 3693.556773187181, 3704.7221458390727, 3739.0091625719206, 3757.680597149273, 3760.2667479841716, 615.7690865925279, 636.0872148466965, 659.4921910129174, 681.2404169351237, 690.5373399822131, 575.7581815637442, 597.6025942748024, 602.3193791016212, 627.9403456671608, 629.4429429954523, 7746.767596972099, 8571.82856342882, 8634.784130396665, 8647.0, 8690.695825646199, 585.7861880413618, 590.9290885093816, 593.6141508019736, 608.1296281551072, 615.2094558492316, 3909.882703518899, 4044.5550989391145, 4058.817353219112, 4097.836086556505, 4184.309588917856, 92596.14807703943, 95019.0, 97644.0, 97645.0, 97869.0, 84591.0, 84851.5757421209, 85086.14913850906, 85454.00910968086, 86500.5674971621, 72471.63764181145, 73228.0, 74979.62510187524, 75389.0, 76529.17354132382, 7967.442279040411, 8158.836823263383, 8199.385046121446, 8301.169883011891, 8378.120297368932, 50833.23750143677, 51204.231936521726, 52347.0, 53560.732196338766, 55310.0, 51242.0, 67491.0, 68977.65511172613, 71513.28486715275, 71817.0, 9122.859642544681, 10321.372483936484, 10414.531346089292, 10672.35965842021, 10729.9463502682, 11309.943450282695, 11316.37759923212, 11353.48909299067, 11442.656720298404, 11498.597549085742, 10330.586776528855, 10717.464126793786, 10734.302270352402, 10933.125349972142, 10994.725131871768, 10761.677149685522, 10847.891521085005, 11013.504392302206, 11040.00639942409, 11483.36841473727, 10406.427646479517, 10559.841602375816, 10672.679819605424, 10875.531803206466, 10906.781864362827, 9288.11762882525, 9402.059794020817, 9492.335536512377, 9513.857292140485, 9619.759506012406, 9200.723978280663, 9241.491717955578, 9300.534973251175, 9385.765355865884, 9405.576749046446], "unit": "score", "name": "yui.html", "value": 7132.569508416578}], "name": "dromaeo_css", "value": 7794.988365217228}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [155.0, 159.0, 165.0, 115.0, 116.0, 130.0, 113.0, 117.0, 116.0, 116.0], "unit": "score", "name": "ai-astar", "value": 130.2}, {"lowerIsBetter": true, "replicates": [147.0, 115.0, 161.0, 146.0, 106.0, 174.0, 148.0, 138.0, 146.0, 152.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [193.0, 273.0, 196.0, 270.0, 245.0, 185.0, 272.0, 277.0, 190.0, 282.0], "unit": "score", "name": "audio-dft", "value": 238.3}, {"lowerIsBetter": true, "replicates": [66.0, 74.0, 77.0, 113.0, 51.0, 66.0, 82.0, 87.0, 117.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [83.0, 75.0, 118.0, 65.0, 81.0, 68.0, 133.0, 114.0, 65.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [135.0, 87.0, 90.0, 87.0, 90.0, 87.0, 90.0, 91.0, 91.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.4}, {"lowerIsBetter": true, "replicates": [109.0, 123.0, 95.0, 97.0, 109.0, 95.0, 95.0, 95.0, 110.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 107.7}, {"lowerIsBetter": true, "replicates": [91.0, 95.0, 92.0, 89.0, 121.0, 146.0, 97.0, 145.0, 143.0, 100.0], "unit": "score", "name": "imaging-desaturate", "value": 111.9}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 55.0, 83.0, 88.0, 86.0, 87.0, 87.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [66.0, 80.0, 95.0, 68.0, 97.0, 85.0, 76.0, 92.0, 86.0, 82.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 82.7}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 83.0, 99.0, 110.0, 70.0, 68.0, 103.0, 71.0, 74.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [119.0, 130.0, 131.0, 134.0, 120.0, 128.0, 131.0, 116.0, 133.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [108.0, 149.0, 119.0, 152.0, 122.0, 154.0, 170.0, 171.0, 160.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [68.0, 64.0, 68.0, 66.0, 67.0, 68.0, 71.0, 98.0, 96.0, 90.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.6}], "name": "kraken", "value": 1583.5999999999997}]} 03:59:16 INFO - Return code: 0 03:59:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:59:16 ERROR - # TBPL SUCCESS # 03:59:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:59:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:59:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:59:16 INFO - 2016-05-11 03:59:16.600 screenresolution[1686:10578] starting screenresolution argv=screenresolution get 03:59:16 INFO - 2016-05-11 03:59:16.603 screenresolution[1686:10578] Display 0: 1600x1200x32@60 03:59:16 INFO - 2016-05-11 03:59:16.608 screenresolution[1687:10581] starting screenresolution argv=screenresolution list 03:59:16 INFO - Available Modes on Display 0 03:59:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:59:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:59:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:59:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:59:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:59:16 INFO - Intel Iris: 03:59:16 INFO - Chipset Model: Intel Iris 03:59:16 INFO - Type: GPU 03:59:16 INFO - Bus: Built-In 03:59:16 INFO - VRAM (Dynamic, Max): 1536 MB 03:59:16 INFO - Vendor: Intel (0x8086) 03:59:16 INFO - Device ID: 0x0a2e 03:59:16 INFO - Revision ID: 0x0009 03:59:16 INFO - Displays: 03:59:16 INFO - Display: 03:59:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:59:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:59:16 INFO - Display Serial Number: 1600x1200 60 03:59:16 INFO - Main Display: Yes 03:59:16 INFO - Mirror: Off 03:59:16 INFO - Online: Yes 03:59:16 INFO - Rotation: Supported 03:59:16 INFO - Return code: 0 03:59:16 INFO - Running post-action listener: _resource_record_post_action 03:59:16 INFO - Running post-run listener: _resource_record_post_run 03:59:17 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 37549568; Write bytes: 510243840; Read time: 403; Write time: 1647 03:59:17 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 211511808; Write bytes: 208877568; Read time: 19087; Write time: 424 03:59:17 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 30436864; Write bytes: 300309504; Read time: 312; Write time: 1218 03:59:17 INFO - Running post-run listener: _upload_blobber_files 03:59:17 INFO - Blob upload gear active. 03:59:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:59:17 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 03:59:17 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'] 03:59:17 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 03:59:18 INFO - (blobuploader) - INFO - Open directory for files ... 03:59:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:59:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:59:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:18 INFO - (blobuploader) - INFO - Done attempting. 03:59:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:59:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:59:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:20 INFO - (blobuploader) - INFO - Done attempting. 03:59:20 INFO - (blobuploader) - INFO - Iteration through files over. 03:59:20 INFO - Return code: 0 03:59:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:59:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:59:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f511742c61e9081ca4451eb9abbb79468e2e0e08703400c03273841df34aeee7e081c73dd27ee77bcee422d56541c0c8dc0706dd8e22c30636dbbd4afbd32f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9671a144fd37690fd4b86a3d20c85c1bda882fe2369cbc141f9cc1199a15b89951d8d64e95094a3db11b1c95f24ee146e403d2257c3611f62d9e563ec8447670"} 03:59:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:59:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:59:20 INFO - Contents: 03:59:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f511742c61e9081ca4451eb9abbb79468e2e0e08703400c03273841df34aeee7e081c73dd27ee77bcee422d56541c0c8dc0706dd8e22c30636dbbd4afbd32f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9671a144fd37690fd4b86a3d20c85c1bda882fe2369cbc141f9cc1199a15b89951d8d64e95094a3db11b1c95f24ee146e403d2257c3611f62d9e563ec8447670"} 03:59:20 INFO - Running post-run listener: copy_logs_to_upload_dir 03:59:20 INFO - Copying logs to upload dir... 03:59:20 INFO - mkdir: /builds/slave/test/build/upload/logs 03:59:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.302598 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-11 03:59:20.088915) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 03:59:20.092669) ========= 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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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/1f511742c61e9081ca4451eb9abbb79468e2e0e08703400c03273841df34aeee7e081c73dd27ee77bcee422d56541c0c8dc0706dd8e22c30636dbbd4afbd32f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9671a144fd37690fd4b86a3d20c85c1bda882fe2369cbc141f9cc1199a15b89951d8d64e95094a3db11b1c95f24ee146e403d2257c3611f62d9e563ec8447670"} build_url:https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010557 build_url: 'https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/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/1f511742c61e9081ca4451eb9abbb79468e2e0e08703400c03273841df34aeee7e081c73dd27ee77bcee422d56541c0c8dc0706dd8e22c30636dbbd4afbd32f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9671a144fd37690fd4b86a3d20c85c1bda882fe2369cbc141f9cc1199a15b89951d8d64e95094a3db11b1c95f24ee146e403d2257c3611f62d9e563ec8447670"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 03:59:20.124550) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:59:20.124987) ========= 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.ed1QoZ8FDx/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.J8W6coqMy6/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.004944 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:59:20.175223) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 03:59:20.175671) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 03:59:20.176145) ========= ========= Total master_lag: 0.16 =========