builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0070 starttime: 1462963596.89 results: success (0) buildid: 20160510142413 builduid: 93e058acf8334e7aae447a8479c457fb revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:36.885824) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:36.886281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:36.886580) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:36.905650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:36.906034) ========= 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.5AwKd7whXQ/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.uswe0pAcsD/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-11 03:46:36-- 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% 13.4M=0.001s 2016-05-11 03:46:37 (13.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:37.028866) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:37.029291) ========= 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.5AwKd7whXQ/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.uswe0pAcsD/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.027199 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:37.078468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 03:46:37.078843) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1dd42a351054c5b697873d647169019d4d77d762 --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 1dd42a351054c5b697873d647169019d4d77d762 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5AwKd7whXQ/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.uswe0pAcsD/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-11 03:46:37,150 truncating revision to first 12 chars 2016-05-11 03:46:37,151 Setting DEBUG logging. 2016-05-11 03:46:37,151 attempt 1/10 2016-05-11 03:46:37,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1dd42a351054?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 03:46:38,108 unpacking tar archive at: mozilla-aurora-1dd42a351054/testing/mozharness/ program finished with exit code 0 elapsedTime=1.198161 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 03:46:38.294989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:38.295325) ========= script_repo_revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:38.295744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:38.296008) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 03:46:38.309236) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-05-11 03:46:38.309546) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.5AwKd7whXQ/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.uswe0pAcsD/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:46:38 INFO - MultiFileLogger online at 20160511 03:46:38 in /builds/slave/test 03:46:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:46:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:46:38 INFO - {'append_to_log': False, 03:46:38 INFO - 'base_work_dir': '/builds/slave/test', 03:46:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:46:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:46:38 INFO - 'branch': 'Mozilla-Aurora', 03:46:38 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:38 INFO - 'config_files': ('talos/mac_config.py',), 03:46:38 INFO - 'default_actions': ('clobber', 03:46:38 INFO - 'read-buildbot-config', 03:46:38 INFO - 'download-and-extract', 03:46:38 INFO - 'populate-webroot', 03:46:38 INFO - 'create-virtualenv', 03:46:38 INFO - 'install', 03:46:38 INFO - 'run-tests'), 03:46:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:38 INFO - 'download_minidump_stackwalk': True, 03:46:38 INFO - 'download_symbols': 'ondemand', 03:46:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:46:38 INFO - 'tooltool.py': '/tools/tooltool.py', 03:46:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:46:38 INFO - '/tools/misc-python/virtualenv.py')}, 03:46:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:38 INFO - 'installer_path': 'installer.exe', 03:46:38 INFO - 'log_level': 'info', 03:46:38 INFO - 'log_name': 'talos', 03:46:38 INFO - 'log_to_console': True, 03:46:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:46:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:46:38 INFO - 'opt_config_files': (), 03:46:38 INFO - 'pip_index': False, 03:46:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:46:38 INFO - 'cmd': ('bash', 03:46:38 INFO - '-c', 03:46:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:46:38 INFO - 'enabled': True, 03:46:38 INFO - 'halt_on_failure': False, 03:46:38 INFO - 'name': 'check_screen_resolution'},), 03:46:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:46:38 INFO - 'cmd': ('bash', 03:46:38 INFO - '-c', 03:46:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:46:38 INFO - 'enabled': True, 03:46:38 INFO - 'halt_on_failure': False, 03:46:38 INFO - 'name': 'check_screen_resolution'},), 03:46:38 INFO - 'run_cmd_checks_enabled': True, 03:46:38 INFO - 'sps_profile': False, 03:46:38 INFO - 'sps_profile_interval': 0, 03:46:38 INFO - 'suite': 'dromaeojs-e10s', 03:46:38 INFO - 'system_bits': '32', 03:46:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:38 INFO - 'title': 't-yosemite-r7-0070', 03:46:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:38 INFO - 'use_talos_json': True, 03:46:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:46:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:38 INFO - 'work_dir': 'build'} 03:46:38 INFO - ##### 03:46:38 INFO - ##### Running clobber step. 03:46:38 INFO - ##### 03:46:38 INFO - Running pre-action listener: _resource_record_pre_action 03:46:38 INFO - Running main action method: clobber 03:46:38 INFO - rmtree: /builds/slave/test/build 03:46:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:46:40 INFO - Running post-action listener: _resource_record_post_action 03:46:40 INFO - ##### 03:46:40 INFO - ##### Running read-buildbot-config step. 03:46:40 INFO - ##### 03:46:40 INFO - Running pre-action listener: _resource_record_pre_action 03:46:40 INFO - Running main action method: read_buildbot_config 03:46:40 INFO - Using buildbot properties: 03:46:40 INFO - { 03:46:40 INFO - "project": "", 03:46:40 INFO - "product": "firefox", 03:46:40 INFO - "script_repo_revision": "production", 03:46:40 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:46:40 INFO - "repository": "", 03:46:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:46:40 INFO - "buildid": "20160510142413", 03:46:40 INFO - "pgo_build": "False", 03:46:40 INFO - "basedir": "/builds/slave/test", 03:46:40 INFO - "buildnumber": 9, 03:46:40 INFO - "slavename": "t-yosemite-r7-0070", 03:46:40 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:46:40 INFO - "platform": "yosemite_r7", 03:46:40 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:46:40 INFO - "branch": "mozilla-aurora", 03:46:40 INFO - "repo_path": "releases/mozilla-aurora", 03:46:40 INFO - "revision": "1dd42a351054c5b697873d647169019d4d77d762", 03:46:40 INFO - "stage_platform": "macosx64", 03:46:40 INFO - "builduid": "93e058acf8334e7aae447a8479c457fb", 03:46:40 INFO - "slavebuilddir": "test" 03:46:40 INFO - } 03:46:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 03:46:40 INFO - Running post-action listener: _resource_record_post_action 03:46:40 INFO - ##### 03:46:40 INFO - ##### Running download-and-extract step. 03:46:40 INFO - ##### 03:46:40 INFO - Running pre-action listener: _resource_record_pre_action 03:46:40 INFO - Running main action method: download_and_extract 03:46:40 INFO - mkdir: /builds/slave/test/build/tests 03:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:40 INFO - https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:46:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 03:46:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 03:46:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/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 03:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/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 03:46:41 INFO - Downloaded 1199 bytes. 03:46:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 03:46:41 INFO - Using the following test package requirements: 03:46:41 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 03:46:41 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:46:41 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 03:46:41 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:46:41 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 03:46:41 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:46:41 INFO - u'jsshell-mac.zip'], 03:46:41 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:46:41 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 03:46:41 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 03:46:41 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:46:41 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 03:46:41 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:46:41 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 03:46:41 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:46:41 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 03:46:41 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:46:41 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 03:46:41 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:41 INFO - https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/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 03:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/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 03:46:42 INFO - Downloaded 18089246 bytes. 03:46:42 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'] 03:46:42 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 03:46:45 INFO - Return code: 0 03:46:45 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 03:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:45 INFO - https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:46:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:46:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:46:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/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 03:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/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 03:46:47 INFO - Downloaded 18089246 bytes. 03:46:47 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'] 03:46:47 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 03:46:51 INFO - Return code: 0 03:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:51 INFO - https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:46:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:46:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:46:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/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 03:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/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 03:46:52 INFO - Downloaded 10840145 bytes. 03:46:52 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'] 03:46:52 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 03:46:52 INFO - Return code: 0 03:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:52 INFO - https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 03:46:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:46:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:46:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 03:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8CVojXuQjGmk8NvQeFISg/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 03:46:57 INFO - Downloaded 114088564 bytes. 03:46:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:46:57 INFO - mkdir: /builds/slave/test/properties 03:46:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:46:57 INFO - Writing to file /builds/slave/test/properties/build_url 03:46:57 INFO - Contents: 03:46:57 INFO - build_url:https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:46:58 INFO - Running post-action listener: _resource_record_post_action 03:46:58 INFO - Running post-action listener: set_extra_try_arguments 03:46:58 INFO - ##### 03:46:58 INFO - ##### Running populate-webroot step. 03:46:58 INFO - ##### 03:46:58 INFO - Running pre-action listener: _resource_record_pre_action 03:46:58 INFO - Running main action method: populate_webroot 03:46:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:46:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:46:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:46:58 INFO - '--tppagecycles', 03:46:58 INFO - '7'], 03:46:58 INFO - 'tests': ['tsvgm']}}, 03:46:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:46:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:46:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:46:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:46:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:46:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:46:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:58 INFO - 'talos_options': ['--disable-e10s'], 03:46:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:58 INFO - 'talos_options': ['--disable-e10s'], 03:46:58 INFO - 'tests': ['damp', 'tps']}, 03:46:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:58 INFO - 'tests': ['damp', 'tps']}, 03:46:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:46:58 INFO - 'tests': ['dromaeo_dom']}, 03:46:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:46:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:46:58 INFO - 'tests': ['a11yr', 03:46:58 INFO - 'ts_paint', 03:46:58 INFO - 'tpaint', 03:46:58 INFO - 'sessionrestore', 03:46:58 INFO - 'sessionrestore_no_auto_restore', 03:46:58 INFO - 'tabpaint']}, 03:46:58 INFO - 'other-e10s': {'tests': ['a11yr', 03:46:58 INFO - 'ts_paint', 03:46:58 INFO - 'tpaint', 03:46:58 INFO - 'sessionrestore', 03:46:58 INFO - 'sessionrestore_no_auto_restore', 03:46:58 INFO - 'tabpaint']}, 03:46:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:46:58 INFO - 'ts_paint', 03:46:58 INFO - 'tpaint', 03:46:58 INFO - 'sessionrestore', 03:46:58 INFO - 'sessionrestore_no_auto_restore', 03:46:58 INFO - 'tabpaint']}, 03:46:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:46:58 INFO - 'ts_paint', 03:46:58 INFO - 'tpaint', 03:46:58 INFO - 'sessionrestore', 03:46:58 INFO - 'sessionrestore_no_auto_restore', 03:46:58 INFO - 'tabpaint']}, 03:46:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:46:58 INFO - 'tests': ['a11yr', 03:46:58 INFO - 'ts_paint', 03:46:58 INFO - 'tpaint', 03:46:58 INFO - 'sessionrestore', 03:46:58 INFO - 'sessionrestore_no_auto_restore', 03:46:58 INFO - 'tabpaint']}, 03:46:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:46:58 INFO - 'tests': ['a11yr', 03:46:58 INFO - 'ts_paint', 03:46:58 INFO - 'tpaint', 03:46:58 INFO - 'sessionrestore', 03:46:58 INFO - 'sessionrestore_no_auto_restore', 03:46:58 INFO - 'tabpaint']}, 03:46:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:46:58 INFO - 'tests': ['tsvgx', 03:46:58 INFO - 'tsvgr_opacity', 03:46:58 INFO - 'tart', 03:46:58 INFO - 'tscrollx', 03:46:58 INFO - 'cart']}, 03:46:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:46:58 INFO - 'tsvgr_opacity', 03:46:58 INFO - 'tart', 03:46:58 INFO - 'tscrollx', 03:46:58 INFO - 'cart']}, 03:46:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:58 INFO - 'talos_options': ['--disable-e10s'], 03:46:58 INFO - 'tests': ['tp5o']}, 03:46:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:58 INFO - 'tests': ['tp5o']}, 03:46:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:58 INFO - 'talos_options': ['--disable-e10s', 03:46:58 INFO - '--xperf_path', 03:46:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:58 INFO - 'tests': ['tp5n']}, 03:46:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:58 INFO - 'talos_options': ['--xperf_path', 03:46:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:58 INFO - 'tests': ['tp5n']}}, 03:46:58 INFO - 'talos.zip': {'path': '', 03:46:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:46:58 INFO - Running post-action listener: _resource_record_post_action 03:46:58 INFO - ##### 03:46:58 INFO - ##### Running create-virtualenv step. 03:46:58 INFO - ##### 03:46:58 INFO - Running pre-action listener: _resource_record_pre_action 03:46:58 INFO - Running main action method: create_virtualenv 03:46:58 INFO - Creating virtualenv /builds/slave/test/build/venv 03:46:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:46:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:46:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:58 INFO - Using real prefix '/tools/python27' 03:46:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:46:59 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:02 INFO - Installing pip.................done. 03:47:02 INFO - Return code: 0 03:47:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10118ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10119b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe253d7b0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10102ae00>, '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 0x100e93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101025b20>, '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.5AwKd7whXQ/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.uswe0pAcsD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:47:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AwKd7whXQ/Render', 03:47:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:02 INFO - 'HOME': '/Users/cltbld', 03:47:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:02 INFO - 'LOGNAME': 'cltbld', 03:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:02 INFO - 'MOZ_NO_REMOTE': '1', 03:47:02 INFO - 'NO_EM_RESTART': '1', 03:47:02 INFO - 'PAGER': '/bin/cat', 03:47:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:02 INFO - 'PWD': '/builds/slave/test', 03:47:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:02 INFO - 'SHELL': '/bin/bash', 03:47:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uswe0pAcsD/Listeners', 03:47:02 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 03:47:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:02 INFO - 'USER': 'cltbld', 03:47:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:02 INFO - 'XPC_FLAGS': '0x0', 03:47:02 INFO - 'XPC_SERVICE_NAME': '0', 03:47:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:47:02 INFO - Cleaning up... 03:47:02 INFO - Return code: 0 03:47:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10118ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10119b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe253d7b0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10102ae00>, '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 0x100e93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101025b20>, '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.5AwKd7whXQ/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.uswe0pAcsD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:47:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AwKd7whXQ/Render', 03:47:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:02 INFO - 'HOME': '/Users/cltbld', 03:47:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:02 INFO - 'LOGNAME': 'cltbld', 03:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:02 INFO - 'MOZ_NO_REMOTE': '1', 03:47:02 INFO - 'NO_EM_RESTART': '1', 03:47:02 INFO - 'PAGER': '/bin/cat', 03:47:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:02 INFO - 'PWD': '/builds/slave/test', 03:47:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:02 INFO - 'SHELL': '/bin/bash', 03:47:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uswe0pAcsD/Listeners', 03:47:02 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 03:47:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:02 INFO - 'USER': 'cltbld', 03:47:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:02 INFO - 'XPC_FLAGS': '0x0', 03:47:02 INFO - 'XPC_SERVICE_NAME': '0', 03:47:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:02 INFO - Downloading/unpacking psutil>=0.7.1 03:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:05 INFO - Installing collected packages: psutil 03:47:05 INFO - Running setup.py install for psutil 03:47:06 INFO - building 'psutil._psutil_osx' extension 03:47:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:47:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:47:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:47:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:47:06 INFO - building 'psutil._psutil_posix' extension 03:47:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:47:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:47:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:47:06 INFO - ^ 03:47:06 INFO - 1 warning generated. 03:47:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:47:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:07 INFO - Successfully installed psutil 03:47:07 INFO - Cleaning up... 03:47:07 INFO - Return code: 0 03:47:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10118ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10119b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe253d7b0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10102ae00>, '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 0x100e93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101025b20>, '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.5AwKd7whXQ/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.uswe0pAcsD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:47:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AwKd7whXQ/Render', 03:47:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:07 INFO - 'HOME': '/Users/cltbld', 03:47:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:07 INFO - 'LOGNAME': 'cltbld', 03:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:07 INFO - 'MOZ_NO_REMOTE': '1', 03:47:07 INFO - 'NO_EM_RESTART': '1', 03:47:07 INFO - 'PAGER': '/bin/cat', 03:47:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:07 INFO - 'PWD': '/builds/slave/test', 03:47:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:07 INFO - 'SHELL': '/bin/bash', 03:47:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uswe0pAcsD/Listeners', 03:47:07 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 03:47:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:07 INFO - 'USER': 'cltbld', 03:47:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:07 INFO - 'XPC_FLAGS': '0x0', 03:47:07 INFO - 'XPC_SERVICE_NAME': '0', 03:47:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:47:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:47:09 INFO - Installing collected packages: mozsystemmonitor 03:47:09 INFO - Running setup.py install for mozsystemmonitor 03:47:10 INFO - Successfully installed mozsystemmonitor 03:47:10 INFO - Cleaning up... 03:47:10 INFO - Return code: 0 03:47:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10118ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10119b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe253d7b0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10102ae00>, '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 0x100e93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101025b20>, '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.5AwKd7whXQ/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.uswe0pAcsD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:47:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AwKd7whXQ/Render', 03:47:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:10 INFO - 'HOME': '/Users/cltbld', 03:47:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:10 INFO - 'LOGNAME': 'cltbld', 03:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:10 INFO - 'MOZ_NO_REMOTE': '1', 03:47:10 INFO - 'NO_EM_RESTART': '1', 03:47:10 INFO - 'PAGER': '/bin/cat', 03:47:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:10 INFO - 'PWD': '/builds/slave/test', 03:47:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:10 INFO - 'SHELL': '/bin/bash', 03:47:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uswe0pAcsD/Listeners', 03:47:10 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 03:47:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:10 INFO - 'USER': 'cltbld', 03:47:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:10 INFO - 'XPC_FLAGS': '0x0', 03:47:10 INFO - 'XPC_SERVICE_NAME': '0', 03:47:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:10 INFO - Downloading/unpacking blobuploader==1.2.4 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:12 INFO - Downloading blobuploader-1.2.4.tar.gz 03:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:47:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:47:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:14 INFO - Downloading docopt-0.6.1.tar.gz 03:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:47:14 INFO - Installing collected packages: blobuploader, requests, docopt 03:47:14 INFO - Running setup.py install for blobuploader 03:47:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:47:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:47:14 INFO - Running setup.py install for requests 03:47:14 INFO - Running setup.py install for docopt 03:47:14 INFO - Successfully installed blobuploader requests docopt 03:47:14 INFO - Cleaning up... 03:47:14 INFO - Return code: 0 03:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:14 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 0x10118ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10119b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe253d7b0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10102ae00>, '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 0x100e93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101025b20>, '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.5AwKd7whXQ/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.uswe0pAcsD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:47:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AwKd7whXQ/Render', 03:47:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:14 INFO - 'HOME': '/Users/cltbld', 03:47:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:14 INFO - 'LOGNAME': 'cltbld', 03:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:14 INFO - 'MOZ_NO_REMOTE': '1', 03:47:14 INFO - 'NO_EM_RESTART': '1', 03:47:14 INFO - 'PAGER': '/bin/cat', 03:47:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:14 INFO - 'PWD': '/builds/slave/test', 03:47:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:14 INFO - 'SHELL': '/bin/bash', 03:47:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uswe0pAcsD/Listeners', 03:47:14 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 03:47:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:14 INFO - 'USER': 'cltbld', 03:47:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:14 INFO - 'XPC_FLAGS': '0x0', 03:47:14 INFO - 'XPC_SERVICE_NAME': '0', 03:47:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:47:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-52MQwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:47:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-eKuWuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:47:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-m0rePm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:47:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-uuSpAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:47:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-N_OLDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:47:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-V0UHq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:47:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Ww1Fan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:47:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Y00h9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:47:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-X2NDUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:47:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-mdhQqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:47:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-nptlJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:47:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-b3Y44r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:47:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-JT17pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:47:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-zvYMhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-yj6GNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:47:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-R8Odw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:47:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-PhR7Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:47:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:47:17 INFO - Running setup.py install for manifestparser 03:47:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:47:17 INFO - Running setup.py install for mozcrash 03:47:17 INFO - Running setup.py install for mozdebug 03:47:17 INFO - Running setup.py install for mozdevice 03:47:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:47:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:47:17 INFO - Running setup.py install for mozfile 03:47:17 INFO - Running setup.py install for mozhttpd 03:47:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:47:17 INFO - Running setup.py install for mozinfo 03:47:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:47:18 INFO - Running setup.py install for mozInstall 03:47:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:47:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:47:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:47:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:47:18 INFO - Running setup.py install for mozleak 03:47:18 INFO - Running setup.py install for mozlog 03:47:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:47:18 INFO - Running setup.py install for moznetwork 03:47:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:47:18 INFO - Running setup.py install for mozprocess 03:47:18 INFO - Running setup.py install for mozprofile 03:47:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:47:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:47:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:47:18 INFO - Running setup.py install for mozrunner 03:47:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:47:19 INFO - Running setup.py install for mozscreenshot 03:47:19 INFO - Running setup.py install for moztest 03:47:19 INFO - Running setup.py install for mozversion 03:47:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:47:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:47:19 INFO - Cleaning up... 03:47:19 INFO - Return code: 0 03:47:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47: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')]} 03:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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')]} 03:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:19 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 0x10118ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10119b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe253d7b0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10102ae00>, '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 0x100e93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101025b20>, '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.5AwKd7whXQ/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.uswe0pAcsD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AwKd7whXQ/Render', 03:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:19 INFO - 'HOME': '/Users/cltbld', 03:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:19 INFO - 'LOGNAME': 'cltbld', 03:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:19 INFO - 'MOZ_NO_REMOTE': '1', 03:47:19 INFO - 'NO_EM_RESTART': '1', 03:47:19 INFO - 'PAGER': '/bin/cat', 03:47:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:19 INFO - 'PWD': '/builds/slave/test', 03:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:19 INFO - 'SHELL': '/bin/bash', 03:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uswe0pAcsD/Listeners', 03:47:19 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 03:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:19 INFO - 'USER': 'cltbld', 03:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:19 INFO - 'XPC_FLAGS': '0x0', 03:47:19 INFO - 'XPC_SERVICE_NAME': '0', 03:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:47:19 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-M4SkKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:47:19 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-rnaxBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:47:20 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-mVZKfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:47:20 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-eLxERB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:47:20 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-_bql2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:47:20 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-AmIaFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:47:20 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-pHdq6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:47:20 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-cYvnqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:47:20 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-3QsdTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:47:20 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-wIJA6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:47:20 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-_7uy6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:47:20 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-qEeagr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:47:21 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-nLqQiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:47:21 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-nXoq_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:21 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-AT8c6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:47:21 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-PCr2Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:47:21 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-jhbqJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:24 INFO - Downloading blessings-1.6.tar.gz 03:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:47:24 INFO - Installing collected packages: blessings 03:47:24 INFO - Running setup.py install for blessings 03:47:24 INFO - Successfully installed blessings 03:47:24 INFO - Cleaning up... 03:47:24 INFO - Return code: 0 03:47:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:47:24 INFO - Reading from file tmpfile_stdout 03:47:24 INFO - Current package versions: 03:47:24 INFO - blessings == 1.6 03:47:24 INFO - blobuploader == 1.2.4 03:47:24 INFO - docopt == 0.6.1 03:47:24 INFO - manifestparser == 1.1 03:47:24 INFO - mozInstall == 1.12 03:47:24 INFO - mozcrash == 0.17 03:47:24 INFO - mozdebug == 0.1 03:47:24 INFO - mozdevice == 0.48 03:47:24 INFO - mozfile == 1.2 03:47:24 INFO - mozhttpd == 0.7 03:47:24 INFO - mozinfo == 0.9 03:47:24 INFO - mozleak == 0.1 03:47:24 INFO - mozlog == 3.1 03:47:24 INFO - moznetwork == 0.27 03:47:24 INFO - mozprocess == 0.22 03:47:24 INFO - mozprofile == 0.28 03:47:24 INFO - mozrunner == 6.11 03:47:24 INFO - mozscreenshot == 0.1 03:47:24 INFO - mozsystemmonitor == 0.0 03:47:24 INFO - moztest == 0.7 03:47:24 INFO - mozversion == 1.4 03:47:24 INFO - psutil == 3.1.1 03:47:24 INFO - requests == 1.2.3 03:47:24 INFO - wsgiref == 0.1.2 03:47:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:24 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 0x10118ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10119b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe253d7b0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10102ae00>, '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 0x100e93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101025b20>, '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.5AwKd7whXQ/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.uswe0pAcsD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AwKd7whXQ/Render', 03:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:24 INFO - 'HOME': '/Users/cltbld', 03:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:24 INFO - 'LOGNAME': 'cltbld', 03:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:24 INFO - 'MOZ_NO_REMOTE': '1', 03:47:24 INFO - 'NO_EM_RESTART': '1', 03:47:24 INFO - 'PAGER': '/bin/cat', 03:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:24 INFO - 'PWD': '/builds/slave/test', 03:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:24 INFO - 'SHELL': '/bin/bash', 03:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uswe0pAcsD/Listeners', 03:47:24 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 03:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:24 INFO - 'USER': 'cltbld', 03:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:24 INFO - 'XPC_FLAGS': '0x0', 03:47:24 INFO - 'XPC_SERVICE_NAME': '0', 03:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:47:24 INFO - Cleaning up... 03:47:24 INFO - Return code: 0 03:47:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:24 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 0x10118ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10119b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe253d7b0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10102ae00>, '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 0x100e93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101025b20>, '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.5AwKd7whXQ/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.uswe0pAcsD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AwKd7whXQ/Render', 03:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:24 INFO - 'HOME': '/Users/cltbld', 03:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:24 INFO - 'LOGNAME': 'cltbld', 03:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:24 INFO - 'MOZ_NO_REMOTE': '1', 03:47:24 INFO - 'NO_EM_RESTART': '1', 03:47:24 INFO - 'PAGER': '/bin/cat', 03:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:24 INFO - 'PWD': '/builds/slave/test', 03:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:24 INFO - 'SHELL': '/bin/bash', 03:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uswe0pAcsD/Listeners', 03:47:24 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 03:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:24 INFO - 'USER': 'cltbld', 03:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:24 INFO - 'XPC_FLAGS': '0x0', 03:47:24 INFO - 'XPC_SERVICE_NAME': '0', 03:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:25 INFO - Downloading/unpacking jsonschema 03:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:47:27 INFO - Downloading/unpacking functools32 (from jsonschema) 03:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:27 INFO - Downloading functools32-3.2.3-2.tar.gz 03:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:47:27 INFO - warning: no files found matching '*.txt' 03:47:27 INFO - no previously-included directories found matching 'build' 03:47:27 INFO - no previously-included directories found matching 'dist' 03:47:27 INFO - no previously-included directories found matching '.git*' 03:47:28 INFO - Installing collected packages: jsonschema, functools32 03:47:28 INFO - Running setup.py install for functools32 03:47:28 INFO - warning: no files found matching '*.txt' 03:47:28 INFO - no previously-included directories found matching 'build' 03:47:28 INFO - no previously-included directories found matching 'dist' 03:47:28 INFO - no previously-included directories found matching '.git*' 03:47:28 INFO - Successfully installed jsonschema functools32 03:47:28 INFO - Cleaning up... 03:47:28 INFO - Return code: 0 03:47:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:28 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 0x10118ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10119b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe253d7b0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10102ae00>, '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 0x100e93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101025b20>, '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.5AwKd7whXQ/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.uswe0pAcsD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AwKd7whXQ/Render', 03:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:28 INFO - 'HOME': '/Users/cltbld', 03:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:28 INFO - 'LOGNAME': 'cltbld', 03:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:28 INFO - 'MOZ_NO_REMOTE': '1', 03:47:28 INFO - 'NO_EM_RESTART': '1', 03:47:28 INFO - 'PAGER': '/bin/cat', 03:47:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:28 INFO - 'PWD': '/builds/slave/test', 03:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:28 INFO - 'SHELL': '/bin/bash', 03:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uswe0pAcsD/Listeners', 03:47:28 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 03:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:28 INFO - 'USER': 'cltbld', 03:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:28 INFO - 'XPC_FLAGS': '0x0', 03:47:28 INFO - 'XPC_SERVICE_NAME': '0', 03:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:28 INFO - Downloading/unpacking flake8 03:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:47:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:47:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:47:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:47:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:47:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:47:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:47:32 INFO - no previously-included directories found matching 'docs/_build' 03:47:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:47:32 INFO - Running setup.py install for pep8 03:47:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:47:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:47:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:47:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:47:32 INFO - no previously-included directories found matching 'docs/_build' 03:47:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:47:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:47:32 INFO - Cleaning up... 03:47:32 INFO - Return code: 0 03:47:32 INFO - Running post-action listener: _resource_record_post_action 03:47:32 INFO - Running post-action listener: _start_resource_monitoring 03:47:32 INFO - Starting resource monitoring. 03:47:32 INFO - ##### 03:47:32 INFO - ##### Running install step. 03:47:32 INFO - ##### 03:47:32 INFO - Running pre-action listener: _resource_record_pre_action 03:47:32 INFO - Running main action method: install 03:47:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:47:32 INFO - Reading from file tmpfile_stdout 03:47:32 INFO - Detecting whether we're running mozinstall >=1.0... 03:47:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:47:33 INFO - Reading from file tmpfile_stdout 03:47:33 INFO - Output received: 03:47:33 INFO - Usage: mozinstall [options] installer 03:47:33 INFO - Options: 03:47:33 INFO - -h, --help show this help message and exit 03:47:33 INFO - -d DEST, --destination=DEST 03:47:33 INFO - Directory to install application into. [default: 03:47:33 INFO - "/builds/slave/test"] 03:47:33 INFO - --app=APP Application being installed. [default: firefox] 03:47:33 INFO - mkdir: /builds/slave/test/build/application 03:47:33 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'] 03:47:33 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 03:48:04 INFO - Reading from file tmpfile_stdout 03:48:04 INFO - Output received: 03:48:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:48:04 INFO - Running post-action listener: _resource_record_post_action 03:48:04 INFO - ##### 03:48:04 INFO - ##### Running run-tests step. 03:48:04 INFO - ##### 03:48:04 INFO - Running pre-action listener: _resource_record_pre_action 03:48:04 INFO - Running main action method: run_tests 03:48:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:48:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:48:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:48:04 INFO - 2016-05-11 03:48:04.561 screenresolution[1640:7554] starting screenresolution argv=screenresolution get 03:48:04 INFO - 2016-05-11 03:48:04.564 screenresolution[1640:7554] Display 0: 1600x1200x32@60 03:48:04 INFO - 2016-05-11 03:48:04.569 screenresolution[1641:7556] starting screenresolution argv=screenresolution list 03:48:04 INFO - Available Modes on Display 0 03:48:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:48:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:48:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:48:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:48:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:48:04 INFO - Intel Iris: 03:48:04 INFO - Chipset Model: Intel Iris 03:48:04 INFO - Type: GPU 03:48:04 INFO - Bus: Built-In 03:48:04 INFO - VRAM (Dynamic, Max): 1536 MB 03:48:04 INFO - Vendor: Intel (0x8086) 03:48:04 INFO - Device ID: 0x0a2e 03:48:04 INFO - Revision ID: 0x0009 03:48:04 INFO - Displays: 03:48:04 INFO - Display: 03:48:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:48:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:48:04 INFO - Display Serial Number: 1600x1200 60 03:48:04 INFO - Main Display: Yes 03:48:04 INFO - Mirror: Off 03:48:04 INFO - Online: Yes 03:48:04 INFO - Rotation: Supported 03:48:04 INFO - Return code: 0 03:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:48:04 INFO - Python 2.7.3 03:48:04 INFO - Return code: 0 03:48:04 INFO - grabbing minidump binary from tooltool 03:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:04 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 0x10102ae00>, '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 0x100e93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101025b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:48:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:48:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:48:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:48:04 INFO - Return code: 0 03:48:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:48:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:48:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:48:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:48:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:48:05 INFO - Return code: 0 03:48:05 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:48:05 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:48:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AwKd7whXQ/Render', 03:48:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:05 INFO - 'HOME': '/Users/cltbld', 03:48:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:05 INFO - 'LOGNAME': 'cltbld', 03:48:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:48:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:05 INFO - 'MOZ_NO_REMOTE': '1', 03:48:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:48:05 INFO - 'NO_EM_RESTART': '1', 03:48:05 INFO - 'PAGER': '/bin/cat', 03:48:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:05 INFO - 'PWD': '/builds/slave/test', 03:48:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:48:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:05 INFO - 'SHELL': '/bin/bash', 03:48:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uswe0pAcsD/Listeners', 03:48:05 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 03:48:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:05 INFO - 'USER': 'cltbld', 03:48:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:05 INFO - 'XPC_FLAGS': '0x0', 03:48:05 INFO - 'XPC_SERVICE_NAME': '0', 03:48:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:48:06 INFO - mozversion application_buildid: 20160510142413 03:48:06 INFO - mozversion application_changeset: 1dd42a351054c5b697873d647169019d4d77d762 03:48:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:48:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:48:06 INFO - mozversion application_name: Firefox 03:48:06 INFO - mozversion application_remotingname: firefox-dev 03:48:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:48:06 INFO - mozversion application_vendor: Mozilla 03:48:06 INFO - mozversion application_version: 48.0a2 03:48:06 INFO - mozversion platform_buildid: 20160510142413 03:48:06 INFO - mozversion platform_changeset: 1dd42a351054c5b697873d647169019d4d77d762 03:48:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:48:06 INFO - mozversion platform_version: 48.0a2 03:48:06 INFO - using testdate: 1462963686 03:48:06 INFO - actual date: 1462963686 03:48:06 INFO - starting webserver on 'localhost:49279' 03:48:06 INFO - SUITE-START | Running 2 tests 03:48:06 INFO - TEST-START | dromaeo_css 03:48:06 INFO - operating with platform_type : mac_ 03:48:06 INFO - Initialising browser for dromaeo_css test... 03:48:06 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpPXZ9Y4/profile http://localhost:49279/getInfo.html) 03:48:08 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 03:48:08 INFO - PROCESS | 1659 | colorDepth:24 03:48:08 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 03:48:08 INFO - PROCESS | 1659 | __metrics 03:48:09 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:48:09 INFO - TEST-INFO | 1659: exit 0 03:48:09 INFO - Browser initialized. 03:48:09 INFO - Running cycle 1/1 for dromaeo_css test... 03:48:09 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpPXZ9Y4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:21 INFO - PROCESS | 1662 | RSS: Main: 220737536 03:48:21 INFO - PROCESS | 1662 | 03:49:11 INFO - PROCESS | 1662 | 1462963751385 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:51:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 03:51:24 INFO - PROCESS | 1662 | RSS: Main: 234442752 03:51:24 INFO - PROCESS | 1662 | 03:54:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 03:54:27 INFO - PROCESS | 1662 | RSS: Main: 246378496 03:54:27 INFO - PROCESS | 1662 | 03:57:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 03:57:29 INFO - PROCESS | 1662 | RSS: Main: 248709120 03:57:29 INFO - PROCESS | 1662 | 04:00:31 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 04:00:32 INFO - PROCESS | 1662 | RSS: Main: 249901056 04:00:32 INFO - PROCESS | 1662 | 04:03:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 04:03:35 INFO - PROCESS | 1662 | RSS: Main: 252694528 04:03:35 INFO - PROCESS | 1662 | 04:06:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 04:06:38 INFO - PROCESS | 1662 | RSS: Main: 253816832 04:06:38 INFO - PROCESS | 1662 | 04:06:38 INFO - PROCESS | 1662 | __start_tp_report 04:06:38 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 04:06:38 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 04:06:38 INFO - PROCESS | 1662 | |i|pagename|runs| 04:06:38 INFO - PROCESS | 1662 | |0;dojo.html;3446.121239084034;3486.686198242158;3507.8421471033803;3520.9295814083725;3534.982325088374;5708.286464191976;5720.856978575533;5736.827895163141;5738.167965644984;5752.453516915897;5695.316562012565;5714.171445140452;5732.5127364174095;5752.395998420168;5753.338366087901;5177.5599074078655;5193.714345710984;5201.349831271091;5244.370675518943;5250.474952504738;4646.884747660571;4910.7299098549565;5131.358580177478;5236.738163091849;5242.449542798008;3769.9632601034796;4976.377952755905;5123.795048198086;5218.8695282617855;5235.633505654606;4421.248387774102;5235.895282094356;5237.633365664405;5248.5538729208065;5253.579713622901;5103.362079740033;5183.041137389595;5186.455422180655;5201.609879259071;5239.554637855748;5610.382857885629;5660.094384898396;5694.886102277973;5717.313922329306;5718.885622287573;6073.271207455089;6085.574009819315;6188.040853667689;6238.968805155945;6245.812625621239;6125.26597467571;6161.969190154021;6223.284322302902;6267.62394256346;6300.779472718433;5826.621269617462;5835.416458354173;5850.151727999459;5860.589758716891;5873.588848780587;6274.874502509924;6278.748850045947;6284.277308109535;6293.937060629427;6304.275008374096;5035.748212589356;5991.790287340009;6098.847528811726;6112.602680825732;6146.323904370515;6159.199304090529;6213.813585592439;6237.937620623827;6252.062190671345;6263.71813268404;6200.875982480326;6209.9068513972325;6215.06773983897;6231.501479881598;6284.214473190851;6158.1686472326555;6167.198264225712;6200.0699895016105;6256.624602523863;6264.718087686065;4934.383202099738;4949.232868905326;4950.405951285797;4980.12847751642;4988.9750551247735;3963.3353991323715;4033.052232725307;4499.235130027903;4500.3249512573375;4504.369388285642;5743.195952566644;5749.453801888814;5761.769529218868;5771.249737534177;5814.941850581525;6287.434130928238;6311.589746666452;6315.5579109462815;6317.842053948688;6328.905066424008;4618.422697162855;5628.943710562924;5719.456651618089;5782.392848750905;5790.739416726257;5336.17289320156;5389.622726409192;5451.591130665216;5472.398036216013;5505.834824955257;6366.267879193952;6395.680215989182;6407.7757278495965;6450.193725784277;6458.257300410513;5637.577181711306;6120.387961203844;6274.247090349188;6280.371962803683;6289.182406287337;6341.904871427025;6391.808245752635;6396.232452105777;6422.486201103994;6426.100345951477;5593.776248950159;5937.703114844327;6216.2540495140875;6218.378162183745;6220;6133;6166.136740856374;6197.876042479215;6280.403361680633;6292.496600271876;6107.358727333566;6146.508279337731;6164.815055548341;6171.228596425447;6197.938020619917;5353.705546194841;5652.689102099424;6077.908831367621;6156.846078847885;6162.075688646739;5706.942930570641;5869.970650146893;5926.703664816828;5969.253843269591;5983.431574000463;6096.481799047131;6108.053251745987;6118.174046503843;6138.877222455437;6165.321814600301;5977.252843394575;5980.37206093354;6003.039513677791;6028.819135425944;6030.969845150747 04:06:38 INFO - PROCESS | 1662 | |1;ext.html;505.3607186908561;520.7266185252743;546.3580293155542;562.0894151474611;630.8644440007985;33454.16364590886;37488.81255593725;38053.61946380536;38099.42850857236;38152.855414337544;38936.41595376072;39521;39554.60445395545;39603;39647.60352396475;9196.172344489012;9390.953045234799;9427.387219830689;9496.477693726842;9507.857382139273;9306.302027347941;9480.81038379232;9540.99819518951;9556.044395560422;9566.904330956706;9544.379615325017;9554.904450955506;9578.329516933818;9596.992315806845;9608.567614457332;9485.810283794355;9560.904390956071;9575.281853860954;9595.808083838285;9636.518174091338;9433.716988490356;9463.053694630482;9505.049495050509;9528.999455057257;9574.856377154349;38005.23989520222;38445.23109537794;38611.8069409654;38726;38825.029374265585;2607.296030071889;2607.960880586793;3091.1653853459666;3196.7122958933573;3250.8537115829845;26103.869480652476;26136.738632613622;26286.6057009145;26576;26768.063117790978;2695.7439043290856;2742.0951086141527;2745.203890871645;2764;2766.405222877071;329069;341281;342231;342374;345105;56834.71582642143;57281.71359143178;57374.7131264341;57455.712721436124;57493.425065749645;56642.716786415804;65141.697166056416;66010;66101;66576;12901.903338216169;15722.05667659944;17097.914510427367;17143.57141071483;17151.399701010403;12750.744985100246;13086;13106.410211540504;13159.210447373189;13164.60506184816;18992.860428374064;19092.618147637248;19290.324838630582;19303.710444343345;19341.80658193428;8187.485315216704;8373.29177655244;8397.580120993925;8448.32413406926;8496.957515212385;873.2359185712502;912.6805618033768;950.5104870991445;964.5370222293338;1101.4634584754224;25764.54077964096;26905.547540721593;27266.45467090647;27501.31246718848;28055.859720701264;866.4671227195356;1046.3198920701604;1079.4710591810115;1096.5065720425841;1122.259308856151;11348.14888883337;13980.86019139816;14111.294435278194;14235.928820355832;14360.640983975276;640590;653237;653754;655481;655844;57186.570335741104;57966;59406.40593594095;59687.701561491915;59996;1280.5262053040249;1512.1154124837094;1514.833368329483;1519.4833756522835;1522.5051858146146;27109.457810844066;27259.182224533295;27752.861235693694;27926;28057.859710702134;48851;48884.75557622189;49216.753916231624;49647.007059857875;49686.75156624194;605187;605883;609348;609396;611252;26209.4758104833;26572.7342726578;26598.33504162334;26945.0569230076;41248.58751412568;41414;41834.79082604689;42499.787501062296;42968.78515607402;43080.56919430891;35867;36788.816055919546;36850.23623228322;37165.6283437173;37308;36091.91724248277;36135;36671;36763.816180918926;36797.63202367942;29647.96232131865;35730.28539429145;36146.81926590455;36827.447588285664;36976.26047479089;31026.224344391572;31771.875929045502;31989.840050799598;32222.677773221967;32412.35175296528;24441.777911104728;24474.63288050645;24487.75512244926;24788.38029049288;24807.62788558137 04:06:38 INFO - PROCESS | 1662 | |2;jquery.html;376.28505838906074;403.76581582682047;405.07036351573134;410.273815346836;413.9772312522812;14961.177135257556;15886;17613.82386176138;20001.59996800063;20761.688574671392;19862.50343741407;20870.26954056608;21051.894740526313;21147.942602869873;21651.67522487164;5482.068048431776;5801.129830525423;5922.6150300230565;5968.7612495500125;6056.182415373913;5838.182654428383;5838.4453476919625;5906.9704651476895;5919.763209471616;5950.613210141327;5583.58123140764;5882.852928676796;5891.499222566087;5894.734736936848;5899.292084949812;5811.854703632422;5840.15317778924;5861.413858614104;5863.2670916135485;5876.265466816648;5156.974215128937;5182.067227899014;5185.196294574347;5190.818321358772;5202.375714914197;20987.895060524752;25515.48969020628;25875.741242587523;26050.86974565115;26377.549234792077;1733.8526225270866;1941.2041063164177;2136.2202795979356;2220.578090162864;2337.789598936087;10035.648752293635;12022.67109435468;13770.586882393543;15160.620984475367;15160.696786064327;1738.6261953680018;1818.6999145141035;1924.490010147312;1937.8643494955359;1976.802319768026;108093;112400.87599123985;112745.99999999919;113817.43091284491;118845.99999999914;10832.729181770519;11943.880561194277;12008.579699710468;12038.277703337828;12084.033277337967;14873.47942821996;14973.251337433303;14989.70020599582;15110.697786044437;15231.390744370101;9029.864552031724;9073.863892041625;9074.137956894085;9081.228095611816;9148.085191480799;7348;7989.960050199712;8357.289630381485;9114.680986165453;9126.634934602675;4779.354787103696;4785.114753770494;4819.421669399694;4820.662553621213;4865.927011094836;2035.9185632574531;2038.9184432622826;2056.5578400643635;2061.701053347256;2079.3553998260586;764.4037650632515;832.6710949175042;862.3747782857379;885.3050355470924;989.0702739424918;15367;19224.134913928905;19508;19941.202351906053;20126;834.4534330013851;845.809692819123;869.0483920107472;908.2597682888425;921.6313474610209;10406.947965260126;10619.787604247871;10720.46397680113;10740.946295268473;10744.462776861126;628249;636473;643639;649785;651588;105269.47365263278;113822;119546;122072;125248;937.5312343828086;950.1686024728363;958.7842735384482;958.8178246133212;995.5370752600076;14796.704065918837;17598.208080636658;17840.91079544646;18055.368062117763;18538.443846684622;46634;49284.50715492799;52403.47596523986;53916.191257131955;55852.16221756596;77807.22192778;78442.87441665232;79664.60167699124;81233.59383203046;83060.58469707613;8091.55496447701;8362.540060296742;8388.412811103164;8519.787005324917;8729.825403492021;11291.266067705574;12891.355432228538;12976;13004.8049279259;13313.001524885478;10766.977137171956;10855.402952837354;10874.130069594572;10905.56377744913;11026.669199924016;9502;10659.840102398626;11127.72180695489;11208.215424920178;11485.827712584485;10824.05167069935;11005.339679619248;11080.113590912546;11190.552377905118;11446.255993360737;7930.246626570467;8311.459755115899;8429.199226073513;8521.659133634585;8787.34094942869;8810.823783524422;10888.891111088788;11015.173861960546;11082.944585277022;11107.000369966741 04:06:38 INFO - PROCESS | 1662 | |3;mootools.html;1573.1347758732697;1587.5078725595063;1711.7846329106335;1828.615990641965;1886.9527412286193;6469.57947733397;8617.052124266342;8732.650693972242;8940.150685684857;8977.730668079952;8754.124587541242;8762.561871906395;8872.290216782658;8877.422967507107;8882.600282987265;2486.900523979043;2500.4249022724784;2502.4119331957068;2503.0988844016138;2512.095645567594;2432.282476669378;2507.4608959073794;2510.146550172941;2515.76100270474;2516.358328626198;2475.7648023437746;2488.191337815208;2535.1253817432957;2538.834975726581;2548.3119557719406;2495.7129930058095;2507.034791605227;2516.7609077137645;2524.7222805491383;2544.465662210938;2503.173952595639;2510.7740303372602;2527.292358139724;2538.263903467992;2550.4006558458746;9108.726738197865;9113.043130471338;9118.270538356981;9118.86321705175;9178.495182764946;5541.27963364764;5568.192612071227;5655.3779084300695;5656.095024796054;5717.885642287131;3582.1044738815294;3642.3990041643096;3644.0343309022865;3713.554373475173;3732.477453156533;1038.678009816959;1051.6003918510994;1065.7495488560182;1067.6209945469402;1070.1545778834711;12237.571684990982;12377.69055773604;12406.75186496265;12421.503139874394;12495.375231238402;4936.950630493721;4976.004799040206;5039.77321020555;5062.594992400599;5094.592432605383;10412.739681508023;10511.369317840954;10528.473576321154;10549.525271362807;10555.525001374957;5612.214289999403;5616.438356164351;5639.718014099279;5640.97179514108;5667.603267771216;4113.794310284474;4470.888227794331;4971.304017437562;5013.373328333958;5085.338905942203;3708.165662725919;3819.1788765415567;4058.6347228748964;4165.97917010413;4278.614924656796;1166.2710805746408;1368.9383977721027;1387.7293927684207;1392.0325373865066;1408.901376903607;773.9496932699357;789.5894135049742;803.5500119932856;878.4421892098563;920.59953920045;5017.54842064216;5388.809010304394;5554.666719996813;5671.291088613923;5919.904817608756;958.8897276813256;969.3263182088381;988.3970777825521;1009.9899001010043;1016.7102375823002;3702.5742039665784;3721.9069523262133;3806.847726090981;3891.727579069438;3925.8822235332987;10284.537195826206;10499.317544359592;10614.840777388345;10674.839877401846;10690.251682382313;10343.9482802587;10362.430066346424;10444.321119127233;10487.056164945192;10526.052655261063;8130.186981301823;8201.343892488705;8310.626021829032;8385.748427547062;8427.073021967457;5394.838154855361;5710.2291190690385;5820.1560773688425;5952.285725712942;6029.276486821609;8343.791405214675;9421.952890235505;9635.807283854423;9667;9680.951595241979;9632.422054676741;9814.705558833246;9835.311528193244;9995.400275983464;9999.050090241415;6895.5173137879865;7369.373603243785;7522.811929701582;7661.310482056641;7724.957130787272;8314.750557483285;8338.416310858182;8368.330533557422;8380.622871970654;8400.579971001303;7224.927750722636;7382.704691812267;7403.555786652818;7482.588457634664;7540.095188577406;7241.275872412716;7299.160596531467;7329.670164842488;7385.483016188815;7408.148062972611;6859.622720750406;6916.412104971134;6959.373656370951;7017.087778588751;7025.01649769043;4743.051389722138;4755.310479980314;4777.689450185727;4860.635452341018;4862.343583616308;4309.439772829513;4851.733154676385;4856.150173719514;4898.8775280618265;4974.054929563516 04:06:38 INFO - PROCESS | 1662 | |4;prototype.html;327.48584721986475;329.22139140931705;334.7874099946534;335.0217365293343;338.4550873094319;6743.527953043289;6788.864222715542;6842.144731908512;6871.415929645974;6913.239543650195;5353.411124776281;6745.3591908768585;6750.932490675092;6766.086578311926;6799.150106236721;4702.97648511757;4743.691660042104;4850.9029819403595;4854.514548545152;4947.431045429767;4887.218045112782;4939.259111133323;4952.232403977371;4996.650234483587;5009.298698182258;4939.555440010398;4956.87607809804;4961.156603377416;4961.429435614915;4990.925136122943;4973.403191617011;4973.552380285773;4973.701577905301;4996;4997.825076122354;3532.6114127445962;4243.61807437329;4267.551907049746;4273.572642735701;4277.935830962538;6389.424951754318;6506.479481641504;6532.085508028832;6570.244421891448;6592.835179120512;4497.302918047675;4988.002399520111;5753.424657534255;5930.406959304035;5991.670458124801;5799.82600521985;7260.818479538001;7263.818404539876;7269.055022847049;7298;4803.591694705954;4817.51824817519;4820.939393333496;4822.132016237076;4836.347093142451;6887.725770732431;6967.049226216667;7660.693572257103;7674.117476490219;7680.308772210527;4014.7189696721534;4693.178693728584;4883.609311255091;4902.313676085351;4910.091633047898;4943.9258411123865;4990.525900039491;4999.150144475375;5001.64988450805;5014.122528557488;4901.656884018084;5802.564807639444;5931.733072011683;5943.524518038546;5948.643081415129;7275.67259473325;7290.890636640454;7297.708091676273;7310.890336644955;7314.195438501761;1426.4650755966513;1708.8465285931945;1742.9716467284109;1744.5725797179773;1744.8778585499147;1080.152080616712;1126.1159989408275;1127.6617014895498;1130.621241883978;1144.9828252576217;6706.228783689938;6727.562708424035;6752.189737231465;6768.83077923046;6771.661416929134;7260.38286745622;7552.093748750075;7560.735374261874;7577.583232922242;7586.089669239726;6721.227058888193;6815.488838337144;6820.556663816936;6827.214870289881;6838.14523184602;3224.2261857154585;4030.0932290234464;4047.0894048838777;4050.4936882889638;4062.9593704063172;8001.319887809602;8005.679772809022;8015.078265999368;8017.719379821679;8025.598720063974;6743.853544897379;7548.66031028605;7587.848243035219;7927.246911543394;7968.322692571081;7439.55362678241;7941.9999999998845;8008.039035315799;8011.919880801117;8020.639071241808;6122.326544080059;7628.54228746277;7632.80917977055;7642.694292228249;7654.15804261542;7511.248875112664;7535.623218839146;7541.773746787605;7546.207648196861;7560.697572097055;6087.847803804941;7837.137914829478;7993.12075671664;8010.319122874621;8011.6795328188555;4012.398140278865;4883.316335713074;4902.950970490249;4935.358403407534;4940.604751619933;7601.733939312097;7633.809154771176;7641.465097443125;7658.69365225407;7675.04061992251;7324.487285889936;7340.009098771811;7351.70593176267;7354.521956072838;7375.041244638377;6971.58170509771;7312.488125831141;7320.377767889789;7339.339459448462;7352.154502232312;5316.8139115132335;5921.822345329647;7113.75101871432;7194;7200.531965422231;7322.450816188701;7361.895715642697;7363.447741419308;7368.1526624438875;7390.150132734804;6892.586444813327;7125.038119853753;7146.356827885307;7162.820929476805;7170.354668079898 04:06:38 INFO - PROCESS | 1662 | |5;yui.html;662.7978466567695;706.6078326528776;708.8936659501071;729.1286912139991;770.468376819994;14746.557603271893;14852.108873467587;15041.62395940102;15064.472743453967;15084;13737.58787236382;15276.388944442237;15611.531654050397;15629.609259768511;15653.84346156538;724.8731471992406;889.0975659705405;910.6357457017212;917.9311551633621;919.31511024287;885.0972008551274;902.2060586683709;905.5879574793486;910.1308250620674;911.2664305234284;933.8926023507315;961.6441916490908;962.6534447598893;962.74006018375;965.242284806427;924.1036194890945;929.1080562659855;950.8716323296336;952.7046615549167;961.2694352292239;602.7347966894596;700.6321681117403;711.7046425733314;717.7667258141125;720.1646090535006;15278.618034549114;15302.005369651048;15314.923425382913;15336.846631533765;15349.693006139927;12435.191712538655;12462.252264864046;12564.497420103186;12599.811002834966;12612.81080783789;10000.199984001263;10238.692839214835;10252.589896404135;10444.373337599693;10530.47347632623;2977.1366303772097;3092.4588197065423;3203.3913556424436;3309.7352211822995;3335;76571.6171419145;77360;77447;79711;82515.3496930058;9320.487373194539;9430;9430.717078487656;9445.386049906734;9557.23542116643;21089.261875834272;21125.78874211269;21132.577348452945;21150.576988460143;21155;7200.639968001579;7317.15852676949;7321.341079302888;7351.852962940711;7470.589117598475;3528.065062758371;3963.4847469828737;4007.779572123503;4031.9798401007806;4046.7167298288837;2666.9599956000675;3226.7257283130725;3277.6230733465954;3363;3409.5226668266464;539.382407143826;643.5527308520627;644.937586685154;653.3433898931638;661.8610091880759;519.3482179864246;570.9714514274269;587.6620942957817;615.5414216408805;616.7810427298334;6916.585004899722;6965.686544105527;8031.156728543536;8042.718504852302;8048.315893149031;519.5090639345857;527.3171243240014;534.8582625604218;573.4437595532327;587.1310460518457;3606.585242697071;3812.313783518993;3821.178446633987;3863.74885632433;3876;95189.57215641771;95592;96734.5163274179;97110;98184;76136.61931690306;76785.61607191928;76823.61588192135;77073.84389234165;78190.21809781829;71013;71352.64323678348;71354;72568.63715681387;73031.63484182545;6595.637239951849;7643.694252229849;7736.110347310131;7741.187175346733;7914.1294457608465;45694.771526142154;45830.08339833118;46806;47448.52551474441;48940;60476.39523604708;63266.683666583216;63528.682356587924;63722.36277637164;66468.33531664622;10642.361458312525;10769.569217231536;10770.353778773298;11041.447927603427;11124.276922000368;11505.654830355103;11695.76608467843;11855.466504007512;12031.4585843639;12068.155229133876;10747.355158690503;11604.825927611262;11658.358790266617;11726.589569365031;11896.881031189578;11232.3260604364;11316.660500185008;11329.839404777289;11360.772784544097;11860.525578976743;11174;11177.16171287173;11311.886881131413;11556.191066625255;11619.767604648028;9714.514274286399;9768.902310976799;9791.559379827782;9842.360246583949;9883.752906177404;9483.312978240601;9683.080107389787;9687.079727425884;9752.024797520475;9803.970408747966 04:06:38 INFO - PROCESS | 1662 | __end_tp_report 04:06:38 INFO - PROCESS | 1662 | __start_cc_report 04:06:38 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,418 04:06:38 INFO - PROCESS | 1662 | __end_cc_report 04:06:38 INFO - PROCESS | 1662 | __startTimestamp1462964798041__endTimestamp 04:06:38 INFO - PROCESS | 1662 | 04:06:38 INFO - PROCESS | 1662 | ------- Summary: start ------- 04:06:38 INFO - PROCESS | 1662 | Number of tests: 6 04:06:38 INFO - PROCESS | 1662 | 04:06:38 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5715.01 Median:5926.70 stddev:672.75 (11.4%) stddev-sans-first:650.84 04:06:38 INFO - PROCESS | 1662 | Values: 3446.1 3486.7 3507.8 3520.9 3535.0 5708.3 5720.9 5736.8 5738.2 5752.5 5695.3 5714.2 5732.5 5752.4 5753.3 5177.6 5193.7 5201.3 5244.4 5250.5 4646.9 4910.7 5131.4 5236.7 5242.4 3770.0 4976.4 5123.8 5218.9 5235.6 4421.2 5235.9 5237.6 5248.6 5253.6 5103.4 5183.0 5186.5 5201.6 5239.6 5610.4 5660.1 5694.9 5717.3 5718.9 6073.3 6085.6 6188.0 6239.0 6245.8 6125.3 6162.0 6223.3 6267.6 6300.8 5826.6 5835.4 5850.2 5860.6 5873.6 6274.9 6278.7 6284.3 6293.9 6304.3 5035.7 5991.8 6098.8 6112.6 6146.3 6159.2 6213.8 6237.9 6252.1 6263.7 6200.9 6209.9 6215.1 6231.5 6284.2 6158.2 6167.2 6200.1 6256.6 6264.7 4934.4 4949.2 4950.4 4980.1 4989.0 3963.3 4033.1 4499.2 4500.3 4504.4 5743.2 5749.5 5761.8 5771.2 5814.9 6287.4 6311.6 6315.6 6317.8 6328.9 4618.4 5628.9 5719.5 5782.4 5790.7 5336.2 5389.6 5451.6 5472.4 5505.8 6366.3 6395.7 6407.8 6450.2 6458.3 5637.6 6120.4 6274.2 6280.4 6289.2 6341.9 6391.8 6396.2 6422.5 6426.1 5593.8 5937.7 6216.3 6218.4 6220.0 6133.0 6166.1 6197.9 6280.4 6292.5 6107.4 6146.5 6164.8 6171.2 6197.9 5353.7 5652.7 6077.9 6156.8 6162.1 5706.9 5870.0 5926.7 5969.3 5983.4 6096.5 6108.1 6118.2 6138.9 6165.3 5977.3 5980.4 6003.0 6028.8 6031.0 04:06:38 INFO - PROCESS | 1662 | 04:06:38 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:66384.36 Median:37747.03 stddev:147743.72 (391.4%) stddev-sans-first:148075.39 04:06:38 INFO - PROCESS | 1662 | Values: 505.4 520.7 546.4 562.1 630.9 33454.2 37488.8 38053.6 38099.4 38152.9 38936.4 39521.0 39554.6 39603.0 39647.6 9196.2 9391.0 9427.4 9496.5 9507.9 9306.3 9480.8 9541.0 9556.0 9566.9 9544.4 9554.9 9578.3 9597.0 9608.6 9485.8 9560.9 9575.3 9595.8 9636.5 9433.7 9463.1 9505.0 9529.0 9574.9 38005.2 38445.2 38611.8 38726.0 38825.0 2607.3 2608.0 3091.2 3196.7 3250.9 26103.9 26136.7 26286.6 26576.0 26768.1 2695.7 2742.1 2745.2 2764.0 2766.4 329069.0 341281.0 342231.0 342374.0 345105.0 56834.7 57281.7 57374.7 57455.7 57493.4 56642.7 65141.7 66010.0 66101.0 66576.0 12901.9 15722.1 17097.9 17143.6 17151.4 12750.7 13086.0 13106.4 13159.2 13164.6 18992.9 19092.6 19290.3 19303.7 19341.8 8187.5 8373.3 8397.6 8448.3 8497.0 873.2 912.7 950.5 964.5 1101.5 25764.5 26905.5 27266.5 27501.3 28055.9 866.5 1046.3 1079.5 1096.5 1122.3 11348.1 13980.9 14111.3 14235.9 14360.6 640590.0 653237.0 653754.0 655481.0 655844.0 57186.6 57966.0 59406.4 59687.7 59996.0 1280.5 1512.1 1514.8 1519.5 1522.5 27109.5 27259.2 27752.9 27926.0 28057.9 48851.0 48884.8 49216.8 49647.0 49686.8 605187.0 605883.0 609348.0 609396.0 611252.0 26209.5 26572.7 26598.3 26945.1 41248.6 41414.0 41834.8 42499.8 42968.8 43080.6 35867.0 36788.8 36850.2 37165.6 37308.0 36091.9 36135.0 36671.0 36763.8 36797.6 29648.0 35730.3 36146.8 36827.4 36976.3 31026.2 31771.9 31989.8 32222.7 32412.4 24441.8 24474.6 24487.8 24788.4 24807.6 04:06:38 INFO - PROCESS | 1662 | 04:06:38 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:35763.17 Median:25963.31 stddev:106447.76 (410.0%) stddev-sans-first:106713.21 04:06:38 INFO - PROCESS | 1662 | Values: 376.3 403.8 405.1 410.3 414.0 14961.2 15886.0 17613.8 20001.6 20761.7 19862.5 20870.3 21051.9 21147.9 21651.7 5482.1 5801.1 5922.6 5968.8 6056.2 5838.2 5838.4 5907.0 5919.8 5950.6 5583.6 5882.9 5891.5 5894.7 5899.3 5811.9 5840.2 5861.4 5863.3 5876.3 5157.0 5182.1 5185.2 5190.8 5202.4 20987.9 25515.5 25875.7 26050.9 26377.5 1733.9 1941.2 2136.2 2220.6 2337.8 10035.6 12022.7 13770.6 15160.6 15160.7 1738.6 1818.7 1924.5 1937.9 1976.8 108093.0 112400.9 112746.0 113817.4 118846.0 10832.7 11943.9 12008.6 12038.3 12084.0 14873.5 14973.3 14989.7 15110.7 15231.4 9029.9 9073.9 9074.1 9081.2 9148.1 7348.0 7990.0 8357.3 9114.7 9126.6 4779.4 4785.1 4819.4 4820.7 4865.9 2035.9 2038.9 2056.6 2061.7 2079.4 764.4 832.7 862.4 885.3 989.1 15367.0 19224.1 19508.0 19941.2 20126.0 834.5 845.8 869.0 908.3 921.6 10406.9 10619.8 10720.5 10740.9 10744.5 628249.0 636473.0 643639.0 649785.0 651588.0 105269.5 113822.0 119546.0 122072.0 125248.0 937.5 950.2 958.8 958.8 995.5 14796.7 17598.2 17840.9 18055.4 18538.4 46634.0 49284.5 52403.5 53916.2 55852.2 77807.2 78442.9 79664.6 81233.6 83060.6 8091.6 8362.5 8388.4 8519.8 8729.8 11291.3 12891.4 12976.0 13004.8 13313.0 10767.0 10855.4 10874.1 10905.6 11026.7 9502.0 10659.8 11127.7 11208.2 11485.8 10824.1 11005.3 11080.1 11190.6 11446.3 7930.2 8311.5 8429.2 8521.7 8787.3 8810.8 10888.9 11015.2 11082.9 11107.0 04:06:38 INFO - PROCESS | 1662 | 04:06:38 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5751.17 Median:4975.03 stddev:3194.74 (64.2%) stddev-sans-first:3188.27 04:06:38 INFO - PROCESS | 1662 | Values: 1573.1 1587.5 1711.8 1828.6 1887.0 6469.6 8617.1 8732.7 8940.2 8977.7 8754.1 8762.6 8872.3 8877.4 8882.6 2486.9 2500.4 2502.4 2503.1 2512.1 2432.3 2507.5 2510.1 2515.8 2516.4 2475.8 2488.2 2535.1 2538.8 2548.3 2495.7 2507.0 2516.8 2524.7 2544.5 2503.2 2510.8 2527.3 2538.3 2550.4 9108.7 9113.0 9118.3 9118.9 9178.5 5541.3 5568.2 5655.4 5656.1 5717.9 3582.1 3642.4 3644.0 3713.6 3732.5 1038.7 1051.6 1065.7 1067.6 1070.2 12237.6 12377.7 12406.8 12421.5 12495.4 4937.0 4976.0 5039.8 5062.6 5094.6 10412.7 10511.4 10528.5 10549.5 10555.5 5612.2 5616.4 5639.7 5641.0 5667.6 4113.8 4470.9 4971.3 5013.4 5085.3 3708.2 3819.2 4058.6 4166.0 4278.6 1166.3 1368.9 1387.7 1392.0 1408.9 773.9 789.6 803.6 878.4 920.6 5017.5 5388.8 5554.7 5671.3 5919.9 958.9 969.3 988.4 1010.0 1016.7 3702.6 3721.9 3806.8 3891.7 3925.9 10284.5 10499.3 10614.8 10674.8 10690.3 10343.9 10362.4 10444.3 10487.1 10526.1 8130.2 8201.3 8310.6 8385.7 8427.1 5394.8 5710.2 5820.2 5952.3 6029.3 8343.8 9422.0 9635.8 9667.0 9681.0 9632.4 9814.7 9835.3 9995.4 9999.1 6895.5 7369.4 7522.8 7661.3 7725.0 8314.8 8338.4 8368.3 8380.6 8400.6 7224.9 7382.7 7403.6 7482.6 7540.1 7241.3 7299.2 7329.7 7385.5 7408.1 6859.6 6916.4 6959.4 7017.1 7025.0 4743.1 4755.3 4777.7 4860.6 4862.3 4309.4 4851.7 4856.2 4898.9 4974.1 04:06:38 INFO - PROCESS | 1662 | 04:06:38 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5914.79 Median:6744.61 stddev:1921.21 (28.5%) stddev-sans-first:1880.27 04:06:38 INFO - PROCESS | 1662 | Values: 327.5 329.2 334.8 335.0 338.5 6743.5 6788.9 6842.1 6871.4 6913.2 5353.4 6745.4 6750.9 6766.1 6799.2 4703.0 4743.7 4850.9 4854.5 4947.4 4887.2 4939.3 4952.2 4996.7 5009.3 4939.6 4956.9 4961.2 4961.4 4990.9 4973.4 4973.6 4973.7 4996.0 4997.8 3532.6 4243.6 4267.6 4273.6 4277.9 6389.4 6506.5 6532.1 6570.2 6592.8 4497.3 4988.0 5753.4 5930.4 5991.7 5799.8 7260.8 7263.8 7269.1 7298.0 4803.6 4817.5 4820.9 4822.1 4836.3 6887.7 6967.0 7660.7 7674.1 7680.3 4014.7 4693.2 4883.6 4902.3 4910.1 4943.9 4990.5 4999.2 5001.6 5014.1 4901.7 5802.6 5931.7 5943.5 5948.6 7275.7 7290.9 7297.7 7310.9 7314.2 1426.5 1708.8 1743.0 1744.6 1744.9 1080.2 1126.1 1127.7 1130.6 1145.0 6706.2 6727.6 6752.2 6768.8 6771.7 7260.4 7552.1 7560.7 7577.6 7586.1 6721.2 6815.5 6820.6 6827.2 6838.1 3224.2 4030.1 4047.1 4050.5 4063.0 8001.3 8005.7 8015.1 8017.7 8025.6 6743.9 7548.7 7587.8 7927.2 7968.3 7439.6 7942.0 8008.0 8011.9 8020.6 6122.3 7628.5 7632.8 7642.7 7654.2 7511.2 7535.6 7541.8 7546.2 7560.7 6087.8 7837.1 7993.1 8010.3 8011.7 4012.4 4883.3 4903.0 4935.4 4940.6 7601.7 7633.8 7641.5 7658.7 7675.0 7324.5 7340.0 7351.7 7354.5 7375.0 6971.6 7312.5 7320.4 7339.3 7352.2 5316.8 5921.8 7113.8 7194.0 7200.5 7322.5 7361.9 7363.4 7368.2 7390.2 6892.6 7125.0 7146.4 7162.8 7170.4 04:06:38 INFO - PROCESS | 1662 | 04:06:38 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18147.75 Median:30545.97 stddev:25652.80 (84.0%) stddev-sans-first:25691.16 04:06:38 INFO - PROCESS | 1662 | Values: 662.8 706.6 708.9 729.1 770.5 14746.6 14852.1 15041.6 15064.5 15084.0 13737.6 15276.4 15611.5 15629.6 15653.8 724.9 889.1 910.6 917.9 919.3 885.1 902.2 905.6 910.1 911.3 933.9 961.6 962.7 962.7 965.2 924.1 929.1 950.9 952.7 961.3 602.7 700.6 711.7 717.8 720.2 15278.6 15302.0 15314.9 15336.8 15349.7 12435.2 12462.3 12564.5 12599.8 12612.8 10000.2 10238.7 10252.6 10444.4 10530.5 2977.1 3092.5 3203.4 3309.7 3335.0 76571.6 77360.0 77447.0 79711.0 82515.3 9320.5 9430.0 9430.7 9445.4 9557.2 21089.3 21125.8 21132.6 21150.6 21155.0 7200.6 7317.2 7321.3 7351.9 7470.6 3528.1 3963.5 4007.8 4032.0 4046.7 2667.0 3226.7 3277.6 3363.0 3409.5 539.4 643.6 644.9 653.3 661.9 519.3 571.0 587.7 615.5 616.8 6916.6 6965.7 8031.2 8042.7 8048.3 519.5 527.3 534.9 573.4 587.1 3606.6 3812.3 3821.2 3863.7 3876.0 95189.6 95592.0 96734.5 97110.0 98184.0 76136.6 76785.6 76823.6 77073.8 78190.2 71013.0 71352.6 71354.0 72568.6 73031.6 6595.6 7643.7 7736.1 7741.2 7914.1 45694.8 45830.1 46806.0 47448.5 48940.0 60476.4 63266.7 63528.7 63722.4 66468.3 10642.4 10769.6 10770.4 11041.4 11124.3 11505.7 11695.8 11855.5 12031.5 12068.2 10747.4 11604.8 11658.4 11726.6 11896.9 11232.3 11316.7 11329.8 11360.8 11860.5 11174.0 11177.2 11311.9 11556.2 11619.8 9714.5 9768.9 9791.6 9842.4 9883.8 9483.3 9683.1 9687.1 9752.0 9804.0 04:06:38 INFO - PROCESS | 1662 | -------- Summary: end -------- 04:06:38 INFO - PROCESS | 1662 | 04:06:38 INFO - TEST-INFO | 1662: exit 0 04:06:38 INFO - TEST-OK | dromaeo_css | took 1112358ms 04:06:38 INFO - TEST-START | kraken 04:06:38 INFO - operating with platform_type : mac_ 04:06:38 INFO - Initialising browser for kraken test... 04:06:38 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpfr0AH1/profile http://localhost:49279/getInfo.html) 04:06:41 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 04:06:41 INFO - PROCESS | 1678 | colorDepth:24 04:06:41 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 04:06:41 INFO - PROCESS | 1678 | __metrics 04:06:41 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:06:41 INFO - TEST-INFO | 1678: exit 0 04:06:41 INFO - Browser initialized. 04:06:41 INFO - Running cycle 1/1 for kraken test... 04:06:41 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpfr0AH1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:54 INFO - PROCESS | 1681 | RSS: Main: 220749824 04:06:54 INFO - PROCESS | 1681 | 04:06:56 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:57 INFO - PROCESS | 1681 | RSS: Main: 232947712 04:06:57 INFO - PROCESS | 1681 | 04:07:00 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 04:07:00 INFO - PROCESS | 1681 | RSS: Main: 241717248 04:07:00 INFO - PROCESS | 1681 | 04:07:04 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 04:07:04 INFO - PROCESS | 1681 | RSS: Main: 245415936 04:07:04 INFO - PROCESS | 1681 | 04:07:06 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 04:07:07 INFO - PROCESS | 1681 | RSS: Main: 245882880 04:07:07 INFO - PROCESS | 1681 | 04:07:09 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:07:10 INFO - PROCESS | 1681 | RSS: Main: 247529472 04:07:10 INFO - PROCESS | 1681 | 04:07:13 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 04:07:13 INFO - PROCESS | 1681 | RSS: Main: 247840768 04:07:13 INFO - PROCESS | 1681 | 04:07:16 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 04:07:17 INFO - PROCESS | 1681 | RSS: Main: 247951360 04:07:17 INFO - PROCESS | 1681 | 04:07:20 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 04:07:21 INFO - PROCESS | 1681 | RSS: Main: 248143872 04:07:21 INFO - PROCESS | 1681 | 04:07:22 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:07:23 INFO - PROCESS | 1681 | RSS: Main: 247287808 04:07:23 INFO - PROCESS | 1681 | 04:07:25 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:07:26 INFO - PROCESS | 1681 | RSS: Main: 247304192 04:07:26 INFO - PROCESS | 1681 | 04:07:28 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:07:28 INFO - PROCESS | 1681 | RSS: Main: 247689216 04:07:28 INFO - PROCESS | 1681 | 04:07:31 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:07:32 INFO - PROCESS | 1681 | RSS: Main: 247848960 04:07:32 INFO - PROCESS | 1681 | 04:07:35 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:07:35 INFO - PROCESS | 1681 | RSS: Main: 247689216 04:07:35 INFO - PROCESS | 1681 | 04:07:37 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 04:07:38 INFO - PROCESS | 1681 | RSS: Main: 249368576 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | __start_tp_report 04:07:38 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 04:07:38 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 04:07:38 INFO - PROCESS | 1681 | |i|pagename|runs| 04:07:38 INFO - PROCESS | 1681 | |0;ai-astar;116;119;109;116;125;139;106;116;116;116 04:07:38 INFO - PROCESS | 1681 | |1;audio-beat-detection;155;121;156;175;119;140;120;153;164;125 04:07:38 INFO - PROCESS | 1681 | |2;audio-dft;202;198;200;198;198;194;200;190;202;198 04:07:38 INFO - PROCESS | 1681 | |3;audio-fft;67;69;82;144;56;69;80;88;161;59 04:07:38 INFO - PROCESS | 1681 | |4;audio-oscillator;79;83;132;95;115;70;144;120;118;153 04:07:38 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;88;86;88;85;107;74;91;132;136;118 04:07:38 INFO - PROCESS | 1681 | |6;imaging-darkroom;95;97;96;94;96;96;95;95;115;94 04:07:38 INFO - PROCESS | 1681 | |7;imaging-desaturate;132;91;138;76;147;146;139;91;92;99 04:07:38 INFO - PROCESS | 1681 | |8;json-parse-financial;62;62;65;67;64;63;66;82;64;59 04:07:38 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;68;79;98;67;109;117;110;74;72;68 04:07:38 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;82;82;82;84;84;84;86;86;85;88 04:07:38 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;130;129;130;128;127;129;128;131;148;146 04:07:38 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;172;223;223;170;171;169;201;210;230;208 04:07:38 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;67;69;66;69;72;69;81;96;99;69 04:07:38 INFO - PROCESS | 1681 | __end_tp_report 04:07:38 INFO - PROCESS | 1681 | __start_cc_report 04:07:38 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1106 04:07:38 INFO - PROCESS | 1681 | __end_cc_report 04:07:38 INFO - PROCESS | 1681 | __startTimestamp1462964858002__endTimestamp 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | ------- Summary: start ------- 04:07:38 INFO - PROCESS | 1681 | Number of tests: 14 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:117.80 Median:116.00 stddev:9.04 (7.8%) stddev-sans-first:9.57 04:07:38 INFO - PROCESS | 1681 | Values: 116.0 119.0 109.0 116.0 125.0 139.0 106.0 116.0 116.0 116.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:154.00 stddev:20.55 (13.3%) stddev-sans-first:21.31 04:07:38 INFO - PROCESS | 1681 | Values: 155.0 121.0 156.0 175.0 119.0 140.0 120.0 153.0 164.0 125.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:198.00 Median:199.00 stddev:3.65 (1.8%) stddev-sans-first:3.57 04:07:38 INFO - PROCESS | 1681 | Values: 202.0 198.0 200.0 198.0 198.0 194.0 200.0 190.0 202.0 198.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:87.50 Median:69.00 stddev:35.89 (52.0%) stddev-sans-first:37.29 04:07:38 INFO - PROCESS | 1681 | Values: 67.0 69.0 82.0 144.0 56.0 69.0 80.0 88.0 161.0 59.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:111.50 stddev:28.25 (25.3%) stddev-sans-first:27.51 04:07:38 INFO - PROCESS | 1681 | Values: 79.0 83.0 132.0 95.0 115.0 70.0 144.0 120.0 118.0 153.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:100.50 Median:85.50 stddev:21.49 (25.1%) stddev-sans-first:22.31 04:07:38 INFO - PROCESS | 1681 | Values: 88.0 86.0 88.0 85.0 107.0 74.0 91.0 132.0 136.0 118.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:95.50 stddev:6.29 (6.6%) stddev-sans-first:6.62 04:07:38 INFO - PROCESS | 1681 | Values: 95.0 97.0 96.0 94.0 96.0 96.0 95.0 95.0 115.0 94.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:115.10 Median:83.50 stddev:27.56 (33.0%) stddev-sans-first:28.55 04:07:38 INFO - PROCESS | 1681 | Values: 132.0 91.0 138.0 76.0 147.0 146.0 139.0 91.0 92.0 99.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:64.50 stddev:6.26 (9.7%) stddev-sans-first:6.51 04:07:38 INFO - PROCESS | 1681 | Values: 62.0 62.0 65.0 67.0 64.0 63.0 66.0 82.0 64.0 59.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:86.20 Median:70.00 stddev:20.02 (28.6%) stddev-sans-first:20.12 04:07:38 INFO - PROCESS | 1681 | Values: 68.0 79.0 98.0 67.0 109.0 117.0 110.0 74.0 72.0 68.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:2.00 (2.4%) stddev-sans-first:1.94 04:07:38 INFO - PROCESS | 1681 | Values: 82.0 82.0 82.0 84.0 84.0 84.0 86.0 86.0 85.0 88.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:130.00 stddev:7.69 (5.9%) stddev-sans-first:8.10 04:07:38 INFO - PROCESS | 1681 | Values: 130.0 129.0 130.0 128.0 127.0 129.0 128.0 131.0 148.0 146.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.70 Median:209.00 stddev:24.85 (11.9%) stddev-sans-first:24.55 04:07:38 INFO - PROCESS | 1681 | Values: 172.0 223.0 223.0 170.0 171.0 169.0 201.0 210.0 230.0 208.0 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:70.50 stddev:12.23 (17.3%) stddev-sans-first:12.56 04:07:38 INFO - PROCESS | 1681 | Values: 67.0 69.0 66.0 69.0 72.0 69.0 81.0 96.0 99.0 69.0 04:07:38 INFO - PROCESS | 1681 | -------- Summary: end -------- 04:07:38 INFO - PROCESS | 1681 | 04:07:38 INFO - TEST-INFO | 1681: exit 0 04:07:38 INFO - TEST-OK | kraken | took 60303ms 04:07:38 INFO - SUITE-END | took 1172s 04:07:39 INFO - Completed test suite (00:19:32) 04:07:39 INFO - javascript benchmark 04:07:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3446.121239084034, 3486.686198242158, 3507.8421471033803, 3520.9295814083725, 3534.982325088374, 5708.286464191976, 5720.856978575533, 5736.827895163141, 5738.167965644984, 5752.453516915897, 5695.316562012565, 5714.171445140452, 5732.5127364174095, 5752.395998420168, 5753.338366087901, 5177.5599074078655, 5193.714345710984, 5201.349831271091, 5244.370675518943, 5250.474952504738, 4646.884747660571, 4910.7299098549565, 5131.358580177478, 5236.738163091849, 5242.449542798008, 3769.9632601034796, 4976.377952755905, 5123.795048198086, 5218.8695282617855, 5235.633505654606, 4421.248387774102, 5235.895282094356, 5237.633365664405, 5248.5538729208065, 5253.579713622901, 5103.362079740033, 5183.041137389595, 5186.455422180655, 5201.609879259071, 5239.554637855748, 5610.382857885629, 5660.094384898396, 5694.886102277973, 5717.313922329306, 5718.885622287573, 6073.271207455089, 6085.574009819315, 6188.040853667689, 6238.968805155945, 6245.812625621239, 6125.26597467571, 6161.969190154021, 6223.284322302902, 6267.62394256346, 6300.779472718433, 5826.621269617462, 5835.416458354173, 5850.151727999459, 5860.589758716891, 5873.588848780587, 6274.874502509924, 6278.748850045947, 6284.277308109535, 6293.937060629427, 6304.275008374096, 5035.748212589356, 5991.790287340009, 6098.847528811726, 6112.602680825732, 6146.323904370515, 6159.199304090529, 6213.813585592439, 6237.937620623827, 6252.062190671345, 6263.71813268404, 6200.875982480326, 6209.9068513972325, 6215.06773983897, 6231.501479881598, 6284.214473190851, 6158.1686472326555, 6167.198264225712, 6200.0699895016105, 6256.624602523863, 6264.718087686065, 4934.383202099738, 4949.232868905326, 4950.405951285797, 4980.12847751642, 4988.9750551247735, 3963.3353991323715, 4033.052232725307, 4499.235130027903, 4500.3249512573375, 4504.369388285642, 5743.195952566644, 5749.453801888814, 5761.769529218868, 5771.249737534177, 5814.941850581525, 6287.434130928238, 6311.589746666452, 6315.5579109462815, 6317.842053948688, 6328.905066424008, 4618.422697162855, 5628.943710562924, 5719.456651618089, 5782.392848750905, 5790.739416726257, 5336.17289320156, 5389.622726409192, 5451.591130665216, 5472.398036216013, 5505.834824955257, 6366.267879193952, 6395.680215989182, 6407.7757278495965, 6450.193725784277, 6458.257300410513, 5637.577181711306, 6120.387961203844, 6274.247090349188, 6280.371962803683, 6289.182406287337, 6341.904871427025, 6391.808245752635, 6396.232452105777, 6422.486201103994, 6426.100345951477, 5593.776248950159, 5937.703114844327, 6216.2540495140875, 6218.378162183745, 6220.0, 6133.0, 6166.136740856374, 6197.876042479215, 6280.403361680633, 6292.496600271876, 6107.358727333566, 6146.508279337731, 6164.815055548341, 6171.228596425447, 6197.938020619917, 5353.705546194841, 5652.689102099424, 6077.908831367621, 6156.846078847885, 6162.075688646739, 5706.942930570641, 5869.970650146893, 5926.703664816828, 5969.253843269591, 5983.431574000463, 6096.481799047131, 6108.053251745987, 6118.174046503843, 6138.877222455437, 6165.321814600301, 5977.252843394575, 5980.37206093354, 6003.039513677791, 6028.819135425944, 6030.969845150747], "value": 5673.026039441752, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.3607186908561, 520.7266185252743, 546.3580293155542, 562.0894151474611, 630.8644440007985, 33454.16364590886, 37488.81255593725, 38053.61946380536, 38099.42850857236, 38152.855414337544, 38936.41595376072, 39521.0, 39554.60445395545, 39603.0, 39647.60352396475, 9196.172344489012, 9390.953045234799, 9427.387219830689, 9496.477693726842, 9507.857382139273, 9306.302027347941, 9480.81038379232, 9540.99819518951, 9556.044395560422, 9566.904330956706, 9544.379615325017, 9554.904450955506, 9578.329516933818, 9596.992315806845, 9608.567614457332, 9485.810283794355, 9560.904390956071, 9575.281853860954, 9595.808083838285, 9636.518174091338, 9433.716988490356, 9463.053694630482, 9505.049495050509, 9528.999455057257, 9574.856377154349, 38005.23989520222, 38445.23109537794, 38611.8069409654, 38726.0, 38825.029374265585, 2607.296030071889, 2607.960880586793, 3091.1653853459666, 3196.7122958933573, 3250.8537115829845, 26103.869480652476, 26136.738632613622, 26286.6057009145, 26576.0, 26768.063117790978, 2695.7439043290856, 2742.0951086141527, 2745.203890871645, 2764.0, 2766.405222877071, 329069.0, 341281.0, 342231.0, 342374.0, 345105.0, 56834.71582642143, 57281.71359143178, 57374.7131264341, 57455.712721436124, 57493.425065749645, 56642.716786415804, 65141.697166056416, 66010.0, 66101.0, 66576.0, 12901.903338216169, 15722.05667659944, 17097.914510427367, 17143.57141071483, 17151.399701010403, 12750.744985100246, 13086.0, 13106.410211540504, 13159.210447373189, 13164.60506184816, 18992.860428374064, 19092.618147637248, 19290.324838630582, 19303.710444343345, 19341.80658193428, 8187.485315216704, 8373.29177655244, 8397.580120993925, 8448.32413406926, 8496.957515212385, 873.2359185712502, 912.6805618033768, 950.5104870991445, 964.5370222293338, 1101.4634584754224, 25764.54077964096, 26905.547540721593, 27266.45467090647, 27501.31246718848, 28055.859720701264, 866.4671227195356, 1046.3198920701604, 1079.4710591810115, 1096.5065720425841, 1122.259308856151, 11348.14888883337, 13980.86019139816, 14111.294435278194, 14235.928820355832, 14360.640983975276, 640590.0, 653237.0, 653754.0, 655481.0, 655844.0, 57186.570335741104, 57966.0, 59406.40593594095, 59687.701561491915, 59996.0, 1280.5262053040249, 1512.1154124837094, 1514.833368329483, 1519.4833756522835, 1522.5051858146146, 27109.457810844066, 27259.182224533295, 27752.861235693694, 27926.0, 28057.859710702134, 48851.0, 48884.75557622189, 49216.753916231624, 49647.007059857875, 49686.75156624194, 605187.0, 605883.0, 609348.0, 609396.0, 611252.0, 26209.4758104833, 26572.7342726578, 26598.33504162334, 26945.0569230076, 41248.58751412568, 41414.0, 41834.79082604689, 42499.787501062296, 42968.78515607402, 43080.56919430891, 35867.0, 36788.816055919546, 36850.23623228322, 37165.6283437173, 37308.0, 36091.91724248277, 36135.0, 36671.0, 36763.816180918926, 36797.63202367942, 29647.96232131865, 35730.28539429145, 36146.81926590455, 36827.447588285664, 36976.26047479089, 31026.224344391572, 31771.875929045502, 31989.840050799598, 32222.677773221967, 32412.35175296528, 24441.777911104728, 24474.63288050645, 24487.75512244926, 24788.38029049288, 24807.62788558137], "value": 19248.95742193354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.28505838906074, 403.76581582682047, 405.07036351573134, 410.273815346836, 413.9772312522812, 14961.177135257556, 15886.0, 17613.82386176138, 20001.59996800063, 20761.688574671392, 19862.50343741407, 20870.26954056608, 21051.894740526313, 21147.942602869873, 21651.67522487164, 5482.068048431776, 5801.129830525423, 5922.6150300230565, 5968.7612495500125, 6056.182415373913, 5838.182654428383, 5838.4453476919625, 5906.9704651476895, 5919.763209471616, 5950.613210141327, 5583.58123140764, 5882.852928676796, 5891.499222566087, 5894.734736936848, 5899.292084949812, 5811.854703632422, 5840.15317778924, 5861.413858614104, 5863.2670916135485, 5876.265466816648, 5156.974215128937, 5182.067227899014, 5185.196294574347, 5190.818321358772, 5202.375714914197, 20987.895060524752, 25515.48969020628, 25875.741242587523, 26050.86974565115, 26377.549234792077, 1733.8526225270866, 1941.2041063164177, 2136.2202795979356, 2220.578090162864, 2337.789598936087, 10035.648752293635, 12022.67109435468, 13770.586882393543, 15160.620984475367, 15160.696786064327, 1738.6261953680018, 1818.6999145141035, 1924.490010147312, 1937.8643494955359, 1976.802319768026, 108093.0, 112400.87599123985, 112745.99999999919, 113817.43091284491, 118845.99999999914, 10832.729181770519, 11943.880561194277, 12008.579699710468, 12038.277703337828, 12084.033277337967, 14873.47942821996, 14973.251337433303, 14989.70020599582, 15110.697786044437, 15231.390744370101, 9029.864552031724, 9073.863892041625, 9074.137956894085, 9081.228095611816, 9148.085191480799, 7348.0, 7989.960050199712, 8357.289630381485, 9114.680986165453, 9126.634934602675, 4779.354787103696, 4785.114753770494, 4819.421669399694, 4820.662553621213, 4865.927011094836, 2035.9185632574531, 2038.9184432622826, 2056.5578400643635, 2061.701053347256, 2079.3553998260586, 764.4037650632515, 832.6710949175042, 862.3747782857379, 885.3050355470924, 989.0702739424918, 15367.0, 19224.134913928905, 19508.0, 19941.202351906053, 20126.0, 834.4534330013851, 845.809692819123, 869.0483920107472, 908.2597682888425, 921.6313474610209, 10406.947965260126, 10619.787604247871, 10720.46397680113, 10740.946295268473, 10744.462776861126, 628249.0, 636473.0, 643639.0, 649785.0, 651588.0, 105269.47365263278, 113822.0, 119546.0, 122072.0, 125248.0, 937.5312343828086, 950.1686024728363, 958.7842735384482, 958.8178246133212, 995.5370752600076, 14796.704065918837, 17598.208080636658, 17840.91079544646, 18055.368062117763, 18538.443846684622, 46634.0, 49284.50715492799, 52403.47596523986, 53916.191257131955, 55852.16221756596, 77807.22192778, 78442.87441665232, 79664.60167699124, 81233.59383203046, 83060.58469707613, 8091.55496447701, 8362.540060296742, 8388.412811103164, 8519.787005324917, 8729.825403492021, 11291.266067705574, 12891.355432228538, 12976.0, 13004.8049279259, 13313.001524885478, 10766.977137171956, 10855.402952837354, 10874.130069594572, 10905.56377744913, 11026.669199924016, 9502.0, 10659.840102398626, 11127.72180695489, 11208.215424920178, 11485.827712584485, 10824.05167069935, 11005.339679619248, 11080.113590912546, 11190.552377905118, 11446.255993360737, 7930.246626570467, 8311.459755115899, 8429.199226073513, 8521.659133634585, 8787.34094942869, 8810.823783524422, 10888.891111088788, 11015.173861960546, 11082.944585277022, 11107.000369966741], "value": 9526.974433161424, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.1347758732697, 1587.5078725595063, 1711.7846329106335, 1828.615990641965, 1886.9527412286193, 6469.57947733397, 8617.052124266342, 8732.650693972242, 8940.150685684857, 8977.730668079952, 8754.124587541242, 8762.561871906395, 8872.290216782658, 8877.422967507107, 8882.600282987265, 2486.900523979043, 2500.4249022724784, 2502.4119331957068, 2503.0988844016138, 2512.095645567594, 2432.282476669378, 2507.4608959073794, 2510.146550172941, 2515.76100270474, 2516.358328626198, 2475.7648023437746, 2488.191337815208, 2535.1253817432957, 2538.834975726581, 2548.3119557719406, 2495.7129930058095, 2507.034791605227, 2516.7609077137645, 2524.7222805491383, 2544.465662210938, 2503.173952595639, 2510.7740303372602, 2527.292358139724, 2538.263903467992, 2550.4006558458746, 9108.726738197865, 9113.043130471338, 9118.270538356981, 9118.86321705175, 9178.495182764946, 5541.27963364764, 5568.192612071227, 5655.3779084300695, 5656.095024796054, 5717.885642287131, 3582.1044738815294, 3642.3990041643096, 3644.0343309022865, 3713.554373475173, 3732.477453156533, 1038.678009816959, 1051.6003918510994, 1065.7495488560182, 1067.6209945469402, 1070.1545778834711, 12237.571684990982, 12377.69055773604, 12406.75186496265, 12421.503139874394, 12495.375231238402, 4936.950630493721, 4976.004799040206, 5039.77321020555, 5062.594992400599, 5094.592432605383, 10412.739681508023, 10511.369317840954, 10528.473576321154, 10549.525271362807, 10555.525001374957, 5612.214289999403, 5616.438356164351, 5639.718014099279, 5640.97179514108, 5667.603267771216, 4113.794310284474, 4470.888227794331, 4971.304017437562, 5013.373328333958, 5085.338905942203, 3708.165662725919, 3819.1788765415567, 4058.6347228748964, 4165.97917010413, 4278.614924656796, 1166.2710805746408, 1368.9383977721027, 1387.7293927684207, 1392.0325373865066, 1408.901376903607, 773.9496932699357, 789.5894135049742, 803.5500119932856, 878.4421892098563, 920.59953920045, 5017.54842064216, 5388.809010304394, 5554.666719996813, 5671.291088613923, 5919.904817608756, 958.8897276813256, 969.3263182088381, 988.3970777825521, 1009.9899001010043, 1016.7102375823002, 3702.5742039665784, 3721.9069523262133, 3806.847726090981, 3891.727579069438, 3925.8822235332987, 10284.537195826206, 10499.317544359592, 10614.840777388345, 10674.839877401846, 10690.251682382313, 10343.9482802587, 10362.430066346424, 10444.321119127233, 10487.056164945192, 10526.052655261063, 8130.186981301823, 8201.343892488705, 8310.626021829032, 8385.748427547062, 8427.073021967457, 5394.838154855361, 5710.2291190690385, 5820.1560773688425, 5952.285725712942, 6029.276486821609, 8343.791405214675, 9421.952890235505, 9635.807283854423, 9667.0, 9680.951595241979, 9632.422054676741, 9814.705558833246, 9835.311528193244, 9995.400275983464, 9999.050090241415, 6895.5173137879865, 7369.373603243785, 7522.811929701582, 7661.310482056641, 7724.957130787272, 8314.750557483285, 8338.416310858182, 8368.330533557422, 8380.622871970654, 8400.579971001303, 7224.927750722636, 7382.704691812267, 7403.555786652818, 7482.588457634664, 7540.095188577406, 7241.275872412716, 7299.160596531467, 7329.670164842488, 7385.483016188815, 7408.148062972611, 6859.622720750406, 6916.412104971134, 6959.373656370951, 7017.087778588751, 7025.01649769043, 4743.051389722138, 4755.310479980314, 4777.689450185727, 4860.635452341018, 4862.343583616308, 4309.439772829513, 4851.733154676385, 4856.150173719514, 4898.8775280618265, 4974.054929563516], "value": 4650.946807239199, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.48584721986475, 329.22139140931705, 334.7874099946534, 335.0217365293343, 338.4550873094319, 6743.527953043289, 6788.864222715542, 6842.144731908512, 6871.415929645974, 6913.239543650195, 5353.411124776281, 6745.3591908768585, 6750.932490675092, 6766.086578311926, 6799.150106236721, 4702.97648511757, 4743.691660042104, 4850.9029819403595, 4854.514548545152, 4947.431045429767, 4887.218045112782, 4939.259111133323, 4952.232403977371, 4996.650234483587, 5009.298698182258, 4939.555440010398, 4956.87607809804, 4961.156603377416, 4961.429435614915, 4990.925136122943, 4973.403191617011, 4973.552380285773, 4973.701577905301, 4996.0, 4997.825076122354, 3532.6114127445962, 4243.61807437329, 4267.551907049746, 4273.572642735701, 4277.935830962538, 6389.424951754318, 6506.479481641504, 6532.085508028832, 6570.244421891448, 6592.835179120512, 4497.302918047675, 4988.002399520111, 5753.424657534255, 5930.406959304035, 5991.670458124801, 5799.82600521985, 7260.818479538001, 7263.818404539876, 7269.055022847049, 7298.0, 4803.591694705954, 4817.51824817519, 4820.939393333496, 4822.132016237076, 4836.347093142451, 6887.725770732431, 6967.049226216667, 7660.693572257103, 7674.117476490219, 7680.308772210527, 4014.7189696721534, 4693.178693728584, 4883.609311255091, 4902.313676085351, 4910.091633047898, 4943.9258411123865, 4990.525900039491, 4999.150144475375, 5001.64988450805, 5014.122528557488, 4901.656884018084, 5802.564807639444, 5931.733072011683, 5943.524518038546, 5948.643081415129, 7275.67259473325, 7290.890636640454, 7297.708091676273, 7310.890336644955, 7314.195438501761, 1426.4650755966513, 1708.8465285931945, 1742.9716467284109, 1744.5725797179773, 1744.8778585499147, 1080.152080616712, 1126.1159989408275, 1127.6617014895498, 1130.621241883978, 1144.9828252576217, 6706.228783689938, 6727.562708424035, 6752.189737231465, 6768.83077923046, 6771.661416929134, 7260.38286745622, 7552.093748750075, 7560.735374261874, 7577.583232922242, 7586.089669239726, 6721.227058888193, 6815.488838337144, 6820.556663816936, 6827.214870289881, 6838.14523184602, 3224.2261857154585, 4030.0932290234464, 4047.0894048838777, 4050.4936882889638, 4062.9593704063172, 8001.319887809602, 8005.679772809022, 8015.078265999368, 8017.719379821679, 8025.598720063974, 6743.853544897379, 7548.66031028605, 7587.848243035219, 7927.246911543394, 7968.322692571081, 7439.55362678241, 7941.9999999998845, 8008.039035315799, 8011.919880801117, 8020.639071241808, 6122.326544080059, 7628.54228746277, 7632.80917977055, 7642.694292228249, 7654.15804261542, 7511.248875112664, 7535.623218839146, 7541.773746787605, 7546.207648196861, 7560.697572097055, 6087.847803804941, 7837.137914829478, 7993.12075671664, 8010.319122874621, 8011.6795328188555, 4012.398140278865, 4883.316335713074, 4902.950970490249, 4935.358403407534, 4940.604751619933, 7601.733939312097, 7633.809154771176, 7641.465097443125, 7658.69365225407, 7675.04061992251, 7324.487285889936, 7340.009098771811, 7351.70593176267, 7354.521956072838, 7375.041244638377, 6971.58170509771, 7312.488125831141, 7320.377767889789, 7339.339459448462, 7352.154502232312, 5316.8139115132335, 5921.822345329647, 7113.75101871432, 7194.0, 7200.531965422231, 7322.450816188701, 7361.895715642697, 7363.447741419308, 7368.1526624438875, 7390.150132734804, 6892.586444813327, 7125.038119853753, 7146.356827885307, 7162.820929476805, 7170.354668079898], "value": 5278.236113438819, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.7978466567695, 706.6078326528776, 708.8936659501071, 729.1286912139991, 770.468376819994, 14746.557603271893, 14852.108873467587, 15041.62395940102, 15064.472743453967, 15084.0, 13737.58787236382, 15276.388944442237, 15611.531654050397, 15629.609259768511, 15653.84346156538, 724.8731471992406, 889.0975659705405, 910.6357457017212, 917.9311551633621, 919.31511024287, 885.0972008551274, 902.2060586683709, 905.5879574793486, 910.1308250620674, 911.2664305234284, 933.8926023507315, 961.6441916490908, 962.6534447598893, 962.74006018375, 965.242284806427, 924.1036194890945, 929.1080562659855, 950.8716323296336, 952.7046615549167, 961.2694352292239, 602.7347966894596, 700.6321681117403, 711.7046425733314, 717.7667258141125, 720.1646090535006, 15278.618034549114, 15302.005369651048, 15314.923425382913, 15336.846631533765, 15349.693006139927, 12435.191712538655, 12462.252264864046, 12564.497420103186, 12599.811002834966, 12612.81080783789, 10000.199984001263, 10238.692839214835, 10252.589896404135, 10444.373337599693, 10530.47347632623, 2977.1366303772097, 3092.4588197065423, 3203.3913556424436, 3309.7352211822995, 3335.0, 76571.6171419145, 77360.0, 77447.0, 79711.0, 82515.3496930058, 9320.487373194539, 9430.0, 9430.717078487656, 9445.386049906734, 9557.23542116643, 21089.261875834272, 21125.78874211269, 21132.577348452945, 21150.576988460143, 21155.0, 7200.639968001579, 7317.15852676949, 7321.341079302888, 7351.852962940711, 7470.589117598475, 3528.065062758371, 3963.4847469828737, 4007.779572123503, 4031.9798401007806, 4046.7167298288837, 2666.9599956000675, 3226.7257283130725, 3277.6230733465954, 3363.0, 3409.5226668266464, 539.382407143826, 643.5527308520627, 644.937586685154, 653.3433898931638, 661.8610091880759, 519.3482179864246, 570.9714514274269, 587.6620942957817, 615.5414216408805, 616.7810427298334, 6916.585004899722, 6965.686544105527, 8031.156728543536, 8042.718504852302, 8048.315893149031, 519.5090639345857, 527.3171243240014, 534.8582625604218, 573.4437595532327, 587.1310460518457, 3606.585242697071, 3812.313783518993, 3821.178446633987, 3863.74885632433, 3876.0, 95189.57215641771, 95592.0, 96734.5163274179, 97110.0, 98184.0, 76136.61931690306, 76785.61607191928, 76823.61588192135, 77073.84389234165, 78190.21809781829, 71013.0, 71352.64323678348, 71354.0, 72568.63715681387, 73031.63484182545, 6595.637239951849, 7643.694252229849, 7736.110347310131, 7741.187175346733, 7914.1294457608465, 45694.771526142154, 45830.08339833118, 46806.0, 47448.52551474441, 48940.0, 60476.39523604708, 63266.683666583216, 63528.682356587924, 63722.36277637164, 66468.33531664622, 10642.361458312525, 10769.569217231536, 10770.353778773298, 11041.447927603427, 11124.276922000368, 11505.654830355103, 11695.76608467843, 11855.466504007512, 12031.4585843639, 12068.155229133876, 10747.355158690503, 11604.825927611262, 11658.358790266617, 11726.589569365031, 11896.881031189578, 11232.3260604364, 11316.660500185008, 11329.839404777289, 11360.772784544097, 11860.525578976743, 11174.0, 11177.16171287173, 11311.886881131413, 11556.191066625255, 11619.767604648028, 9714.514274286399, 9768.902310976799, 9791.559379827782, 9842.360246583949, 9883.752906177404, 9483.312978240601, 9683.080107389787, 9687.079727425884, 9752.024797520475, 9803.970408747966], "value": 6797.937283117533, "unit": "score"}], "name": "dromaeo_css", "value": 7469.12880682678, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 109.0, 116.0, 125.0, 139.0, 106.0, 116.0, 116.0, 116.0], "value": 117.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 156.0, 175.0, 119.0, 140.0, 120.0, 153.0, 164.0, 125.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 198.0, 200.0, 198.0, 198.0, 194.0, 200.0, 190.0, 202.0, 198.0], "value": 198.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 82.0, 144.0, 56.0, 69.0, 80.0, 88.0, 161.0, 59.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 132.0, 95.0, 115.0, 70.0, 144.0, 120.0, 118.0, 153.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 85.0, 107.0, 74.0, 91.0, 132.0, 136.0, 118.0], "value": 100.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 94.0, 96.0, 96.0, 95.0, 95.0, 115.0, 94.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 91.0, 138.0, 76.0, 147.0, 146.0, 139.0, 91.0, 92.0, 99.0], "value": 115.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 65.0, 67.0, 64.0, 63.0, 66.0, 82.0, 64.0, 59.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 79.0, 98.0, 67.0, 109.0, 117.0, 110.0, 74.0, 72.0, 68.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 84.0, 84.0, 84.0, 86.0, 86.0, 85.0, 88.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 130.0, 128.0, 127.0, 129.0, 128.0, 131.0, 148.0, 146.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 223.0, 223.0, 170.0, 171.0, 169.0, 201.0, 210.0, 230.0, 208.0], "value": 197.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 66.0, 69.0, 72.0, 69.0, 81.0, 96.0, 99.0, 69.0], "value": 75.7, "unit": "score"}], "name": "kraken", "value": 1611.8, "alertThreshold": 2.0}]} 04:07:39 INFO - Return code: 0 04:07:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:07:39 ERROR - # TBPL SUCCESS # 04:07:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:07:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:07:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:07:39 INFO - 2016-05-11 04:07:39.305 screenresolution[1686:10433] starting screenresolution argv=screenresolution get 04:07:39 INFO - 2016-05-11 04:07:39.308 screenresolution[1686:10433] Display 0: 1600x1200x32@60 04:07:39 INFO - 2016-05-11 04:07:39.313 screenresolution[1687:10436] starting screenresolution argv=screenresolution list 04:07:39 INFO - Available Modes on Display 0 04:07:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:07:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:07:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:07:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:07:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:07:39 INFO - Intel Iris: 04:07:39 INFO - Chipset Model: Intel Iris 04:07:39 INFO - Type: GPU 04:07:39 INFO - Bus: Built-In 04:07:39 INFO - VRAM (Dynamic, Max): 1536 MB 04:07:39 INFO - Vendor: Intel (0x8086) 04:07:39 INFO - Device ID: 0x0a2e 04:07:39 INFO - Revision ID: 0x0009 04:07:39 INFO - Displays: 04:07:39 INFO - Display: 04:07:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:07:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:07:39 INFO - Display Serial Number: 1600x1200 60 04:07:39 INFO - Main Display: Yes 04:07:39 INFO - Mirror: Off 04:07:39 INFO - Online: Yes 04:07:39 INFO - Rotation: Supported 04:07:39 INFO - Return code: 0 04:07:39 INFO - Running post-action listener: _resource_record_post_action 04:07:39 INFO - Running post-run listener: _resource_record_post_run 04:07:40 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 38237696; Write bytes: 655707136; Read time: 426; Write time: 1826 04:07:40 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 345489920; Write bytes: 346228224; Read time: 26504; Write time: 665 04:07:40 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 37053952; Write bytes: 299521536; Read time: 403; Write time: 1128 04:07:40 INFO - Running post-run listener: _upload_blobber_files 04:07:40 INFO - Blob upload gear active. 04:07:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:07:40 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 04:07:40 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'] 04:07:40 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 04:07:41 INFO - (blobuploader) - INFO - Open directory for files ... 04:07:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:07:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:07:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:42 INFO - (blobuploader) - INFO - Done attempting. 04:07:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:07:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:07:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:43 INFO - (blobuploader) - INFO - Done attempting. 04:07:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:07:43 INFO - Return code: 0 04:07:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:07:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:07:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5fbb1a9d73320e8cdc1cad63380a7589e9b0cd8d144150ada3a3c954693725220fa61fdd8f1285bd76c4dd60a3aceac3d041e624c23978bce70719b4bc7c444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/869ef6e07e3e60c8febe5770fbf1735d0a8ed3947c1cd75f0195e1528f0504127ad85ccca995123e8bf1b4a1321cf360a236cfd914e4d1f4529e3bb7b85875f2"} 04:07:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:07:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:07:43 INFO - Contents: 04:07:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5fbb1a9d73320e8cdc1cad63380a7589e9b0cd8d144150ada3a3c954693725220fa61fdd8f1285bd76c4dd60a3aceac3d041e624c23978bce70719b4bc7c444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/869ef6e07e3e60c8febe5770fbf1735d0a8ed3947c1cd75f0195e1528f0504127ad85ccca995123e8bf1b4a1321cf360a236cfd914e4d1f4529e3bb7b85875f2"} 04:07:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:07:43 INFO - Copying logs to upload dir... 04:07:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:07:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.943925 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-05-11 04:07:43.294049) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:43.297911) ========= 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.5AwKd7whXQ/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.uswe0pAcsD/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5fbb1a9d73320e8cdc1cad63380a7589e9b0cd8d144150ada3a3c954693725220fa61fdd8f1285bd76c4dd60a3aceac3d041e624c23978bce70719b4bc7c444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/869ef6e07e3e60c8febe5770fbf1735d0a8ed3947c1cd75f0195e1528f0504127ad85ccca995123e8bf1b4a1321cf360a236cfd914e4d1f4529e3bb7b85875f2"} build_url:https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/D8CVojXuQjGmk8NvQeFISg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5fbb1a9d73320e8cdc1cad63380a7589e9b0cd8d144150ada3a3c954693725220fa61fdd8f1285bd76c4dd60a3aceac3d041e624c23978bce70719b4bc7c444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/869ef6e07e3e60c8febe5770fbf1735d0a8ed3947c1cd75f0195e1528f0504127ad85ccca995123e8bf1b4a1321cf360a236cfd914e4d1f4529e3bb7b85875f2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:43.325875) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:43.326200) ========= 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.5AwKd7whXQ/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.uswe0pAcsD/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005190 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:43.374550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:07:43.374870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:07:43.375196) ========= ========= Total master_lag: 0.16 =========