builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0163 starttime: 1463063930.17 results: success (0) buildid: 20160512061943 builduid: 5f55196abfaf45eb8d0a191876533746 revision: fca62ad9c45ca847ac004a2b16807a63763e5c29 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 07:38:50.169989) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 07:38:50.170441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 07:38:50.170724) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 07:38:50.336159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:38:50.336699) ========= 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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-12 07:38:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 76.7M=0s 2016-05-12 07:38:50 (76.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114388 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:38:50.505107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:38:50.505474) ========= 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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.019911 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:38:50.580701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-05-12 07:38:50.587107) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fca62ad9c45ca847ac004a2b16807a63763e5c29 --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-aurora --rev fca62ad9c45ca847ac004a2b16807a63763e5c29 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QUSZ8DUjSd/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.elyD0nYO1K/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-12 07:38:50,673 truncating revision to first 12 chars 2016-05-12 07:38:50,673 Setting DEBUG logging. 2016-05-12 07:38:50,673 attempt 1/10 2016-05-12 07:38:50,673 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fca62ad9c45c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 07:38:52,462 unpacking tar archive at: mozilla-aurora-fca62ad9c45c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.040438 ========= master_lag: 3.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-05-12 07:38:55.775587) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 07:38:55.775937) ========= script_repo_revision: fca62ad9c45ca847ac004a2b16807a63763e5c29 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 07:38:55.776334) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 14 secs) (at 2016-05-12 07:38:55.776601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 14 secs) (at 2016-05-12 07:39:10.181288) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-05-12 07:39:10.181634) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QUSZ8DUjSd/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.elyD0nYO1K/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:39:10 INFO - MultiFileLogger online at 20160512 07:39:10 in /builds/slave/test 07:39:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:39:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:39:10 INFO - {'append_to_log': False, 07:39:10 INFO - 'base_work_dir': '/builds/slave/test', 07:39:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:39:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:39:10 INFO - 'branch': 'Mozilla-Aurora', 07:39:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:39:10 INFO - 'config_files': ('talos/mac_config.py',), 07:39:10 INFO - 'default_actions': ('clobber', 07:39:10 INFO - 'read-buildbot-config', 07:39:10 INFO - 'download-and-extract', 07:39:10 INFO - 'populate-webroot', 07:39:10 INFO - 'create-virtualenv', 07:39:10 INFO - 'install', 07:39:10 INFO - 'run-tests'), 07:39:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:39:10 INFO - 'download_minidump_stackwalk': True, 07:39:10 INFO - 'download_symbols': 'ondemand', 07:39:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:39:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:39:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:39:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:39:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:39:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:39:10 INFO - 'installer_path': 'installer.exe', 07:39:10 INFO - 'log_level': 'info', 07:39:10 INFO - 'log_name': 'talos', 07:39:10 INFO - 'log_to_console': True, 07:39:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:39:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:39:10 INFO - 'opt_config_files': (), 07:39:10 INFO - 'pip_index': False, 07:39:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:39:10 INFO - 'cmd': ('bash', 07:39:10 INFO - '-c', 07:39:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:39:10 INFO - 'enabled': True, 07:39:10 INFO - 'halt_on_failure': False, 07:39:10 INFO - 'name': 'check_screen_resolution'},), 07:39:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:39:10 INFO - 'cmd': ('bash', 07:39:10 INFO - '-c', 07:39:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:39:10 INFO - 'enabled': True, 07:39:10 INFO - 'halt_on_failure': False, 07:39:10 INFO - 'name': 'check_screen_resolution'},), 07:39:10 INFO - 'run_cmd_checks_enabled': True, 07:39:10 INFO - 'sps_profile': False, 07:39:10 INFO - 'sps_profile_interval': 0, 07:39:10 INFO - 'suite': 'dromaeojs', 07:39:10 INFO - 'system_bits': '32', 07:39:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:39:10 INFO - 'title': 't-yosemite-r7-0163', 07:39:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:39:10 INFO - 'use_talos_json': True, 07:39:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:39:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:39:10 INFO - 'work_dir': 'build'} 07:39:10 INFO - ##### 07:39:10 INFO - ##### Running clobber step. 07:39:10 INFO - ##### 07:39:10 INFO - Running pre-action listener: _resource_record_pre_action 07:39:10 INFO - Running main action method: clobber 07:39:10 INFO - rmtree: /builds/slave/test/build 07:39:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:39:12 INFO - Running post-action listener: _resource_record_post_action 07:39:12 INFO - ##### 07:39:12 INFO - ##### Running read-buildbot-config step. 07:39:12 INFO - ##### 07:39:12 INFO - Running pre-action listener: _resource_record_pre_action 07:39:12 INFO - Running main action method: read_buildbot_config 07:39:12 INFO - Using buildbot properties: 07:39:12 INFO - { 07:39:12 INFO - "project": "", 07:39:12 INFO - "product": "firefox", 07:39:12 INFO - "script_repo_revision": "production", 07:39:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:39:12 INFO - "repository": "", 07:39:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:39:12 INFO - "buildid": "20160512061943", 07:39:12 INFO - "pgo_build": "False", 07:39:12 INFO - "basedir": "/builds/slave/test", 07:39:12 INFO - "buildnumber": 319, 07:39:12 INFO - "slavename": "t-yosemite-r7-0163", 07:39:12 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:39:12 INFO - "platform": "yosemite_r7", 07:39:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:39:12 INFO - "branch": "mozilla-aurora", 07:39:12 INFO - "repo_path": "releases/mozilla-aurora", 07:39:12 INFO - "revision": "fca62ad9c45ca847ac004a2b16807a63763e5c29", 07:39:12 INFO - "stage_platform": "macosx64", 07:39:12 INFO - "builduid": "5f55196abfaf45eb8d0a191876533746", 07:39:12 INFO - "slavebuilddir": "test" 07:39:12 INFO - } 07:39:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 07:39:12 INFO - Running post-action listener: _resource_record_post_action 07:39:12 INFO - ##### 07:39:12 INFO - ##### Running download-and-extract step. 07:39:12 INFO - ##### 07:39:12 INFO - Running pre-action listener: _resource_record_pre_action 07:39:12 INFO - Running main action method: download_and_extract 07:39:12 INFO - mkdir: /builds/slave/test/build/tests 07:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:12 INFO - https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:39:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 07:39:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 07:39:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 07:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 07:39:14 INFO - Downloaded 1199 bytes. 07:39:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 07:39:14 INFO - Using the following test package requirements: 07:39:14 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 07:39:14 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 07:39:14 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 07:39:14 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 07:39:14 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 07:39:14 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 07:39:14 INFO - u'jsshell-mac.zip'], 07:39:14 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 07:39:14 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 07:39:14 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 07:39:14 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 07:39:14 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 07:39:14 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 07:39:14 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 07:39:14 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 07:39:14 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 07:39:14 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 07:39:14 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 07:39:14 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:14 INFO - https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:39:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 07:39:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 07:39:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 07:39:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:39:16 INFO - Downloaded 18089434 bytes. 07:39:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:39:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:39:19 INFO - Return code: 0 07:39:19 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:19 INFO - https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:39:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 07:39:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 07:39:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 07:39:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:39:23 INFO - Downloaded 18089434 bytes. 07:39:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:39:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:39:26 INFO - Return code: 0 07:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:26 INFO - https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:39:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 07:39:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 07:39:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 07:39:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:39:29 INFO - Downloaded 10840145 bytes. 07:39:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:39:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:39:29 INFO - Return code: 0 07:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:29 INFO - https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 07:39:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 07:39:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 07:39:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 07:39:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 07:39:33 INFO - Downloaded 114122605 bytes. 07:39:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 07:39:33 INFO - mkdir: /builds/slave/test/properties 07:39:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:39:33 INFO - Writing to file /builds/slave/test/properties/build_url 07:39:33 INFO - Contents: 07:39:33 INFO - build_url:https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 07:39:35 INFO - Running post-action listener: _resource_record_post_action 07:39:35 INFO - Running post-action listener: set_extra_try_arguments 07:39:35 INFO - ##### 07:39:35 INFO - ##### Running populate-webroot step. 07:39:35 INFO - ##### 07:39:35 INFO - Running pre-action listener: _resource_record_pre_action 07:39:35 INFO - Running main action method: populate_webroot 07:39:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:39:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:39:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:39:35 INFO - '--tppagecycles', 07:39:35 INFO - '7'], 07:39:35 INFO - 'tests': ['tsvgm']}}, 07:39:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:39:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:39:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:39:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:39:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:39:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:39:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:39:35 INFO - 'talos_options': ['--disable-e10s'], 07:39:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:39:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:39:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:39:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:39:35 INFO - 'talos_options': ['--disable-e10s'], 07:39:35 INFO - 'tests': ['damp', 'tps']}, 07:39:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:39:35 INFO - 'tests': ['damp', 'tps']}, 07:39:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:39:35 INFO - 'tests': ['dromaeo_dom']}, 07:39:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:39:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:39:35 INFO - 'tests': ['a11yr', 07:39:35 INFO - 'ts_paint', 07:39:35 INFO - 'tpaint', 07:39:35 INFO - 'sessionrestore', 07:39:35 INFO - 'sessionrestore_no_auto_restore', 07:39:35 INFO - 'tabpaint']}, 07:39:35 INFO - 'other-e10s': {'tests': ['a11yr', 07:39:35 INFO - 'ts_paint', 07:39:35 INFO - 'tpaint', 07:39:35 INFO - 'sessionrestore', 07:39:35 INFO - 'sessionrestore_no_auto_restore', 07:39:35 INFO - 'tabpaint']}, 07:39:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:39:35 INFO - 'ts_paint', 07:39:35 INFO - 'tpaint', 07:39:35 INFO - 'sessionrestore', 07:39:35 INFO - 'sessionrestore_no_auto_restore', 07:39:35 INFO - 'tabpaint']}, 07:39:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:39:35 INFO - 'ts_paint', 07:39:35 INFO - 'tpaint', 07:39:35 INFO - 'sessionrestore', 07:39:35 INFO - 'sessionrestore_no_auto_restore', 07:39:35 INFO - 'tabpaint']}, 07:39:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:39:35 INFO - 'tests': ['a11yr', 07:39:35 INFO - 'ts_paint', 07:39:35 INFO - 'tpaint', 07:39:35 INFO - 'sessionrestore', 07:39:35 INFO - 'sessionrestore_no_auto_restore', 07:39:35 INFO - 'tabpaint']}, 07:39:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:39:35 INFO - 'tests': ['a11yr', 07:39:35 INFO - 'ts_paint', 07:39:35 INFO - 'tpaint', 07:39:35 INFO - 'sessionrestore', 07:39:35 INFO - 'sessionrestore_no_auto_restore', 07:39:35 INFO - 'tabpaint']}, 07:39:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:39:35 INFO - 'tests': ['tsvgx', 07:39:35 INFO - 'tsvgr_opacity', 07:39:35 INFO - 'tart', 07:39:35 INFO - 'tscrollx', 07:39:35 INFO - 'cart']}, 07:39:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:39:35 INFO - 'tsvgr_opacity', 07:39:35 INFO - 'tart', 07:39:35 INFO - 'tscrollx', 07:39:35 INFO - 'cart']}, 07:39:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:39:35 INFO - 'talos_options': ['--disable-e10s'], 07:39:35 INFO - 'tests': ['tp5o']}, 07:39:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:39:35 INFO - 'tests': ['tp5o']}, 07:39:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:39:35 INFO - 'talos_options': ['--disable-e10s', 07:39:35 INFO - '--xperf_path', 07:39:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:39:35 INFO - 'tests': ['tp5n']}, 07:39:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:39:35 INFO - 'talos_options': ['--xperf_path', 07:39:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:39:35 INFO - 'tests': ['tp5n']}}, 07:39:35 INFO - 'talos.zip': {'path': '', 07:39:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:39:35 INFO - Running post-action listener: _resource_record_post_action 07:39:35 INFO - ##### 07:39:35 INFO - ##### Running create-virtualenv step. 07:39:35 INFO - ##### 07:39:35 INFO - Running pre-action listener: _resource_record_pre_action 07:39:35 INFO - Running main action method: create_virtualenv 07:39:35 INFO - Creating virtualenv /builds/slave/test/build/venv 07:39:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:39:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:39:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:39:35 INFO - Using real prefix '/tools/python27' 07:39:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:39:36 INFO - Installing distribute.............................................................................................................................................................................................done. 07:39:38 INFO - Installing pip.................done. 07:39:38 INFO - Return code: 0 07:39:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fdbc81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f38be00>, '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 0x10f1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f386b20>, '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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QUSZ8DUjSd/Render', 07:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:39:38 INFO - 'HOME': '/Users/cltbld', 07:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:39:38 INFO - 'LOGNAME': 'cltbld', 07:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:38 INFO - 'MOZ_NO_REMOTE': '1', 07:39:38 INFO - 'NO_EM_RESTART': '1', 07:39:38 INFO - 'PAGER': '/bin/cat', 07:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:38 INFO - 'PWD': '/builds/slave/test', 07:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:39:38 INFO - 'SHELL': '/bin/bash', 07:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elyD0nYO1K/Listeners', 07:39:38 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:39:38 INFO - 'USER': 'cltbld', 07:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:38 INFO - 'XPC_FLAGS': '0x0', 07:39:38 INFO - 'XPC_SERVICE_NAME': '0', 07:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:39:39 INFO - Cleaning up... 07:39:39 INFO - Return code: 0 07:39:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:39 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 0x10f4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fdbc81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f38be00>, '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 0x10f1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f386b20>, '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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:39:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:39:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QUSZ8DUjSd/Render', 07:39:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:39:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:39:39 INFO - 'HOME': '/Users/cltbld', 07:39:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:39:39 INFO - 'LOGNAME': 'cltbld', 07:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:39 INFO - 'MOZ_NO_REMOTE': '1', 07:39:39 INFO - 'NO_EM_RESTART': '1', 07:39:39 INFO - 'PAGER': '/bin/cat', 07:39:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:39 INFO - 'PWD': '/builds/slave/test', 07:39:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:39:39 INFO - 'SHELL': '/bin/bash', 07:39:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elyD0nYO1K/Listeners', 07:39:39 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:39:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:39:39 INFO - 'USER': 'cltbld', 07:39:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:39:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:39 INFO - 'XPC_FLAGS': '0x0', 07:39:39 INFO - 'XPC_SERVICE_NAME': '0', 07:39:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:39 INFO - Downloading/unpacking psutil>=0.7.1 07:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:39:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:39:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:39:42 INFO - Installing collected packages: psutil 07:39:42 INFO - Running setup.py install for psutil 07:39:42 INFO - building 'psutil._psutil_osx' extension 07:39:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:39:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:39:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:39:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:39:43 INFO - building 'psutil._psutil_posix' extension 07:39:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:39:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:39:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:39:43 INFO - ^ 07:39:43 INFO - 1 warning generated. 07:39:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:39:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:39:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:39:43 INFO - Successfully installed psutil 07:39:43 INFO - Cleaning up... 07:39:43 INFO - Return code: 0 07:39:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:43 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 0x10f4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fdbc81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f38be00>, '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 0x10f1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f386b20>, '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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:39:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QUSZ8DUjSd/Render', 07:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:39:43 INFO - 'HOME': '/Users/cltbld', 07:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:39:43 INFO - 'LOGNAME': 'cltbld', 07:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:43 INFO - 'MOZ_NO_REMOTE': '1', 07:39:43 INFO - 'NO_EM_RESTART': '1', 07:39:43 INFO - 'PAGER': '/bin/cat', 07:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:43 INFO - 'PWD': '/builds/slave/test', 07:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:39:43 INFO - 'SHELL': '/bin/bash', 07:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elyD0nYO1K/Listeners', 07:39:43 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:39:43 INFO - 'USER': 'cltbld', 07:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:43 INFO - 'XPC_FLAGS': '0x0', 07:39:43 INFO - 'XPC_SERVICE_NAME': '0', 07:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:39:46 INFO - Installing collected packages: mozsystemmonitor 07:39:46 INFO - Running setup.py install for mozsystemmonitor 07:39:46 INFO - Successfully installed mozsystemmonitor 07:39:46 INFO - Cleaning up... 07:39:46 INFO - Return code: 0 07:39:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:46 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 0x10f4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fdbc81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f38be00>, '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 0x10f1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f386b20>, '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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QUSZ8DUjSd/Render', 07:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:39:46 INFO - 'HOME': '/Users/cltbld', 07:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:39:46 INFO - 'LOGNAME': 'cltbld', 07:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:46 INFO - 'MOZ_NO_REMOTE': '1', 07:39:46 INFO - 'NO_EM_RESTART': '1', 07:39:46 INFO - 'PAGER': '/bin/cat', 07:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:46 INFO - 'PWD': '/builds/slave/test', 07:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:39:46 INFO - 'SHELL': '/bin/bash', 07:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elyD0nYO1K/Listeners', 07:39:46 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:39:46 INFO - 'USER': 'cltbld', 07:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:46 INFO - 'XPC_FLAGS': '0x0', 07:39:46 INFO - 'XPC_SERVICE_NAME': '0', 07:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:46 INFO - Downloading/unpacking blobuploader==1.2.4 07:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:39:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:39:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:39: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 07:39: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 07:39: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 07:39: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 07:39: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 07:39: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 07:39:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:39:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:50 INFO - Downloading docopt-0.6.1.tar.gz 07:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:39:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:39:50 INFO - Running setup.py install for blobuploader 07:39:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:39:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:39:50 INFO - Running setup.py install for requests 07:39:51 INFO - Running setup.py install for docopt 07:39:51 INFO - Successfully installed blobuploader requests docopt 07:39:51 INFO - Cleaning up... 07:39:51 INFO - Return code: 0 07:39:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:51 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 0x10f4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fdbc81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f38be00>, '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 0x10f1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f386b20>, '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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:39:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QUSZ8DUjSd/Render', 07:39:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:39:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:39:51 INFO - 'HOME': '/Users/cltbld', 07:39:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:39:51 INFO - 'LOGNAME': 'cltbld', 07:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:51 INFO - 'MOZ_NO_REMOTE': '1', 07:39:51 INFO - 'NO_EM_RESTART': '1', 07:39:51 INFO - 'PAGER': '/bin/cat', 07:39:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:51 INFO - 'PWD': '/builds/slave/test', 07:39:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:39:51 INFO - 'SHELL': '/bin/bash', 07:39:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elyD0nYO1K/Listeners', 07:39:51 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:39:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:39:51 INFO - 'USER': 'cltbld', 07:39:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:39:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:51 INFO - 'XPC_FLAGS': '0x0', 07:39:51 INFO - 'XPC_SERVICE_NAME': '0', 07:39:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:39:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-GF2BMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:39:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-AWPPWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:39:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-1qr2FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:39:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-i_fc_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:39:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-5dGqQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:39:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Iudwi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:39:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-kapfj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:39:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-odMwGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:39:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-4keBcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:39:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-pIrfZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:39:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-vDYzFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:39:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-DRaw9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:39:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-yfM92w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:39:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-DC0Gjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Zeg7px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:39:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-arO9Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:39:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ORdUdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:39:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:39:53 INFO - Running setup.py install for manifestparser 07:39:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:39:53 INFO - Running setup.py install for mozcrash 07:39:53 INFO - Running setup.py install for mozdebug 07:39:53 INFO - Running setup.py install for mozdevice 07:39:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:39:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:39:54 INFO - Running setup.py install for mozfile 07:39:54 INFO - Running setup.py install for mozhttpd 07:39:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:39:54 INFO - Running setup.py install for mozinfo 07:39:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:39:54 INFO - Running setup.py install for mozInstall 07:39:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:39:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:39:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:39:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:39:54 INFO - Running setup.py install for mozleak 07:39:54 INFO - Running setup.py install for mozlog 07:39:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:39:54 INFO - Running setup.py install for moznetwork 07:39:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:39:55 INFO - Running setup.py install for mozprocess 07:39:55 INFO - Running setup.py install for mozprofile 07:39:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:39:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:39:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:39:55 INFO - Running setup.py install for mozrunner 07:39:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:39:55 INFO - Running setup.py install for mozscreenshot 07:39:55 INFO - Running setup.py install for moztest 07:39:55 INFO - Running setup.py install for mozversion 07:39:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:39:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:39:55 INFO - Cleaning up... 07:39:56 INFO - Return code: 0 07:39:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:56 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 0x10f4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fdbc81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f38be00>, '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 0x10f1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f386b20>, '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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:39:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QUSZ8DUjSd/Render', 07:39:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:39:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:39:56 INFO - 'HOME': '/Users/cltbld', 07:39:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:39:56 INFO - 'LOGNAME': 'cltbld', 07:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:56 INFO - 'MOZ_NO_REMOTE': '1', 07:39:56 INFO - 'NO_EM_RESTART': '1', 07:39:56 INFO - 'PAGER': '/bin/cat', 07:39:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:56 INFO - 'PWD': '/builds/slave/test', 07:39:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:39:56 INFO - 'SHELL': '/bin/bash', 07:39:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elyD0nYO1K/Listeners', 07:39:56 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:39:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:39:56 INFO - 'USER': 'cltbld', 07:39:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:39:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:56 INFO - 'XPC_FLAGS': '0x0', 07:39:56 INFO - 'XPC_SERVICE_NAME': '0', 07:39:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:39:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-BDUbhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:39:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-TqCHwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:39:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-IsEUgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:39:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-IhrQIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:39:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Lpcfev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:39:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-OHEQ0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:39:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-M5X_Yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:39:57 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3lvEFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:39:57 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-M1BKFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:39:57 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-lfvIEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:39:57 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-A4iNpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:39:57 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-5RuQfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:39:57 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-EjiYjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:39:57 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-U_toMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:57 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-_TfBvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:39:57 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-VpdPe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:39:57 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-wVSG0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:39:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:03 INFO - Downloading blessings-1.6.tar.gz 07:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:40:03 INFO - Installing collected packages: blessings 07:40:03 INFO - Running setup.py install for blessings 07:40:03 INFO - Successfully installed blessings 07:40:03 INFO - Cleaning up... 07:40:03 INFO - Return code: 0 07:40:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:40:04 INFO - Reading from file tmpfile_stdout 07:40:04 INFO - Current package versions: 07:40:04 INFO - blessings == 1.6 07:40:04 INFO - blobuploader == 1.2.4 07:40:04 INFO - docopt == 0.6.1 07:40:04 INFO - manifestparser == 1.1 07:40:04 INFO - mozInstall == 1.12 07:40:04 INFO - mozcrash == 0.17 07:40:04 INFO - mozdebug == 0.1 07:40:04 INFO - mozdevice == 0.48 07:40:04 INFO - mozfile == 1.2 07:40:04 INFO - mozhttpd == 0.7 07:40:04 INFO - mozinfo == 0.9 07:40:04 INFO - mozleak == 0.1 07:40:04 INFO - mozlog == 3.1 07:40:04 INFO - moznetwork == 0.27 07:40:04 INFO - mozprocess == 0.22 07:40:04 INFO - mozprofile == 0.28 07:40:04 INFO - mozrunner == 6.11 07:40:04 INFO - mozscreenshot == 0.1 07:40:04 INFO - mozsystemmonitor == 0.0 07:40:04 INFO - moztest == 0.7 07:40:04 INFO - mozversion == 1.4 07:40:04 INFO - psutil == 3.1.1 07:40:04 INFO - requests == 1.2.3 07:40:04 INFO - wsgiref == 0.1.2 07:40:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:04 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 0x10f4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fdbc81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f38be00>, '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 0x10f1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f386b20>, '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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:40:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QUSZ8DUjSd/Render', 07:40:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:40:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:40:04 INFO - 'HOME': '/Users/cltbld', 07:40:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:40:04 INFO - 'LOGNAME': 'cltbld', 07:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:04 INFO - 'MOZ_NO_REMOTE': '1', 07:40:04 INFO - 'NO_EM_RESTART': '1', 07:40:04 INFO - 'PAGER': '/bin/cat', 07:40:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:04 INFO - 'PWD': '/builds/slave/test', 07:40:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:40:04 INFO - 'SHELL': '/bin/bash', 07:40:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elyD0nYO1K/Listeners', 07:40:04 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:40:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:40:04 INFO - 'USER': 'cltbld', 07:40:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:40:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:04 INFO - 'XPC_FLAGS': '0x0', 07:40:04 INFO - 'XPC_SERVICE_NAME': '0', 07:40:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:40:04 INFO - Cleaning up... 07:40:04 INFO - Return code: 0 07:40:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:04 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 0x10f4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fdbc81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f38be00>, '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 0x10f1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f386b20>, '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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:40:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QUSZ8DUjSd/Render', 07:40:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:40:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:40:04 INFO - 'HOME': '/Users/cltbld', 07:40:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:40:04 INFO - 'LOGNAME': 'cltbld', 07:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:04 INFO - 'MOZ_NO_REMOTE': '1', 07:40:04 INFO - 'NO_EM_RESTART': '1', 07:40:04 INFO - 'PAGER': '/bin/cat', 07:40:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:04 INFO - 'PWD': '/builds/slave/test', 07:40:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:40:04 INFO - 'SHELL': '/bin/bash', 07:40:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elyD0nYO1K/Listeners', 07:40:04 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:40:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:40:04 INFO - 'USER': 'cltbld', 07:40:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:40:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:04 INFO - 'XPC_FLAGS': '0x0', 07:40:04 INFO - 'XPC_SERVICE_NAME': '0', 07:40:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:04 INFO - Downloading/unpacking jsonschema 07:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:40:07 INFO - Downloading/unpacking functools32 (from jsonschema) 07:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:07 INFO - Downloading functools32-3.2.3-2.tar.gz 07:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:40:07 INFO - warning: no files found matching '*.txt' 07:40:07 INFO - no previously-included directories found matching 'build' 07:40:07 INFO - no previously-included directories found matching 'dist' 07:40:07 INFO - no previously-included directories found matching '.git*' 07:40:07 INFO - Installing collected packages: jsonschema, functools32 07:40:07 INFO - Running setup.py install for functools32 07:40:07 INFO - warning: no files found matching '*.txt' 07:40:07 INFO - no previously-included directories found matching 'build' 07:40:07 INFO - no previously-included directories found matching 'dist' 07:40:07 INFO - no previously-included directories found matching '.git*' 07:40:07 INFO - Successfully installed jsonschema functools32 07:40:07 INFO - Cleaning up... 07:40:08 INFO - Return code: 0 07:40:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:08 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 0x10f4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fdbc81770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f38be00>, '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 0x10f1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f386b20>, '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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:40:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QUSZ8DUjSd/Render', 07:40:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:40:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:40:08 INFO - 'HOME': '/Users/cltbld', 07:40:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:40:08 INFO - 'LOGNAME': 'cltbld', 07:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:08 INFO - 'MOZ_NO_REMOTE': '1', 07:40:08 INFO - 'NO_EM_RESTART': '1', 07:40:08 INFO - 'PAGER': '/bin/cat', 07:40:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:08 INFO - 'PWD': '/builds/slave/test', 07:40:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:40:08 INFO - 'SHELL': '/bin/bash', 07:40:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elyD0nYO1K/Listeners', 07:40:08 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:40:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:40:08 INFO - 'USER': 'cltbld', 07:40:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:40:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:08 INFO - 'XPC_FLAGS': '0x0', 07:40:08 INFO - 'XPC_SERVICE_NAME': '0', 07:40:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:08 INFO - Downloading/unpacking flake8 07:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:40:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:40: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 07:40: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 07:40: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 07:40: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 07:40: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 07:40: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 07:40:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:40:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:40:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:40:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:40:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:40:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:40:11 INFO - no previously-included directories found matching 'docs/_build' 07:40:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:40:12 INFO - Running setup.py install for pep8 07:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:40:12 INFO - no previously-included directories found matching 'docs/_build' 07:40:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:40:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:40:12 INFO - Cleaning up... 07:40:12 INFO - Return code: 0 07:40:12 INFO - Running post-action listener: _resource_record_post_action 07:40:12 INFO - Running post-action listener: _start_resource_monitoring 07:40:12 INFO - Starting resource monitoring. 07:40:12 INFO - ##### 07:40:12 INFO - ##### Running install step. 07:40:12 INFO - ##### 07:40:12 INFO - Running pre-action listener: _resource_record_pre_action 07:40:12 INFO - Running main action method: install 07:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:40:12 INFO - Reading from file tmpfile_stdout 07:40:12 INFO - Detecting whether we're running mozinstall >=1.0... 07:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:40:12 INFO - Reading from file tmpfile_stdout 07:40:12 INFO - Output received: 07:40:12 INFO - Usage: mozinstall [options] installer 07:40:12 INFO - Options: 07:40:12 INFO - -h, --help show this help message and exit 07:40:12 INFO - -d DEST, --destination=DEST 07:40:12 INFO - Directory to install application into. [default: 07:40:12 INFO - "/builds/slave/test"] 07:40:12 INFO - --app=APP Application being installed. [default: firefox] 07:40:12 INFO - mkdir: /builds/slave/test/build/application 07:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:40:44 INFO - Reading from file tmpfile_stdout 07:40:44 INFO - Output received: 07:40:44 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:40:44 INFO - Running post-action listener: _resource_record_post_action 07:40:44 INFO - ##### 07:40:44 INFO - ##### Running run-tests step. 07:40:44 INFO - ##### 07:40:44 INFO - Running pre-action listener: _resource_record_pre_action 07:40:44 INFO - Running main action method: run_tests 07:40:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:40:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:40:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:40:44 INFO - 2016-05-12 07:40:44.248 screenresolution[1981:11482] starting screenresolution argv=screenresolution get 07:40:44 INFO - 2016-05-12 07:40:44.250 screenresolution[1981:11482] Display 0: 1600x1200x32@60 07:40:44 INFO - 2016-05-12 07:40:44.255 screenresolution[1982:11485] starting screenresolution argv=screenresolution list 07:40:44 INFO - Available Modes on Display 0 07:40:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:40:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:40:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:40:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:40:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:40:44 INFO - Intel Iris: 07:40:44 INFO - Chipset Model: Intel Iris 07:40:44 INFO - Type: GPU 07:40:44 INFO - Bus: Built-In 07:40:44 INFO - VRAM (Dynamic, Max): 1536 MB 07:40:44 INFO - Vendor: Intel (0x8086) 07:40:44 INFO - Device ID: 0x0a2e 07:40:44 INFO - Revision ID: 0x0009 07:40:44 INFO - Displays: 07:40:44 INFO - Display: 07:40:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:40:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:40:44 INFO - Display Serial Number: 1600x1200 60 07:40:44 INFO - Main Display: Yes 07:40:44 INFO - Mirror: Off 07:40:44 INFO - Online: Yes 07:40:44 INFO - Rotation: Supported 07:40:44 INFO - Return code: 0 07:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:40:44 INFO - Python 2.7.3 07:40:44 INFO - Return code: 0 07:40:44 INFO - grabbing minidump binary from tooltool 07:40: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')]} 07:40:44 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 0x10f38be00>, '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 0x10f1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f386b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:40:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:40:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:40:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:40:44 INFO - Return code: 0 07:40:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:40:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:40:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:40:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:40:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:40:45 INFO - Return code: 0 07:40:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:40:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QUSZ8DUjSd/Render', 07:40:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:40:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:40:45 INFO - 'HOME': '/Users/cltbld', 07:40:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:40:45 INFO - 'LOGNAME': 'cltbld', 07:40:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:40:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:45 INFO - 'MOZ_NO_REMOTE': '1', 07:40:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:40:45 INFO - 'NO_EM_RESTART': '1', 07:40:45 INFO - 'PAGER': '/bin/cat', 07:40:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:45 INFO - 'PWD': '/builds/slave/test', 07:40:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:40:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:40:45 INFO - 'SHELL': '/bin/bash', 07:40:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elyD0nYO1K/Listeners', 07:40:45 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:40:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:40:45 INFO - 'USER': 'cltbld', 07:40:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:40:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:45 INFO - 'XPC_FLAGS': '0x0', 07:40:45 INFO - 'XPC_SERVICE_NAME': '0', 07:40:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:40:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:40:45 INFO - mozversion application_buildid: 20160512061943 07:40:45 INFO - mozversion application_changeset: fca62ad9c45ca847ac004a2b16807a63763e5c29 07:40:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:40:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:40:45 INFO - mozversion application_name: Firefox 07:40:45 INFO - mozversion application_remotingname: firefox-dev 07:40:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:40:45 INFO - mozversion application_vendor: Mozilla 07:40:45 INFO - mozversion application_version: 48.0a2 07:40:45 INFO - mozversion platform_buildid: 20160512061943 07:40:45 INFO - mozversion platform_changeset: fca62ad9c45ca847ac004a2b16807a63763e5c29 07:40:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:40:45 INFO - mozversion platform_version: 48.0a2 07:40:45 INFO - using testdate: 1463064045 07:40:45 INFO - actual date: 1463064045 07:40:45 INFO - starting webserver on 'localhost:49401' 07:40:45 INFO - SUITE-START | Running 2 tests 07:40:45 INFO - TEST-START | dromaeo_css 07:40:45 INFO - operating with platform_type : mac_ 07:40:45 INFO - Initialising browser for dromaeo_css test... 07:40:45 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp6OIKuF/profile http://localhost:49401/getInfo.html) 07:40:48 INFO - PROCESS | 2000 | __metrics Screen width/height:1600/1200 07:40:48 INFO - PROCESS | 2000 | colorDepth:24 07:40:48 INFO - PROCESS | 2000 | Browser inner width/height: 1024/689 07:40:48 INFO - PROCESS | 2000 | __metrics 07:40:48 INFO - PROCESS | 2000 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:40:48 ERROR - PROCESS | 2000 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:40:48 INFO - TEST-INFO | 2000: exit 0 07:40:48 INFO - Browser initialized. 07:40:48 INFO - Running cycle 1/1 for dromaeo_css test... 07:40:48 INFO - TEST-INFO | started process 2002 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp6OIKuF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:41:00 INFO - PROCESS | 2002 | RSS: Main: 210927616 07:41:00 INFO - PROCESS | 2002 | 07:41:51 INFO - PROCESS | 2002 | 1463064111623 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:44:03 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49401/tests/dromaeo/cssquery-ext.html) 07:44:04 INFO - PROCESS | 2002 | RSS: Main: 319918080 07:44:04 INFO - PROCESS | 2002 | 07:47:07 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-ext.html (next: http://localhost:49401/tests/dromaeo/cssquery-jquery.html) 07:47:08 INFO - PROCESS | 2002 | RSS: Main: 360947712 07:47:08 INFO - PROCESS | 2002 | 07:50:10 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49401/tests/dromaeo/cssquery-mootools.html) 07:50:10 INFO - PROCESS | 2002 | RSS: Main: 362184704 07:50:10 INFO - PROCESS | 2002 | 07:53:12 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49401/tests/dromaeo/cssquery-prototype.html) 07:53:13 INFO - PROCESS | 2002 | RSS: Main: 360972288 07:53:13 INFO - PROCESS | 2002 | 07:56:16 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49401/tests/dromaeo/cssquery-yui.html) 07:56:17 INFO - PROCESS | 2002 | RSS: Main: 324915200 07:56:17 INFO - PROCESS | 2002 | 07:59:19 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-yui.html (next: http://localhost:49401/tests/dromaeo/cssquery-dojo.html) 07:59:20 INFO - PROCESS | 2002 | RSS: Main: 368558080 07:59:20 INFO - PROCESS | 2002 | 07:59:20 INFO - PROCESS | 2002 | __start_tp_report 07:59:20 INFO - PROCESS | 2002 | _x_x_mozilla_page_load 07:59:20 INFO - PROCESS | 2002 | _x_x_mozilla_page_load_details 07:59:20 INFO - PROCESS | 2002 | |i|pagename|runs| 07:59:20 INFO - PROCESS | 2002 | |0;dojo.html;3293.8023718576887;3368.4442067058953;3383.8646454141835;3411.1131105912486;3428.588569371674;4571.679982401233;5536.4186760390185;5549.361823390312;5596.048671725806;5597.6641401515935;5547.472990065948;5579.776808927648;5583.218349431083;5605.075162598167;5614.831555053344;5041.798328066873;5093.414257360396;5142.382914050319;5151.974240128794;5199.324087868572;4611.746353950532;4902.705837649734;5107.923381149267;5184.429712731597;5207.192885102796;5132.794688212467;5179.792808287664;5186.092433824085;5195.6622819516615;5217.713025783581;5187.273781670569;5242.108841496916;5244.265802787613;5252.737363131866;5262.05283049051;5024.547790698854;5031.547160755549;5108.923366149511;5131.692098474104;5139.460356662534;4423.800928958204;5417.241586177938;5455.890882182334;5477.424870388591;5478.835634930959;6168.814935551941;6197.0704394340755;6203.100550420164;6205.038219076006;6207.162033125515;6057.273127224761;6116.944513560587;6150.862090513269;6227.782027629011;6249.125122482856;5710.828675139753;5734.8279551613105;5737.3975732548315;5740.68426236561;5767;6210.534209934182;6260.906086408617;6261.812145635638;6262.5929314594405;6275.152854364603;5862.882742345215;5960.314563825129;6093.939060609426;6107.328193898667;6113.969430152821;5478.233047373371;6058.0004299291;6110.474672510798;6193.6903154842075;6214.098955651405;6138.386161383915;6144.56988010835;6145.324014358417;6152.846178845564;6166.445019948226;6028.4272994065495;6095.116208149793;6176.289726681399;6190.81427557174;6190.969045154836;4867.951320486821;4869.220924652039;4870.951290487121;4889.437714662859;4892.68197567157;4403;4418.0942906704695;4425.668074894332;4427.424434823452;4431.911361772811;4712.50518695532;5269.367675878919;5522.337319521603;5566.666000040011;5598;6171.311552818541;6259.186305780219;6278.30938596754;6299.748010079637;6305.8108256752375;5592.888142237132;5604.355499117653;5617.38208797032;5622.24099746529;5645.23789288449;4489.438820147481;5190.870228244324;5269.077911365495;5296.2055691646565;5317.494837990384;6258.906116408258;6283.120363149072;6283.937160628427;6284.3087260402235;6298.1812364392335;6218.347073557392;6221.160143380585;6222.222222222223;6226.719797609027;6231.376862313732;6062.696865156813;6131.193168498027;6154.599951003171;6157.9692101540995;6214.658193799384;6061.7575296987625;6087;6096.207493025879;6113.266408031065;6114.571979961538;5033.823816166417;6012;6173.043178307369;6197.101420294122;6202.689865506616;5875;5912.379200183918;5974.462298393166;6003.189569408249;6007;6038.758449661965;6063.333033366414;6068.089786532056;6070.028795392716;6084.60450070744;5664.575156863334;5852;5911.733971971185;5927.8221653350465;5932.851678708067;6063.211782468251;6087.66517841523;6090.69546522681;6091.969540152271;6092.177556030057;5878.706064696663;5906.96628090074;5916.593095811712;5933.347331793413;5945.078512830518 07:59:20 INFO - PROCESS | 2002 | |1;ext.html;504.4602275565145;530.7770736290757;552.5689961829769;589.8321323778918;617.444300129883;31078.37843243134;38231;38667.8399648011;38685.22629547407;38754.41868371977;33234.501482477724;34132;42192.36711449331;42221.78889105558;42433.57566424335;8351.874721879176;8481.533515656636;9306.255499560037;9525.047495250454;9525.380850244746;11419.314841109519;11617.709557261052;11618.8257176142;11619.419029048513;11622.244554103956;11332.320060796337;11445.484953177127;11447.255928364671;11451.656450306504;11459.59891403801;8471.957640211822;8616.26761725254;8622.310215182833;8623.223909848144;11231.66305010847;11375.4881030353;11585.536578536849;11586.536538538448;11589.36258505782;11593.768124637545;38551.8072409639;38949.80525097385;38993.41509877354;39040.60959390398;39097.80451097755;3121.110483512211;3194.4569423198113;3206.5350524173864;3687.94468082979;3696.2237930034726;27451.862740686167;28167.295817604518;28311.858440707663;28544.857275713697;28926.421471570662;2465.3836540864786;2741.9451610967867;2795.7344052314997;2796.3708165662765;2822.745952864252;466537.66731166467;558955;659815;661096;662346.9999999952;64280.67859660672;64578;65002.37494062686;65127.67436162789;65136;68058;68407.97388039183;71628.64185679039;72364.63817680984;72581;17301.56746081333;17440.302387904343;17453.65092698164;17456.214470348867;17465.952042877467;12227.938860305641;12487.375631218403;13266.53567125146;13554.254516001714;13557.25435101079;19900.402987910387;19978.600427991358;20114;20173.596528069356;20193;8285.8342833143;8416.579171041545;8444.915550844413;8448.78878028042;8495.320374370036;936.8782058332373;998.8152191844532;1066.706655669697;1077.5151181968147;1120.6133883810073;30419.847900760353;30500;30549.541756873663;30872.691273087432;31123.84438077795;1155.0874808900874;1161.5237752521425;1167.3579531257774;1221.9979616714209;1249.4502418935822;15318.310676019382;15448.995815271972;15540.222988850512;15683.47336137216;15867.920660396625;644760;650624;650701;652075;654199;60690.0896486553;60790.696046519486;61568.076478852854;61642;61655;1350.3923234544495;1367.5487089260719;1507.6155580326947;1509.8867584931174;1525.2221367102636;26298.843264300227;31119.688803112585;31244.375112498077;31479.37041259116;32027.83986080055;58521.41478585159;59539;59859.700701496215;59883.700581496814;60063;559718;560972;561108;561735;565960;24017.759822401553;27433.862830685717;27705.44589108166;28292.717072829833;28331.433371332045;43641.34537981996;44111.77944110259;45378.09243815171;45556.54443455523;45692.77153614211;37551.624483754815;38412.80793596126;38620.420693690176;38923;39516.60483395129;36942.63057369392;37855;38018.111461284025;38748;38901.416478752275;30086.398272034;37039.6296037047;38410.42384364181;38486;38545.421818672185;33141;33516;33824.98525044253;33861;34023.31953360968;21161.047752851468;23482.88258558696;24510.509789803746;25278.494430111663;25405.872970635766 07:59:20 INFO - PROCESS | 2002 | |2;jquery.html;354.35684233116893;392.3095352180163;398.53570590262336;404.75512315049394;413.33040474431385;19497;20216.494587635316;20843.583128337425;21020.8948955255;21546.676799848014;20475.87382693951;20765.96170191492;21119.260825871097;21730.348089557297;21740.782592174073;5776.682282474462;5883.646981181143;5966.67183304918;5974.8506287342725;5984.910226346608;5771.971140144294;5886.4113588641;5899.233099697033;5969.074793407029;5980.940190598104;5812.941870581303;5901.262342207224;5903.439173278532;5910.734016969225;5918.88162236755;5820.941790582082;5821.970890145564;5833.8833223335505;5866.442687944638;5870.530357571384;5102.056119617882;5188.688678679291;5189;5190.351206099238;5191.351081114861;26193.214203573923;26387.604185937227;26518.071867484545;26595;26673.06644267441;2239.9888000559895;2349.706286714161;2390.1992832401165;2446.963295550568;2685.489756946174;15019.624509387353;15082;15190.468333608382;15236.390544378211;15554.988925719905;1736.505096047633;1785.4375871600405;1790.6866298397858;1803.1525183163892;1891.5649400637792;101534;104619;111552;112493;116017.83982160155;10978.066864316463;11296.774064518664;11475.942620286845;11527.596534121265;11659.183857130089;11826.645200643994;14326.140431574138;14413.855861441461;14415.207163605892;14448.783268250985;8771.473711577326;8885.600147993357;8928.15182557656;8960.820783584291;9034.819303614022;8972.19250267479;8986.86519702205;8990.145936136056;9057.411268267542;9081.863772043425;6714.597124172467;6796.451330750969;6826.283240259801;6826.692798824065;6848.6918088686125;1877.1928070929632;1907.122723547156;1914.3969649560345;1918.8081191880979;1944.6207989441923;957.3250858144991;1018.1193267823279;1027.0807627173638;1028.1980055556678;1045.5817672930737;20621.58756824885;21273.574528509344;21472.78527214739;21757.456063598536;21833.344999650035;992.5087081894509;999.5452069308448;1003.7440452684518;1015.939043657383;1021.8927012663563;9387.436753794795;11195.25979037515;11584.942075289739;11591.420428978518;11599.478023488964;600149;611158;615419;620030;621658;64295.03557446642;84563.73154402689;105672;107981;118284;1024.6721049264313;1027.6095083868083;1029.7528593137592;1059.195011791029;1063.7978784031163;19161.808381916002;19489.902550487157;19542.31601893927;19714.704279436108;20066.436578964476;47224.58326250218;47477.52522474731;49250;51473;52471;62958.685206573675;65918;66021.33978660151;67219.66390168213;69237.96143057758;7995.080565735015;8134.796630084295;8203.794905127419;8249.79375515617;8498.830023399621;12688.302143382203;12725.045621578234;12799.488020479077;13020.869791301966;13048.869511304765;10559.736006599896;11106.222564420736;11277.097832173242;11445.313281203154;11563.88436115628;10923.399213043358;11015.944920275668;11060.668179954615;11362.204645674723;11472.82790758156;11393.487293071666;11459.942700286445;11501.849815018431;11762.647120586396;11814.94092529532;8095.190480951857;8221.218984196492;8242.17578242171;8248.958755206186;8391.035030971516;11211.215214934877;11232.943835280772;11446;11480.253783504046;11579.478923448634 07:59:20 INFO - PROCESS | 2002 | |3;mootools.html;1436.7413865504218;1581.4939219449775;1604.7913771209742;1829.9634007319853;1952.5801952580202;7759.689612415504;8467.661293548259;8655.134486551358;8667.60995755191;8668.783280417985;8338.45800022998;8586.828263434727;8589.91410085899;8598.441101328424;8603.655853765842;2079.6880467929855;2135.540858715376;2139.229877244191;2394.305651361103;2424.599941009731;2136.807687308142;2364.361622361961;2438.8658623775686;2439.1097249503982;2439.7072351317865;2363.598188307983;2399.4961058177714;2405.1461731085387;2407.554602398553;2410.9517809643885;2111.6410210264294;2408.542376948374;2413.722421921484;2415.7825795678295;2418.6251131074623;2370.0519792083132;2441.157800558822;2443.7800597946093;2445.0464318915638;2445.2297526279167;8540.914590854074;8583.871241931314;8586.527740974245;8591.527465989368;8613.913860861374;5153.66501177426;5230.607704422146;5260.973695131538;5265.499777521168;5288.68267903927;3347.916302092443;3427.2288735034667;3490.8778192763384;3501;3511.473279008144;1041.6874937518714;1054.3463052907246;1057.7144171073767;1075.4837677914566;1096.7916095941825;11387.943060284728;11401.48693308803;11414.315141091562;11434.885651143466;11491.885081149248;4329.8525890639;4417.293233082692;4426.981794187355;4468;4795.520447955247;9784.168345690554;9813.411195328303;9813.411195328303;9818.45998470091;9856.655017074369;5300.549453296436;5301.522862942354;5320.334958130234;5329.57363410934;5340.439253878365;4283.24387001328;4373.343998400265;4829.372181616438;4870.342503761947;4884.755762211875;3981.7013723970817;4033.798310084484;4067.430559721641;4069.552349241581;4102;1328.5947785925387;1348.2719331561043;1351.1487762709626;1354.8035534847393;1362.1758835904334;894.4499133033268;902.5126431726925;933.262722449271;934.1405906565975;959.2709540749081;5698.401667824819;5833.008388573952;5874.530037596982;5890.793822216202;6005.850886821611;917.1149840404042;917.2616044084442;936.9578368973413;968.2931460034074;969.1471505075489;3766.60450652683;3827.234553089393;3842.558105817811;3885.436611691289;3916.6279203475624;10089.697309080739;10276.691699249035;10463.319884207502;10480;10584.259101862795;10272.589096436208;10290.639827605997;10314.02016808402;10318.535665895053;10419.479026048668;6087.969560152171;7745.573993430303;8087.838243235103;8184.468009579358;8525.914740852637;5562.944370556243;5616.69108199053;5784.710764461676;5801.332846722512;5903.321118071477;9113.908860911306;9188.44869307817;9205.079492051009;9241.537923103953;9360.4383736976;9331.066893310615;9462.952685236529;9493.66772162971;9513.191378732885;9608.27937904646;7247.746328878464;7493.812654683677;7514.248575142442;7959.92040079615;7960.721374752087;7197.352238298578;8091.352691784761;8276.58617069132;8288.50268983863;8299.751007469786;7131.750388736369;7237.927620723725;7249.963750181426;7317.414606831547;7420.220876807857;7107.466939979626;7120.501564890408;7187.353138217585;7240.493165478366;7241.4206863451855;6776.864462710817;6905.37851593359;6930.5148639594745;6975.581465112109;7010.088688470466;4048.311786996159;4763.857084287477;4804.6876952997945;4899.804007839646;4978.775955081957;4837.05677392905;4887.902241955212;4899.755012249445;4935.679180853233;5113.41195762492 07:59:20 INFO - PROCESS | 2002 | |4;prototype.html;293.1557115507338;299.5970419785388;316.5615622363028;321.78279661228675;331.2447619427705;6692.63190524521;6733.293004234552;6736.730530778763;6758.053872457847;6788.830279243015;6647.966760166204;6680.03139544767;6690;6718.46252299816;6761.1210542629515;4774.3077253798265;4856.975715121437;4862.076205520957;4873.147199240137;5051.116054690433;4992.176290911995;5010.624203184758;5015.899682006358;5023.296738456619;5039.866030143206;4878.878028049292;4945.77744001519;4947.727874966876;4968.30443737877;4980.800767969277;4188.539260681323;4735.337052812609;4805.639577031737;4899.118158731427;4954.207326827726;4222.838719352172;4226.281532139544;4233.640140588053;4236.428082208893;4239.130978149472;6417.358264173592;6423.710933008026;6473.870522589569;6478.2873883872735;6481.83795405114;5871;5876.147958546029;5898;5907.734151963129;5909.113632955048;7172;7174.677139528681;7178.892316615255;7179.784606461814;7198.064251647253;4583.1062942726185;4702.294655801623;4764.071006153801;4779.880502987453;4783.689060211075;7545.547267163988;7600.619969001527;7619.199984001711;7632.580208088553;7640.73257435987;4150;4731.976340118277;4868.148074087091;4868.926966095441;4870.14772414826;4042.656374208166;4930.580900623487;4932.975335123373;4938.654294199443;4941.925871111936;5877.471027607536;5889;5894.764209431574;5895.086261629454;5914.852128696731;6866.313368663094;7128.786136415916;7185.53294035886;7215.711371545184;7232.059832221883;1591.618011677189;1601.471514400245;1617.6522047759788;1618.328393716618;1621.1894052973514;920.5673333533229;967.2358836519071;993.6373223773415;1038.3043360948184;1064.7284942339654;6468.191476065492;6586.242582103119;6593.274739778621;6707.295733947963;6736.93263067363;7455.552666839899;7473.6263186841525;7530.849383012309;7543.245675432413;7578.583177925157;4698.976505117521;6753.966230168818;6778.18661760582;6783.355581219875;6942.340477654615;3931.233409485123;3987.441758153861;3987.7407968481957;3990.0224445010576;3991.5210174779213;7521.699132034657;7835.921640783519;7862.488938219112;7863.449558530848;7870.173631768582;6589;7694.153643099255;7702.768916932501;7715.189905059888;7717.536947783151;7800.492967957065;7813.765587032398;7817.10103338112;7825.921740782747;7851.018622672166;7200.747973820891;7470;7493.175750667531;7493.662785174572;7518.436117291334;7285.979962805318;7326.670299836626;7341.816454588678;7342.5227360221415;7351.889721654073;7820.687172513263;7829.3345065670055;7849.293563579306;7866.567338796421;7870.803229919298;4709;4711.199096153594;4711.646626502958;4712.057588482386;4713.434387873477;6788.151481064867;7159.964200178966;7443.776686699408;7446.957425960261;7454.217307182667;7124.180719217149;7173;7174.139103307636;7175.569465832067;7194.776887929169;5839.240898683144;7160.641967901688;7309.195988441374;7338.486305958531;7345.192028876926;5668.291463567054;7013.018177455262;7016.26329235423;7016.719331226898;7023.051887995055;6846.246912839484;7166;7166.713331466892;7178.353948144692;7180.676869540987;6704;6943.652817359213;6958.373746362851;7011.439084873095;7047.788566343018 07:59:20 INFO - PROCESS | 2002 | |5;yui.html;684.4797953555299;740.9110906691197;759.2369668483177;773.5049568276304;773.8529679360925;15117.546473605797;15380.154091524962;15394.923025384871;15402.460913868017;15413.614659633515;13949.511767088128;13986.790198147011;13992.65018374541;14004.719905601907;14025.999999999975;735.7608777147422;752.9397648188159;922.432703887108;947.3605316411429;952.2524818017857;930.3859452761179;945.5508633399149;946.4132238012407;952.6713283917038;953.5327689432163;995.5520015992832;999.2605471950741;1000.0949141027381;1001.4892404873531;1003.909648131668;782.62042909189;965.4448692002056;983.788485475619;990.1682586627196;999.1307562420704;739.1536690489413;739.3567596191294;740.8851627997669;741.1439787045971;745.4483682075279;14052.156870587798;14077.859221407758;14100.788488172686;14106.788398174036;14140.575782726535;11791.941040294743;11858.644240672793;11943.781067242375;11988.70028249292;12243.69390765229;9926.751831204205;10002;10152.746181345452;10365.170786337076;10650.236985602565;3468.7745296555895;3481.3211423772373;3498.3003399320237;3541.3271478419274;3641.1261297288725;84183.57908210481;84325.15674843235;84997.57501212516;85707.5714621429;86512.5674371624;9270.397424167408;9284.628614855465;9291.396059256127;9481.66814161501;9484.95257523708;20542.281020164522;20600.484987875123;20604.175832966812;20635.79364206339;20654.690179647318;7079.469039822034;7119.430445564342;7130.857382852418;7273.27267273279;7456.627168641547;3472.774269672463;3996.9400458993136;4062.8171732271526;4091.4272001919753;4229.323308270724;3606.1705807664384;3670.6512881276235;3673.393890008172;3676.871309504208;3676.889693309205;621.4686443091182;646.360103497534;661.497262080822;668.6088638146641;680.4080450008425;509.3487753376284;532.738957910621;538.8114160044032;577.3302968556454;612.2958597612692;8150.633221505046;8164.469309494863;8164.591770411455;8202.917970820215;8219.917800822035;594.9464548190683;596.5049009322252;596.8612817175331;601.3535449391921;621.4407033669643;3743.9438408423894;3809.154112980694;3840.8271627776817;3849.5957924418094;3867.439221312894;91650;92007;92246;92609.53695231481;92998;72185;72819;73112.90330645045;73945.63027184829;74457.62771186109;66045;66970.99543506754;67973.66013169903;68691.96962045574;69636;7467.58928258951;7557.848843022999;7581.166071732216;7736.1877002916135;7803.687852485837;45182.77408612936;45994;46218.53781462277;46372.7681361591;46529;60603.69698151481;64278;65118;65255.36861578499;65777.67111164413;9904.851427228741;10031.197504199792;10090.2432317575;10140.898591013995;10181.796364072825;10741.033307002095;10815.188860835311;10990.285631433931;11012.229143959847;11509.712257193638;10270.07569318765;10318.43248621303;10376.273660843668;10478.63324783629;10637.574497020032;10387.740306492398;10426.165906727596;10528.420936848546;10568.84146737815;10610.204234682275;10154.949225253826;10159.187265018929;10253.641122560675;10292;10376.740581485523;8962.097236412517;8999.505027223566;9073.546322683971;9170.495622740813;9713.757156071155;8535.8719619207;9086.182243598108;9582.960087588224;9683.66107186245;9950.900490994998 07:59:20 INFO - PROCESS | 2002 | __end_tp_report 07:59:20 INFO - PROCESS | 2002 | __start_cc_report 07:59:20 INFO - PROCESS | 2002 | _x_x_mozilla_cycle_collect,1073 07:59:20 INFO - PROCESS | 2002 | __end_cc_report 07:59:20 INFO - PROCESS | 2002 | __startTimestamp1463065160188__endTimestamp 07:59:20 INFO - PROCESS | 2002 | 07:59:20 INFO - PROCESS | 2002 | ------- Summary: start ------- 07:59:20 INFO - PROCESS | 2002 | Number of tests: 6 07:59:20 INFO - PROCESS | 2002 | 07:59:20 INFO - PROCESS | 2002 | [#0] dojo.html Cycles:165 Average:5638.33 Median:5906.97 stddev:655.51 (11.1%) stddev-sans-first:631.19 07:59:20 INFO - PROCESS | 2002 | Values: 3293.8 3368.4 3383.9 3411.1 3428.6 4571.7 5536.4 5549.4 5596.0 5597.7 5547.5 5579.8 5583.2 5605.1 5614.8 5041.8 5093.4 5142.4 5152.0 5199.3 4611.7 4902.7 5107.9 5184.4 5207.2 5132.8 5179.8 5186.1 5195.7 5217.7 5187.3 5242.1 5244.3 5252.7 5262.1 5024.5 5031.5 5108.9 5131.7 5139.5 4423.8 5417.2 5455.9 5477.4 5478.8 6168.8 6197.1 6203.1 6205.0 6207.2 6057.3 6116.9 6150.9 6227.8 6249.1 5710.8 5734.8 5737.4 5740.7 5767.0 6210.5 6260.9 6261.8 6262.6 6275.2 5862.9 5960.3 6093.9 6107.3 6114.0 5478.2 6058.0 6110.5 6193.7 6214.1 6138.4 6144.6 6145.3 6152.8 6166.4 6028.4 6095.1 6176.3 6190.8 6191.0 4868.0 4869.2 4871.0 4889.4 4892.7 4403.0 4418.1 4425.7 4427.4 4431.9 4712.5 5269.4 5522.3 5566.7 5598.0 6171.3 6259.2 6278.3 6299.7 6305.8 5592.9 5604.4 5617.4 5622.2 5645.2 4489.4 5190.9 5269.1 5296.2 5317.5 6258.9 6283.1 6283.9 6284.3 6298.2 6218.3 6221.2 6222.2 6226.7 6231.4 6062.7 6131.2 6154.6 6158.0 6214.7 6061.8 6087.0 6096.2 6113.3 6114.6 5033.8 6012.0 6173.0 6197.1 6202.7 5875.0 5912.4 5974.5 6003.2 6007.0 6038.8 6063.3 6068.1 6070.0 6084.6 5664.6 5852.0 5911.7 5927.8 5932.9 6063.2 6087.7 6090.7 6092.0 6092.2 5878.7 5907.0 5916.6 5933.3 5945.1 07:59:20 INFO - PROCESS | 2002 | 07:59:20 INFO - PROCESS | 2002 | [#1] ext.html Cycles:180 Average:73752.72 Median:18909.97 stddev:162504.82 (859.4%) stddev-sans-first:162867.63 07:59:20 INFO - PROCESS | 2002 | Values: 504.5 530.8 552.6 589.8 617.4 31078.4 38231.0 38667.8 38685.2 38754.4 33234.5 34132.0 42192.4 42221.8 42433.6 8351.9 8481.5 9306.3 9525.0 9525.4 11419.3 11617.7 11618.8 11619.4 11622.2 11332.3 11445.5 11447.3 11451.7 11459.6 8472.0 8616.3 8622.3 8623.2 11231.7 11375.5 11585.5 11586.5 11589.4 11593.8 38551.8 38949.8 38993.4 39040.6 39097.8 3121.1 3194.5 3206.5 3687.9 3696.2 27451.9 28167.3 28311.9 28544.9 28926.4 2465.4 2741.9 2795.7 2796.4 2822.7 466537.7 558955.0 659815.0 661096.0 662347.0 64280.7 64578.0 65002.4 65127.7 65136.0 68058.0 68408.0 71628.6 72364.6 72581.0 17301.6 17440.3 17453.7 17456.2 17466.0 12227.9 12487.4 13266.5 13554.3 13557.3 19900.4 19978.6 20114.0 20173.6 20193.0 8285.8 8416.6 8444.9 8448.8 8495.3 936.9 998.8 1066.7 1077.5 1120.6 30419.8 30500.0 30549.5 30872.7 31123.8 1155.1 1161.5 1167.4 1222.0 1249.5 15318.3 15449.0 15540.2 15683.5 15867.9 644760.0 650624.0 650701.0 652075.0 654199.0 60690.1 60790.7 61568.1 61642.0 61655.0 1350.4 1367.5 1507.6 1509.9 1525.2 26298.8 31119.7 31244.4 31479.4 32027.8 58521.4 59539.0 59859.7 59883.7 60063.0 559718.0 560972.0 561108.0 561735.0 565960.0 24017.8 27433.9 27705.4 28292.7 28331.4 43641.3 44111.8 45378.1 45556.5 45692.8 37551.6 38412.8 38620.4 38923.0 39516.6 36942.6 37855.0 38018.1 38748.0 38901.4 30086.4 37039.6 38410.4 38486.0 38545.4 33141.0 33516.0 33825.0 33861.0 34023.3 21161.0 23482.9 24510.5 25278.5 25405.9 07:59:20 INFO - PROCESS | 2002 | 07:59:20 INFO - PROCESS | 2002 | [#2] jquery.html Cycles:180 Average:34262.43 Median:21735.57 stddev:101269.24 (465.9%) stddev-sans-first:101521.32 07:59:20 INFO - PROCESS | 2002 | Values: 354.4 392.3 398.5 404.8 413.3 19497.0 20216.5 20843.6 21020.9 21546.7 20475.9 20766.0 21119.3 21730.3 21740.8 5776.7 5883.6 5966.7 5974.9 5984.9 5772.0 5886.4 5899.2 5969.1 5980.9 5812.9 5901.3 5903.4 5910.7 5918.9 5820.9 5822.0 5833.9 5866.4 5870.5 5102.1 5188.7 5189.0 5190.4 5191.4 26193.2 26387.6 26518.1 26595.0 26673.1 2240.0 2349.7 2390.2 2447.0 2685.5 15019.6 15082.0 15190.5 15236.4 15555.0 1736.5 1785.4 1790.7 1803.2 1891.6 101534.0 104619.0 111552.0 112493.0 116017.8 10978.1 11296.8 11475.9 11527.6 11659.2 11826.6 14326.1 14413.9 14415.2 14448.8 8771.5 8885.6 8928.2 8960.8 9034.8 8972.2 8986.9 8990.1 9057.4 9081.9 6714.6 6796.5 6826.3 6826.7 6848.7 1877.2 1907.1 1914.4 1918.8 1944.6 957.3 1018.1 1027.1 1028.2 1045.6 20621.6 21273.6 21472.8 21757.5 21833.3 992.5 999.5 1003.7 1015.9 1021.9 9387.4 11195.3 11584.9 11591.4 11599.5 600149.0 611158.0 615419.0 620030.0 621658.0 64295.0 84563.7 105672.0 107981.0 118284.0 1024.7 1027.6 1029.8 1059.2 1063.8 19161.8 19489.9 19542.3 19714.7 20066.4 47224.6 47477.5 49250.0 51473.0 52471.0 62958.7 65918.0 66021.3 67219.7 69238.0 7995.1 8134.8 8203.8 8249.8 8498.8 12688.3 12725.0 12799.5 13020.9 13048.9 10559.7 11106.2 11277.1 11445.3 11563.9 10923.4 11015.9 11060.7 11362.2 11472.8 11393.5 11459.9 11501.8 11762.6 11814.9 8095.2 8221.2 8242.2 8249.0 8391.0 11211.2 11232.9 11446.0 11480.3 11579.5 07:59:20 INFO - PROCESS | 2002 | 07:59:20 INFO - PROCESS | 2002 | [#3] mootools.html Cycles:180 Average:5583.31 Median:5192.14 stddev:3071.74 (59.2%) stddev-sans-first:3064.55 07:59:20 INFO - PROCESS | 2002 | Values: 1436.7 1581.5 1604.8 1830.0 1952.6 7759.7 8467.7 8655.1 8667.6 8668.8 8338.5 8586.8 8589.9 8598.4 8603.7 2079.7 2135.5 2139.2 2394.3 2424.6 2136.8 2364.4 2438.9 2439.1 2439.7 2363.6 2399.5 2405.1 2407.6 2411.0 2111.6 2408.5 2413.7 2415.8 2418.6 2370.1 2441.2 2443.8 2445.0 2445.2 8540.9 8583.9 8586.5 8591.5 8613.9 5153.7 5230.6 5261.0 5265.5 5288.7 3347.9 3427.2 3490.9 3501.0 3511.5 1041.7 1054.3 1057.7 1075.5 1096.8 11387.9 11401.5 11414.3 11434.9 11491.9 4329.9 4417.3 4427.0 4468.0 4795.5 9784.2 9813.4 9813.4 9818.5 9856.7 5300.5 5301.5 5320.3 5329.6 5340.4 4283.2 4373.3 4829.4 4870.3 4884.8 3981.7 4033.8 4067.4 4069.6 4102.0 1328.6 1348.3 1351.1 1354.8 1362.2 894.4 902.5 933.3 934.1 959.3 5698.4 5833.0 5874.5 5890.8 6005.9 917.1 917.3 937.0 968.3 969.1 3766.6 3827.2 3842.6 3885.4 3916.6 10089.7 10276.7 10463.3 10480.0 10584.3 10272.6 10290.6 10314.0 10318.5 10419.5 6088.0 7745.6 8087.8 8184.5 8525.9 5562.9 5616.7 5784.7 5801.3 5903.3 9113.9 9188.4 9205.1 9241.5 9360.4 9331.1 9463.0 9493.7 9513.2 9608.3 7247.7 7493.8 7514.2 7959.9 7960.7 7197.4 8091.4 8276.6 8288.5 8299.8 7131.8 7237.9 7250.0 7317.4 7420.2 7107.5 7120.5 7187.4 7240.5 7241.4 6776.9 6905.4 6930.5 6975.6 7010.1 4048.3 4763.9 4804.7 4899.8 4978.8 4837.1 4887.9 4899.8 4935.7 5113.4 07:59:20 INFO - PROCESS | 2002 | 07:59:20 INFO - PROCESS | 2002 | [#4] prototype.html Cycles:180 Average:5878.45 Median:6725.88 stddev:1896.66 (28.2%) stddev-sans-first:1855.07 07:59:20 INFO - PROCESS | 2002 | Values: 293.2 299.6 316.6 321.8 331.2 6692.6 6733.3 6736.7 6758.1 6788.8 6648.0 6680.0 6690.0 6718.5 6761.1 4774.3 4857.0 4862.1 4873.1 5051.1 4992.2 5010.6 5015.9 5023.3 5039.9 4878.9 4945.8 4947.7 4968.3 4980.8 4188.5 4735.3 4805.6 4899.1 4954.2 4222.8 4226.3 4233.6 4236.4 4239.1 6417.4 6423.7 6473.9 6478.3 6481.8 5871.0 5876.1 5898.0 5907.7 5909.1 7172.0 7174.7 7178.9 7179.8 7198.1 4583.1 4702.3 4764.1 4779.9 4783.7 7545.5 7600.6 7619.2 7632.6 7640.7 4150.0 4732.0 4868.1 4868.9 4870.1 4042.7 4930.6 4933.0 4938.7 4941.9 5877.5 5889.0 5894.8 5895.1 5914.9 6866.3 7128.8 7185.5 7215.7 7232.1 1591.6 1601.5 1617.7 1618.3 1621.2 920.6 967.2 993.6 1038.3 1064.7 6468.2 6586.2 6593.3 6707.3 6736.9 7455.6 7473.6 7530.8 7543.2 7578.6 4699.0 6754.0 6778.2 6783.4 6942.3 3931.2 3987.4 3987.7 3990.0 3991.5 7521.7 7835.9 7862.5 7863.4 7870.2 6589.0 7694.2 7702.8 7715.2 7717.5 7800.5 7813.8 7817.1 7825.9 7851.0 7200.7 7470.0 7493.2 7493.7 7518.4 7286.0 7326.7 7341.8 7342.5 7351.9 7820.7 7829.3 7849.3 7866.6 7870.8 4709.0 4711.2 4711.6 4712.1 4713.4 6788.2 7160.0 7443.8 7447.0 7454.2 7124.2 7173.0 7174.1 7175.6 7194.8 5839.2 7160.6 7309.2 7338.5 7345.2 5668.3 7013.0 7016.3 7016.7 7023.1 6846.2 7166.0 7166.7 7178.4 7180.7 6704.0 6943.7 6958.4 7011.4 7047.8 07:59:20 INFO - PROCESS | 2002 | 07:59:20 INFO - PROCESS | 2002 | [#5] yui.html Cycles:180 Average:17786.71 Median:616.87 stddev:25323.71 (4105.2%) stddev-sans-first:25362.19 07:59:20 INFO - PROCESS | 2002 | Values: 684.5 740.9 759.2 773.5 773.9 15117.5 15380.2 15394.9 15402.5 15413.6 13949.5 13986.8 13992.7 14004.7 14026.0 735.8 752.9 922.4 947.4 952.3 930.4 945.6 946.4 952.7 953.5 995.6 999.3 1000.1 1001.5 1003.9 782.6 965.4 983.8 990.2 999.1 739.2 739.4 740.9 741.1 745.4 14052.2 14077.9 14100.8 14106.8 14140.6 11791.9 11858.6 11943.8 11988.7 12243.7 9926.8 10002.0 10152.7 10365.2 10650.2 3468.8 3481.3 3498.3 3541.3 3641.1 84183.6 84325.2 84997.6 85707.6 86512.6 9270.4 9284.6 9291.4 9481.7 9485.0 20542.3 20600.5 20604.2 20635.8 20654.7 7079.5 7119.4 7130.9 7273.3 7456.6 3472.8 3996.9 4062.8 4091.4 4229.3 3606.2 3670.7 3673.4 3676.9 3676.9 621.5 646.4 661.5 668.6 680.4 509.3 532.7 538.8 577.3 612.3 8150.6 8164.5 8164.6 8202.9 8219.9 594.9 596.5 596.9 601.4 621.4 3743.9 3809.2 3840.8 3849.6 3867.4 91650.0 92007.0 92246.0 92609.5 92998.0 72185.0 72819.0 73112.9 73945.6 74457.6 66045.0 66971.0 67973.7 68692.0 69636.0 7467.6 7557.8 7581.2 7736.2 7803.7 45182.8 45994.0 46218.5 46372.8 46529.0 60603.7 64278.0 65118.0 65255.4 65777.7 9904.9 10031.2 10090.2 10140.9 10181.8 10741.0 10815.2 10990.3 11012.2 11509.7 10270.1 10318.4 10376.3 10478.6 10637.6 10387.7 10426.2 10528.4 10568.8 10610.2 10154.9 10159.2 10253.6 10292.0 10376.7 8962.1 8999.5 9073.5 9170.5 9713.8 8535.9 9086.2 9583.0 9683.7 9950.9 07:59:20 INFO - PROCESS | 2002 | -------- Summary: end -------- 07:59:20 INFO - PROCESS | 2002 | 07:59:20 INFO - TEST-INFO | 2002: exit 0 07:59:20 INFO - TEST-OK | dromaeo_css | took 1114968ms 07:59:20 INFO - TEST-START | kraken 07:59:20 INFO - operating with platform_type : mac_ 07:59:20 INFO - Initialising browser for kraken test... 07:59:20 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpzpjVFB/profile http://localhost:49401/getInfo.html) 07:59:23 INFO - PROCESS | 2005 | __metrics Screen width/height:1600/1200 07:59:23 INFO - PROCESS | 2005 | colorDepth:24 07:59:23 INFO - PROCESS | 2005 | Browser inner width/height: 1024/689 07:59:23 INFO - PROCESS | 2005 | __metrics 07:59:23 INFO - PROCESS | 2005 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:59:23 ERROR - PROCESS | 2005 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:59:23 INFO - TEST-INFO | 2005: exit 0 07:59:23 INFO - Browser initialized. 07:59:23 INFO - Running cycle 1/1 for kraken test... 07:59:23 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpzpjVFB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:59:35 INFO - PROCESS | 2007 | RSS: Main: 211468288 07:59:35 INFO - PROCESS | 2007 | 07:59:38 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-beat-detection) 07:59:39 INFO - PROCESS | 2007 | RSS: Main: 271941632 07:59:39 INFO - PROCESS | 2007 | 07:59:42 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-dft) 07:59:42 INFO - PROCESS | 2007 | RSS: Main: 285831168 07:59:42 INFO - PROCESS | 2007 | 07:59:45 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-fft) 07:59:46 INFO - PROCESS | 2007 | RSS: Main: 375054336 07:59:46 INFO - PROCESS | 2007 | 07:59:48 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-oscillator) 07:59:49 INFO - PROCESS | 2007 | RSS: Main: 280240128 07:59:49 INFO - PROCESS | 2007 | 07:59:51 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:59:51 INFO - PROCESS | 2007 | RSS: Main: 280113152 07:59:51 INFO - PROCESS | 2007 | 07:59:54 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49401/tests/kraken/driver.html?testName=imaging-darkroom) 07:59:55 INFO - PROCESS | 2007 | RSS: Main: 319119360 07:59:55 INFO - PROCESS | 2007 | 07:59:58 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49401/tests/kraken/driver.html?testName=imaging-desaturate) 07:59:58 INFO - PROCESS | 2007 | RSS: Main: 318959616 07:59:58 INFO - PROCESS | 2007 | 08:00:01 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49401/tests/kraken/driver.html?testName=json-parse-financial) 08:00:02 INFO - PROCESS | 2007 | RSS: Main: 316198912 08:00:02 INFO - PROCESS | 2007 | 08:00:04 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:00:04 INFO - PROCESS | 2007 | RSS: Main: 309452800 08:00:04 INFO - PROCESS | 2007 | 08:00:06 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:00:07 INFO - PROCESS | 2007 | RSS: Main: 316760064 08:00:07 INFO - PROCESS | 2007 | 08:00:09 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:00:10 INFO - PROCESS | 2007 | RSS: Main: 318840832 08:00:10 INFO - PROCESS | 2007 | 08:00:12 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:00:13 INFO - PROCESS | 2007 | RSS: Main: 321490944 08:00:13 INFO - PROCESS | 2007 | 08:00:16 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:00:16 INFO - PROCESS | 2007 | RSS: Main: 321982464 08:00:16 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49401/tests/kraken/driver.html?testName=ai-astar) 08:00:18 INFO - PROCESS | 2007 | RSS: Main: 386551808 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | __start_tp_report 08:00:18 INFO - PROCESS | 2007 | _x_x_mozilla_page_load 08:00:18 INFO - PROCESS | 2007 | _x_x_mozilla_page_load_details 08:00:18 INFO - PROCESS | 2007 | |i|pagename|runs| 08:00:18 INFO - PROCESS | 2007 | |0;ai-astar;114;114;119;113;114;113;114;112;113;132 08:00:18 INFO - PROCESS | 2007 | |1;audio-beat-detection;157;122;146;169;119;140;120;152;159;124 08:00:18 INFO - PROCESS | 2007 | |2;audio-dft;182;187;187;186;184;185;185;185;184;186 08:00:18 INFO - PROCESS | 2007 | |3;audio-fft;71;80;77;156;56;56;55;65;135;56 08:00:18 INFO - PROCESS | 2007 | |4;audio-oscillator;91;91;145;76;81;78;127;79;78;161 08:00:18 INFO - PROCESS | 2007 | |5;imaging-gaussian-blur;89;87;90;88;88;86;91;86;91;89 08:00:18 INFO - PROCESS | 2007 | |6;imaging-darkroom;94;94;138;149;103;93;93;94;94;94 08:00:18 INFO - PROCESS | 2007 | |7;imaging-desaturate;84;103;135;131;83;83;85;84;85;85 08:00:18 INFO - PROCESS | 2007 | |8;json-parse-financial;60;64;63;63;62;63;64;85;57;56 08:00:18 INFO - PROCESS | 2007 | |9;json-stringify-tinderbox;65;67;69;69;82;77;72;68;70;69 08:00:18 INFO - PROCESS | 2007 | |10;stanford-crypto-aes;82;81;82;78;81;82;82;78;81;85 08:00:18 INFO - PROCESS | 2007 | |11;stanford-crypto-ccm;145;151;123;141;131;128;130;129;189;150 08:00:18 INFO - PROCESS | 2007 | |12;stanford-crypto-pbkdf2;165;167;168;171;169;163;155;165;170;163 08:00:18 INFO - PROCESS | 2007 | |13;stanford-crypto-sha256-iterative;70;72;95;95;96;70;67;72;67;67 08:00:18 INFO - PROCESS | 2007 | __end_tp_report 08:00:18 INFO - PROCESS | 2007 | __start_cc_report 08:00:18 INFO - PROCESS | 2007 | _x_x_mozilla_cycle_collect,2027 08:00:18 INFO - PROCESS | 2007 | __end_cc_report 08:00:18 INFO - PROCESS | 2007 | __startTimestamp1463065218950__endTimestamp 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | ------- Summary: start ------- 08:00:18 INFO - PROCESS | 2007 | Number of tests: 14 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#0] ai-astar Cycles:10 Average:115.80 Median:114.00 stddev:6.00 (5.3%) stddev-sans-first:6.32 08:00:18 INFO - PROCESS | 2007 | Values: 114.0 114.0 119.0 113.0 114.0 113.0 114.0 112.0 113.0 132.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:149.00 stddev:18.52 (12.4%) stddev-sans-first:18.69 08:00:18 INFO - PROCESS | 2007 | Values: 157.0 122.0 146.0 169.0 119.0 140.0 120.0 152.0 159.0 124.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#2] audio-dft Cycles:10 Average:185.10 Median:185.50 stddev:1.52 (0.8%) stddev-sans-first:1.13 08:00:18 INFO - PROCESS | 2007 | Values: 182.0 187.0 187.0 186.0 184.0 185.0 185.0 185.0 184.0 186.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#3] audio-fft Cycles:10 Average:80.70 Median:60.50 stddev:35.69 (59.0%) stddev-sans-first:37.68 08:00:18 INFO - PROCESS | 2007 | Values: 71.0 80.0 77.0 156.0 56.0 56.0 55.0 65.0 135.0 56.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:78.50 stddev:31.58 (40.2%) stddev-sans-first:33.30 08:00:18 INFO - PROCESS | 2007 | Values: 91.0 91.0 145.0 76.0 81.0 78.0 127.0 79.0 78.0 161.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.00 stddev:1.84 (2.1%) stddev-sans-first:1.94 08:00:18 INFO - PROCESS | 2007 | Values: 89.0 87.0 90.0 88.0 88.0 86.0 91.0 86.0 91.0 89.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:94.00 stddev:20.87 (22.2%) stddev-sans-first:21.78 08:00:18 INFO - PROCESS | 2007 | Values: 94.0 94.0 138.0 149.0 103.0 93.0 93.0 94.0 94.0 94.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:84.00 stddev:20.50 (24.4%) stddev-sans-first:21.30 08:00:18 INFO - PROCESS | 2007 | Values: 84.0 103.0 135.0 131.0 83.0 83.0 85.0 84.0 85.0 85.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.00 stddev:8.00 (12.7%) stddev-sans-first:8.37 08:00:18 INFO - PROCESS | 2007 | Values: 60.0 64.0 63.0 63.0 62.0 63.0 64.0 85.0 57.0 56.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:69.50 stddev:5.07 (7.3%) stddev-sans-first:4.93 08:00:18 INFO - PROCESS | 2007 | Values: 65.0 67.0 69.0 69.0 82.0 77.0 72.0 68.0 70.0 69.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:82.00 stddev:2.04 (2.5%) stddev-sans-first:2.15 08:00:18 INFO - PROCESS | 2007 | Values: 82.0 81.0 82.0 78.0 81.0 82.0 82.0 78.0 81.0 85.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:143.00 stddev:19.30 (13.5%) stddev-sans-first:20.44 08:00:18 INFO - PROCESS | 2007 | Values: 145.0 151.0 123.0 141.0 131.0 128.0 130.0 129.0 189.0 150.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:167.50 stddev:4.65 (2.8%) stddev-sans-first:4.92 08:00:18 INFO - PROCESS | 2007 | Values: 165.0 167.0 168.0 171.0 169.0 163.0 155.0 165.0 170.0 163.0 08:00:18 INFO - PROCESS | 2007 | 08:00:18 INFO - PROCESS | 2007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.10 Median:72.00 stddev:12.72 (17.7%) stddev-sans-first:13.23 08:00:18 INFO - PROCESS | 2007 | Values: 70.0 72.0 95.0 95.0 96.0 70.0 67.0 72.0 67.0 67.0 08:00:18 INFO - PROCESS | 2007 | -------- Summary: end -------- 08:00:18 INFO - PROCESS | 2007 | 08:00:19 INFO - TEST-INFO | 2007: exit 0 08:00:19 INFO - TEST-OK | kraken | took 58897ms 08:00:19 INFO - SUITE-END | took 1173s 08:00:20 INFO - Completed test suite (00:19:34) 08:00:20 INFO - javascript benchmark 08:00:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.8023718576887, 3368.4442067058953, 3383.8646454141835, 3411.1131105912486, 3428.588569371674, 4571.679982401233, 5536.4186760390185, 5549.361823390312, 5596.048671725806, 5597.6641401515935, 5547.472990065948, 5579.776808927648, 5583.218349431083, 5605.075162598167, 5614.831555053344, 5041.798328066873, 5093.414257360396, 5142.382914050319, 5151.974240128794, 5199.324087868572, 4611.746353950532, 4902.705837649734, 5107.923381149267, 5184.429712731597, 5207.192885102796, 5132.794688212467, 5179.792808287664, 5186.092433824085, 5195.6622819516615, 5217.713025783581, 5187.273781670569, 5242.108841496916, 5244.265802787613, 5252.737363131866, 5262.05283049051, 5024.547790698854, 5031.547160755549, 5108.923366149511, 5131.692098474104, 5139.460356662534, 4423.800928958204, 5417.241586177938, 5455.890882182334, 5477.424870388591, 5478.835634930959, 6168.814935551941, 6197.0704394340755, 6203.100550420164, 6205.038219076006, 6207.162033125515, 6057.273127224761, 6116.944513560587, 6150.862090513269, 6227.782027629011, 6249.125122482856, 5710.828675139753, 5734.8279551613105, 5737.3975732548315, 5740.68426236561, 5767.0, 6210.534209934182, 6260.906086408617, 6261.812145635638, 6262.5929314594405, 6275.152854364603, 5862.882742345215, 5960.314563825129, 6093.939060609426, 6107.328193898667, 6113.969430152821, 5478.233047373371, 6058.0004299291, 6110.474672510798, 6193.6903154842075, 6214.098955651405, 6138.386161383915, 6144.56988010835, 6145.324014358417, 6152.846178845564, 6166.445019948226, 6028.4272994065495, 6095.116208149793, 6176.289726681399, 6190.81427557174, 6190.969045154836, 4867.951320486821, 4869.220924652039, 4870.951290487121, 4889.437714662859, 4892.68197567157, 4403.0, 4418.0942906704695, 4425.668074894332, 4427.424434823452, 4431.911361772811, 4712.50518695532, 5269.367675878919, 5522.337319521603, 5566.666000040011, 5598.0, 6171.311552818541, 6259.186305780219, 6278.30938596754, 6299.748010079637, 6305.8108256752375, 5592.888142237132, 5604.355499117653, 5617.38208797032, 5622.24099746529, 5645.23789288449, 4489.438820147481, 5190.870228244324, 5269.077911365495, 5296.2055691646565, 5317.494837990384, 6258.906116408258, 6283.120363149072, 6283.937160628427, 6284.3087260402235, 6298.1812364392335, 6218.347073557392, 6221.160143380585, 6222.222222222223, 6226.719797609027, 6231.376862313732, 6062.696865156813, 6131.193168498027, 6154.599951003171, 6157.9692101540995, 6214.658193799384, 6061.7575296987625, 6087.0, 6096.207493025879, 6113.266408031065, 6114.571979961538, 5033.823816166417, 6012.0, 6173.043178307369, 6197.101420294122, 6202.689865506616, 5875.0, 5912.379200183918, 5974.462298393166, 6003.189569408249, 6007.0, 6038.758449661965, 6063.333033366414, 6068.089786532056, 6070.028795392716, 6084.60450070744, 5664.575156863334, 5852.0, 5911.733971971185, 5927.8221653350465, 5932.851678708067, 6063.211782468251, 6087.66517841523, 6090.69546522681, 6091.969540152271, 6092.177556030057, 5878.706064696663, 5906.96628090074, 5916.593095811712, 5933.347331793413, 5945.078512830518], "value": 5597.220659237863, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.4602275565145, 530.7770736290757, 552.5689961829769, 589.8321323778918, 617.444300129883, 31078.37843243134, 38231.0, 38667.8399648011, 38685.22629547407, 38754.41868371977, 33234.501482477724, 34132.0, 42192.36711449331, 42221.78889105558, 42433.57566424335, 8351.874721879176, 8481.533515656636, 9306.255499560037, 9525.047495250454, 9525.380850244746, 11419.314841109519, 11617.709557261052, 11618.8257176142, 11619.419029048513, 11622.244554103956, 11332.320060796337, 11445.484953177127, 11447.255928364671, 11451.656450306504, 11459.59891403801, 8471.957640211822, 8616.26761725254, 8622.310215182833, 8623.223909848144, 11231.66305010847, 11375.4881030353, 11585.536578536849, 11586.536538538448, 11589.36258505782, 11593.768124637545, 38551.8072409639, 38949.80525097385, 38993.41509877354, 39040.60959390398, 39097.80451097755, 3121.110483512211, 3194.4569423198113, 3206.5350524173864, 3687.94468082979, 3696.2237930034726, 27451.862740686167, 28167.295817604518, 28311.858440707663, 28544.857275713697, 28926.421471570662, 2465.3836540864786, 2741.9451610967867, 2795.7344052314997, 2796.3708165662765, 2822.745952864252, 466537.66731166467, 558955.0, 659815.0, 661096.0, 662346.9999999952, 64280.67859660672, 64578.0, 65002.37494062686, 65127.67436162789, 65136.0, 68058.0, 68407.97388039183, 71628.64185679039, 72364.63817680984, 72581.0, 17301.56746081333, 17440.302387904343, 17453.65092698164, 17456.214470348867, 17465.952042877467, 12227.938860305641, 12487.375631218403, 13266.53567125146, 13554.254516001714, 13557.25435101079, 19900.402987910387, 19978.600427991358, 20114.0, 20173.596528069356, 20193.0, 8285.8342833143, 8416.579171041545, 8444.915550844413, 8448.78878028042, 8495.320374370036, 936.8782058332373, 998.8152191844532, 1066.706655669697, 1077.5151181968147, 1120.6133883810073, 30419.847900760353, 30500.0, 30549.541756873663, 30872.691273087432, 31123.84438077795, 1155.0874808900874, 1161.5237752521425, 1167.3579531257774, 1221.9979616714209, 1249.4502418935822, 15318.310676019382, 15448.995815271972, 15540.222988850512, 15683.47336137216, 15867.920660396625, 644760.0, 650624.0, 650701.0, 652075.0, 654199.0, 60690.0896486553, 60790.696046519486, 61568.076478852854, 61642.0, 61655.0, 1350.3923234544495, 1367.5487089260719, 1507.6155580326947, 1509.8867584931174, 1525.2221367102636, 26298.843264300227, 31119.688803112585, 31244.375112498077, 31479.37041259116, 32027.83986080055, 58521.41478585159, 59539.0, 59859.700701496215, 59883.700581496814, 60063.0, 559718.0, 560972.0, 561108.0, 561735.0, 565960.0, 24017.759822401553, 27433.862830685717, 27705.44589108166, 28292.717072829833, 28331.433371332045, 43641.34537981996, 44111.77944110259, 45378.09243815171, 45556.54443455523, 45692.77153614211, 37551.624483754815, 38412.80793596126, 38620.420693690176, 38923.0, 39516.60483395129, 36942.63057369392, 37855.0, 38018.111461284025, 38748.0, 38901.416478752275, 30086.398272034, 37039.6296037047, 38410.42384364181, 38486.0, 38545.421818672185, 33141.0, 33516.0, 33824.98525044253, 33861.0, 34023.31953360968, 21161.047752851468, 23482.88258558696, 24510.509789803746, 25278.494430111663, 25405.872970635766], "value": 20604.952044717356, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.35684233116893, 392.3095352180163, 398.53570590262336, 404.75512315049394, 413.33040474431385, 19497.0, 20216.494587635316, 20843.583128337425, 21020.8948955255, 21546.676799848014, 20475.87382693951, 20765.96170191492, 21119.260825871097, 21730.348089557297, 21740.782592174073, 5776.682282474462, 5883.646981181143, 5966.67183304918, 5974.8506287342725, 5984.910226346608, 5771.971140144294, 5886.4113588641, 5899.233099697033, 5969.074793407029, 5980.940190598104, 5812.941870581303, 5901.262342207224, 5903.439173278532, 5910.734016969225, 5918.88162236755, 5820.941790582082, 5821.970890145564, 5833.8833223335505, 5866.442687944638, 5870.530357571384, 5102.056119617882, 5188.688678679291, 5189.0, 5190.351206099238, 5191.351081114861, 26193.214203573923, 26387.604185937227, 26518.071867484545, 26595.0, 26673.06644267441, 2239.9888000559895, 2349.706286714161, 2390.1992832401165, 2446.963295550568, 2685.489756946174, 15019.624509387353, 15082.0, 15190.468333608382, 15236.390544378211, 15554.988925719905, 1736.505096047633, 1785.4375871600405, 1790.6866298397858, 1803.1525183163892, 1891.5649400637792, 101534.0, 104619.0, 111552.0, 112493.0, 116017.83982160155, 10978.066864316463, 11296.774064518664, 11475.942620286845, 11527.596534121265, 11659.183857130089, 11826.645200643994, 14326.140431574138, 14413.855861441461, 14415.207163605892, 14448.783268250985, 8771.473711577326, 8885.600147993357, 8928.15182557656, 8960.820783584291, 9034.819303614022, 8972.19250267479, 8986.86519702205, 8990.145936136056, 9057.411268267542, 9081.863772043425, 6714.597124172467, 6796.451330750969, 6826.283240259801, 6826.692798824065, 6848.6918088686125, 1877.1928070929632, 1907.122723547156, 1914.3969649560345, 1918.8081191880979, 1944.6207989441923, 957.3250858144991, 1018.1193267823279, 1027.0807627173638, 1028.1980055556678, 1045.5817672930737, 20621.58756824885, 21273.574528509344, 21472.78527214739, 21757.456063598536, 21833.344999650035, 992.5087081894509, 999.5452069308448, 1003.7440452684518, 1015.939043657383, 1021.8927012663563, 9387.436753794795, 11195.25979037515, 11584.942075289739, 11591.420428978518, 11599.478023488964, 600149.0, 611158.0, 615419.0, 620030.0, 621658.0, 64295.03557446642, 84563.73154402689, 105672.0, 107981.0, 118284.0, 1024.6721049264313, 1027.6095083868083, 1029.7528593137592, 1059.195011791029, 1063.7978784031163, 19161.808381916002, 19489.902550487157, 19542.31601893927, 19714.704279436108, 20066.436578964476, 47224.58326250218, 47477.52522474731, 49250.0, 51473.0, 52471.0, 62958.685206573675, 65918.0, 66021.33978660151, 67219.66390168213, 69237.96143057758, 7995.080565735015, 8134.796630084295, 8203.794905127419, 8249.79375515617, 8498.830023399621, 12688.302143382203, 12725.045621578234, 12799.488020479077, 13020.869791301966, 13048.869511304765, 10559.736006599896, 11106.222564420736, 11277.097832173242, 11445.313281203154, 11563.88436115628, 10923.399213043358, 11015.944920275668, 11060.668179954615, 11362.204645674723, 11472.82790758156, 11393.487293071666, 11459.942700286445, 11501.849815018431, 11762.647120586396, 11814.94092529532, 8095.190480951857, 8221.218984196492, 8242.17578242171, 8248.958755206186, 8391.035030971516, 11211.215214934877, 11232.943835280772, 11446.0, 11480.253783504046, 11579.478923448634], "value": 9791.195994999598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.7413865504218, 1581.4939219449775, 1604.7913771209742, 1829.9634007319853, 1952.5801952580202, 7759.689612415504, 8467.661293548259, 8655.134486551358, 8667.60995755191, 8668.783280417985, 8338.45800022998, 8586.828263434727, 8589.91410085899, 8598.441101328424, 8603.655853765842, 2079.6880467929855, 2135.540858715376, 2139.229877244191, 2394.305651361103, 2424.599941009731, 2136.807687308142, 2364.361622361961, 2438.8658623775686, 2439.1097249503982, 2439.7072351317865, 2363.598188307983, 2399.4961058177714, 2405.1461731085387, 2407.554602398553, 2410.9517809643885, 2111.6410210264294, 2408.542376948374, 2413.722421921484, 2415.7825795678295, 2418.6251131074623, 2370.0519792083132, 2441.157800558822, 2443.7800597946093, 2445.0464318915638, 2445.2297526279167, 8540.914590854074, 8583.871241931314, 8586.527740974245, 8591.527465989368, 8613.913860861374, 5153.66501177426, 5230.607704422146, 5260.973695131538, 5265.499777521168, 5288.68267903927, 3347.916302092443, 3427.2288735034667, 3490.8778192763384, 3501.0, 3511.473279008144, 1041.6874937518714, 1054.3463052907246, 1057.7144171073767, 1075.4837677914566, 1096.7916095941825, 11387.943060284728, 11401.48693308803, 11414.315141091562, 11434.885651143466, 11491.885081149248, 4329.8525890639, 4417.293233082692, 4426.981794187355, 4468.0, 4795.520447955247, 9784.168345690554, 9813.411195328303, 9813.411195328303, 9818.45998470091, 9856.655017074369, 5300.549453296436, 5301.522862942354, 5320.334958130234, 5329.57363410934, 5340.439253878365, 4283.24387001328, 4373.343998400265, 4829.372181616438, 4870.342503761947, 4884.755762211875, 3981.7013723970817, 4033.798310084484, 4067.430559721641, 4069.552349241581, 4102.0, 1328.5947785925387, 1348.2719331561043, 1351.1487762709626, 1354.8035534847393, 1362.1758835904334, 894.4499133033268, 902.5126431726925, 933.262722449271, 934.1405906565975, 959.2709540749081, 5698.401667824819, 5833.008388573952, 5874.530037596982, 5890.793822216202, 6005.850886821611, 917.1149840404042, 917.2616044084442, 936.9578368973413, 968.2931460034074, 969.1471505075489, 3766.60450652683, 3827.234553089393, 3842.558105817811, 3885.436611691289, 3916.6279203475624, 10089.697309080739, 10276.691699249035, 10463.319884207502, 10480.0, 10584.259101862795, 10272.589096436208, 10290.639827605997, 10314.02016808402, 10318.535665895053, 10419.479026048668, 6087.969560152171, 7745.573993430303, 8087.838243235103, 8184.468009579358, 8525.914740852637, 5562.944370556243, 5616.69108199053, 5784.710764461676, 5801.332846722512, 5903.321118071477, 9113.908860911306, 9188.44869307817, 9205.079492051009, 9241.537923103953, 9360.4383736976, 9331.066893310615, 9462.952685236529, 9493.66772162971, 9513.191378732885, 9608.27937904646, 7247.746328878464, 7493.812654683677, 7514.248575142442, 7959.92040079615, 7960.721374752087, 7197.352238298578, 8091.352691784761, 8276.58617069132, 8288.50268983863, 8299.751007469786, 7131.750388736369, 7237.927620723725, 7249.963750181426, 7317.414606831547, 7420.220876807857, 7107.466939979626, 7120.501564890408, 7187.353138217585, 7240.493165478366, 7241.4206863451855, 6776.864462710817, 6905.37851593359, 6930.5148639594745, 6975.581465112109, 7010.088688470466, 4048.311786996159, 4763.857084287477, 4804.6876952997945, 4899.804007839646, 4978.775955081957, 4837.05677392905, 4887.902241955212, 4899.755012249445, 4935.679180853233, 5113.41195762492], "value": 4529.5519929225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.1557115507338, 299.5970419785388, 316.5615622363028, 321.78279661228675, 331.2447619427705, 6692.63190524521, 6733.293004234552, 6736.730530778763, 6758.053872457847, 6788.830279243015, 6647.966760166204, 6680.03139544767, 6690.0, 6718.46252299816, 6761.1210542629515, 4774.3077253798265, 4856.975715121437, 4862.076205520957, 4873.147199240137, 5051.116054690433, 4992.176290911995, 5010.624203184758, 5015.899682006358, 5023.296738456619, 5039.866030143206, 4878.878028049292, 4945.77744001519, 4947.727874966876, 4968.30443737877, 4980.800767969277, 4188.539260681323, 4735.337052812609, 4805.639577031737, 4899.118158731427, 4954.207326827726, 4222.838719352172, 4226.281532139544, 4233.640140588053, 4236.428082208893, 4239.130978149472, 6417.358264173592, 6423.710933008026, 6473.870522589569, 6478.2873883872735, 6481.83795405114, 5871.0, 5876.147958546029, 5898.0, 5907.734151963129, 5909.113632955048, 7172.0, 7174.677139528681, 7178.892316615255, 7179.784606461814, 7198.064251647253, 4583.1062942726185, 4702.294655801623, 4764.071006153801, 4779.880502987453, 4783.689060211075, 7545.547267163988, 7600.619969001527, 7619.199984001711, 7632.580208088553, 7640.73257435987, 4150.0, 4731.976340118277, 4868.148074087091, 4868.926966095441, 4870.14772414826, 4042.656374208166, 4930.580900623487, 4932.975335123373, 4938.654294199443, 4941.925871111936, 5877.471027607536, 5889.0, 5894.764209431574, 5895.086261629454, 5914.852128696731, 6866.313368663094, 7128.786136415916, 7185.53294035886, 7215.711371545184, 7232.059832221883, 1591.618011677189, 1601.471514400245, 1617.6522047759788, 1618.328393716618, 1621.1894052973514, 920.5673333533229, 967.2358836519071, 993.6373223773415, 1038.3043360948184, 1064.7284942339654, 6468.191476065492, 6586.242582103119, 6593.274739778621, 6707.295733947963, 6736.93263067363, 7455.552666839899, 7473.6263186841525, 7530.849383012309, 7543.245675432413, 7578.583177925157, 4698.976505117521, 6753.966230168818, 6778.18661760582, 6783.355581219875, 6942.340477654615, 3931.233409485123, 3987.441758153861, 3987.7407968481957, 3990.0224445010576, 3991.5210174779213, 7521.699132034657, 7835.921640783519, 7862.488938219112, 7863.449558530848, 7870.173631768582, 6589.0, 7694.153643099255, 7702.768916932501, 7715.189905059888, 7717.536947783151, 7800.492967957065, 7813.765587032398, 7817.10103338112, 7825.921740782747, 7851.018622672166, 7200.747973820891, 7470.0, 7493.175750667531, 7493.662785174572, 7518.436117291334, 7285.979962805318, 7326.670299836626, 7341.816454588678, 7342.5227360221415, 7351.889721654073, 7820.687172513263, 7829.3345065670055, 7849.293563579306, 7866.567338796421, 7870.803229919298, 4709.0, 4711.199096153594, 4711.646626502958, 4712.057588482386, 4713.434387873477, 6788.151481064867, 7159.964200178966, 7443.776686699408, 7446.957425960261, 7454.217307182667, 7124.180719217149, 7173.0, 7174.139103307636, 7175.569465832067, 7194.776887929169, 5839.240898683144, 7160.641967901688, 7309.195988441374, 7338.486305958531, 7345.192028876926, 5668.291463567054, 7013.018177455262, 7016.26329235423, 7016.719331226898, 7023.051887995055, 6846.246912839484, 7166.0, 7166.713331466892, 7178.353948144692, 7180.676869540987, 6704.0, 6943.652817359213, 6958.373746362851, 7011.439084873095, 7047.788566343018], "value": 5225.485783937654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.4797953555299, 740.9110906691197, 759.2369668483177, 773.5049568276304, 773.8529679360925, 15117.546473605797, 15380.154091524962, 15394.923025384871, 15402.460913868017, 15413.614659633515, 13949.511767088128, 13986.790198147011, 13992.65018374541, 14004.719905601907, 14025.999999999975, 735.7608777147422, 752.9397648188159, 922.432703887108, 947.3605316411429, 952.2524818017857, 930.3859452761179, 945.5508633399149, 946.4132238012407, 952.6713283917038, 953.5327689432163, 995.5520015992832, 999.2605471950741, 1000.0949141027381, 1001.4892404873531, 1003.909648131668, 782.62042909189, 965.4448692002056, 983.788485475619, 990.1682586627196, 999.1307562420704, 739.1536690489413, 739.3567596191294, 740.8851627997669, 741.1439787045971, 745.4483682075279, 14052.156870587798, 14077.859221407758, 14100.788488172686, 14106.788398174036, 14140.575782726535, 11791.941040294743, 11858.644240672793, 11943.781067242375, 11988.70028249292, 12243.69390765229, 9926.751831204205, 10002.0, 10152.746181345452, 10365.170786337076, 10650.236985602565, 3468.7745296555895, 3481.3211423772373, 3498.3003399320237, 3541.3271478419274, 3641.1261297288725, 84183.57908210481, 84325.15674843235, 84997.57501212516, 85707.5714621429, 86512.5674371624, 9270.397424167408, 9284.628614855465, 9291.396059256127, 9481.66814161501, 9484.95257523708, 20542.281020164522, 20600.484987875123, 20604.175832966812, 20635.79364206339, 20654.690179647318, 7079.469039822034, 7119.430445564342, 7130.857382852418, 7273.27267273279, 7456.627168641547, 3472.774269672463, 3996.9400458993136, 4062.8171732271526, 4091.4272001919753, 4229.323308270724, 3606.1705807664384, 3670.6512881276235, 3673.393890008172, 3676.871309504208, 3676.889693309205, 621.4686443091182, 646.360103497534, 661.497262080822, 668.6088638146641, 680.4080450008425, 509.3487753376284, 532.738957910621, 538.8114160044032, 577.3302968556454, 612.2958597612692, 8150.633221505046, 8164.469309494863, 8164.591770411455, 8202.917970820215, 8219.917800822035, 594.9464548190683, 596.5049009322252, 596.8612817175331, 601.3535449391921, 621.4407033669643, 3743.9438408423894, 3809.154112980694, 3840.8271627776817, 3849.5957924418094, 3867.439221312894, 91650.0, 92007.0, 92246.0, 92609.53695231481, 92998.0, 72185.0, 72819.0, 73112.90330645045, 73945.63027184829, 74457.62771186109, 66045.0, 66970.99543506754, 67973.66013169903, 68691.96962045574, 69636.0, 7467.58928258951, 7557.848843022999, 7581.166071732216, 7736.1877002916135, 7803.687852485837, 45182.77408612936, 45994.0, 46218.53781462277, 46372.7681361591, 46529.0, 60603.69698151481, 64278.0, 65118.0, 65255.36861578499, 65777.67111164413, 9904.851427228741, 10031.197504199792, 10090.2432317575, 10140.898591013995, 10181.796364072825, 10741.033307002095, 10815.188860835311, 10990.285631433931, 11012.229143959847, 11509.712257193638, 10270.07569318765, 10318.43248621303, 10376.273660843668, 10478.63324783629, 10637.574497020032, 10387.740306492398, 10426.165906727596, 10528.420936848546, 10568.84146737815, 10610.204234682275, 10154.949225253826, 10159.187265018929, 10253.641122560675, 10292.0, 10376.740581485523, 8962.097236412517, 8999.505027223566, 9073.546322683971, 9170.495622740813, 9713.757156071155, 8535.8719619207, 9086.182243598108, 9582.960087588224, 9683.66107186245, 9950.900490994998], "value": 6754.254872262723, "unit": "score"}], "name": "dromaeo_css", "value": 7517.898769294125, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 119.0, 113.0, 114.0, 113.0, 114.0, 112.0, 113.0, 132.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 122.0, 146.0, 169.0, 119.0, 140.0, 120.0, 152.0, 159.0, 124.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 187.0, 187.0, 186.0, 184.0, 185.0, 185.0, 185.0, 184.0, 186.0], "value": 185.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 80.0, 77.0, 156.0, 56.0, 56.0, 55.0, 65.0, 135.0, 56.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 145.0, 76.0, 81.0, 78.0, 127.0, 79.0, 78.0, 161.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 88.0, 88.0, 86.0, 91.0, 86.0, 91.0, 89.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 138.0, 149.0, 103.0, 93.0, 93.0, 94.0, 94.0, 94.0], "value": 104.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 103.0, 135.0, 131.0, 83.0, 83.0, 85.0, 84.0, 85.0, 85.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 63.0, 63.0, 62.0, 63.0, 64.0, 85.0, 57.0, 56.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 69.0, 69.0, 82.0, 77.0, 72.0, 68.0, 70.0, 69.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 78.0, 81.0, 82.0, 82.0, 78.0, 81.0, 85.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 151.0, 123.0, 141.0, 131.0, 128.0, 130.0, 129.0, 189.0, 150.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 168.0, 171.0, 169.0, 163.0, 155.0, 165.0, 170.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 95.0, 95.0, 96.0, 70.0, 67.0, 72.0, 67.0, 67.0], "value": 77.1, "unit": "score"}], "name": "kraken", "value": 1512.1000000000001, "alertThreshold": 2.0}]} 08:00:20 INFO - Return code: 0 08:00:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:00:20 ERROR - # TBPL SUCCESS # 08:00:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:00:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:00:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:00:20 INFO - 2016-05-12 08:00:20.265 screenresolution[2011:13621] starting screenresolution argv=screenresolution get 08:00:20 INFO - 2016-05-12 08:00:20.268 screenresolution[2011:13621] Display 0: 1600x1200x32@60 08:00:20 INFO - 2016-05-12 08:00:20.274 screenresolution[2012:13627] starting screenresolution argv=screenresolution list 08:00:20 INFO - Available Modes on Display 0 08:00:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:00:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:00:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:00:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:00:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:00:20 INFO - Intel Iris: 08:00:20 INFO - Chipset Model: Intel Iris 08:00:20 INFO - Type: GPU 08:00:20 INFO - Bus: Built-In 08:00:20 INFO - VRAM (Dynamic, Max): 1536 MB 08:00:20 INFO - Vendor: Intel (0x8086) 08:00:20 INFO - Device ID: 0x0a2e 08:00:20 INFO - Revision ID: 0x0009 08:00:20 INFO - Displays: 08:00:20 INFO - Display: 08:00:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:00:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:00:20 INFO - Display Serial Number: 1600x1200 60 08:00:20 INFO - Main Display: Yes 08:00:20 INFO - Mirror: Off 08:00:20 INFO - Online: Yes 08:00:20 INFO - Rotation: Supported 08:00:20 INFO - Return code: 0 08:00:20 INFO - Running post-action listener: _resource_record_post_action 08:00:20 INFO - Running post-run listener: _resource_record_post_run 08:00:21 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 958464; Write bytes: 653046272; Read time: 18; Write time: 2274 08:00:21 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 344930816; Write bytes: 346732032; Read time: 26493; Write time: 802 08:00:21 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 958464; Write bytes: 296356864; Read time: 18; Write time: 1442 08:00:21 INFO - Running post-run listener: _upload_blobber_files 08:00:21 INFO - Blob upload gear active. 08:00:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:00:21 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 08:00:21 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:00:21 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:00:22 INFO - (blobuploader) - INFO - Open directory for files ... 08:00:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:00:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:00:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:00:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:00:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:00:23 INFO - (blobuploader) - INFO - Done attempting. 08:00:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:00:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:00:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:00:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:00:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:00:24 INFO - (blobuploader) - INFO - Done attempting. 08:00:24 INFO - (blobuploader) - INFO - Iteration through files over. 08:00:24 INFO - Return code: 0 08:00:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:00:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:00:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/418fd7bcc78c93fa6acd051eb322f4b5c2dc27653e99c5e2daaac62f2308222795f13e929e82afd40dd0155ddc3733439cc243bb8e6a9150c3f13e21318da366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5214271e09f155dbb445903344fbbd6566ee84005461e1a24e7b54536f5d26484a24564cc2f99f617fddc0da226237f656db0360ddd870aba75c638456fb28d"} 08:00:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:00:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:00:24 INFO - Contents: 08:00:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/418fd7bcc78c93fa6acd051eb322f4b5c2dc27653e99c5e2daaac62f2308222795f13e929e82afd40dd0155ddc3733439cc243bb8e6a9150c3f13e21318da366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5214271e09f155dbb445903344fbbd6566ee84005461e1a24e7b54536f5d26484a24564cc2f99f617fddc0da226237f656db0360ddd870aba75c638456fb28d"} 08:00:24 INFO - Running post-run listener: copy_logs_to_upload_dir 08:00:24 INFO - Copying logs to upload dir... 08:00:24 INFO - mkdir: /builds/slave/test/build/upload/logs 08:00:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.088352 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-05-12 08:00:24.338554) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 08:00:24.346416) ========= 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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-Aurora/sha512/418fd7bcc78c93fa6acd051eb322f4b5c2dc27653e99c5e2daaac62f2308222795f13e929e82afd40dd0155ddc3733439cc243bb8e6a9150c3f13e21318da366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5214271e09f155dbb445903344fbbd6566ee84005461e1a24e7b54536f5d26484a24564cc2f99f617fddc0da226237f656db0360ddd870aba75c638456fb28d"} build_url:https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/XhSKU-7DSNC5B8B2nv6wog/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/418fd7bcc78c93fa6acd051eb322f4b5c2dc27653e99c5e2daaac62f2308222795f13e929e82afd40dd0155ddc3733439cc243bb8e6a9150c3f13e21318da366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5214271e09f155dbb445903344fbbd6566ee84005461e1a24e7b54536f5d26484a24564cc2f99f617fddc0da226237f656db0360ddd870aba75c638456fb28d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 08:00:24.377392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 08:00:24.377714) ========= 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.QUSZ8DUjSd/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.elyD0nYO1K/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.004636 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 08:00:24.434775) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 08:00:24.435161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 08:00:24.435515) ========= ========= Total master_lag: 3.40 =========