builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0274 starttime: 1468024580.95 results: success (0) buildid: 20160708154328 builduid: fa428b6b8f0a49af80ecfad604562652 revision: 8e54a7dccda8dfa6d61f45d4804de5c95a205fb7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:20.954441) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:20.954913) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:20.955198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:20.979527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:20.979864) ========= 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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-08 17:36:20-- 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% 21.1M=0.001s 2016-07-08 17:36:21 (21.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093596 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:21.095711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:21.096072) ========= 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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.035885 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:21.152054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 17:36:21.152406) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8e54a7dccda8dfa6d61f45d4804de5c95a205fb7 --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 8e54a7dccda8dfa6d61f45d4804de5c95a205fb7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-08 17:36:21,236 truncating revision to first 12 chars 2016-07-08 17:36:21,236 Setting DEBUG logging. 2016-07-08 17:36:21,236 attempt 1/10 2016-07-08 17:36:21,236 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8e54a7dccda8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 17:36:22,307 unpacking tar archive at: mozilla-beta-8e54a7dccda8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.347678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 17:36:22.522913) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:22.523243) ========= script_repo_revision: 8e54a7dccda8dfa6d61f45d4804de5c95a205fb7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:22.523627) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:22.524096) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 17:36:22.543535) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-08 17:36:22.544000) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 17:36:22 INFO - MultiFileLogger online at 20160708 17:36:22 in /builds/slave/test 17:36:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:36:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:36:22 INFO - {'append_to_log': False, 17:36:22 INFO - 'base_work_dir': '/builds/slave/test', 17:36:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:36:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:36:22 INFO - 'branch': 'Mozilla-Beta', 17:36:22 INFO - 'buildbot_json_path': 'buildprops.json', 17:36:22 INFO - 'config_files': ('talos/mac_config.py',), 17:36:22 INFO - 'default_actions': ('clobber', 17:36:22 INFO - 'read-buildbot-config', 17:36:22 INFO - 'download-and-extract', 17:36:22 INFO - 'populate-webroot', 17:36:22 INFO - 'create-virtualenv', 17:36:22 INFO - 'install', 17:36:22 INFO - 'run-tests'), 17:36:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:36:22 INFO - 'download_minidump_stackwalk': True, 17:36:22 INFO - 'download_symbols': 'ondemand', 17:36:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:36:22 INFO - 'tooltool.py': '/tools/tooltool.py', 17:36:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:36:22 INFO - '/tools/misc-python/virtualenv.py')}, 17:36:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:36:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:36:22 INFO - 'installer_path': 'installer.exe', 17:36:22 INFO - 'log_level': 'info', 17:36:22 INFO - 'log_name': 'talos', 17:36:22 INFO - 'log_to_console': True, 17:36:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:36:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:36:22 INFO - 'opt_config_files': (), 17:36:22 INFO - 'pip_index': False, 17:36:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:36:22 INFO - 'cmd': ('bash', 17:36:22 INFO - '-c', 17:36:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:36:22 INFO - 'enabled': True, 17:36:22 INFO - 'halt_on_failure': False, 17:36:22 INFO - 'name': 'check_screen_resolution'},), 17:36:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:36:22 INFO - 'cmd': ('bash', 17:36:22 INFO - '-c', 17:36:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:36:22 INFO - 'enabled': True, 17:36:22 INFO - 'halt_on_failure': False, 17:36:22 INFO - 'name': 'check_screen_resolution'},), 17:36:22 INFO - 'run_cmd_checks_enabled': True, 17:36:22 INFO - 'sps_profile': False, 17:36:22 INFO - 'sps_profile_interval': 0, 17:36:22 INFO - 'suite': 'dromaeojs', 17:36:22 INFO - 'system_bits': '32', 17:36:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:36:22 INFO - 'title': 't-yosemite-r7-0274', 17:36:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:36:22 INFO - 'use_talos_json': True, 17:36:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:36:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:36:22 INFO - 'work_dir': 'build'} 17:36:22 INFO - ##### 17:36:22 INFO - ##### Running clobber step. 17:36:22 INFO - ##### 17:36:22 INFO - Running pre-action listener: _resource_record_pre_action 17:36:22 INFO - Running main action method: clobber 17:36:22 INFO - rmtree: /builds/slave/test/build 17:36:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:36:24 INFO - Running post-action listener: _resource_record_post_action 17:36:24 INFO - ##### 17:36:24 INFO - ##### Running read-buildbot-config step. 17:36:24 INFO - ##### 17:36:24 INFO - Running pre-action listener: _resource_record_pre_action 17:36:24 INFO - Running main action method: read_buildbot_config 17:36:24 INFO - Using buildbot properties: 17:36:24 INFO - { 17:36:24 INFO - "project": "", 17:36:24 INFO - "product": "firefox", 17:36:24 INFO - "script_repo_revision": "production", 17:36:24 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:36:24 INFO - "repository": "", 17:36:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:36:24 INFO - "buildid": "20160708154328", 17:36:24 INFO - "pgo_build": "False", 17:36:24 INFO - "basedir": "/builds/slave/test", 17:36:24 INFO - "buildnumber": 37, 17:36:24 INFO - "slavename": "t-yosemite-r7-0274", 17:36:24 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:36:24 INFO - "platform": "yosemite_r7", 17:36:24 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:36:24 INFO - "branch": "mozilla-beta", 17:36:24 INFO - "repo_path": "releases/mozilla-beta", 17:36:24 INFO - "revision": "8e54a7dccda8dfa6d61f45d4804de5c95a205fb7", 17:36:24 INFO - "stage_platform": "macosx64", 17:36:24 INFO - "builduid": "fa428b6b8f0a49af80ecfad604562652", 17:36:24 INFO - "slavebuilddir": "test" 17:36:24 INFO - } 17:36:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 17:36:24 INFO - Running post-action listener: _resource_record_post_action 17:36:24 INFO - ##### 17:36:24 INFO - ##### Running download-and-extract step. 17:36:24 INFO - ##### 17:36:24 INFO - Running pre-action listener: _resource_record_pre_action 17:36:24 INFO - Running main action method: download_and_extract 17:36:24 INFO - mkdir: /builds/slave/test/build/tests 17:36:24 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')]} 17:36:24 INFO - https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:36:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 17:36:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 17:36:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 17:36:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 17:36:25 INFO - Downloaded 1165 bytes. 17:36:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 17:36:25 INFO - Using the following test package requirements: 17:36:25 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 17:36:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:36:25 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 17:36:25 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:36:25 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 17:36:25 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:36:25 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:36:25 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 17:36:25 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 17:36:25 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:36:25 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 17:36:25 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:36:25 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 17:36:25 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:36:25 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 17:36:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:36:25 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 17:36:25 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 17:36:25 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')]} 17:36:25 INFO - https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:36:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:36:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:36:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 17:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 17:36:28 INFO - Downloaded 18351471 bytes. 17:36:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:36:31 INFO - Return code: 0 17:36:31 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:36: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')]} 17:36:31 INFO - https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:36:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:36:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:36:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 17:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 17:36:32 INFO - Downloaded 18351471 bytes. 17:36:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:36:35 INFO - Return code: 0 17:36: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')]} 17:36:35 INFO - https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:36:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 17:36:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 17:36:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 17:36:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 17:36:36 INFO - Downloaded 10840145 bytes. 17:36:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:36:37 INFO - Return code: 0 17:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:37 INFO - https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 17:36:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:36:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:36:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 17:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 17:36:39 INFO - Downloaded 86189319 bytes. 17:36:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:36:39 INFO - mkdir: /builds/slave/test/properties 17:36:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:36:39 INFO - Writing to file /builds/slave/test/properties/build_url 17:36:39 INFO - Contents: 17:36:39 INFO - build_url:https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:36:40 INFO - Running post-action listener: _resource_record_post_action 17:36:40 INFO - Running post-action listener: set_extra_try_arguments 17:36:40 INFO - ##### 17:36:40 INFO - ##### Running populate-webroot step. 17:36:40 INFO - ##### 17:36:40 INFO - Running pre-action listener: _resource_record_pre_action 17:36:40 INFO - Running main action method: populate_webroot 17:36:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:36:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:36:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:36:40 INFO - '--tppagecycles', 17:36:40 INFO - '7'], 17:36:40 INFO - 'tests': ['tsvgm']}}, 17:36:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:36:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:36:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:36:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:36:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:36:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:36:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:40 INFO - 'talos_options': ['--disable-e10s'], 17:36:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:40 INFO - 'talos_options': ['--disable-e10s'], 17:36:40 INFO - 'tests': ['damp', 'tps']}, 17:36:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:40 INFO - 'tests': ['damp', 'tps']}, 17:36:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:36:40 INFO - 'tests': ['dromaeo_dom']}, 17:36:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:36:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:36:40 INFO - 'tests': ['a11yr', 17:36:40 INFO - 'ts_paint', 17:36:40 INFO - 'tpaint', 17:36:40 INFO - 'sessionrestore', 17:36:40 INFO - 'sessionrestore_no_auto_restore', 17:36:40 INFO - 'tabpaint']}, 17:36:40 INFO - 'other-e10s': {'tests': ['a11yr', 17:36:40 INFO - 'ts_paint', 17:36:40 INFO - 'tpaint', 17:36:40 INFO - 'sessionrestore', 17:36:40 INFO - 'sessionrestore_no_auto_restore', 17:36:40 INFO - 'tabpaint']}, 17:36:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:36:40 INFO - 'ts_paint', 17:36:40 INFO - 'tpaint', 17:36:40 INFO - 'sessionrestore', 17:36:40 INFO - 'sessionrestore_no_auto_restore', 17:36:40 INFO - 'tabpaint']}, 17:36:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:36:40 INFO - 'ts_paint', 17:36:40 INFO - 'tpaint', 17:36:40 INFO - 'sessionrestore', 17:36:40 INFO - 'sessionrestore_no_auto_restore', 17:36:40 INFO - 'tabpaint']}, 17:36:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:36:40 INFO - 'tests': ['a11yr', 17:36:40 INFO - 'ts_paint', 17:36:40 INFO - 'tpaint', 17:36:40 INFO - 'sessionrestore', 17:36:40 INFO - 'sessionrestore_no_auto_restore', 17:36:40 INFO - 'tabpaint']}, 17:36:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:36:40 INFO - 'tests': ['a11yr', 17:36:40 INFO - 'ts_paint', 17:36:40 INFO - 'tpaint', 17:36:40 INFO - 'sessionrestore', 17:36:40 INFO - 'sessionrestore_no_auto_restore', 17:36:40 INFO - 'tabpaint']}, 17:36:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:36:40 INFO - 'tests': ['tsvgx', 17:36:40 INFO - 'tsvgr_opacity', 17:36:40 INFO - 'tart', 17:36:40 INFO - 'tscrollx', 17:36:40 INFO - 'cart']}, 17:36:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:36:40 INFO - 'tsvgr_opacity', 17:36:40 INFO - 'tart', 17:36:40 INFO - 'tscrollx', 17:36:40 INFO - 'cart']}, 17:36:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:40 INFO - 'talos_options': ['--disable-e10s'], 17:36:40 INFO - 'tests': ['tp5o']}, 17:36:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:40 INFO - 'tests': ['tp5o']}, 17:36:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:40 INFO - 'talos_options': ['--disable-e10s', 17:36:40 INFO - '--xperf_path', 17:36:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:40 INFO - 'tests': ['tp5n']}, 17:36:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:40 INFO - 'talos_options': ['--xperf_path', 17:36:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:40 INFO - 'tests': ['tp5n']}}, 17:36:40 INFO - 'talos.zip': {'path': '', 17:36:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:36:40 INFO - Running post-action listener: _resource_record_post_action 17:36:40 INFO - ##### 17:36:40 INFO - ##### Running create-virtualenv step. 17:36:40 INFO - ##### 17:36:40 INFO - Running pre-action listener: _resource_record_pre_action 17:36:40 INFO - Running main action method: create_virtualenv 17:36:40 INFO - Creating virtualenv /builds/slave/test/build/venv 17:36:40 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 17:36:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:36:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:36:40 INFO - Using real prefix '/tools/python27' 17:36:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:36:41 INFO - Installing distribute.............................................................................................................................................................................................done. 17:36:44 INFO - Installing pip.................done. 17:36:44 INFO - Return code: 0 17:36:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:36:44 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')]} 17:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:44 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')]} 17:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:44 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 0x102de2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102df2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff82858c000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c81e00>, '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 0x102aeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c7cb20>, '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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 17:36:44 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 17:36:44 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 17:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khSt3FUHzf/Render', 17:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:44 INFO - 'HOME': '/Users/cltbld', 17:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:44 INFO - 'LOGNAME': 'cltbld', 17:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:44 INFO - 'MOZ_NO_REMOTE': '1', 17:36:44 INFO - 'NO_EM_RESTART': '1', 17:36:44 INFO - 'PAGER': '/bin/cat', 17:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:44 INFO - 'PWD': '/builds/slave/test', 17:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:44 INFO - 'SHELL': '/bin/bash', 17:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hm2ZiDHhz5/Listeners', 17:36:44 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 17:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:44 INFO - 'USER': 'cltbld', 17:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:44 INFO - 'XPC_FLAGS': '0x0', 17:36:44 INFO - 'XPC_SERVICE_NAME': '0', 17:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:44 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 17:36:44 INFO - Cleaning up... 17:36:44 INFO - Return code: 0 17:36:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:36:44 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')]} 17:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:44 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')]} 17:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:44 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 0x102de2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102df2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff82858c000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c81e00>, '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 0x102aeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c7cb20>, '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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 17:36:44 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 17:36:44 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 17:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khSt3FUHzf/Render', 17:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:44 INFO - 'HOME': '/Users/cltbld', 17:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:44 INFO - 'LOGNAME': 'cltbld', 17:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:44 INFO - 'MOZ_NO_REMOTE': '1', 17:36:44 INFO - 'NO_EM_RESTART': '1', 17:36:44 INFO - 'PAGER': '/bin/cat', 17:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:44 INFO - 'PWD': '/builds/slave/test', 17:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:44 INFO - 'SHELL': '/bin/bash', 17:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hm2ZiDHhz5/Listeners', 17:36:44 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 17:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:44 INFO - 'USER': 'cltbld', 17:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:44 INFO - 'XPC_FLAGS': '0x0', 17:36:44 INFO - 'XPC_SERVICE_NAME': '0', 17:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:45 INFO - Downloading/unpacking psutil>=0.7.1 17:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:36:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:48 INFO - Installing collected packages: psutil 17:36:48 INFO - Running setup.py install for psutil 17:36:48 INFO - building 'psutil._psutil_osx' extension 17:36:48 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 17:36:48 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 17:36:48 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 17:36:48 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 17:36:48 INFO - building 'psutil._psutil_posix' extension 17:36:48 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 17:36:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:36:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:36:49 INFO - ^ 17:36:49 INFO - 1 warning generated. 17:36:49 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 17:36:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:49 INFO - Successfully installed psutil 17:36:49 INFO - Cleaning up... 17:36:49 INFO - Return code: 0 17:36:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:36:49 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')]} 17:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:49 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')]} 17:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:49 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 0x102de2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102df2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff82858c000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c81e00>, '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 0x102aeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c7cb20>, '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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 17:36:49 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 17:36:49 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 17:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khSt3FUHzf/Render', 17:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:49 INFO - 'HOME': '/Users/cltbld', 17:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:49 INFO - 'LOGNAME': 'cltbld', 17:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:49 INFO - 'MOZ_NO_REMOTE': '1', 17:36:49 INFO - 'NO_EM_RESTART': '1', 17:36:49 INFO - 'PAGER': '/bin/cat', 17:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:49 INFO - 'PWD': '/builds/slave/test', 17:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:49 INFO - 'SHELL': '/bin/bash', 17:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hm2ZiDHhz5/Listeners', 17:36:49 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 17:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:49 INFO - 'USER': 'cltbld', 17:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:49 INFO - 'XPC_FLAGS': '0x0', 17:36:49 INFO - 'XPC_SERVICE_NAME': '0', 17:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:36:49 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 17:36:49 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 17:36:49 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 17:36:49 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 17:36:49 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 17:36:49 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 17:36:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:36:52 INFO - Installing collected packages: mozsystemmonitor 17:36:52 INFO - Running setup.py install for mozsystemmonitor 17:36:52 INFO - Successfully installed mozsystemmonitor 17:36:52 INFO - Cleaning up... 17:36:52 INFO - Return code: 0 17:36:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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', '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 0x102de2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102df2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff82858c000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c81e00>, '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 0x102aeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c7cb20>, '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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 17:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:36: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 blobuploader==1.2.4 17:36:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khSt3FUHzf/Render', 17:36:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:52 INFO - 'HOME': '/Users/cltbld', 17:36:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:52 INFO - 'LOGNAME': 'cltbld', 17:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:52 INFO - 'MOZ_NO_REMOTE': '1', 17:36:52 INFO - 'NO_EM_RESTART': '1', 17:36:52 INFO - 'PAGER': '/bin/cat', 17:36:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:52 INFO - 'PWD': '/builds/slave/test', 17:36:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:52 INFO - 'SHELL': '/bin/bash', 17:36:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hm2ZiDHhz5/Listeners', 17:36:52 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 17:36:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:52 INFO - 'USER': 'cltbld', 17:36:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:52 INFO - 'XPC_FLAGS': '0x0', 17:36:52 INFO - 'XPC_SERVICE_NAME': '0', 17:36:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:52 INFO - Downloading/unpacking blobuploader==1.2.4 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36:55 INFO - Downloading blobuploader-1.2.4.tar.gz 17:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:36:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:36:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:56 INFO - Downloading docopt-0.6.1.tar.gz 17:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:36:56 INFO - Installing collected packages: blobuploader, requests, docopt 17:36:56 INFO - Running setup.py install for blobuploader 17:36:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:36:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:36:56 INFO - Running setup.py install for requests 17:36:56 INFO - Running setup.py install for docopt 17:36:57 INFO - Successfully installed blobuploader requests docopt 17:36:57 INFO - Cleaning up... 17:36:57 INFO - Return code: 0 17:36:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:57 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')]} 17:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:57 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')]} 17:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:57 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 0x102de2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102df2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff82858c000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c81e00>, '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 0x102aeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c7cb20>, '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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 17:36:57 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 17:36:57 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 17:36:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khSt3FUHzf/Render', 17:36:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:57 INFO - 'HOME': '/Users/cltbld', 17:36:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:57 INFO - 'LOGNAME': 'cltbld', 17:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:57 INFO - 'MOZ_NO_REMOTE': '1', 17:36:57 INFO - 'NO_EM_RESTART': '1', 17:36:57 INFO - 'PAGER': '/bin/cat', 17:36:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:57 INFO - 'PWD': '/builds/slave/test', 17:36:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:57 INFO - 'SHELL': '/bin/bash', 17:36:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hm2ZiDHhz5/Listeners', 17:36:57 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 17:36:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:57 INFO - 'USER': 'cltbld', 17:36:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:57 INFO - 'XPC_FLAGS': '0x0', 17:36:57 INFO - 'XPC_SERVICE_NAME': '0', 17:36:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-jTGWkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-RSlpdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-8hFmPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-tydMnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-U40wIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-EDxAZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-bfNxeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-1tHG8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-gZgQyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-yME_L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-hRNXo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-hWQAEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-50VISg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-1vN44T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-srKQyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:59 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-8YjucQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:59 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-4Eb2QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:36:59 INFO - Running setup.py install for manifestparser 17:36:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:36:59 INFO - Running setup.py install for mozcrash 17:36:59 INFO - Running setup.py install for mozdebug 17:36:59 INFO - Running setup.py install for mozdevice 17:36:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:36:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:36:59 INFO - Running setup.py install for mozfile 17:36:59 INFO - Running setup.py install for mozhttpd 17:37:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:37:00 INFO - Running setup.py install for mozinfo 17:37:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:37:00 INFO - Running setup.py install for mozInstall 17:37:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:37:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:37:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:37:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:37:00 INFO - Running setup.py install for mozleak 17:37:00 INFO - Running setup.py install for mozlog 17:37:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:37:00 INFO - Running setup.py install for moznetwork 17:37:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:37:00 INFO - Running setup.py install for mozprocess 17:37:01 INFO - Running setup.py install for mozprofile 17:37:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:37:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:37:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:37:01 INFO - Running setup.py install for mozrunner 17:37:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:37:01 INFO - Running setup.py install for mozscreenshot 17:37:01 INFO - Running setup.py install for moztest 17:37:01 INFO - Running setup.py install for mozversion 17:37:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:37:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:37:01 INFO - Cleaning up... 17:37:01 INFO - Return code: 0 17:37:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37:01 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')]} 17:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:01 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')]} 17:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:01 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 0x102de2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102df2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff82858c000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c81e00>, '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 0x102aeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c7cb20>, '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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 17:37:01 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 17:37:01 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 17:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khSt3FUHzf/Render', 17:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:01 INFO - 'HOME': '/Users/cltbld', 17:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:01 INFO - 'LOGNAME': 'cltbld', 17:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:01 INFO - 'MOZ_NO_REMOTE': '1', 17:37:01 INFO - 'NO_EM_RESTART': '1', 17:37:01 INFO - 'PAGER': '/bin/cat', 17:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:01 INFO - 'PWD': '/builds/slave/test', 17:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:01 INFO - 'SHELL': '/bin/bash', 17:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hm2ZiDHhz5/Listeners', 17:37:01 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 17:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:01 INFO - 'USER': 'cltbld', 17:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:01 INFO - 'XPC_FLAGS': '0x0', 17:37:01 INFO - 'XPC_SERVICE_NAME': '0', 17:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:37:02 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-EEmVNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:37:02 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)) 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:37:02 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-aB7h4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:37:02 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)) 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:37:02 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-WWuHiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:37:02 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)) 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:37:02 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-FhoQoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:37:02 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)) 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:37:02 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-kWQu_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:37:02 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)) 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:37:02 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-sAdkN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:37:02 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)) 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:37:02 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-0Y9ViJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:37:02 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)) 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:37:02 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-8bqN1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:37:02 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)) 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:37:02 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-1SPmAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:37:03 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)) 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:37:03 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Hlr3tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:37:03 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)) 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:37:03 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-8XU94g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:37:03 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)) 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:37:03 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-o4gegQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:37:03 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)) 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:37:03 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-zL3YI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:37:03 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)) 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:37:03 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-76Kmkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:37:03 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)) 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:03 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-DX2q1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:03 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)) 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:37:03 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-kg4CZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:37:03 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)) 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:37:03 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-e8xr5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:37:03 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)) 17:37:03 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)) 17:37:03 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)) 17:37:03 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)) 17:37:03 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)) 17:37:03 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)) 17:37:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37:06 INFO - Downloading blessings-1.6.tar.gz 17:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:37:06 INFO - Installing collected packages: blessings 17:37:06 INFO - Running setup.py install for blessings 17:37:06 INFO - Successfully installed blessings 17:37:06 INFO - Cleaning up... 17:37:06 INFO - Return code: 0 17:37:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:06 INFO - Reading from file tmpfile_stdout 17:37:07 INFO - Current package versions: 17:37:07 INFO - blessings == 1.6 17:37:07 INFO - blobuploader == 1.2.4 17:37:07 INFO - docopt == 0.6.1 17:37:07 INFO - manifestparser == 1.1 17:37:07 INFO - mozInstall == 1.12 17:37:07 INFO - mozcrash == 0.17 17:37:07 INFO - mozdebug == 0.1 17:37:07 INFO - mozdevice == 0.48 17:37:07 INFO - mozfile == 1.2 17:37:07 INFO - mozhttpd == 0.7 17:37:07 INFO - mozinfo == 0.9 17:37:07 INFO - mozleak == 0.1 17:37:07 INFO - mozlog == 3.1 17:37:07 INFO - moznetwork == 0.27 17:37:07 INFO - mozprocess == 0.22 17:37:07 INFO - mozprofile == 0.28 17:37:07 INFO - mozrunner == 6.11 17:37:07 INFO - mozscreenshot == 0.1 17:37:07 INFO - mozsystemmonitor == 0.0 17:37:07 INFO - moztest == 0.7 17:37:07 INFO - mozversion == 1.4 17:37:07 INFO - psutil == 3.1.1 17:37:07 INFO - requests == 1.2.3 17:37:07 INFO - wsgiref == 0.1.2 17:37:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:07 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 0x102de2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102df2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff82858c000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c81e00>, '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 0x102aeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c7cb20>, '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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 17:37:07 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 17:37:07 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 17:37:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khSt3FUHzf/Render', 17:37:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:07 INFO - 'HOME': '/Users/cltbld', 17:37:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:07 INFO - 'LOGNAME': 'cltbld', 17:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:07 INFO - 'MOZ_NO_REMOTE': '1', 17:37:07 INFO - 'NO_EM_RESTART': '1', 17:37:07 INFO - 'PAGER': '/bin/cat', 17:37:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:07 INFO - 'PWD': '/builds/slave/test', 17:37:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:07 INFO - 'SHELL': '/bin/bash', 17:37:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hm2ZiDHhz5/Listeners', 17:37:07 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 17:37:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:07 INFO - 'USER': 'cltbld', 17:37:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:07 INFO - 'XPC_FLAGS': '0x0', 17:37:07 INFO - 'XPC_SERVICE_NAME': '0', 17:37:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:07 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)) 17:37:07 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)) 17:37:07 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)) 17:37:07 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)) 17:37:07 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)) 17:37:07 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)) 17:37:07 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)) 17:37:07 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)) 17:37:07 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)) 17:37:07 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)) 17:37:07 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)) 17:37:07 INFO - Cleaning up... 17:37:07 INFO - Return code: 0 17:37:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102de2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102df2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff82858c000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c81e00>, '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 0x102aeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c7cb20>, '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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 17:37:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:37:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khSt3FUHzf/Render', 17:37:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:07 INFO - 'HOME': '/Users/cltbld', 17:37:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:07 INFO - 'LOGNAME': 'cltbld', 17:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:07 INFO - 'MOZ_NO_REMOTE': '1', 17:37:07 INFO - 'NO_EM_RESTART': '1', 17:37:07 INFO - 'PAGER': '/bin/cat', 17:37:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:07 INFO - 'PWD': '/builds/slave/test', 17:37:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:07 INFO - 'SHELL': '/bin/bash', 17:37:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hm2ZiDHhz5/Listeners', 17:37:07 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 17:37:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:07 INFO - 'USER': 'cltbld', 17:37:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:07 INFO - 'XPC_FLAGS': '0x0', 17:37:07 INFO - 'XPC_SERVICE_NAME': '0', 17:37:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:07 INFO - Downloading/unpacking jsonschema 17:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:37:09 INFO - Downloading/unpacking functools32 (from jsonschema) 17:37:09 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 17:37:09 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 17:37:09 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 17:37:09 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 17:37:09 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 17:37:09 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 17:37:10 INFO - Downloading functools32-3.2.3-2.tar.gz 17:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:37:10 INFO - warning: no files found matching '*.txt' 17:37:10 INFO - no previously-included directories found matching 'build' 17:37:10 INFO - no previously-included directories found matching 'dist' 17:37:10 INFO - no previously-included directories found matching '.git*' 17:37:10 INFO - Installing collected packages: jsonschema, functools32 17:37:10 INFO - Running setup.py install for functools32 17:37:10 INFO - warning: no files found matching '*.txt' 17:37:10 INFO - no previously-included directories found matching 'build' 17:37:10 INFO - no previously-included directories found matching 'dist' 17:37:10 INFO - no previously-included directories found matching '.git*' 17:37:10 INFO - Successfully installed jsonschema functools32 17:37:10 INFO - Cleaning up... 17:37:10 INFO - Return code: 0 17:37:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:37:10 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')]} 17:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:10 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')]} 17:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:10 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 0x102de2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102df2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff82858c000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c81e00>, '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 0x102aeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c7cb20>, '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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 17:37:10 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 17:37:10 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 17:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khSt3FUHzf/Render', 17:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:10 INFO - 'HOME': '/Users/cltbld', 17:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:10 INFO - 'LOGNAME': 'cltbld', 17:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:10 INFO - 'MOZ_NO_REMOTE': '1', 17:37:10 INFO - 'NO_EM_RESTART': '1', 17:37:10 INFO - 'PAGER': '/bin/cat', 17:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:10 INFO - 'PWD': '/builds/slave/test', 17:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:10 INFO - 'SHELL': '/bin/bash', 17:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hm2ZiDHhz5/Listeners', 17:37:10 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 17:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:10 INFO - 'USER': 'cltbld', 17:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:10 INFO - 'XPC_FLAGS': '0x0', 17:37:10 INFO - 'XPC_SERVICE_NAME': '0', 17:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:10 INFO - Downloading/unpacking flake8 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:37:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:37:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:37:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:37:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:37:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:37:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:37:14 INFO - no previously-included directories found matching 'docs/_build' 17:37:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:37:14 INFO - Running setup.py install for pep8 17:37:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:37:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:37:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:37:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:37:15 INFO - no previously-included directories found matching 'docs/_build' 17:37:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:37:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:37:15 INFO - Cleaning up... 17:37:15 INFO - Return code: 0 17:37:15 INFO - Running post-action listener: _resource_record_post_action 17:37:15 INFO - Running post-action listener: _start_resource_monitoring 17:37:15 INFO - Starting resource monitoring. 17:37:15 INFO - ##### 17:37:15 INFO - ##### Running install step. 17:37:15 INFO - ##### 17:37:15 INFO - Running pre-action listener: _resource_record_pre_action 17:37:15 INFO - Running main action method: install 17:37:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:15 INFO - Reading from file tmpfile_stdout 17:37:15 INFO - Detecting whether we're running mozinstall >=1.0... 17:37:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:37:15 INFO - Reading from file tmpfile_stdout 17:37:15 INFO - Output received: 17:37:15 INFO - Usage: mozinstall [options] installer 17:37:15 INFO - Options: 17:37:15 INFO - -h, --help show this help message and exit 17:37:15 INFO - -d DEST, --destination=DEST 17:37:15 INFO - Directory to install application into. [default: 17:37:15 INFO - "/builds/slave/test"] 17:37:15 INFO - --app=APP Application being installed. [default: firefox] 17:37:15 INFO - mkdir: /builds/slave/test/build/application 17:37:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:37:37 INFO - Reading from file tmpfile_stdout 17:37:37 INFO - Output received: 17:37:37 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:37:37 INFO - Running post-action listener: _resource_record_post_action 17:37:37 INFO - ##### 17:37:37 INFO - ##### Running run-tests step. 17:37:37 INFO - ##### 17:37:37 INFO - Running pre-action listener: _resource_record_pre_action 17:37:37 INFO - Running main action method: run_tests 17:37:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:37:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:37:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:37:37 INFO - 2016-07-08 17:37:37.351 screenresolution[1641:7602] starting screenresolution argv=screenresolution get 17:37:37 INFO - 2016-07-08 17:37:37.354 screenresolution[1641:7602] Display 0: 1600x1200x32@60 17:37:37 INFO - 2016-07-08 17:37:37.359 screenresolution[1642:7604] starting screenresolution argv=screenresolution list 17:37:37 INFO - Available Modes on Display 0 17:37:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:37:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:37:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:37:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:37:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:37:37 INFO - Intel Iris: 17:37:37 INFO - Chipset Model: Intel Iris 17:37:37 INFO - Type: GPU 17:37:37 INFO - Bus: Built-In 17:37:37 INFO - VRAM (Dynamic, Max): 1536 MB 17:37:37 INFO - Vendor: Intel (0x8086) 17:37:37 INFO - Device ID: 0x0a2e 17:37:37 INFO - Revision ID: 0x0009 17:37:37 INFO - Displays: 17:37:37 INFO - Display: 17:37:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:37:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:37:37 INFO - Display Serial Number: 1600x1200 60 17:37:37 INFO - Main Display: Yes 17:37:37 INFO - Mirror: Off 17:37:37 INFO - Online: Yes 17:37:37 INFO - Rotation: Supported 17:37:37 INFO - Return code: 0 17:37:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:37:37 INFO - Python 2.7.3 17:37:37 INFO - Return code: 0 17:37:37 INFO - grabbing minidump binary from tooltool 17:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:37 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 0x102c81e00>, '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 0x102aeadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c7cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:37:37 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 17:37:37 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 17:37:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:37:37 INFO - Return code: 0 17:37:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:37:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:37:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:37:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:37:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:37:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:37:38 INFO - Return code: 0 17:37:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0274 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khSt3FUHzf/Render', 17:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:38 INFO - 'HOME': '/Users/cltbld', 17:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:38 INFO - 'LOGNAME': 'cltbld', 17:37:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:37:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:38 INFO - 'MOZ_NO_REMOTE': '1', 17:37:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:37:38 INFO - 'NO_EM_RESTART': '1', 17:37:38 INFO - 'PAGER': '/bin/cat', 17:37:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:38 INFO - 'PWD': '/builds/slave/test', 17:37:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:38 INFO - 'SHELL': '/bin/bash', 17:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hm2ZiDHhz5/Listeners', 17:37:38 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 17:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:38 INFO - 'USER': 'cltbld', 17:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:38 INFO - 'XPC_FLAGS': '0x0', 17:37:38 INFO - 'XPC_SERVICE_NAME': '0', 17:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:37:38 INFO - mozversion application_buildid: 20160708154328 17:37:38 INFO - mozversion application_changeset: 8e54a7dccda8dfa6d61f45d4804de5c95a205fb7 17:37:38 INFO - mozversion application_display_name: Firefox 17:37:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:37:38 INFO - mozversion application_name: Firefox 17:37:38 INFO - mozversion application_remotingname: firefox 17:37:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:37:38 INFO - mozversion application_vendor: Mozilla 17:37:38 INFO - mozversion application_version: 48.0 17:37:38 INFO - mozversion platform_buildid: 20160708154328 17:37:38 INFO - mozversion platform_changeset: 8e54a7dccda8dfa6d61f45d4804de5c95a205fb7 17:37:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:37:39 INFO - mozversion platform_version: 48.0 17:37:39 INFO - using testdate: 1468024658 17:37:39 INFO - actual date: 1468024658 17:37:39 INFO - starting webserver on 'localhost:49277' 17:37:39 INFO - SUITE-START | Running 2 tests 17:37:39 INFO - TEST-START | dromaeo_css 17:37:39 INFO - operating with platform_type : mac_ 17:37:39 INFO - Initialising browser for dromaeo_css test... 17:37:39 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpWhYpRl/profile http://localhost:49277/getInfo.html) 17:37:41 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 17:37:41 INFO - PROCESS | 1660 | colorDepth:24 17:37:41 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 17:37:41 INFO - PROCESS | 1660 | __metrics 17:37:41 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:37:41 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:37:42 INFO - TEST-INFO | 1660: exit 0 17:37:42 INFO - Browser initialized. 17:37:42 INFO - Running cycle 1/1 for dromaeo_css test... 17:37:42 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpWhYpRl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:54 INFO - PROCESS | 1663 | RSS: Main: 161325056 17:37:54 INFO - PROCESS | 1663 | 17:38:45 INFO - PROCESS | 1663 | 1468024725295 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] 17:40:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 17:40:56 INFO - PROCESS | 1663 | RSS: Main: 292823040 17:40:56 INFO - PROCESS | 1663 | 17:43:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 17:44:00 INFO - PROCESS | 1663 | RSS: Main: 307912704 17:44:00 INFO - PROCESS | 1663 | 17:47:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 17:47:02 INFO - PROCESS | 1663 | RSS: Main: 311926784 17:47:02 INFO - PROCESS | 1663 | 17:50:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 17:50:05 INFO - PROCESS | 1663 | RSS: Main: 306622464 17:50:05 INFO - PROCESS | 1663 | 17:53:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 17:53:09 INFO - PROCESS | 1663 | RSS: Main: 269537280 17:53:09 INFO - PROCESS | 1663 | 17:56:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 17:56:11 INFO - PROCESS | 1663 | RSS: Main: 315756544 17:56:11 INFO - PROCESS | 1663 | 17:56:11 INFO - PROCESS | 1663 | __start_tp_report 17:56:11 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 17:56:11 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 17:56:11 INFO - PROCESS | 1663 | |i|pagename|runs| 17:56:11 INFO - PROCESS | 1663 | |0;dojo.html;3517.665821746934;3632.2735452909424;3632.5096112024876;3643.3441980443527;3711.164987877728;5924.437178468044;5942.584019118653;5951.970584855801;5966.373530779265;6007.7596896124105;5319.468053194679;5618.932402843457;5928.407159284069;6015.398460153993;6032.336442991267;4303.763293018883;5317.813876514323;5334.066538355792;5420.457954204568;5466.262054622634;5399.406065332811;5439.075357189287;5446.809361672343;5451.972740136293;5462.016836969364;5358.732063396834;5421.891562168754;5429.728513574325;5443.401225865152;5468.890622187554;5458.4814442627885;5467.20725494805;5488.725563721798;5502.119660854244;5545.195946587763;5223.843284701465;5291.735413229323;5367.624266301361;5406.351237851443;5422.75597598109;5786.508146807527;5791.131330300446;5792.739326730307;5812;5863.648181109104;6229.127922090911;6275.058741188813;6280.560360774748;6282.089097080898;6301.40136687014;6221.906671399933;6338.429541341301;6342.619442833445;6343.682815859234;6344.49244060474;6100.938990610081;6109.419605137549;6123.693815309217;6124.6325220486915;6129.111278864584;6410.038494225903;6425.100485931974;6437.678116094176;6448.903266450913;6455.774047908395;6110;6226.906596401058;6282.465990390868;6296.275928268308;6336.081268216083;5991.281046274475;6282.057691346335;6286.277078136073;6307.211598550181;6327.050942358683;5449.631963211258;6199.597026193283;6254.061890716429;6269.247690277105;6273.466755325757;6219.440250377397;6228.968855155696;6271.310155882849;6275.466585340206;6307.274663413767;5041.344625198701;5072;5076.695398276115;5081.0854046272025;5102.846914592568;4581.518940511265;4593.977030114828;4595.241785105421;4628.976855115703;4631.397918270671;6019.969900150471;6048.222313036346;6096.267865410208;6132.601380910227;6144.969275153685;6307.400796924285;6311.242650881832;6311.936880631227;6321.778737744157;6329.2721337045905;6029.638221706711;6086.056661217518;6110.7861224856915;6125.601835880653;6128.571000030044;5556.249906262603;5560.833175004756;5567.8886422272135;5573.749181286852;5574.60977731563;6441.806745797634;6550.410463058348;6551.1155993941165;6553.115329430466;6557.245916719638;6296.33888441707;6364.77723279683;6371.713272902638;6377.96811015942;6394.4564712;6559.409653131241;6560.573562718408;6576.408123268738;6580.407763301135;6584.308647592125;6167.722452489559;6210.037444196157;6256.812295631138;6264.185655864891;6272.937270627235;6299.748010079728;6378.936210637834;6386.489080873426;6387.808365749035;6402;6183.041628547582;6196.039613859859;6209.689515524115;6212.161358216583;6213.844653883689;6103.176071230327;6131.774283661862;6160.7535698571555;6178.104174894705;6178.443940045418;5951.672658003851;6129.08063790435;6135.84660383494;6175.96912015437;6208.2239720034995;6202.131701561695;6268;6271.090691849748;6272.278687950944;6277.2781130170615;6100.420460056288;6143.542582966849;6184.536159787944;6196.721147548281;6267.9971204607045 17:56:11 INFO - PROCESS | 1663 | |1;ext.html;511.3837825420368;541.1747085694316;602.5661523702934;604.8125081224823;606.4723690389359;25876.611850822253;32913.341733165355;39644.99999999996;40573.75409967203;40575.797121014424;43432.782836085855;43910.90222744433;43931;43949.340759888626;43991.56008439915;9620.855687164682;9830.803383932318;9834.852477212811;9837.508124593778;9845.81850177976;9197.172254497094;11945.387372704705;12233.571824986127;12242.81635775464;12264.693382665415;11865.169438139334;11971.461284242187;11972.580959666413;11984.460699268553;11984.640460786146;11877.16859819813;12027.338496382696;12069.336186509738;12069.698257543632;12141.757164856741;11816.527338906433;11885.405729713566;11898.702532436671;11917.404129793562;11955.40222988847;41841;42133.94665133365;42135.367969480176;42145;42247;3413.6586341365664;3425.246445781924;3546.202104526487;3557.3774589447003;4015.819288132041;28937.855310723524;29342.41315173706;29607.407851843058;29891.25271868199;30481;2712.823666461674;2731.6721993360725;2790.260580946051;2847.985760071186;2902.1438675590753;422930;426895.9999999969;428010.99999999686;428227;429848;32419.837900810344;37399.4390084149;37907.62092379041;38012.80993595014;66618.00072998909;36442.63557364445;36682.51516105966;36805.815970919975;36824;36882.524699012276;16164.515064548083;16303.836961630232;16317;16347.91826040886;16350.672986540203;12307.876921230853;12467.75064498723;13582.252976086213;13617.455301788015;14338.713225735635;8452.450590711584;8477.660893564189;8511.53186574732;8562.058173600899;8575.228229459379;3572.1962558424666;3609.133807886141;3613.674769270726;3624.3838547447;3639.1448009717697;991.6231831903974;1021.596469394585;1050.5167622893402;1118.8545489086366;1119.3843386137755;30107.69892301093;30830.84584577063;30898.227544311572;31431.057068287988;31584.210394740316;1143.8112711402525;1243.2291978972914;1258.9055820813476;1288.2656885575132;1316.73665266947;15544.300506477235;15649.139297338528;15686.76469852953;15781.605459863595;16006.279717412745;630495;637188;639449;640429;642165;62781.68609157016;64186.679066605306;64378.356216437234;64439.355606444275;64499.35500645027;1457.1330058615108;1474.808274924253;1479.8816094712613;1592.0527286264653;1617.9676406471804;23830;30574.235644109074;30759.462026899015;30843.69156308408;31491.84254078715;58947;59382.70308648429;59763;59802.40197597969;59831.401685984325;563001;565604;566137;566678;567489;24050.63924041106;24780.628290575296;25019.374515637253;28132.85933570319;28604.141875742927;37366.813165934;43156.13687726291;44358.778206108764;45817.77091114523;45903.54096458993;36763.26473470569;38730.6126938727;38767;39043.609563904;39525;37852.674708860046;37891.81054094712;38075.048123797125;38706.0323491915;38853.611463885;36640.81679591585;37504.59919849587;37749;38107.42838857364;38332;31960.84019579887;33547.664523354455;33606.831965840014;33637;33727;24942.37644058913;25319;25578.94368695334;25865.612015819403;25951.22146335613 17:56:11 INFO - PROCESS | 1663 | |2;jquery.html;408.8282921173107;411.2330503610763;413.6174039013913;415.16344565700115;419.99160016799664;12876.742465150692;16520.58698532537;19595.118219680113;21264.4683882903;21319.82740949247;21525.138994440244;21701.565968680618;21763.782362176375;22492.8875355623;22504;5799.2750906136835;5911.083782013773;6112.724927378256;6132.110843927628;6148.96925515374;4470.530594287602;5114.565261952738;6031.517478601723;6101;6429.292777794439;6672.099266598995;6677.899831502531;6686.0305255737885;6692.23039350476;6702.865942681144;5905.527557795366;6382.744690212386;6434.616557440149;6627.4366678831875;6650.767223147191;5831.271091113611;5838.678872662002;5848.502877255439;5859.033259512175;5860.06239001762;26985.46029079427;27329.590056149173;27801.165965021082;27980.160595181973;28058;2283.246528645543;2554.5529532331766;2662.174725834978;2955.143008527524;2970.910872673823;15654;15749.448769293134;15806.36774529029;15888.443904463404;16008.279627416794;1577.2508058672154;1810.1039985207406;1890.9243630254773;1902.1440351841588;1914.5405102775374;111755.44122279336;119165;119337;121468.78531214752;121705;9824.361416507903;10537.736556585993;10838;11592.246503977383;11772.941135294268;13289.3355332233;13852.099613525088;15073.020253683695;15078.54764357071;15082.698346033018;8922.55387230649;9096.727098187064;9237.307201959746;9262.444253344685;9382.718518444457;8002.1997800219515;9398.201152901944;9420.717378478657;9436.575354109082;9524;6059.6364218147055;7016.859662806715;7115.75094871677;7134.964325178341;7141.000259963609;1946.7371904792956;1961.686130219158;1966.1152481383435;1982.1377700699952;2002.6595478768354;916.4730280088976;925.6204955968021;974.468914441631;993.8558908958161;1024.4314405504867;21120.683189752166;22221.11115555392;22424.43938901508;22600.773992260194;22635.094596215968;993.5429702336861;996.8704068471197;1082.9783404332027;1122.2761318949233;1128.9717757055976;11420.543178272776;11867.762644747057;11915.642530724092;11923.463444145034;11990.700232494082;578585;610056;628239;639737;664935.6753216203;89621;119187;119709;120066;123046.38476807559;1064.223117124488;1080.4057768227444;1087.9564817407215;1088.8693356797078;1096.0519150934385;18827.435176944713;19487.707684384462;19602.215911363386;19810.910399928143;19907.800921991173;30077.11697322102;36453.45319820258;47102.82242943954;48540;49734.75132624314;66915.66542167257;69148;69306;69916.6504167476;73190.90213646693;8296.958515207385;8346;8584.570771461527;8597.484150950962;8820.86768698483;9712.417254964725;10862.782744345226;13171;13586.592402227949;13614.52349167814;11258.66224013281;11591.826122608;11758.647240582795;11821.586244481401;11878.643640690792;11263.380514071805;11311.660650180507;11450;11745.647630571097;11760.176787624785;11445.484953177294;11771.411429428666;11912.702182445508;11920.344381059125;12022.458989345676;8341.95829020851;8407.495550267004;8473.66105355779;8488.575571221538;8776.429532080394;9424.539196424565;11763.941180294043;11782.293062416282;11956;12049.638510844688 17:56:11 INFO - PROCESS | 1663 | |3;mootools.html;1418.8723014928655;1600.7918970533829;1606.7991501062368;1880.3230836898715;2006.7391239138901;8253.628586713598;8805.559722013897;8963.820723585524;8974.910250897488;9010;8737.694180703676;8995.370324077317;9002.86495702565;9020.729378118667;9051.728448146567;2511.9120830770926;2531.886065127074;2533.138732830837;2535.264773215765;2538.1624064058815;2461.9753802461923;2477.6283557466345;2481.7642323979194;2483.6522886795865;2490.887910044043;2417.903283868643;2450.2649205238445;2506.385935445809;2508.9623655645178;2509.2472258322523;2510.1089113364765;2537.124691981273;2537.822352435321;2550.6684131062843;2558.155808583163;2488.701355837293;2532.2150133458686;2540.8221424500293;2541.4789968056502;2542.9618555721677;8539.188777066169;9150.267978561698;9216.354855160074;9227.03116172799;9237.076292370777;5275.762590683428;5649.293838270216;5725.914111288334;5783.5084017858535;5806.477417032487;3429.382711111999;3597.80212088335;3694.9815250923575;3702.5186725725753;3741.307858046243;1045.2892033417272;1077.6928575355985;1080.8594882665204;1080.9838751573575;1081.8972197641212;12232.755344893052;12304.692382690415;12477.688057798629;12478.625641230687;12486;4676.321933319649;4725.07860967115;4840;4865.172920603506;4868.756562171877;9604.231661467065;9630.374025688308;9638.90361096394;9644.228461723045;9674.951625241969;5535.612507124462;5551.306086739158;5594.524465420485;5595.972020139955;5597.328320601554;4685.086408150446;4724.740139292303;4783.7129772213775;4797.232442809203;5213.087709650796;3382.661733826647;3798.430235464647;3928.508936382952;4024.195160967818;4032.3951407288555;1220.871808460099;1221.1818081885158;1229.4528934624186;1235.6231349438508;1244.0296568676447;880.903100658927;925.3476299209042;939.4457270210609;950.9239260859254;979.8775153105862;5984.880302393928;6090.116933044772;6106.931287024753;6166.630002199882;6215.720292586844;953.8664586957832;964.0648570886369;977.2768151567789;990.6087095597198;1006.5520843224841;3922.941155882664;4011.3180759270995;4033.072393349546;4046.676265898721;4093.5906409359422;10946.835797463045;11536.307821530734;11552.76894462106;11579.189456738117;11592.594259200887;11236.66290011301;11367.602133925273;11401.600943966921;11402.201845870875;11525.538978440936;6781.287964763727;8796.120387961153;8798;8818.779530511789;8863.468191908507;5633.2113504110275;5916.556258280732;6009.90985135232;6045.244344456943;6097.359777223328;9942.353747006422;10046.24653151002;10182.643607473703;10270.948645257025;10300.381977081399;9924.255680824112;10539.998700123477;10542.051215390651;10552.894471055191;10592.046715795615;6627.536072474881;7124.358807707331;7251.20236773965;7270.527415717961;7371.115466144097;7968.800779980547;8387.412881098264;8529.275011624082;8543.145685431407;8548.145185481402;7507.549547027196;7599.65801538921;7616.162222155448;7758.185390533913;7782.105057918412;7442.479026468095;7494.475386722877;7537.773866784005;7538.057742782153;7601.277878601524;7139.964300178466;7201.855962880818;7231.855362892607;7237.927620723725;7316.487845850739;4963.029576338842;4967.05625931072;5091.719955402488;5166.328377310925;5207.531322181022;5054.140796064605;5070.41690205631;5107.233914912793;5216.530512253916;5341.97329013368 17:56:11 INFO - PROCESS | 1663 | |4;prototype.html;294.1704393610021;323.7054280604649;324.8716756881032;335.83544063408937;339.7095483361727;5249.186376111704;6673.165854268216;6752.76365327213;6876.965615171917;6885;6608.372204640564;6611.041398997142;6625.436837868775;6633.038209459625;6643.667816609162;3951.5060617422823;4707.364505791717;4782.784774685148;4863.513648635144;4877.756112194394;3913.5890731473214;4874.390701162355;4894.143524883131;4898.730569818658;4926.45808961014;4779.259214821708;4846.297286893398;4872.123017856784;4902.681325713835;4940;4673.6027437667835;4730.526947305277;4864.927026094611;4913.656044076916;4925.605951523888;3620.7646502977223;4036.910034290725;4150.8547200847825;4154.480689913761;4163.500379954395;6289.654069026202;6365.681715914186;6379.234491861006;6391.680415979229;6398.328175541595;5772.134179873053;5777.768889244425;5782.768689252425;5786.710664466802;5793.8551536211935;5677.432256774331;6260.841744277323;6522.119513865615;7062.611556364398;7107.928920710779;4350.869473915787;4541.205289074399;4560.452745670507;4714.104320179155;4724.4094488188975;7269.563826170447;7352.4485663574915;7408.073990751156;7426.257374262585;7464.701411943516;4645.512221216791;4650.255959046536;4652.720836749806;4661.3707149534375;4662.254039353687;3905.3165696003084;4679.485256621769;4724.267738500538;4740.3837501124635;4743.739094349844;5613.607047506635;5620.044592419298;5620.662760234399;5632.718364081779;5645.887082258332;6748.763793267311;7021.929780702128;7097.89353159703;7114.359707626339;7126.893096603555;1619.3927277271023;1624.4558073045425;1642.53187841467;1644.284736139783;1648.5796121988817;973.0950216298769;1014.4065721552827;1019.2253887045898;1039.729670285716;1041.2034793383068;6502.544821862424;6542.934570654328;6636.270010298863;6722.9663851680425;6729.629870357177;7397.667104980289;7398.704051837974;7405.925940740523;7415.221401752846;7424.814379640552;6695.263521012685;6706.83232919181;6711.288621401609;6712.932870671329;6716.194056713128;3869.2261547690573;3910.159315747128;3918.6277303656107;3921.0785465415606;3928.5678575356687;5910.645361278337;6507.056476810836;7639.770806875803;7646.847063058708;7728.033995750531;7469.9253007470315;7621.618919054025;7634.656440460192;7643.694252229849;7666.195049519832;7706.961465192639;7707.653155608011;7733.961330193313;7741.496802707806;7747.651355689008;7090.6100164491445;7370.373518250794;7380.335769780745;7385.409167266498;7386.372158366384;7214.458915581247;7228.421726261991;7233.782986510413;7296.306850849161;7304.96347518259;7751.263629955145;7763.340116089969;7767.572783496962;7772.261635144652;7773.766786996399;4818.71087734737;4898.628384052471;4901.652045687322;4909.926351104665;4920.630952678635;7063.470239731938;7335.559866408033;7344.265573442613;7354.852902942018;7354.963225184054;7051.259617740064;7068.540544864567;7078.8938165928585;7079.610621415872;7083.716651333889;7053.4004609608755;7065.682044307916;7081.68132434052;7089.468289878177;7090.539114957512;6933.202681691469;6951.131108611424;6953.269906659728;6959.686814093277;6969;6848.8972665409065;7086.653535828176;7106.502544821813;7110.146782386147;7110.4667149962925;5289.6032797539565;6797.490188236001;6879;6948.166220053626;6982.406495447944 17:56:11 INFO - PROCESS | 1663 | |5;yui.html;681.3356976947475;769.8375453065869;773.365840011191;774.1097737601757;782.8943092682487;15156.696866062686;15477.380904763824;15543.06741595505;15563.144027078506;15594;14180.929095354535;14268.286585670701;14271.215083170422;14279.71440571188;14303.998720089598;769.0387016229713;776.8407476467339;935.4901578639658;936.5317341329335;962.3504134709078;951.6574033347989;954.5227386306847;956.2732323434205;957.0094951724966;958.6213445688949;1011.3476807459184;1023.8771347438318;1028.4600584693057;1029.3926583315842;1029.6447725534679;816.2857499687773;1021.8620486234412;1022.018861892584;1022.4376592873926;1024.3290644627743;742.8662840688673;769.0694259945473;769.5113602862167;769.968242554979;770.7572114783825;15102.697946041128;15143.394264229528;15166.696666066617;15173.013754105948;15191.164485953268;12762.680932976657;12837.358132093357;12987.675308117277;13024.544140955117;13409.731805363837;8802.075782042857;10102.595896164217;10274.948625256826;10412.94793526035;10583.788324233472;3501.457274122515;3582.3551760683067;3584.605693373727;3625.89122326328;3682.0794801299676;82245.17754822435;82267.5886620569;82454.58772706157;82514;82698;8195.877061844078;9386.853029895856;9774.951125244328;9845.261605379625;10138.949305253427;22297.331080067623;22361.664575031387;22387.216447424587;22403;22434.32697019092;7523.3981281497345;7525.360344370681;7589.506682065648;7670.194629563815;7838.764837054783;4183.100633363842;4198.181354635878;4207.4951005878875;4267.615914567704;4283.528811830696;3117.922051948674;3176.0154352150907;3182.2521707399205;3185.681431856796;3190.5054716518976;604.5465900574569;662.595816551903;676.2662511175331;682.011083928306;693.9236683964759;605.5670195810017;607.8996965500643;612.1582823617526;620.3393386043849;624.9906995431619;7713.614319284014;8109.635066422025;8207.261346478846;8315.8336833263;8546.017208021032;537.7096367961335;577.9481343953963;591.5430156803453;595.592019466658;612.6416046612692;3751.2122454284904;3854.113553882623;3911.4328422379167;3917.981324855558;4020.216057868746;95309;95970.52014740021;96691;96858.51570742243;97697;58661.826763465346;76627.61686191533;76945.6152719244;77646;78944.21055789369;69223.96164057544;70164.6491767538;70514.23714407181;71512.99999999895;71978.56042879113;6175.919214137598;7953.965984421988;8395.328373729964;8409.747707568782;8431.32549396059;49826.750866245435;50397.496025040746;50500;51213.18327492024;51844.740776295876;69582.3041769596;69778;70020.29979700138;70045;70961.64519177371;11048.61892263467;11189.496472658588;11326.150538709466;11590.505988560764;11638.952494275556;11849.881501184878;12027.27836329823;12065.457054432396;12249.571265005681;12755.97952163806;11525.654230373102;11639.941800290944;11644.475998579916;11872.050235981273;11979.520819167135;11453.427328633701;11718;11783.293002419883;12059.698507537381;12232.266064036186;11146.737831594144;11384;11489.425528723697;11504.769904602028;12132.878671213528;9553.665621703207;9769.902300976899;9894.604215831287;9989.350692204984;10301;9357.92383875863;9775.85336219943;9777.022297770167;9845.901540984498;9914.256430767866 17:56:11 INFO - PROCESS | 1663 | __end_tp_report 17:56:11 INFO - PROCESS | 1663 | __start_cc_report 17:56:11 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1120 17:56:11 INFO - PROCESS | 1663 | __end_cc_report 17:56:11 INFO - PROCESS | 1663 | __startTimestamp1468025771975__endTimestamp 17:56:11 INFO - PROCESS | 1663 | 17:56:11 INFO - PROCESS | 1663 | ------- Summary: start ------- 17:56:11 INFO - PROCESS | 1663 | Number of tests: 6 17:56:11 INFO - PROCESS | 1663 | 17:56:11 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5901.75 Median:6135.85 stddev:620.83 (10.1%) stddev-sans-first:593.89 17:56:11 INFO - PROCESS | 1663 | Values: 3517.7 3632.3 3632.5 3643.3 3711.2 5924.4 5942.6 5952.0 5966.4 6007.8 5319.5 5618.9 5928.4 6015.4 6032.3 4303.8 5317.8 5334.1 5420.5 5466.3 5399.4 5439.1 5446.8 5452.0 5462.0 5358.7 5421.9 5429.7 5443.4 5468.9 5458.5 5467.2 5488.7 5502.1 5545.2 5223.8 5291.7 5367.6 5406.4 5422.8 5786.5 5791.1 5792.7 5812.0 5863.6 6229.1 6275.1 6280.6 6282.1 6301.4 6221.9 6338.4 6342.6 6343.7 6344.5 6100.9 6109.4 6123.7 6124.6 6129.1 6410.0 6425.1 6437.7 6448.9 6455.8 6110.0 6226.9 6282.5 6296.3 6336.1 5991.3 6282.1 6286.3 6307.2 6327.1 5449.6 6199.6 6254.1 6269.2 6273.5 6219.4 6229.0 6271.3 6275.5 6307.3 5041.3 5072.0 5076.7 5081.1 5102.8 4581.5 4594.0 4595.2 4629.0 4631.4 6020.0 6048.2 6096.3 6132.6 6145.0 6307.4 6311.2 6311.9 6321.8 6329.3 6029.6 6086.1 6110.8 6125.6 6128.6 5556.2 5560.8 5567.9 5573.7 5574.6 6441.8 6550.4 6551.1 6553.1 6557.2 6296.3 6364.8 6371.7 6378.0 6394.5 6559.4 6560.6 6576.4 6580.4 6584.3 6167.7 6210.0 6256.8 6264.2 6272.9 6299.7 6378.9 6386.5 6387.8 6402.0 6183.0 6196.0 6209.7 6212.2 6213.8 6103.2 6131.8 6160.8 6178.1 6178.4 5951.7 6129.1 6135.8 6176.0 6208.2 6202.1 6268.0 6271.1 6272.3 6277.3 6100.4 6143.5 6184.5 6196.7 6268.0 17:56:11 INFO - PROCESS | 1663 | 17:56:11 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:67053.98 Median:3590.67 stddev:147282.97 (4101.8%) stddev-sans-first:147611.40 17:56:11 INFO - PROCESS | 1663 | Values: 511.4 541.2 602.6 604.8 606.5 25876.6 32913.3 39645.0 40573.8 40575.8 43432.8 43910.9 43931.0 43949.3 43991.6 9620.9 9830.8 9834.9 9837.5 9845.8 9197.2 11945.4 12233.6 12242.8 12264.7 11865.2 11971.5 11972.6 11984.5 11984.6 11877.2 12027.3 12069.3 12069.7 12141.8 11816.5 11885.4 11898.7 11917.4 11955.4 41841.0 42133.9 42135.4 42145.0 42247.0 3413.7 3425.2 3546.2 3557.4 4015.8 28937.9 29342.4 29607.4 29891.3 30481.0 2712.8 2731.7 2790.3 2848.0 2902.1 422930.0 426896.0 428011.0 428227.0 429848.0 32419.8 37399.4 37907.6 38012.8 66618.0 36442.6 36682.5 36805.8 36824.0 36882.5 16164.5 16303.8 16317.0 16347.9 16350.7 12307.9 12467.8 13582.3 13617.5 14338.7 8452.5 8477.7 8511.5 8562.1 8575.2 3572.2 3609.1 3613.7 3624.4 3639.1 991.6 1021.6 1050.5 1118.9 1119.4 30107.7 30830.8 30898.2 31431.1 31584.2 1143.8 1243.2 1258.9 1288.3 1316.7 15544.3 15649.1 15686.8 15781.6 16006.3 630495.0 637188.0 639449.0 640429.0 642165.0 62781.7 64186.7 64378.4 64439.4 64499.4 1457.1 1474.8 1479.9 1592.1 1618.0 23830.0 30574.2 30759.5 30843.7 31491.8 58947.0 59382.7 59763.0 59802.4 59831.4 563001.0 565604.0 566137.0 566678.0 567489.0 24050.6 24780.6 25019.4 28132.9 28604.1 37366.8 43156.1 44358.8 45817.8 45903.5 36763.3 38730.6 38767.0 39043.6 39525.0 37852.7 37891.8 38075.0 38706.0 38853.6 36640.8 37504.6 37749.0 38107.4 38332.0 31960.8 33547.7 33606.8 33637.0 33727.0 24942.4 25319.0 25578.9 25865.6 25951.2 17:56:11 INFO - PROCESS | 1663 | 17:56:11 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35375.50 Median:2418.90 stddev:103573.01 (4281.8%) stddev-sans-first:103830.28 17:56:11 INFO - PROCESS | 1663 | Values: 408.8 411.2 413.6 415.2 420.0 12876.7 16520.6 19595.1 21264.5 21319.8 21525.1 21701.6 21763.8 22492.9 22504.0 5799.3 5911.1 6112.7 6132.1 6149.0 4470.5 5114.6 6031.5 6101.0 6429.3 6672.1 6677.9 6686.0 6692.2 6702.9 5905.5 6382.7 6434.6 6627.4 6650.8 5831.3 5838.7 5848.5 5859.0 5860.1 26985.5 27329.6 27801.2 27980.2 28058.0 2283.2 2554.6 2662.2 2955.1 2970.9 15654.0 15749.4 15806.4 15888.4 16008.3 1577.3 1810.1 1890.9 1902.1 1914.5 111755.4 119165.0 119337.0 121468.8 121705.0 9824.4 10537.7 10838.0 11592.2 11772.9 13289.3 13852.1 15073.0 15078.5 15082.7 8922.6 9096.7 9237.3 9262.4 9382.7 8002.2 9398.2 9420.7 9436.6 9524.0 6059.6 7016.9 7115.8 7135.0 7141.0 1946.7 1961.7 1966.1 1982.1 2002.7 916.5 925.6 974.5 993.9 1024.4 21120.7 22221.1 22424.4 22600.8 22635.1 993.5 996.9 1083.0 1122.3 1129.0 11420.5 11867.8 11915.6 11923.5 11990.7 578585.0 610056.0 628239.0 639737.0 664935.7 89621.0 119187.0 119709.0 120066.0 123046.4 1064.2 1080.4 1088.0 1088.9 1096.1 18827.4 19487.7 19602.2 19810.9 19907.8 30077.1 36453.5 47102.8 48540.0 49734.8 66915.7 69148.0 69306.0 69916.7 73190.9 8297.0 8346.0 8584.6 8597.5 8820.9 9712.4 10862.8 13171.0 13586.6 13614.5 11258.7 11591.8 11758.6 11821.6 11878.6 11263.4 11311.7 11450.0 11745.6 11760.2 11445.5 11771.4 11912.7 11920.3 12022.5 8342.0 8407.5 8473.7 8488.6 8776.4 9424.5 11763.9 11782.3 11956.0 12049.6 17:56:11 INFO - PROCESS | 1663 | 17:56:11 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5881.36 Median:5062.28 stddev:3309.23 (65.4%) stddev-sans-first:3301.52 17:56:11 INFO - PROCESS | 1663 | Values: 1418.9 1600.8 1606.8 1880.3 2006.7 8253.6 8805.6 8963.8 8974.9 9010.0 8737.7 8995.4 9002.9 9020.7 9051.7 2511.9 2531.9 2533.1 2535.3 2538.2 2462.0 2477.6 2481.8 2483.7 2490.9 2417.9 2450.3 2506.4 2509.0 2509.2 2510.1 2537.1 2537.8 2550.7 2558.2 2488.7 2532.2 2540.8 2541.5 2543.0 8539.2 9150.3 9216.4 9227.0 9237.1 5275.8 5649.3 5725.9 5783.5 5806.5 3429.4 3597.8 3695.0 3702.5 3741.3 1045.3 1077.7 1080.9 1081.0 1081.9 12232.8 12304.7 12477.7 12478.6 12486.0 4676.3 4725.1 4840.0 4865.2 4868.8 9604.2 9630.4 9638.9 9644.2 9675.0 5535.6 5551.3 5594.5 5596.0 5597.3 4685.1 4724.7 4783.7 4797.2 5213.1 3382.7 3798.4 3928.5 4024.2 4032.4 1220.9 1221.2 1229.5 1235.6 1244.0 880.9 925.3 939.4 950.9 979.9 5984.9 6090.1 6106.9 6166.6 6215.7 953.9 964.1 977.3 990.6 1006.6 3922.9 4011.3 4033.1 4046.7 4093.6 10946.8 11536.3 11552.8 11579.2 11592.6 11236.7 11367.6 11401.6 11402.2 11525.5 6781.3 8796.1 8798.0 8818.8 8863.5 5633.2 5916.6 6009.9 6045.2 6097.4 9942.4 10046.2 10182.6 10270.9 10300.4 9924.3 10540.0 10542.1 10552.9 10592.0 6627.5 7124.4 7251.2 7270.5 7371.1 7968.8 8387.4 8529.3 8543.1 8548.1 7507.5 7599.7 7616.2 7758.2 7782.1 7442.5 7494.5 7537.8 7538.1 7601.3 7140.0 7201.9 7231.9 7237.9 7316.5 4963.0 4967.1 5091.7 5166.3 5207.5 5054.1 5070.4 5107.2 5216.5 5342.0 17:56:11 INFO - PROCESS | 1663 | 17:56:11 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5777.01 Median:6629.24 stddev:1866.28 (28.2%) stddev-sans-first:1825.58 17:56:11 INFO - PROCESS | 1663 | Values: 294.2 323.7 324.9 335.8 339.7 5249.2 6673.2 6752.8 6877.0 6885.0 6608.4 6611.0 6625.4 6633.0 6643.7 3951.5 4707.4 4782.8 4863.5 4877.8 3913.6 4874.4 4894.1 4898.7 4926.5 4779.3 4846.3 4872.1 4902.7 4940.0 4673.6 4730.5 4864.9 4913.7 4925.6 3620.8 4036.9 4150.9 4154.5 4163.5 6289.7 6365.7 6379.2 6391.7 6398.3 5772.1 5777.8 5782.8 5786.7 5793.9 5677.4 6260.8 6522.1 7062.6 7107.9 4350.9 4541.2 4560.5 4714.1 4724.4 7269.6 7352.4 7408.1 7426.3 7464.7 4645.5 4650.3 4652.7 4661.4 4662.3 3905.3 4679.5 4724.3 4740.4 4743.7 5613.6 5620.0 5620.7 5632.7 5645.9 6748.8 7021.9 7097.9 7114.4 7126.9 1619.4 1624.5 1642.5 1644.3 1648.6 973.1 1014.4 1019.2 1039.7 1041.2 6502.5 6542.9 6636.3 6723.0 6729.6 7397.7 7398.7 7405.9 7415.2 7424.8 6695.3 6706.8 6711.3 6712.9 6716.2 3869.2 3910.2 3918.6 3921.1 3928.6 5910.6 6507.1 7639.8 7646.8 7728.0 7469.9 7621.6 7634.7 7643.7 7666.2 7707.0 7707.7 7734.0 7741.5 7747.7 7090.6 7370.4 7380.3 7385.4 7386.4 7214.5 7228.4 7233.8 7296.3 7305.0 7751.3 7763.3 7767.6 7772.3 7773.8 4818.7 4898.6 4901.7 4909.9 4920.6 7063.5 7335.6 7344.3 7354.9 7355.0 7051.3 7068.5 7078.9 7079.6 7083.7 7053.4 7065.7 7081.7 7089.5 7090.5 6933.2 6951.1 6953.3 6959.7 6969.0 6848.9 7086.7 7106.5 7110.1 7110.5 5289.6 6797.5 6879.0 6948.2 6982.4 17:56:11 INFO - PROCESS | 1663 | 17:56:11 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18557.49 Median:557.83 stddev:26085.58 (4676.3%) stddev-sans-first:26124.22 17:56:11 INFO - PROCESS | 1663 | Values: 681.3 769.8 773.4 774.1 782.9 15156.7 15477.4 15543.1 15563.1 15594.0 14180.9 14268.3 14271.2 14279.7 14304.0 769.0 776.8 935.5 936.5 962.4 951.7 954.5 956.3 957.0 958.6 1011.3 1023.9 1028.5 1029.4 1029.6 816.3 1021.9 1022.0 1022.4 1024.3 742.9 769.1 769.5 770.0 770.8 15102.7 15143.4 15166.7 15173.0 15191.2 12762.7 12837.4 12987.7 13024.5 13409.7 8802.1 10102.6 10274.9 10412.9 10583.8 3501.5 3582.4 3584.6 3625.9 3682.1 82245.2 82267.6 82454.6 82514.0 82698.0 8195.9 9386.9 9775.0 9845.3 10138.9 22297.3 22361.7 22387.2 22403.0 22434.3 7523.4 7525.4 7589.5 7670.2 7838.8 4183.1 4198.2 4207.5 4267.6 4283.5 3117.9 3176.0 3182.3 3185.7 3190.5 604.5 662.6 676.3 682.0 693.9 605.6 607.9 612.2 620.3 625.0 7713.6 8109.6 8207.3 8315.8 8546.0 537.7 577.9 591.5 595.6 612.6 3751.2 3854.1 3911.4 3918.0 4020.2 95309.0 95970.5 96691.0 96858.5 97697.0 58661.8 76627.6 76945.6 77646.0 78944.2 69224.0 70164.6 70514.2 71513.0 71978.6 6175.9 7954.0 8395.3 8409.7 8431.3 49826.8 50397.5 50500.0 51213.2 51844.7 69582.3 69778.0 70020.3 70045.0 70961.6 11048.6 11189.5 11326.2 11590.5 11639.0 11849.9 12027.3 12065.5 12249.6 12756.0 11525.7 11639.9 11644.5 11872.1 11979.5 11453.4 11718.0 11783.3 12059.7 12232.3 11146.7 11384.0 11489.4 11504.8 12132.9 9553.7 9769.9 9894.6 9989.4 10301.0 9357.9 9775.9 9777.0 9845.9 9914.3 17:56:11 INFO - PROCESS | 1663 | -------- Summary: end -------- 17:56:11 INFO - PROCESS | 1663 | 17:56:12 INFO - TEST-INFO | 1663: exit 0 17:56:12 INFO - TEST-OK | dromaeo_css | took 1113502ms 17:56:12 INFO - TEST-START | kraken 17:56:12 INFO - operating with platform_type : mac_ 17:56:12 INFO - Initialising browser for kraken test... 17:56:12 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpyHi3tD/profile http://localhost:49277/getInfo.html) 17:56:14 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 17:56:14 INFO - PROCESS | 1669 | colorDepth:24 17:56:14 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 17:56:14 INFO - PROCESS | 1669 | __metrics 17:56:14 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:56:14 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:56:15 INFO - TEST-INFO | 1669: exit 0 17:56:15 INFO - Browser initialized. 17:56:15 INFO - Running cycle 1/1 for kraken test... 17:56:15 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpyHi3tD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:27 INFO - PROCESS | 1672 | RSS: Main: 161497088 17:56:27 INFO - PROCESS | 1672 | 17:56:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 17:56:30 INFO - PROCESS | 1672 | RSS: Main: 224452608 17:56:30 INFO - PROCESS | 1672 | 17:56:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 17:56:34 INFO - PROCESS | 1672 | RSS: Main: 239882240 17:56:34 INFO - PROCESS | 1672 | 17:56:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 17:56:37 INFO - PROCESS | 1672 | RSS: Main: 325623808 17:56:37 INFO - PROCESS | 1672 | 17:56:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 17:56:40 INFO - PROCESS | 1672 | RSS: Main: 230526976 17:56:40 INFO - PROCESS | 1672 | 17:56:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:56:43 INFO - PROCESS | 1672 | RSS: Main: 232185856 17:56:43 INFO - PROCESS | 1672 | 17:56:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 17:56:46 INFO - PROCESS | 1672 | RSS: Main: 270336000 17:56:46 INFO - PROCESS | 1672 | 17:56:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 17:56:50 INFO - PROCESS | 1672 | RSS: Main: 269963264 17:56:50 INFO - PROCESS | 1672 | 17:56:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 17:56:53 INFO - PROCESS | 1672 | RSS: Main: 271073280 17:56:53 INFO - PROCESS | 1672 | 17:56:54 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:56:55 INFO - PROCESS | 1672 | RSS: Main: 261165056 17:56:55 INFO - PROCESS | 1672 | 17:56:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:56:58 INFO - PROCESS | 1672 | RSS: Main: 268558336 17:56:58 INFO - PROCESS | 1672 | 17:57:00 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:57:00 INFO - PROCESS | 1672 | RSS: Main: 271552512 17:57:00 INFO - PROCESS | 1672 | 17:57:03 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:57:04 INFO - PROCESS | 1672 | RSS: Main: 278589440 17:57:04 INFO - PROCESS | 1672 | 17:57:06 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:57:07 INFO - PROCESS | 1672 | RSS: Main: 275906560 17:57:07 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 17:57:09 INFO - PROCESS | 1672 | RSS: Main: 336932864 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | __start_tp_report 17:57:09 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 17:57:09 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 17:57:09 INFO - PROCESS | 1672 | |i|pagename|runs| 17:57:09 INFO - PROCESS | 1672 | |0;ai-astar;112;113;121;112;112;111;114;113;113;134 17:57:09 INFO - PROCESS | 1672 | |1;audio-beat-detection;157;112;140;163;119;139;137;115;164;114 17:57:09 INFO - PROCESS | 1672 | |2;audio-dft;185;188;183;183;183;186;183;184;181;184 17:57:09 INFO - PROCESS | 1672 | |3;audio-fft;71;76;75;157;56;57;55;61;130;55 17:57:09 INFO - PROCESS | 1672 | |4;audio-oscillator;92;90;145;79;79;80;121;77;79;128 17:57:09 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;88;85;94;91;94;89;89;86;93;85 17:57:09 INFO - PROCESS | 1672 | |6;imaging-darkroom;93;92;93;93;92;103;148;94;93;93 17:57:09 INFO - PROCESS | 1672 | |7;imaging-desaturate;84;85;83;83;86;86;85;82;85;84 17:57:09 INFO - PROCESS | 1672 | |8;json-parse-financial;59;62;63;61;62;63;63;78;58;56 17:57:09 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;62;64;63;69;70;71;72;67;66;66 17:57:09 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;78;79;80;79;79;78;80;80;79;84 17:57:09 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;140;143;136;134;125;125;124;130;158;161 17:57:09 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;167;165;164;163;165;164;164;162;162;167 17:57:09 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;66;67;66;67;67;66;66;67;65;66 17:57:09 INFO - PROCESS | 1672 | __end_tp_report 17:57:09 INFO - PROCESS | 1672 | __start_cc_report 17:57:09 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1879 17:57:09 INFO - PROCESS | 1672 | __end_cc_report 17:57:09 INFO - PROCESS | 1672 | __startTimestamp1468025829505__endTimestamp 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | ------- Summary: start ------- 17:57:09 INFO - PROCESS | 1672 | Number of tests: 14 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:115.50 Median:113.00 stddev:7.07 (6.3%) stddev-sans-first:7.39 17:57:09 INFO - PROCESS | 1672 | Values: 112.0 113.0 121.0 112.0 112.0 111.0 114.0 113.0 113.0 134.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:139.50 stddev:20.47 (14.7%) stddev-sans-first:20.25 17:57:09 INFO - PROCESS | 1672 | Values: 157.0 112.0 140.0 163.0 119.0 139.0 137.0 115.0 164.0 114.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:1.94 (1.1%) stddev-sans-first:2.03 17:57:09 INFO - PROCESS | 1672 | Values: 185.0 188.0 183.0 183.0 183.0 186.0 183.0 184.0 181.0 184.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:79.30 Median:59.00 stddev:35.37 (60.0%) stddev-sans-first:37.39 17:57:09 INFO - PROCESS | 1672 | Values: 71.0 76.0 75.0 157.0 56.0 57.0 55.0 61.0 130.0 55.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:79.00 stddev:24.89 (31.5%) stddev-sans-first:26.33 17:57:09 INFO - PROCESS | 1672 | Values: 92.0 90.0 145.0 79.0 79.0 80.0 121.0 77.0 79.0 128.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:90.00 stddev:3.50 (3.9%) stddev-sans-first:3.68 17:57:09 INFO - PROCESS | 1672 | Values: 88.0 85.0 94.0 91.0 94.0 89.0 89.0 86.0 93.0 85.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:93.00 stddev:17.38 (18.7%) stddev-sans-first:18.28 17:57:09 INFO - PROCESS | 1672 | Values: 93.0 92.0 93.0 93.0 92.0 103.0 148.0 94.0 93.0 93.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:85.00 stddev:1.34 (1.6%) stddev-sans-first:1.41 17:57:09 INFO - PROCESS | 1672 | Values: 84.0 85.0 83.0 83.0 86.0 86.0 85.0 82.0 85.0 84.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.50 stddev:5.95 (9.5%) stddev-sans-first:6.17 17:57:09 INFO - PROCESS | 1672 | Values: 59.0 62.0 63.0 61.0 62.0 63.0 63.0 78.0 58.0 56.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:68.00 stddev:3.43 (5.0%) stddev-sans-first:3.13 17:57:09 INFO - PROCESS | 1672 | Values: 62.0 64.0 63.0 69.0 70.0 71.0 72.0 67.0 66.0 66.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:1.71 (2.2%) stddev-sans-first:1.72 17:57:09 INFO - PROCESS | 1672 | Values: 78.0 79.0 80.0 79.0 79.0 78.0 80.0 80.0 79.0 84.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:138.00 stddev:13.23 (9.6%) stddev-sans-first:14.00 17:57:09 INFO - PROCESS | 1672 | Values: 140.0 143.0 136.0 134.0 125.0 125.0 124.0 130.0 158.0 161.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.50 stddev:1.77 (1.1%) stddev-sans-first:1.58 17:57:09 INFO - PROCESS | 1672 | Values: 167.0 165.0 164.0 163.0 165.0 164.0 164.0 162.0 162.0 167.0 17:57:09 INFO - PROCESS | 1672 | 17:57:09 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 17:57:09 INFO - PROCESS | 1672 | Values: 66.0 67.0 66.0 67.0 67.0 66.0 66.0 67.0 65.0 66.0 17:57:09 INFO - PROCESS | 1672 | -------- Summary: end -------- 17:57:09 INFO - PROCESS | 1672 | 17:57:10 INFO - TEST-INFO | 1672: exit 0 17:57:10 INFO - TEST-OK | kraken | took 57783ms 17:57:10 INFO - SUITE-END | took 1171s 17:57:10 INFO - Completed test suite (00:19:31) 17:57:10 INFO - javascript benchmark 17:57:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3517.665821746934, 3632.2735452909424, 3632.5096112024876, 3643.3441980443527, 3711.164987877728, 5924.437178468044, 5942.584019118653, 5951.970584855801, 5966.373530779265, 6007.7596896124105, 5319.468053194679, 5618.932402843457, 5928.407159284069, 6015.398460153993, 6032.336442991267, 4303.763293018883, 5317.813876514323, 5334.066538355792, 5420.457954204568, 5466.262054622634, 5399.406065332811, 5439.075357189287, 5446.809361672343, 5451.972740136293, 5462.016836969364, 5358.732063396834, 5421.891562168754, 5429.728513574325, 5443.401225865152, 5468.890622187554, 5458.4814442627885, 5467.20725494805, 5488.725563721798, 5502.119660854244, 5545.195946587763, 5223.843284701465, 5291.735413229323, 5367.624266301361, 5406.351237851443, 5422.75597598109, 5786.508146807527, 5791.131330300446, 5792.739326730307, 5812.0, 5863.648181109104, 6229.127922090911, 6275.058741188813, 6280.560360774748, 6282.089097080898, 6301.40136687014, 6221.906671399933, 6338.429541341301, 6342.619442833445, 6343.682815859234, 6344.49244060474, 6100.938990610081, 6109.419605137549, 6123.693815309217, 6124.6325220486915, 6129.111278864584, 6410.038494225903, 6425.100485931974, 6437.678116094176, 6448.903266450913, 6455.774047908395, 6110.0, 6226.906596401058, 6282.465990390868, 6296.275928268308, 6336.081268216083, 5991.281046274475, 6282.057691346335, 6286.277078136073, 6307.211598550181, 6327.050942358683, 5449.631963211258, 6199.597026193283, 6254.061890716429, 6269.247690277105, 6273.466755325757, 6219.440250377397, 6228.968855155696, 6271.310155882849, 6275.466585340206, 6307.274663413767, 5041.344625198701, 5072.0, 5076.695398276115, 5081.0854046272025, 5102.846914592568, 4581.518940511265, 4593.977030114828, 4595.241785105421, 4628.976855115703, 4631.397918270671, 6019.969900150471, 6048.222313036346, 6096.267865410208, 6132.601380910227, 6144.969275153685, 6307.400796924285, 6311.242650881832, 6311.936880631227, 6321.778737744157, 6329.2721337045905, 6029.638221706711, 6086.056661217518, 6110.7861224856915, 6125.601835880653, 6128.571000030044, 5556.249906262603, 5560.833175004756, 5567.8886422272135, 5573.749181286852, 5574.60977731563, 6441.806745797634, 6550.410463058348, 6551.1155993941165, 6553.115329430466, 6557.245916719638, 6296.33888441707, 6364.77723279683, 6371.713272902638, 6377.96811015942, 6394.4564712, 6559.409653131241, 6560.573562718408, 6576.408123268738, 6580.407763301135, 6584.308647592125, 6167.722452489559, 6210.037444196157, 6256.812295631138, 6264.185655864891, 6272.937270627235, 6299.748010079728, 6378.936210637834, 6386.489080873426, 6387.808365749035, 6402.0, 6183.041628547582, 6196.039613859859, 6209.689515524115, 6212.161358216583, 6213.844653883689, 6103.176071230327, 6131.774283661862, 6160.7535698571555, 6178.104174894705, 6178.443940045418, 5951.672658003851, 6129.08063790435, 6135.84660383494, 6175.96912015437, 6208.2239720034995, 6202.131701561695, 6268.0, 6271.090691849748, 6272.278687950944, 6277.2781130170615, 6100.420460056288, 6143.542582966849, 6184.536159787944, 6196.721147548281, 6267.9971204607045], "value": 5864.8470625157515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.3837825420368, 541.1747085694316, 602.5661523702934, 604.8125081224823, 606.4723690389359, 25876.611850822253, 32913.341733165355, 39644.99999999996, 40573.75409967203, 40575.797121014424, 43432.782836085855, 43910.90222744433, 43931.0, 43949.340759888626, 43991.56008439915, 9620.855687164682, 9830.803383932318, 9834.852477212811, 9837.508124593778, 9845.81850177976, 9197.172254497094, 11945.387372704705, 12233.571824986127, 12242.81635775464, 12264.693382665415, 11865.169438139334, 11971.461284242187, 11972.580959666413, 11984.460699268553, 11984.640460786146, 11877.16859819813, 12027.338496382696, 12069.336186509738, 12069.698257543632, 12141.757164856741, 11816.527338906433, 11885.405729713566, 11898.702532436671, 11917.404129793562, 11955.40222988847, 41841.0, 42133.94665133365, 42135.367969480176, 42145.0, 42247.0, 3413.6586341365664, 3425.246445781924, 3546.202104526487, 3557.3774589447003, 4015.819288132041, 28937.855310723524, 29342.41315173706, 29607.407851843058, 29891.25271868199, 30481.0, 2712.823666461674, 2731.6721993360725, 2790.260580946051, 2847.985760071186, 2902.1438675590753, 422930.0, 426895.9999999969, 428010.99999999686, 428227.0, 429848.0, 32419.837900810344, 37399.4390084149, 37907.62092379041, 38012.80993595014, 66618.00072998909, 36442.63557364445, 36682.51516105966, 36805.815970919975, 36824.0, 36882.524699012276, 16164.515064548083, 16303.836961630232, 16317.0, 16347.91826040886, 16350.672986540203, 12307.876921230853, 12467.75064498723, 13582.252976086213, 13617.455301788015, 14338.713225735635, 8452.450590711584, 8477.660893564189, 8511.53186574732, 8562.058173600899, 8575.228229459379, 3572.1962558424666, 3609.133807886141, 3613.674769270726, 3624.3838547447, 3639.1448009717697, 991.6231831903974, 1021.596469394585, 1050.5167622893402, 1118.8545489086366, 1119.3843386137755, 30107.69892301093, 30830.84584577063, 30898.227544311572, 31431.057068287988, 31584.210394740316, 1143.8112711402525, 1243.2291978972914, 1258.9055820813476, 1288.2656885575132, 1316.73665266947, 15544.300506477235, 15649.139297338528, 15686.76469852953, 15781.605459863595, 16006.279717412745, 630495.0, 637188.0, 639449.0, 640429.0, 642165.0, 62781.68609157016, 64186.679066605306, 64378.356216437234, 64439.355606444275, 64499.35500645027, 1457.1330058615108, 1474.808274924253, 1479.8816094712613, 1592.0527286264653, 1617.9676406471804, 23830.0, 30574.235644109074, 30759.462026899015, 30843.69156308408, 31491.84254078715, 58947.0, 59382.70308648429, 59763.0, 59802.40197597969, 59831.401685984325, 563001.0, 565604.0, 566137.0, 566678.0, 567489.0, 24050.63924041106, 24780.628290575296, 25019.374515637253, 28132.85933570319, 28604.141875742927, 37366.813165934, 43156.13687726291, 44358.778206108764, 45817.77091114523, 45903.54096458993, 36763.26473470569, 38730.6126938727, 38767.0, 39043.609563904, 39525.0, 37852.674708860046, 37891.81054094712, 38075.048123797125, 38706.0323491915, 38853.611463885, 36640.81679591585, 37504.59919849587, 37749.0, 38107.42838857364, 38332.0, 31960.84019579887, 33547.664523354455, 33606.831965840014, 33637.0, 33727.0, 24942.37644058913, 25319.0, 25578.94368695334, 25865.612015819403, 25951.22146335613], "value": 19349.780669887856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.8282921173107, 411.2330503610763, 413.6174039013913, 415.16344565700115, 419.99160016799664, 12876.742465150692, 16520.58698532537, 19595.118219680113, 21264.4683882903, 21319.82740949247, 21525.138994440244, 21701.565968680618, 21763.782362176375, 22492.8875355623, 22504.0, 5799.2750906136835, 5911.083782013773, 6112.724927378256, 6132.110843927628, 6148.96925515374, 4470.530594287602, 5114.565261952738, 6031.517478601723, 6101.0, 6429.292777794439, 6672.099266598995, 6677.899831502531, 6686.0305255737885, 6692.23039350476, 6702.865942681144, 5905.527557795366, 6382.744690212386, 6434.616557440149, 6627.4366678831875, 6650.767223147191, 5831.271091113611, 5838.678872662002, 5848.502877255439, 5859.033259512175, 5860.06239001762, 26985.46029079427, 27329.590056149173, 27801.165965021082, 27980.160595181973, 28058.0, 2283.246528645543, 2554.5529532331766, 2662.174725834978, 2955.143008527524, 2970.910872673823, 15654.0, 15749.448769293134, 15806.36774529029, 15888.443904463404, 16008.279627416794, 1577.2508058672154, 1810.1039985207406, 1890.9243630254773, 1902.1440351841588, 1914.5405102775374, 111755.44122279336, 119165.0, 119337.0, 121468.78531214752, 121705.0, 9824.361416507903, 10537.736556585993, 10838.0, 11592.246503977383, 11772.941135294268, 13289.3355332233, 13852.099613525088, 15073.020253683695, 15078.54764357071, 15082.698346033018, 8922.55387230649, 9096.727098187064, 9237.307201959746, 9262.444253344685, 9382.718518444457, 8002.1997800219515, 9398.201152901944, 9420.717378478657, 9436.575354109082, 9524.0, 6059.6364218147055, 7016.859662806715, 7115.75094871677, 7134.964325178341, 7141.000259963609, 1946.7371904792956, 1961.686130219158, 1966.1152481383435, 1982.1377700699952, 2002.6595478768354, 916.4730280088976, 925.6204955968021, 974.468914441631, 993.8558908958161, 1024.4314405504867, 21120.683189752166, 22221.11115555392, 22424.43938901508, 22600.773992260194, 22635.094596215968, 993.5429702336861, 996.8704068471197, 1082.9783404332027, 1122.2761318949233, 1128.9717757055976, 11420.543178272776, 11867.762644747057, 11915.642530724092, 11923.463444145034, 11990.700232494082, 578585.0, 610056.0, 628239.0, 639737.0, 664935.6753216203, 89621.0, 119187.0, 119709.0, 120066.0, 123046.38476807559, 1064.223117124488, 1080.4057768227444, 1087.9564817407215, 1088.8693356797078, 1096.0519150934385, 18827.435176944713, 19487.707684384462, 19602.215911363386, 19810.910399928143, 19907.800921991173, 30077.11697322102, 36453.45319820258, 47102.82242943954, 48540.0, 49734.75132624314, 66915.66542167257, 69148.0, 69306.0, 69916.6504167476, 73190.90213646693, 8296.958515207385, 8346.0, 8584.570771461527, 8597.484150950962, 8820.86768698483, 9712.417254964725, 10862.782744345226, 13171.0, 13586.592402227949, 13614.52349167814, 11258.66224013281, 11591.826122608, 11758.647240582795, 11821.586244481401, 11878.643640690792, 11263.380514071805, 11311.660650180507, 11450.0, 11745.647630571097, 11760.176787624785, 11445.484953177294, 11771.411429428666, 11912.702182445508, 11920.344381059125, 12022.458989345676, 8341.95829020851, 8407.495550267004, 8473.66105355779, 8488.575571221538, 8776.429532080394, 9424.539196424565, 11763.941180294043, 11782.293062416282, 11956.0, 12049.638510844688], "value": 10062.51394577038, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.8723014928655, 1600.7918970533829, 1606.7991501062368, 1880.3230836898715, 2006.7391239138901, 8253.628586713598, 8805.559722013897, 8963.820723585524, 8974.910250897488, 9010.0, 8737.694180703676, 8995.370324077317, 9002.86495702565, 9020.729378118667, 9051.728448146567, 2511.9120830770926, 2531.886065127074, 2533.138732830837, 2535.264773215765, 2538.1624064058815, 2461.9753802461923, 2477.6283557466345, 2481.7642323979194, 2483.6522886795865, 2490.887910044043, 2417.903283868643, 2450.2649205238445, 2506.385935445809, 2508.9623655645178, 2509.2472258322523, 2510.1089113364765, 2537.124691981273, 2537.822352435321, 2550.6684131062843, 2558.155808583163, 2488.701355837293, 2532.2150133458686, 2540.8221424500293, 2541.4789968056502, 2542.9618555721677, 8539.188777066169, 9150.267978561698, 9216.354855160074, 9227.03116172799, 9237.076292370777, 5275.762590683428, 5649.293838270216, 5725.914111288334, 5783.5084017858535, 5806.477417032487, 3429.382711111999, 3597.80212088335, 3694.9815250923575, 3702.5186725725753, 3741.307858046243, 1045.2892033417272, 1077.6928575355985, 1080.8594882665204, 1080.9838751573575, 1081.8972197641212, 12232.755344893052, 12304.692382690415, 12477.688057798629, 12478.625641230687, 12486.0, 4676.321933319649, 4725.07860967115, 4840.0, 4865.172920603506, 4868.756562171877, 9604.231661467065, 9630.374025688308, 9638.90361096394, 9644.228461723045, 9674.951625241969, 5535.612507124462, 5551.306086739158, 5594.524465420485, 5595.972020139955, 5597.328320601554, 4685.086408150446, 4724.740139292303, 4783.7129772213775, 4797.232442809203, 5213.087709650796, 3382.661733826647, 3798.430235464647, 3928.508936382952, 4024.195160967818, 4032.3951407288555, 1220.871808460099, 1221.1818081885158, 1229.4528934624186, 1235.6231349438508, 1244.0296568676447, 880.903100658927, 925.3476299209042, 939.4457270210609, 950.9239260859254, 979.8775153105862, 5984.880302393928, 6090.116933044772, 6106.931287024753, 6166.630002199882, 6215.720292586844, 953.8664586957832, 964.0648570886369, 977.2768151567789, 990.6087095597198, 1006.5520843224841, 3922.941155882664, 4011.3180759270995, 4033.072393349546, 4046.676265898721, 4093.5906409359422, 10946.835797463045, 11536.307821530734, 11552.76894462106, 11579.189456738117, 11592.594259200887, 11236.66290011301, 11367.602133925273, 11401.600943966921, 11402.201845870875, 11525.538978440936, 6781.287964763727, 8796.120387961153, 8798.0, 8818.779530511789, 8863.468191908507, 5633.2113504110275, 5916.556258280732, 6009.90985135232, 6045.244344456943, 6097.359777223328, 9942.353747006422, 10046.24653151002, 10182.643607473703, 10270.948645257025, 10300.381977081399, 9924.255680824112, 10539.998700123477, 10542.051215390651, 10552.894471055191, 10592.046715795615, 6627.536072474881, 7124.358807707331, 7251.20236773965, 7270.527415717961, 7371.115466144097, 7968.800779980547, 8387.412881098264, 8529.275011624082, 8543.145685431407, 8548.145185481402, 7507.549547027196, 7599.65801538921, 7616.162222155448, 7758.185390533913, 7782.105057918412, 7442.479026468095, 7494.475386722877, 7537.773866784005, 7538.057742782153, 7601.277878601524, 7139.964300178466, 7201.855962880818, 7231.855362892607, 7237.927620723725, 7316.487845850739, 4963.029576338842, 4967.05625931072, 5091.719955402488, 5166.328377310925, 5207.531322181022, 5054.140796064605, 5070.41690205631, 5107.233914912793, 5216.530512253916, 5341.97329013368], "value": 4730.57117360698, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.1704393610021, 323.7054280604649, 324.8716756881032, 335.83544063408937, 339.7095483361727, 5249.186376111704, 6673.165854268216, 6752.76365327213, 6876.965615171917, 6885.0, 6608.372204640564, 6611.041398997142, 6625.436837868775, 6633.038209459625, 6643.667816609162, 3951.5060617422823, 4707.364505791717, 4782.784774685148, 4863.513648635144, 4877.756112194394, 3913.5890731473214, 4874.390701162355, 4894.143524883131, 4898.730569818658, 4926.45808961014, 4779.259214821708, 4846.297286893398, 4872.123017856784, 4902.681325713835, 4940.0, 4673.6027437667835, 4730.526947305277, 4864.927026094611, 4913.656044076916, 4925.605951523888, 3620.7646502977223, 4036.910034290725, 4150.8547200847825, 4154.480689913761, 4163.500379954395, 6289.654069026202, 6365.681715914186, 6379.234491861006, 6391.680415979229, 6398.328175541595, 5772.134179873053, 5777.768889244425, 5782.768689252425, 5786.710664466802, 5793.8551536211935, 5677.432256774331, 6260.841744277323, 6522.119513865615, 7062.611556364398, 7107.928920710779, 4350.869473915787, 4541.205289074399, 4560.452745670507, 4714.104320179155, 4724.4094488188975, 7269.563826170447, 7352.4485663574915, 7408.073990751156, 7426.257374262585, 7464.701411943516, 4645.512221216791, 4650.255959046536, 4652.720836749806, 4661.3707149534375, 4662.254039353687, 3905.3165696003084, 4679.485256621769, 4724.267738500538, 4740.3837501124635, 4743.739094349844, 5613.607047506635, 5620.044592419298, 5620.662760234399, 5632.718364081779, 5645.887082258332, 6748.763793267311, 7021.929780702128, 7097.89353159703, 7114.359707626339, 7126.893096603555, 1619.3927277271023, 1624.4558073045425, 1642.53187841467, 1644.284736139783, 1648.5796121988817, 973.0950216298769, 1014.4065721552827, 1019.2253887045898, 1039.729670285716, 1041.2034793383068, 6502.544821862424, 6542.934570654328, 6636.270010298863, 6722.9663851680425, 6729.629870357177, 7397.667104980289, 7398.704051837974, 7405.925940740523, 7415.221401752846, 7424.814379640552, 6695.263521012685, 6706.83232919181, 6711.288621401609, 6712.932870671329, 6716.194056713128, 3869.2261547690573, 3910.159315747128, 3918.6277303656107, 3921.0785465415606, 3928.5678575356687, 5910.645361278337, 6507.056476810836, 7639.770806875803, 7646.847063058708, 7728.033995750531, 7469.9253007470315, 7621.618919054025, 7634.656440460192, 7643.694252229849, 7666.195049519832, 7706.961465192639, 7707.653155608011, 7733.961330193313, 7741.496802707806, 7747.651355689008, 7090.6100164491445, 7370.373518250794, 7380.335769780745, 7385.409167266498, 7386.372158366384, 7214.458915581247, 7228.421726261991, 7233.782986510413, 7296.306850849161, 7304.96347518259, 7751.263629955145, 7763.340116089969, 7767.572783496962, 7772.261635144652, 7773.766786996399, 4818.71087734737, 4898.628384052471, 4901.652045687322, 4909.926351104665, 4920.630952678635, 7063.470239731938, 7335.559866408033, 7344.265573442613, 7354.852902942018, 7354.963225184054, 7051.259617740064, 7068.540544864567, 7078.8938165928585, 7079.610621415872, 7083.716651333889, 7053.4004609608755, 7065.682044307916, 7081.68132434052, 7089.468289878177, 7090.539114957512, 6933.202681691469, 6951.131108611424, 6953.269906659728, 6959.686814093277, 6969.0, 6848.8972665409065, 7086.653535828176, 7106.502544821813, 7110.146782386147, 7110.4667149962925, 5289.6032797539565, 6797.490188236001, 6879.0, 6948.166220053626, 6982.406495447944], "value": 5147.643887195914, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.3356976947475, 769.8375453065869, 773.365840011191, 774.1097737601757, 782.8943092682487, 15156.696866062686, 15477.380904763824, 15543.06741595505, 15563.144027078506, 15594.0, 14180.929095354535, 14268.286585670701, 14271.215083170422, 14279.71440571188, 14303.998720089598, 769.0387016229713, 776.8407476467339, 935.4901578639658, 936.5317341329335, 962.3504134709078, 951.6574033347989, 954.5227386306847, 956.2732323434205, 957.0094951724966, 958.6213445688949, 1011.3476807459184, 1023.8771347438318, 1028.4600584693057, 1029.3926583315842, 1029.6447725534679, 816.2857499687773, 1021.8620486234412, 1022.018861892584, 1022.4376592873926, 1024.3290644627743, 742.8662840688673, 769.0694259945473, 769.5113602862167, 769.968242554979, 770.7572114783825, 15102.697946041128, 15143.394264229528, 15166.696666066617, 15173.013754105948, 15191.164485953268, 12762.680932976657, 12837.358132093357, 12987.675308117277, 13024.544140955117, 13409.731805363837, 8802.075782042857, 10102.595896164217, 10274.948625256826, 10412.94793526035, 10583.788324233472, 3501.457274122515, 3582.3551760683067, 3584.605693373727, 3625.89122326328, 3682.0794801299676, 82245.17754822435, 82267.5886620569, 82454.58772706157, 82514.0, 82698.0, 8195.877061844078, 9386.853029895856, 9774.951125244328, 9845.261605379625, 10138.949305253427, 22297.331080067623, 22361.664575031387, 22387.216447424587, 22403.0, 22434.32697019092, 7523.3981281497345, 7525.360344370681, 7589.506682065648, 7670.194629563815, 7838.764837054783, 4183.100633363842, 4198.181354635878, 4207.4951005878875, 4267.615914567704, 4283.528811830696, 3117.922051948674, 3176.0154352150907, 3182.2521707399205, 3185.681431856796, 3190.5054716518976, 604.5465900574569, 662.595816551903, 676.2662511175331, 682.011083928306, 693.9236683964759, 605.5670195810017, 607.8996965500643, 612.1582823617526, 620.3393386043849, 624.9906995431619, 7713.614319284014, 8109.635066422025, 8207.261346478846, 8315.8336833263, 8546.017208021032, 537.7096367961335, 577.9481343953963, 591.5430156803453, 595.592019466658, 612.6416046612692, 3751.2122454284904, 3854.113553882623, 3911.4328422379167, 3917.981324855558, 4020.216057868746, 95309.0, 95970.52014740021, 96691.0, 96858.51570742243, 97697.0, 58661.826763465346, 76627.61686191533, 76945.6152719244, 77646.0, 78944.21055789369, 69223.96164057544, 70164.6491767538, 70514.23714407181, 71512.99999999895, 71978.56042879113, 6175.919214137598, 7953.965984421988, 8395.328373729964, 8409.747707568782, 8431.32549396059, 49826.750866245435, 50397.496025040746, 50500.0, 51213.18327492024, 51844.740776295876, 69582.3041769596, 69778.0, 70020.29979700138, 70045.0, 70961.64519177371, 11048.61892263467, 11189.496472658588, 11326.150538709466, 11590.505988560764, 11638.952494275556, 11849.881501184878, 12027.27836329823, 12065.457054432396, 12249.571265005681, 12755.97952163806, 11525.654230373102, 11639.941800290944, 11644.475998579916, 11872.050235981273, 11979.520819167135, 11453.427328633701, 11718.0, 11783.293002419883, 12059.698507537381, 12232.266064036186, 11146.737831594144, 11384.0, 11489.425528723697, 11504.769904602028, 12132.878671213528, 9553.665621703207, 9769.902300976899, 9894.604215831287, 9989.350692204984, 10301.0, 9357.92383875863, 9775.85336219943, 9777.022297770167, 9845.901540984498, 9914.256430767866], "value": 7032.840043055951, "unit": "score"}], "name": "dromaeo_css", "value": 7618.823873017598, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 121.0, 112.0, 112.0, 111.0, 114.0, 113.0, 113.0, 134.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 112.0, 140.0, 163.0, 119.0, 139.0, 137.0, 115.0, 164.0, 114.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 188.0, 183.0, 183.0, 183.0, 186.0, 183.0, 184.0, 181.0, 184.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 75.0, 157.0, 56.0, 57.0, 55.0, 61.0, 130.0, 55.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 145.0, 79.0, 79.0, 80.0, 121.0, 77.0, 79.0, 128.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 94.0, 91.0, 94.0, 89.0, 89.0, 86.0, 93.0, 85.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 92.0, 103.0, 148.0, 94.0, 93.0, 93.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 83.0, 86.0, 86.0, 85.0, 82.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 63.0, 61.0, 62.0, 63.0, 63.0, 78.0, 58.0, 56.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 69.0, 70.0, 71.0, 72.0, 67.0, 66.0, 66.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 80.0, 79.0, 79.0, 78.0, 80.0, 80.0, 79.0, 84.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 143.0, 136.0, 134.0, 125.0, 125.0, 124.0, 130.0, 158.0, 161.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 164.0, 163.0, 165.0, 164.0, 164.0, 162.0, 162.0, 167.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 65.0, 66.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1462.1999999999996, "alertThreshold": 2.0}]} 17:57:10 INFO - Return code: 0 17:57:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:57:10 ERROR - # TBPL SUCCESS # 17:57:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:57:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:57:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:57:10 INFO - 2016-07-08 17:57:10.800 screenresolution[1676:10083] starting screenresolution argv=screenresolution get 17:57:10 INFO - 2016-07-08 17:57:10.803 screenresolution[1676:10083] Display 0: 1600x1200x32@60 17:57:10 INFO - 2016-07-08 17:57:10.809 screenresolution[1677:10086] starting screenresolution argv=screenresolution list 17:57:10 INFO - Available Modes on Display 0 17:57:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:57:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:57:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:57:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:57:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:57:11 INFO - Intel Iris: 17:57:11 INFO - Chipset Model: Intel Iris 17:57:11 INFO - Type: GPU 17:57:11 INFO - Bus: Built-In 17:57:11 INFO - VRAM (Dynamic, Max): 1536 MB 17:57:11 INFO - Vendor: Intel (0x8086) 17:57:11 INFO - Device ID: 0x0a2e 17:57:11 INFO - Revision ID: 0x0009 17:57:11 INFO - Displays: 17:57:11 INFO - Display: 17:57:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:57:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:57:11 INFO - Display Serial Number: 1600x1200 60 17:57:11 INFO - Main Display: Yes 17:57:11 INFO - Mirror: Off 17:57:11 INFO - Online: Yes 17:57:11 INFO - Rotation: Supported 17:57:11 INFO - Return code: 0 17:57:11 INFO - Running post-action listener: _resource_record_post_action 17:57:11 INFO - Running post-run listener: _resource_record_post_run 17:57:12 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 37000704; Write bytes: 493760512; Read time: 241; Write time: 1578 17:57:12 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 200126976; Write bytes: 195597824; Read time: 17669; Write time: 447 17:57:12 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 29896192; Write bytes: 297155072; Read time: 182; Write time: 1128 17:57:12 INFO - Running post-run listener: _upload_blobber_files 17:57:12 INFO - Blob upload gear active. 17:57:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:57:12 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 17:57:12 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'] 17:57:12 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 17:57:12 INFO - (blobuploader) - INFO - Open directory for files ... 17:57:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:57:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:57:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:13 INFO - (blobuploader) - INFO - Done attempting. 17:57:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:57:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:57:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:14 INFO - (blobuploader) - INFO - Done attempting. 17:57:14 INFO - (blobuploader) - INFO - Iteration through files over. 17:57:14 INFO - Return code: 0 17:57:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:57:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:57:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/521d88f16bca907bfd91ac4dd963ef12b68823ca452e8b3eeee18e4c3ad9e2ae216e9af94aba82cc3e69872bf23cb9b71676202134db07fa2274af4c4cde4726", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/897ce3592a002b7189e44739a028e00f24f6e55e186cc9f11621c32610e7d19806a4c39a5490b12c5a92f01d177e74ed5263d711c2ef0714d3120d7de9126770"} 17:57:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:57:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:57:14 INFO - Contents: 17:57:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/521d88f16bca907bfd91ac4dd963ef12b68823ca452e8b3eeee18e4c3ad9e2ae216e9af94aba82cc3e69872bf23cb9b71676202134db07fa2274af4c4cde4726", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/897ce3592a002b7189e44739a028e00f24f6e55e186cc9f11621c32610e7d19806a4c39a5490b12c5a92f01d177e74ed5263d711c2ef0714d3120d7de9126770"} 17:57:14 INFO - Running post-run listener: copy_logs_to_upload_dir 17:57:14 INFO - Copying logs to upload dir... 17:57:14 INFO - mkdir: /builds/slave/test/build/upload/logs 17:57:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.394656 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-08 17:57:14.977523) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 17:57:14.981114) ========= 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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/521d88f16bca907bfd91ac4dd963ef12b68823ca452e8b3eeee18e4c3ad9e2ae216e9af94aba82cc3e69872bf23cb9b71676202134db07fa2274af4c4cde4726", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/897ce3592a002b7189e44739a028e00f24f6e55e186cc9f11621c32610e7d19806a4c39a5490b12c5a92f01d177e74ed5263d711c2ef0714d3120d7de9126770"} build_url:https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011004 build_url: 'https://queue.taskcluster.net/v1/task/IPGM_U6HRnaNaniFUPqUYw/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/521d88f16bca907bfd91ac4dd963ef12b68823ca452e8b3eeee18e4c3ad9e2ae216e9af94aba82cc3e69872bf23cb9b71676202134db07fa2274af4c4cde4726", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/897ce3592a002b7189e44739a028e00f24f6e55e186cc9f11621c32610e7d19806a4c39a5490b12c5a92f01d177e74ed5263d711c2ef0714d3120d7de9126770"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 17:57:15.017439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:57:15.017811) ========= 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.khSt3FUHzf/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.Hm2ZiDHhz5/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.005022 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:57:15.066885) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 17:57:15.067211) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 17:57:15.067582) ========= ========= Total master_lag: 0.17 =========