builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0285 starttime: 1467036763.29 results: success (0) buildid: 20160627051824 builduid: e56724a29d304d78ada99313e57dc5e0 revision: f7521f8f54ab8e2f44ee50f88c29c375cc985899 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:43.288549) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:43.289054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:43.289369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:43.372998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:43.373433) ========= 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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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-06-27 07:12:43-- 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% 19.0M=0.001s 2016-06-27 07:12:43 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166642 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:43.562450) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:43.562842) ========= 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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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.033948 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:43.617859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 07:12:43.618225) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f7521f8f54ab8e2f44ee50f88c29c375cc985899 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f7521f8f54ab8e2f44ee50f88c29c375cc985899 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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-06-27 07:12:43,703 truncating revision to first 12 chars 2016-06-27 07:12:43,703 Setting DEBUG logging. 2016-06-27 07:12:43,703 attempt 1/10 2016-06-27 07:12:43,703 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f7521f8f54ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 07:12:44,671 unpacking tar archive at: mozilla-beta-f7521f8f54ab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.232326 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 07:12:45.121206) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:45.121681) ========= script_repo_revision: f7521f8f54ab8e2f44ee50f88c29c375cc985899 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:45.122141) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:45.122414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 07:12:45.144255) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-27 07:12:45.144665) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:12:45 INFO - MultiFileLogger online at 20160627 07:12:45 in /builds/slave/test 07:12:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:12:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:12:45 INFO - {'append_to_log': False, 07:12:45 INFO - 'base_work_dir': '/builds/slave/test', 07:12:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:12:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:12:45 INFO - 'branch': 'Mozilla-Beta', 07:12:45 INFO - 'buildbot_json_path': 'buildprops.json', 07:12:45 INFO - 'config_files': ('talos/mac_config.py',), 07:12:45 INFO - 'default_actions': ('clobber', 07:12:45 INFO - 'read-buildbot-config', 07:12:45 INFO - 'download-and-extract', 07:12:45 INFO - 'populate-webroot', 07:12:45 INFO - 'create-virtualenv', 07:12:45 INFO - 'install', 07:12:45 INFO - 'run-tests'), 07:12:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:12:45 INFO - 'download_minidump_stackwalk': True, 07:12:45 INFO - 'download_symbols': 'ondemand', 07:12:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:12:45 INFO - 'tooltool.py': '/tools/tooltool.py', 07:12:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:12:45 INFO - '/tools/misc-python/virtualenv.py')}, 07:12:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:12:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:12:45 INFO - 'installer_path': 'installer.exe', 07:12:45 INFO - 'log_level': 'info', 07:12:45 INFO - 'log_name': 'talos', 07:12:45 INFO - 'log_to_console': True, 07:12:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:12:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:12:45 INFO - 'opt_config_files': (), 07:12:45 INFO - 'pip_index': False, 07:12:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:12:45 INFO - 'cmd': ('bash', 07:12:45 INFO - '-c', 07:12:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:12:45 INFO - 'enabled': True, 07:12:45 INFO - 'halt_on_failure': False, 07:12:45 INFO - 'name': 'check_screen_resolution'},), 07:12:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:12:45 INFO - 'cmd': ('bash', 07:12:45 INFO - '-c', 07:12:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:12:45 INFO - 'enabled': True, 07:12:45 INFO - 'halt_on_failure': False, 07:12:45 INFO - 'name': 'check_screen_resolution'},), 07:12:45 INFO - 'run_cmd_checks_enabled': True, 07:12:45 INFO - 'sps_profile': False, 07:12:45 INFO - 'sps_profile_interval': 0, 07:12:45 INFO - 'suite': 'dromaeojs-e10s', 07:12:45 INFO - 'system_bits': '32', 07:12:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:12:45 INFO - 'title': 't-yosemite-r7-0285', 07:12:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:12:45 INFO - 'use_talos_json': True, 07:12:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:12:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:12:45 INFO - 'work_dir': 'build'} 07:12:45 INFO - ##### 07:12:45 INFO - ##### Running clobber step. 07:12:45 INFO - ##### 07:12:45 INFO - Running pre-action listener: _resource_record_pre_action 07:12:45 INFO - Running main action method: clobber 07:12:45 INFO - rmtree: /builds/slave/test/build 07:12:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:12:47 INFO - Running post-action listener: _resource_record_post_action 07:12:47 INFO - ##### 07:12:47 INFO - ##### Running read-buildbot-config step. 07:12:47 INFO - ##### 07:12:47 INFO - Running pre-action listener: _resource_record_pre_action 07:12:47 INFO - Running main action method: read_buildbot_config 07:12:47 INFO - Using buildbot properties: 07:12:47 INFO - { 07:12:47 INFO - "project": "", 07:12:47 INFO - "product": "firefox", 07:12:47 INFO - "script_repo_revision": "production", 07:12:47 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 07:12:47 INFO - "repository": "", 07:12:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 07:12:47 INFO - "buildid": "20160627051824", 07:12:47 INFO - "pgo_build": "False", 07:12:47 INFO - "basedir": "/builds/slave/test", 07:12:47 INFO - "buildnumber": 37, 07:12:47 INFO - "slavename": "t-yosemite-r7-0285", 07:12:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:12:47 INFO - "platform": "yosemite_r7", 07:12:47 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:12:47 INFO - "branch": "mozilla-beta", 07:12:47 INFO - "repo_path": "releases/mozilla-beta", 07:12:47 INFO - "revision": "f7521f8f54ab8e2f44ee50f88c29c375cc985899", 07:12:47 INFO - "stage_platform": "macosx64", 07:12:47 INFO - "builduid": "e56724a29d304d78ada99313e57dc5e0", 07:12:47 INFO - "slavebuilddir": "test" 07:12:47 INFO - } 07:12:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 07:12:47 INFO - Running post-action listener: _resource_record_post_action 07:12:47 INFO - ##### 07:12:47 INFO - ##### Running download-and-extract step. 07:12:47 INFO - ##### 07:12:47 INFO - Running pre-action listener: _resource_record_pre_action 07:12:47 INFO - Running main action method: download_and_extract 07:12:47 INFO - mkdir: /builds/slave/test/build/tests 07:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:47 INFO - https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:12:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:12:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:12:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 07:12:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 07:12:48 INFO - Downloaded 1165 bytes. 07:12:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 07:12:48 INFO - Using the following test package requirements: 07:12:48 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:12:48 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:12:48 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 07:12:48 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:12:48 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 07:12:48 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:12:48 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:12:48 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 07:12:48 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:12:48 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:12:48 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 07:12:48 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:12:48 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 07:12:48 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:12:48 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 07:12:48 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:12:48 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 07:12:48 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 07:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:48 INFO - https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:12:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:12:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:12:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 07:12:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 07:12:50 INFO - Downloaded 18344089 bytes. 07:12:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:12:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:12:53 INFO - Return code: 0 07:12:53 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:53 INFO - https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:12:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:12:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:12:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 07:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 07:12:55 INFO - Downloaded 18344089 bytes. 07:12:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:12:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:12:58 INFO - Return code: 0 07:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:58 INFO - https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:12:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:12:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:12:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 07:12:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 07:12:59 INFO - Downloaded 10840145 bytes. 07:12:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:12:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:12:59 INFO - Return code: 0 07:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:59 INFO - https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 07:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 07:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 07:13:02 INFO - Downloaded 86229084 bytes. 07:13:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:13:02 INFO - mkdir: /builds/slave/test/properties 07:13:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:13:02 INFO - Writing to file /builds/slave/test/properties/build_url 07:13:02 INFO - Contents: 07:13:02 INFO - build_url:https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:13:03 INFO - Running post-action listener: _resource_record_post_action 07:13:03 INFO - Running post-action listener: set_extra_try_arguments 07:13:03 INFO - ##### 07:13:03 INFO - ##### Running populate-webroot step. 07:13:03 INFO - ##### 07:13:03 INFO - Running pre-action listener: _resource_record_pre_action 07:13:03 INFO - Running main action method: populate_webroot 07:13:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:13:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:13:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:13:03 INFO - '--tppagecycles', 07:13:03 INFO - '7'], 07:13:03 INFO - 'tests': ['tsvgm']}}, 07:13:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:13:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:13:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:13:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:13:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:13:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:13:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:03 INFO - 'talos_options': ['--disable-e10s'], 07:13:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:03 INFO - 'talos_options': ['--disable-e10s'], 07:13:03 INFO - 'tests': ['damp', 'tps']}, 07:13:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:03 INFO - 'tests': ['damp', 'tps']}, 07:13:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:13:03 INFO - 'tests': ['dromaeo_dom']}, 07:13:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:13:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:13:03 INFO - 'tests': ['a11yr', 07:13:03 INFO - 'ts_paint', 07:13:03 INFO - 'tpaint', 07:13:03 INFO - 'sessionrestore', 07:13:03 INFO - 'sessionrestore_no_auto_restore', 07:13:03 INFO - 'tabpaint']}, 07:13:03 INFO - 'other-e10s': {'tests': ['a11yr', 07:13:03 INFO - 'ts_paint', 07:13:03 INFO - 'tpaint', 07:13:03 INFO - 'sessionrestore', 07:13:03 INFO - 'sessionrestore_no_auto_restore', 07:13:03 INFO - 'tabpaint']}, 07:13:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:13:03 INFO - 'ts_paint', 07:13:03 INFO - 'tpaint', 07:13:03 INFO - 'sessionrestore', 07:13:03 INFO - 'sessionrestore_no_auto_restore', 07:13:03 INFO - 'tabpaint']}, 07:13:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:13:03 INFO - 'ts_paint', 07:13:03 INFO - 'tpaint', 07:13:03 INFO - 'sessionrestore', 07:13:03 INFO - 'sessionrestore_no_auto_restore', 07:13:03 INFO - 'tabpaint']}, 07:13:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:13:03 INFO - 'tests': ['a11yr', 07:13:03 INFO - 'ts_paint', 07:13:03 INFO - 'tpaint', 07:13:03 INFO - 'sessionrestore', 07:13:03 INFO - 'sessionrestore_no_auto_restore', 07:13:03 INFO - 'tabpaint']}, 07:13:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:13:03 INFO - 'tests': ['a11yr', 07:13:03 INFO - 'ts_paint', 07:13:03 INFO - 'tpaint', 07:13:03 INFO - 'sessionrestore', 07:13:03 INFO - 'sessionrestore_no_auto_restore', 07:13:03 INFO - 'tabpaint']}, 07:13:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:13:03 INFO - 'tests': ['tsvgx', 07:13:03 INFO - 'tsvgr_opacity', 07:13:03 INFO - 'tart', 07:13:03 INFO - 'tscrollx', 07:13:03 INFO - 'cart']}, 07:13:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:13:03 INFO - 'tsvgr_opacity', 07:13:03 INFO - 'tart', 07:13:03 INFO - 'tscrollx', 07:13:03 INFO - 'cart']}, 07:13:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:03 INFO - 'talos_options': ['--disable-e10s'], 07:13:03 INFO - 'tests': ['tp5o']}, 07:13:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:03 INFO - 'tests': ['tp5o']}, 07:13:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:03 INFO - 'talos_options': ['--disable-e10s', 07:13:03 INFO - '--xperf_path', 07:13:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:03 INFO - 'tests': ['tp5n']}, 07:13:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:03 INFO - 'talos_options': ['--xperf_path', 07:13:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:03 INFO - 'tests': ['tp5n']}}, 07:13:03 INFO - 'talos.zip': {'path': '', 07:13:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:13:03 INFO - Running post-action listener: _resource_record_post_action 07:13:03 INFO - ##### 07:13:03 INFO - ##### Running create-virtualenv step. 07:13:03 INFO - ##### 07:13:03 INFO - Running pre-action listener: _resource_record_pre_action 07:13:03 INFO - Running main action method: create_virtualenv 07:13:03 INFO - Creating virtualenv /builds/slave/test/build/venv 07:13:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:13:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:13:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:13:03 INFO - Using real prefix '/tools/python27' 07:13:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:13:04 INFO - Installing distribute.............................................................................................................................................................................................done. 07:13:07 INFO - Installing pip.................done. 07:13:07 INFO - Return code: 0 07:13:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13: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')]} 07:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102315a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102325420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7359e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b4e00>, '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 0x10201ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021afb20>, '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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:13: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', 'pip>=1.5'] in /builds/slave/test/build 07:13: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 pip>=1.5 07:13:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITwZW9UVyR/Render', 07:13:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:07 INFO - 'HOME': '/Users/cltbld', 07:13:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:07 INFO - 'LOGNAME': 'cltbld', 07:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:07 INFO - 'MOZ_NO_REMOTE': '1', 07:13:07 INFO - 'NO_EM_RESTART': '1', 07:13:07 INFO - 'PAGER': '/bin/cat', 07:13:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:07 INFO - 'PWD': '/builds/slave/test', 07:13:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:07 INFO - 'SHELL': '/bin/bash', 07:13:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7CEzDJ5Zi/Listeners', 07:13:07 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 07:13:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:07 INFO - 'USER': 'cltbld', 07:13:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:07 INFO - 'XPC_FLAGS': '0x0', 07:13:07 INFO - 'XPC_SERVICE_NAME': '0', 07:13:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:13:07 INFO - Cleaning up... 07:13:07 INFO - Return code: 0 07:13:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13: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')]} 07:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13: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', '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 0x102315a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102325420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7359e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b4e00>, '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 0x10201ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021afb20>, '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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:13: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', 'psutil>=0.7.1'] in /builds/slave/test/build 07:13: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 psutil>=0.7.1 07:13:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITwZW9UVyR/Render', 07:13:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:07 INFO - 'HOME': '/Users/cltbld', 07:13:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:07 INFO - 'LOGNAME': 'cltbld', 07:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:07 INFO - 'MOZ_NO_REMOTE': '1', 07:13:07 INFO - 'NO_EM_RESTART': '1', 07:13:07 INFO - 'PAGER': '/bin/cat', 07:13:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:07 INFO - 'PWD': '/builds/slave/test', 07:13:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:07 INFO - 'SHELL': '/bin/bash', 07:13:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7CEzDJ5Zi/Listeners', 07:13:07 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 07:13:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:07 INFO - 'USER': 'cltbld', 07:13:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:07 INFO - 'XPC_FLAGS': '0x0', 07:13:07 INFO - 'XPC_SERVICE_NAME': '0', 07:13:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:07 INFO - Downloading/unpacking psutil>=0.7.1 07:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:13:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:10 INFO - Installing collected packages: psutil 07:13:10 INFO - Running setup.py install for psutil 07:13:10 INFO - building 'psutil._psutil_osx' extension 07:13:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:13:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:13:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:13:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:13:11 INFO - building 'psutil._psutil_posix' extension 07:13:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:13:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:13:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:13:11 INFO - ^ 07:13:11 INFO - 1 warning generated. 07:13:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:13:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:11 INFO - Successfully installed psutil 07:13:11 INFO - Cleaning up... 07:13:11 INFO - Return code: 0 07:13:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:11 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 0x102315a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102325420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7359e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b4e00>, '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 0x10201ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021afb20>, '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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITwZW9UVyR/Render', 07:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:11 INFO - 'HOME': '/Users/cltbld', 07:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:11 INFO - 'LOGNAME': 'cltbld', 07:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:11 INFO - 'MOZ_NO_REMOTE': '1', 07:13:11 INFO - 'NO_EM_RESTART': '1', 07:13:11 INFO - 'PAGER': '/bin/cat', 07:13:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:11 INFO - 'PWD': '/builds/slave/test', 07:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:11 INFO - 'SHELL': '/bin/bash', 07:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7CEzDJ5Zi/Listeners', 07:13:11 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 07:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:11 INFO - 'USER': 'cltbld', 07:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:11 INFO - 'XPC_FLAGS': '0x0', 07:13:11 INFO - 'XPC_SERVICE_NAME': '0', 07:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:13:14 INFO - Installing collected packages: mozsystemmonitor 07:13:14 INFO - Running setup.py install for mozsystemmonitor 07:13:14 INFO - Successfully installed mozsystemmonitor 07:13:14 INFO - Cleaning up... 07:13:14 INFO - Return code: 0 07:13:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102315a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102325420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7359e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b4e00>, '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 0x10201ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021afb20>, '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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:13:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITwZW9UVyR/Render', 07:13:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:14 INFO - 'HOME': '/Users/cltbld', 07:13:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:14 INFO - 'LOGNAME': 'cltbld', 07:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:14 INFO - 'MOZ_NO_REMOTE': '1', 07:13:14 INFO - 'NO_EM_RESTART': '1', 07:13:14 INFO - 'PAGER': '/bin/cat', 07:13:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:14 INFO - 'PWD': '/builds/slave/test', 07:13:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:14 INFO - 'SHELL': '/bin/bash', 07:13:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7CEzDJ5Zi/Listeners', 07:13:14 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 07:13:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:14 INFO - 'USER': 'cltbld', 07:13:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:14 INFO - 'XPC_FLAGS': '0x0', 07:13:14 INFO - 'XPC_SERVICE_NAME': '0', 07:13:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:15 INFO - Downloading/unpacking blobuploader==1.2.4 07:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:17 INFO - Downloading blobuploader-1.2.4.tar.gz 07:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:13:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:13:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:18 INFO - Downloading docopt-0.6.1.tar.gz 07:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:13:18 INFO - Installing collected packages: blobuploader, requests, docopt 07:13:18 INFO - Running setup.py install for blobuploader 07:13:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:13:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:13:18 INFO - Running setup.py install for requests 07:13:19 INFO - Running setup.py install for docopt 07:13:19 INFO - Successfully installed blobuploader requests docopt 07:13:19 INFO - Cleaning up... 07:13:19 INFO - Return code: 0 07:13:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:19 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 0x102315a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102325420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7359e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b4e00>, '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 0x10201ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021afb20>, '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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:13:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITwZW9UVyR/Render', 07:13:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:19 INFO - 'HOME': '/Users/cltbld', 07:13:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:19 INFO - 'LOGNAME': 'cltbld', 07:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:19 INFO - 'MOZ_NO_REMOTE': '1', 07:13:19 INFO - 'NO_EM_RESTART': '1', 07:13:19 INFO - 'PAGER': '/bin/cat', 07:13:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:19 INFO - 'PWD': '/builds/slave/test', 07:13:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:19 INFO - 'SHELL': '/bin/bash', 07:13:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7CEzDJ5Zi/Listeners', 07:13:19 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 07:13:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:19 INFO - 'USER': 'cltbld', 07:13:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:19 INFO - 'XPC_FLAGS': '0x0', 07:13:19 INFO - 'XPC_SERVICE_NAME': '0', 07:13:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:19 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-3eQR5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:20 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-DMjIN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:20 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-qDlY0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:20 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-yZTuv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:20 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-uON1g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:20 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-ZUKmB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:20 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-zBDLDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:20 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-MsEw9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:20 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-0BDNoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:20 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-hdWnqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:20 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-TungXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:21 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-EhCpDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:21 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-6enXLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:21 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-p6ImAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:21 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-xt3R3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:21 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-8JshSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:21 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-bFkl6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:13:21 INFO - Running setup.py install for manifestparser 07:13:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:13:21 INFO - Running setup.py install for mozcrash 07:13:21 INFO - Running setup.py install for mozdebug 07:13:22 INFO - Running setup.py install for mozdevice 07:13:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:13:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:13:22 INFO - Running setup.py install for mozfile 07:13:22 INFO - Running setup.py install for mozhttpd 07:13:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:13:22 INFO - Running setup.py install for mozinfo 07:13:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:13:22 INFO - Running setup.py install for mozInstall 07:13:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:13:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:13:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:13:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:13:22 INFO - Running setup.py install for mozleak 07:13:23 INFO - Running setup.py install for mozlog 07:13:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:13:23 INFO - Running setup.py install for moznetwork 07:13:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:13:23 INFO - Running setup.py install for mozprocess 07:13:23 INFO - Running setup.py install for mozprofile 07:13:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:13:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:13:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:13:23 INFO - Running setup.py install for mozrunner 07:13:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:13:23 INFO - Running setup.py install for mozscreenshot 07:13:23 INFO - Running setup.py install for moztest 07:13:24 INFO - Running setup.py install for mozversion 07:13:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:13:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:13:24 INFO - Cleaning up... 07:13:24 INFO - Return code: 0 07:13:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13: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')]} 07:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:24 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 0x102315a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102325420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7359e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b4e00>, '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 0x10201ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021afb20>, '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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:13:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:13:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:13:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITwZW9UVyR/Render', 07:13:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:24 INFO - 'HOME': '/Users/cltbld', 07:13:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:24 INFO - 'LOGNAME': 'cltbld', 07:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:24 INFO - 'MOZ_NO_REMOTE': '1', 07:13:24 INFO - 'NO_EM_RESTART': '1', 07:13:24 INFO - 'PAGER': '/bin/cat', 07:13:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:24 INFO - 'PWD': '/builds/slave/test', 07:13:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:24 INFO - 'SHELL': '/bin/bash', 07:13:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7CEzDJ5Zi/Listeners', 07:13:24 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 07:13:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:24 INFO - 'USER': 'cltbld', 07:13:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:24 INFO - 'XPC_FLAGS': '0x0', 07:13:24 INFO - 'XPC_SERVICE_NAME': '0', 07:13:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:24 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-rc2QoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:24 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-ztOG2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:24 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-DchlAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:24 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-uuih_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:24 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-qGnkoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:25 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-XJaDEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:25 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-hGRw1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:25 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-6fpIXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:25 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-5Vdz85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:25 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-1Kdok4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:25 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-bBnge7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:25 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-Mcro_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:25 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-NOYaIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:25 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-83VYzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:26 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-lydo2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:26 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-6jHQ36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:26 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-kUlCaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:13:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:29 INFO - Downloading blessings-1.6.tar.gz 07:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:13:29 INFO - Installing collected packages: blessings 07:13:29 INFO - Running setup.py install for blessings 07:13:29 INFO - Successfully installed blessings 07:13:29 INFO - Cleaning up... 07:13:29 INFO - Return code: 0 07:13:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:29 INFO - Reading from file tmpfile_stdout 07:13:29 INFO - Current package versions: 07:13:29 INFO - blessings == 1.6 07:13:29 INFO - blobuploader == 1.2.4 07:13:29 INFO - docopt == 0.6.1 07:13:29 INFO - manifestparser == 1.1 07:13:29 INFO - mozInstall == 1.12 07:13:29 INFO - mozcrash == 0.17 07:13:29 INFO - mozdebug == 0.1 07:13:29 INFO - mozdevice == 0.48 07:13:29 INFO - mozfile == 1.2 07:13:29 INFO - mozhttpd == 0.7 07:13:29 INFO - mozinfo == 0.9 07:13:29 INFO - mozleak == 0.1 07:13:29 INFO - mozlog == 3.1 07:13:29 INFO - moznetwork == 0.27 07:13:29 INFO - mozprocess == 0.22 07:13:29 INFO - mozprofile == 0.28 07:13:29 INFO - mozrunner == 6.11 07:13:29 INFO - mozscreenshot == 0.1 07:13:29 INFO - mozsystemmonitor == 0.0 07:13:29 INFO - moztest == 0.7 07:13:29 INFO - mozversion == 1.4 07:13:29 INFO - psutil == 3.1.1 07:13:29 INFO - requests == 1.2.3 07:13:29 INFO - wsgiref == 0.1.2 07:13:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:30 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 0x102315a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102325420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7359e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b4e00>, '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 0x10201ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021afb20>, '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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:13:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITwZW9UVyR/Render', 07:13:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:30 INFO - 'HOME': '/Users/cltbld', 07:13:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:30 INFO - 'LOGNAME': 'cltbld', 07:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:30 INFO - 'MOZ_NO_REMOTE': '1', 07:13:30 INFO - 'NO_EM_RESTART': '1', 07:13:30 INFO - 'PAGER': '/bin/cat', 07:13:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:30 INFO - 'PWD': '/builds/slave/test', 07:13:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:30 INFO - 'SHELL': '/bin/bash', 07:13:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7CEzDJ5Zi/Listeners', 07:13:30 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 07:13:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:30 INFO - 'USER': 'cltbld', 07:13:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:30 INFO - 'XPC_FLAGS': '0x0', 07:13:30 INFO - 'XPC_SERVICE_NAME': '0', 07:13:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:13:30 INFO - Cleaning up... 07:13:30 INFO - Return code: 0 07:13:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:30 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 0x102315a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102325420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7359e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b4e00>, '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 0x10201ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021afb20>, '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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:13:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITwZW9UVyR/Render', 07:13:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:30 INFO - 'HOME': '/Users/cltbld', 07:13:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:30 INFO - 'LOGNAME': 'cltbld', 07:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:30 INFO - 'MOZ_NO_REMOTE': '1', 07:13:30 INFO - 'NO_EM_RESTART': '1', 07:13:30 INFO - 'PAGER': '/bin/cat', 07:13:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:30 INFO - 'PWD': '/builds/slave/test', 07:13:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:30 INFO - 'SHELL': '/bin/bash', 07:13:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7CEzDJ5Zi/Listeners', 07:13:30 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 07:13:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:30 INFO - 'USER': 'cltbld', 07:13:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:30 INFO - 'XPC_FLAGS': '0x0', 07:13:30 INFO - 'XPC_SERVICE_NAME': '0', 07:13:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:30 INFO - Downloading/unpacking jsonschema 07:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:13:33 INFO - Downloading/unpacking functools32 (from jsonschema) 07:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:13:33 INFO - warning: no files found matching '*.txt' 07:13:33 INFO - no previously-included directories found matching 'build' 07:13:33 INFO - no previously-included directories found matching 'dist' 07:13:33 INFO - no previously-included directories found matching '.git*' 07:13:33 INFO - Installing collected packages: jsonschema, functools32 07:13:33 INFO - Running setup.py install for functools32 07:13:34 INFO - warning: no files found matching '*.txt' 07:13:34 INFO - no previously-included directories found matching 'build' 07:13:34 INFO - no previously-included directories found matching 'dist' 07:13:34 INFO - no previously-included directories found matching '.git*' 07:13:34 INFO - Successfully installed jsonschema functools32 07:13:34 INFO - Cleaning up... 07:13:34 INFO - Return code: 0 07:13:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:34 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 0x102315a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102325420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7359e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b4e00>, '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 0x10201ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021afb20>, '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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:13:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITwZW9UVyR/Render', 07:13:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:34 INFO - 'HOME': '/Users/cltbld', 07:13:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:34 INFO - 'LOGNAME': 'cltbld', 07:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:34 INFO - 'MOZ_NO_REMOTE': '1', 07:13:34 INFO - 'NO_EM_RESTART': '1', 07:13:34 INFO - 'PAGER': '/bin/cat', 07:13:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:34 INFO - 'PWD': '/builds/slave/test', 07:13:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:34 INFO - 'SHELL': '/bin/bash', 07:13:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7CEzDJ5Zi/Listeners', 07:13:34 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 07:13:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:34 INFO - 'USER': 'cltbld', 07:13:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:34 INFO - 'XPC_FLAGS': '0x0', 07:13:34 INFO - 'XPC_SERVICE_NAME': '0', 07:13:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:34 INFO - Downloading/unpacking flake8 07:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:13:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:13:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:13:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:13:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:13:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:13:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:13:38 INFO - no previously-included directories found matching 'docs/_build' 07:13:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:13:38 INFO - Running setup.py install for pep8 07:13:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:13:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:13:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:13:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:13:38 INFO - no previously-included directories found matching 'docs/_build' 07:13:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:13:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:13:38 INFO - Cleaning up... 07:13:38 INFO - Return code: 0 07:13:38 INFO - Running post-action listener: _resource_record_post_action 07:13:38 INFO - Running post-action listener: _start_resource_monitoring 07:13:38 INFO - Starting resource monitoring. 07:13:38 INFO - ##### 07:13:38 INFO - ##### Running install step. 07:13:38 INFO - ##### 07:13:38 INFO - Running pre-action listener: _resource_record_pre_action 07:13:38 INFO - Running main action method: install 07:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:38 INFO - Reading from file tmpfile_stdout 07:13:38 INFO - Detecting whether we're running mozinstall >=1.0... 07:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:13:38 INFO - Reading from file tmpfile_stdout 07:13:38 INFO - Output received: 07:13:38 INFO - Usage: mozinstall [options] installer 07:13:38 INFO - Options: 07:13:38 INFO - -h, --help show this help message and exit 07:13:38 INFO - -d DEST, --destination=DEST 07:13:38 INFO - Directory to install application into. [default: 07:13:38 INFO - "/builds/slave/test"] 07:13:38 INFO - --app=APP Application being installed. [default: firefox] 07:13:38 INFO - mkdir: /builds/slave/test/build/application 07:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:14:00 INFO - Reading from file tmpfile_stdout 07:14:00 INFO - Output received: 07:14:00 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:14:00 INFO - Running post-action listener: _resource_record_post_action 07:14:00 INFO - ##### 07:14:00 INFO - ##### Running run-tests step. 07:14:00 INFO - ##### 07:14:00 INFO - Running pre-action listener: _resource_record_pre_action 07:14:00 INFO - Running main action method: run_tests 07:14:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:14:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:14:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:14:00 INFO - 2016-06-27 07:14:00.710 screenresolution[1636:7593] starting screenresolution argv=screenresolution get 07:14:00 INFO - 2016-06-27 07:14:00.713 screenresolution[1636:7593] Display 0: 1600x1200x32@60 07:14:00 INFO - 2016-06-27 07:14:00.719 screenresolution[1637:7595] starting screenresolution argv=screenresolution list 07:14:00 INFO - Available Modes on Display 0 07:14:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:14:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:14:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:14:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:14:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:14:00 INFO - Intel Iris: 07:14:00 INFO - Chipset Model: Intel Iris 07:14:00 INFO - Type: GPU 07:14:00 INFO - Bus: Built-In 07:14:00 INFO - VRAM (Dynamic, Max): 1536 MB 07:14:00 INFO - Vendor: Intel (0x8086) 07:14:00 INFO - Device ID: 0x0a2e 07:14:00 INFO - Revision ID: 0x0009 07:14:00 INFO - Displays: 07:14:00 INFO - Display: 07:14:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:14:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:14:00 INFO - Display Serial Number: 1600x1200 60 07:14:00 INFO - Main Display: Yes 07:14:00 INFO - Mirror: Off 07:14:00 INFO - Online: Yes 07:14:00 INFO - Rotation: Supported 07:14:00 INFO - Return code: 0 07:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:14:00 INFO - Python 2.7.3 07:14:00 INFO - Return code: 0 07:14:00 INFO - grabbing minidump binary from tooltool 07:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:00 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 0x1021b4e00>, '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 0x10201ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021afb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:14:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:14:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:14:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:14:01 INFO - Return code: 0 07:14:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:14:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:14:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:14:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:14:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:14:02 INFO - Return code: 0 07:14:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0285', '--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 07:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0285 --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 07:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITwZW9UVyR/Render', 07:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:02 INFO - 'HOME': '/Users/cltbld', 07:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:02 INFO - 'LOGNAME': 'cltbld', 07:14:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:14:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:02 INFO - 'MOZ_NO_REMOTE': '1', 07:14:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:14:02 INFO - 'NO_EM_RESTART': '1', 07:14:02 INFO - 'PAGER': '/bin/cat', 07:14:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:02 INFO - 'PWD': '/builds/slave/test', 07:14:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:02 INFO - 'SHELL': '/bin/bash', 07:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7CEzDJ5Zi/Listeners', 07:14:02 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 07:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:02 INFO - 'USER': 'cltbld', 07:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:02 INFO - 'XPC_FLAGS': '0x0', 07:14:02 INFO - 'XPC_SERVICE_NAME': '0', 07:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0285', '--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 07:14:02 INFO - mozversion application_buildid: 20160627051824 07:14:02 INFO - mozversion application_changeset: f7521f8f54ab8e2f44ee50f88c29c375cc985899 07:14:02 INFO - mozversion application_display_name: Firefox 07:14:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:14:02 INFO - mozversion application_name: Firefox 07:14:02 INFO - mozversion application_remotingname: firefox 07:14:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:14:02 INFO - mozversion application_vendor: Mozilla 07:14:02 INFO - mozversion application_version: 48.0 07:14:02 INFO - mozversion platform_buildid: 20160627051824 07:14:02 INFO - mozversion platform_changeset: f7521f8f54ab8e2f44ee50f88c29c375cc985899 07:14:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:14:02 INFO - mozversion platform_version: 48.0 07:14:02 INFO - using testdate: 1467036842 07:14:02 INFO - actual date: 1467036842 07:14:02 INFO - starting webserver on 'localhost:49267' 07:14:02 INFO - SUITE-START | Running 2 tests 07:14:02 INFO - TEST-START | dromaeo_css 07:14:02 INFO - operating with platform_type : mac_ 07:14:02 INFO - Initialising browser for dromaeo_css test... 07:14:02 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpqSTM0P/profile http://localhost:49267/getInfo.html) 07:14:05 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 07:14:05 INFO - PROCESS | 1655 | colorDepth:24 07:14:05 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 07:14:05 INFO - PROCESS | 1655 | __metrics 07:14:05 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:14:05 INFO - TEST-INFO | 1655: exit 0 07:14:05 INFO - Browser initialized. 07:14:05 INFO - Running cycle 1/1 for dromaeo_css test... 07:14:05 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpqSTM0P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:17 INFO - PROCESS | 1659 | RSS: Main: 170790912 07:14:17 INFO - PROCESS | 1659 | 07:15:07 INFO - PROCESS | 1659 | 1467036907223 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:17:17 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 07:17:18 INFO - PROCESS | 1659 | RSS: Main: 181850112 07:17:18 INFO - PROCESS | 1659 | 07:20:20 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 07:20:21 INFO - PROCESS | 1659 | RSS: Main: 192438272 07:20:21 INFO - PROCESS | 1659 | 07:23:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 07:23:23 INFO - PROCESS | 1659 | RSS: Main: 194539520 07:23:23 INFO - PROCESS | 1659 | 07:26:25 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 07:26:25 INFO - PROCESS | 1659 | RSS: Main: 198397952 07:26:25 INFO - PROCESS | 1659 | 07:29:28 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 07:29:28 INFO - PROCESS | 1659 | RSS: Main: 197603328 07:29:28 INFO - PROCESS | 1659 | 07:32:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 07:32:31 INFO - PROCESS | 1659 | RSS: Main: 203083776 07:32:31 INFO - PROCESS | 1659 | 07:32:31 INFO - PROCESS | 1659 | __start_tp_report 07:32:31 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 07:32:31 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 07:32:31 INFO - PROCESS | 1659 | |i|pagename|runs| 07:32:31 INFO - PROCESS | 1659 | |0;dojo.html;3135.827529485877;3711.461838033485;3722.7580207286524;3750.587435382106;3768.4158955361927;5974.014287642533;6087.756489740411;6100.359462256466;6105.20632317798;6120.051392034231;4583.839565615204;5330.413654498002;5963.970180149093;6100.084987251915;6130.325664176937;4985.750712464381;5110.361204849394;5423.701696406696;5468.9726551367385;5529.198266251391;5458.072127738294;5497.642653227547;5529.695866727328;5539.501444869961;5544.528715059225;5536.695481748502;5547.472990065938;5565.777368905239;5581.413951535092;5619.466150715696;4853.39332583427;5568.081266591008;5587;5593.965116453429;5603.691796951166;5406.729663516848;5500.532454741352;5510.311211098613;5525.539295825173;5586;5640.915386269209;5791.88416231673;6046.304674962392;6050.3647117052515;6090.939090609081;6458.515611329169;6463.062855885917;6470.6117632941705;6487.967560162169;6491.383318584727;6414.647194404306;6506.31683673217;6520.93479065208;6535.705893234815;6572.5399222054475;6127.4949652051;6140.109684095781;6141.486007784275;6166.075088736726;6209.441150296495;6677.198736151693;6715.3620406061345;6716.361945615159;6717.56335838169;6737.629430381376;6372.394622510854;6384.265809431882;6389.169407976933;6393;6404.7117879695525;5391.56867450603;6370.84072898172;6472.611643301417;6481.935180648227;6534.542582019213;6349.111124442582;6357.364263573698;6358.268799088164;6402.03969404593;6414.390632889868;5331.653442526223;6365.4589359904;6402.423781859562;6413.35866413355;6451.1936007999;5067.974660126676;5174.611904107207;5215.504527069922;5247.160454327366;5264.657797243167;4670.9766451167525;4683.906321873544;4690.413698287714;4691.53084691535;4717.985633088902;5762.884742305214;6116.877662446726;6175.567710260329;6177.81466556004;6219.813405597839;5396.406395296514;6410;6494.9675251624385;6503.9349606504275;6543.705533251015;6151;6196.597221180699;6210.844728881723;6213.471854892385;6216.906746398808;5577.888442231133;5664.26364572603;5698.886022279531;5703.686297253608;5731.226284451629;6712.12742343502;6747.426468750211;6755.716413881347;6767.898481522781;6792.694328755119;6448.032795080588;6456.741730330922;6471.7734879279;6507.12153859223;6510.088587597835;5659.462351076641;6543.738250470118;6674.499412544175;6771.559848609824;6789.1174147360525;6405.943019401747;6413.903791443226;6441.452476539546;6442.645654488861;6462.773802916875;6485.740570377321;6510.251321097945;6518.674066296761;6531.379518945692;6547.70535325902;6202.689865506616;6262.937370626418;6304.5586808922935;6328.335524770017;6373.235211774617;6287.937120628735;6288.5598008138995;6313.652749098844;6329.208848893888;6331.176946996861;5398.700884673577;5724.797792463629;6101.674617273172;6174.25908890936;6226.315105338319;5254.7898084076205;6184.5980011299125;6278.780242691484;6306.9684651576445;6381.8723625528155;6167.753289868355;6198.473129784019;6221.906671399842;6239;6267.529935254783 07:32:31 INFO - PROCESS | 1659 | |1;ext.html;557.2699763310064;566.6147020026382;567.6111863373591;584.5754779045507;607.638455119204;30943.535846962313;32835.01494955149;35206.82396588013;38847;40188.99527511813;43850.684479465584;43892.341614875804;44240;44539.554604453944;44630.553694463044;9837.458939758311;9973.102420782128;10042.74893127674;10046.547905344241;10056.094951454368;9786.119249267564;9918.20654347654;9922.553485093189;9926.602935882556;9943.403395796238;8581.227689507943;9880.802383952318;9905;9940.502974851264;10016.399016059024;9895.802083958317;9914.256430767722;9941.254405919584;9941.75145621358;9960.05379488951;9770.071843174957;9878.913319534846;9895.752606184831;9918.851217231748;9926.2059035277;34126.31747365063;39841.80079099586;40352.39471407931;40558.972051397315;41218.587814121776;3299.6205436374644;3472.409690352621;3609.855605775766;3813.2957841786083;3982.980085099556;29721.40557188844;30160;30252.394952101055;30277.848610757024;30279.972002799765;2711.064682684471;2790.9302267443272;2798.8040837141407;2907.970920290791;2947.0864032150103;491488.62767058524;493401;493535;497097;497962.53056204546;38044.429333560016;38721.22557548833;68647;69868.30131698618;69871.3012869875;31914.521282180787;37636.247275054346;37736.24527509434;37790.86627401182;37849.43225851614;16025.59936001586;16051.43819966319;16475;16527.173641317888;16656.583585410463;13911.513097041556;14158.575242742734;14222.857771422154;14242.216678082805;14247.64380890486;8463.492190468469;8549.316054715608;8578.571071446402;8711;8773.341999350074;3550.4141816600486;3550.715942724576;3552.609212986569;3590.2998915211283;3597.784132951979;1016.1413605503337;1053.1259054984343;1068.7488440216543;1145.9915274558502;1171.912106592009;26662.733372666025;31422.84288578588;31460.842695786374;31774.841125794224;32012.359752804812;1082.1775450657558;1098.780243951213;1153.1985270237271;1184.8447763430759;1193.540486912545;13912.860871391156;15605.751539876783;15966.882318237613;15989.360425582847;16417.58956026109;658254;667417;670151;671730;673154;63983;64755.70488590202;65249.347506524326;65387;65562.67218663971;1540.653352995567;1561.789158463593;1573.3785154863765;1579.2103948025988;1643.4658735910878;28583.571246430904;31136.68863311338;31373.686263137075;31544;31876;56722.149167761694;57685.13472298003;58314.7084264576;58728.70635646794;58875.41124588699;579699;587953;590915.0454247701;591516;593088;29126;44688.77655611701;45446.77276613596;46619.766901165276;46763.29855052109;45690;45833.541664582925;45914.540854591025;46965.53034469748;46997.06005879795;37177.81411092927;37190.44214336841;38075.42886856755;38570.228595428496;39728.2054358917;31220;37184.6281537192;37372.25255494929;37389.439158412104;37519.43720844244;34625.134371639906;38417.4237386445;40258.79870600745;40834.59165408308;40874.59125408708;28671.713282866906;33114.33771324608;34689.13277168091;34850.49784292972;35090.824545877105;26059.478810423305;26364.3408914771;26385.340366490993;26410.943562258064;26637.866810665822 07:32:31 INFO - PROCESS | 1659 | |2;jquery.html;357.915889765905;412.570926236714;421.9071804203078;427.0966904995933;437.42697066842436;20898.686519702198;21443.67834482484;21680.02439890205;21945.890270548643;22659.054322937995;12147.088968327367;12342.691432714186;16315.265813038412;20986.79013209871;21152.365429037116;4381.846635367763;5657;5676.063449530843;5860.619059761123;6306.463950564207;6162.22972128484;6268.49852011838;6289.654069026202;6290.842728931791;6296.055591661265;5985.221921150244;6129.877402451948;6162.969185154068;6230.719617617196;6267.091271765591;6068.848278793022;6140.478059364959;6167.629942203482;6187.319394866561;6247.281562620311;5423.186522021689;5477.4796394342475;5482.5888058395385;5487.862803429906;5527.060399732055;14149.938754593344;14287.928560357235;14533;15795.842041579552;21119.78880211209;2074.9273775417937;2220.5225876436484;2242.5963326601204;2355.6348765941134;2844.288927768058;10096.040876116831;10383.740406489898;10441.68674939753;10564.947175264151;10737.463126843626;1713.7086695261835;1731.2988239762917;1843.5483306589838;1866.9439916802382;1872.5412273992958;121020.39489802583;122082;122811;123433;126593;11068.612598559012;11772.058235341152;12383.504659813507;12512.81230781539;12687.873121268854;15569;15598.688026239412;15974.76037859433;15987.200639967956;16050.197490125447;9372.62509499626;9394.90605093954;9449.527523623792;9646.228301735844;9687.079727425884;8164.346852251806;9124.270058395312;9579.473128977974;9591.712248632552;9697.757556061155;4929.137400954819;5000.2499625056535;5004.699718016931;5015.423226329019;5055.823046193439;1815.391843732338;2067.3537871524472;2125.659894416917;2131.2860191835907;2183.541456294164;911.7219248129384;994.8706668133096;998.2463240253708;1022.8977102289712;1078.7141407527013;17576;21001;21676.56646867054;21803.982200022005;22155.892205389668;874.4447275979799;908.3369140527452;1008.4251976373397;1042.8800687920834;1126.5550107707409;11305.15211359135;11717.941410293064;11722.238054526428;11739.295642261492;11742.823857642143;574071;660953;662619.6869015624;676173;678064;77617.83573246405;113790;131106;140732;141510.2924485371;1038.5482315192914;1057.4184198690843;1057.6456886942806;1067.9907487424464;1075.5213929801164;18960.810391896455;19601.901990489958;19657.606847863248;19724;19755.80244197597;51547.48452515577;52159.73920130375;53719.46280537145;54435;54983.45016549783;77989;79076;79770.80343794731;80151.19848801437;82527;7202.351788338865;8580.184882436159;8614.44006139599;8621.439606425562;8937.776555586162;13017.674558136123;13066.085374023727;13283.66790830237;13297.135686180367;13351.599452016455;11457.59898403552;11538.134639901873;11652;11721.062315014608;11787.705307367041;11188.496517656888;11298.152638552307;11373.829392559284;11456.255343402985;11739.530418783495;10341.63804266847;11411.744708082271;11652.94173529127;11738;12025.879741202825;7519.511231769918;8157.306628936607;8442.451240669583;8484.703035393732;8618.956905215433;8622.396432249683;8946.642134314554;11529.308241505536;11693.415329233334;11734.647960561197 07:32:31 INFO - PROCESS | 1659 | |3;mootools.html;1626.30881875203;1641.9179041047953;1644.9259783309749;1990.88054716717;2037.6943458481235;8304.709335173271;8963.148500892421;9085.40944838585;9264.305177111719;9272.67545635903;8955.552222388887;9003.819923601524;9057.773555661095;9062.728118156449;9093.772655683611;2535.1887396033276;2540.5554028045062;2560.398306397995;2577.8066645001604;2579.7807186389177;2544.134994102005;2562.6027965665353;2598.8440693558355;2601.310652677042;2603.1149409200866;2537.5432422164004;2555.1312553731727;2574.884130214145;2576.188500622298;2591.5464793661126;2542.072143667557;2571.087264021264;2577.445849142434;2607.29603007187;2616.6467526883816;2128.6806978953127;2559.6800399950007;2582.9870850645816;2602;2617.8429294242214;7801.882971755428;9252.537373131316;9278.860817087749;9283.76790580241;9324.720258392259;5656;5657.773689052433;5662.8301150965535;5670.914936275959;5690.573207009491;3229.54786329914;3688.2254726507467;3784.1674831537016;3832.9425058624142;3866.072142685763;1064.446487826326;1083.1713738989679;1093.9006298669785;1094.3324572011068;1096.0354887698775;12198.695032624166;12392.81410778839;12457.75084498305;12499.999999999978;12514.1865778725;4121.5878412158545;4330.41539392178;5063.063333283354;5151.484851514819;5204.869878253074;10462.790744185073;10550.15598752098;10555.26113172086;10686.839697404544;10697.411642359744;5672.829815105553;5729.427057294321;5748.367679555246;5797.826065218051;5838.678872662044;4702.1065997461055;5098.59211263098;5163.483651634881;5213.687178769286;5305.363356397257;3647.6534729200685;4199.76901270427;4245.87262382129;4324.113556720865;4357.433533640607;1392.4499822570028;1420.8295004599515;1424.1455126923763;1424.9907630241516;1425.1449130521605;888.5379602606608;972.5769290358717;975.7658162041059;978.6868202175378;1004.2167109654481;6063.8484037898525;6074.605150665193;6096.969515152396;6141.662208578571;6223.190985171898;490.6663468841222;492.99260511092365;493.4251596889655;494.27835360373535;498.5961371289267;3967.781772002568;4063.593640635913;4092.3452247640234;4105.507339119325;4147;10909;11217.887821121685;11245.662630121109;11342.149338799623;11379.975802177843;10918.563257469612;11062.336259824437;11071.889281107247;11081.058110060574;11130.332180069221;8362.958185209034;8555.486670799772;8688.000879898766;8725;8733.257673097858;5047.646664733434;5879.588428810113;5890.941090589039;5904.852378690567;6008.279006519246;9886.50567471609;9944.254180936314;10002.149817265323;10005.149562287286;10025.047620476043;9769.31614786958;10169.288149829441;10255.794884102126;10267.178625710074;10576.471176440993;6975.3024697529845;7470.589117598584;7657.042869641295;7751;7830.060392752906;8449.23956843887;8575.142485751376;8575.65697372123;8625.180607842245;8656.610452529525;7148.892766608401;7468.887966680612;7679.616019199129;7688.769336919901;7711;6482.319356467691;7539.246075392417;7549.962250188714;7589.6584653689615;7639.885401718868;7230.9638451807405;7280.453965952681;7292;7292.635368231461;7341.412686985135;4963.826266080814;5012.448630650699;5038.596912246938;5053.0399224147295;5060.443351231288;5001.1248031593595;5053.444121146597;5085.338905942352;5165.302684137593;5370.543503802221 07:32:31 INFO - PROCESS | 1659 | |4;prototype.html;320.5144206527111;321.872860220213;327.2277425276349;350.0269251480884;353.58453816765297;6836.623985680785;6872.41584465321;6990.475714321427;7076.867701167807;7120.038794762699;5525.723713814314;6011.939880601192;6403.103565500822;6901.413379862718;7004.894926576093;4194.832206711728;5181.35233095863;5197.298364720771;5197.350331208599;5206.817761378353;5189.325387699594;5197.974010129963;5199.922001169985;5209.322788037569;5224.50367215114;5138.383393992707;5138.6146039047035;5142.228665700138;5144.356955380577;5149.382074151107;5014.047331007097;5046.26829109777;5104.566111880495;5134.974325128388;5143;4364.908772806798;4394.912101757947;4415.4259946206785;4416.028473735773;4420.336949457607;6664.733410663568;6721.932780672179;6723.394894459522;6724.596524208563;6726.990951357287;5242.344706911636;5996.97001514994;6030.698465076773;6033.758649654009;6050.334463209044;7339.229380915034;7446.702131914717;7492.737754178577;7502.399808015401;7539.208383119748;4800.567948884617;4838.42751105892;4938.283948827436;4941.604671626261;4963.1810751226;7886.290233878978;7924.286814186751;7930.405219608552;7944.682212711485;7949.64226609804;4189.539150693421;4946.530079642428;5005.249212618063;5018.723970181602;5045.722485263345;3889.724511160946;4834.226523756252;4906.288588154697;5121.07820592297;5124.256982737482;6006.579539432285;6024.728887200086;6041.2750469943885;6049.153118563405;6056.394360563909;5690.687012214368;7495.550266983998;7517.398608111338;7528.284812942762;7541.283578060075;1698.8216237295153;1709.5213340264745;1730.740388941669;1735.0543953545348;1736.053850651398;877.6401675313091;1076.5101878645198;1079.169039839335;1100.2683215661496;1101.9338839669485;6246.562740608114;7032.683529241196;7091.432685385157;7093.467989900778;7127;7778.572178530122;7794.92205077942;7814.10137834145;7888.802779930433;7916.643751031217;7113.110861142357;7172.139343278735;7172.748953786592;7186.496945213785;7234.987101805751;3992.3612222044912;4111.568285329998;4139.4204811326435;4140.441040459499;4143.399207115011;6443.194600674916;8040.316573091236;8099.919000809917;8122.918770812216;8123.025236971601;7978.760637180894;7982.802579613104;8007.399445041645;8063.435559510778;8128.14654461273;6608.636524991171;8219.630116644765;8225.259726624632;8238.382121340923;8258.545779982158;6679;7546.2831031051965;7818.609069546614;7879.881801773093;7910.169432209535;7701.576413297323;7705.499142555716;7749.186335434698;7764.456488045783;7765.22347765219;8248.670053197804;8251.587420629065;8268.793280168044;8270.751877443687;8298.087210406971;4872.561469467765;4912.8771780705765;4924.926126108183;4927.088488629615;4949.109160351028;6294.339094395023;7580.05249343832;7807.219278072147;7817.726379576688;7827.099883513469;6995.755148569776;7488.812779680552;7515.924840751742;7538.773836784905;7549.0563679540055;7527.247275272429;7530.585817780075;7534.434917381109;7548.811279718051;7559.697612095674;7143.714251429885;7287.781366559012;7347.191808901123;7347.228541003117;7358.300961408658;6519.641419721961;7118.715251389886;7540.773776786705;7556.735514256975;7569.593682842853;7077.504574679723;7195.02867112933;7342.265773422615;7422.220666829905;7443.590602516913 07:32:31 INFO - PROCESS | 1659 | |5;yui.html;680.8638272345532;684.3156843156846;773.7330620935775;778.322859112572;783.4868161354314;17673.29306827727;18016.18927148278;18016.459506214833;18030.909845450755;18073.638527229446;13628.250446225478;15925.964812287193;16547.83452165478;16588.834111658878;16679.83320166798;763.8586861430625;928.8281667891428;949.5632009275724;972.7081875437376;976.4434272464698;900.0639335091497;920.8020275640736;922.2391526990226;930.9674161404353;952.9904700952972;943.056943056943;953.0755167487526;976.799756050008;978.5792109392958;1001.8998100189996;942.3544871762864;944.1502647617165;958.836997710391;975.4342481360829;1002.04304888831;699.8460338725472;708.9078419805393;723.609251004457;725.1262229014026;747.1631772414876;15575.221238938007;15646.608834779108;15720.449784257611;15968.600784980468;16076.678466430723;12576.182548134342;12723.936380318039;13005.86994130056;13199.40602672882;13231.801522977163;9962.701118966443;10063.798724025479;10279.897201027969;10332.741681457948;10404.843927341097;3533;3536.169000284931;3549.5563054618174;3607.5310209672575;3705.8702945397054;73563.52872942564;75314.24685753127;75417.62291188564;75463;86148.13851861464;9674.467904265333;9740.902590974141;9843.852342214872;9845.655402060893;9907.752306192402;20856.79143208579;20878.686819697716;20898.686519702216;21775.67336489954;21777.237796677357;6947.617881016593;7160.641967901584;7209.89185162223;7344.449166312548;7447.44144189188;4028.798560071985;4180.6446452051305;4203.348480985452;4236.173946080547;4245.639120674778;2956;3729;3730.9067273318383;3807.2195199983935;3817.10298079951;593.7862369546959;607.3713706313944;613.2610204703411;675.7026908160394;687.8211664967145;489.307629703972;553.5654511208681;566.3317285602946;570.0793218951446;585.1369230385233;6879.690413931385;8036.156203598655;8076.434649574591;8097.109317975018;8176.305014073751;552.5689961829779;561.6910699115471;578.2078552383261;594.4501336263938;601.7743346245159;3739.121306492972;3805.923881522354;3819.1597848473293;3988.66096381805;4007.579204183519;79330.6033469829;81250;81654.18345816585;81825.59087204526;82081.58959205166;80242.59878700569;82356.58821705973;82992.17007829965;83235.3352932938;84192;67470.66264668645;68427;68977.999999999;70967.93548096783;73190;8417.158284171534;8457.450265732708;8511.74464766058;8556.144385561394;8651.048384677555;37650.43524347082;48465.27302090542;48677.75661121672;50699.746501267255;52051;68368.63262734617;71595.64202178956;72756.90701650834;73253.633731831;73936;9441.480718560546;10898.103875512694;11037.944810275898;11360.829587556358;11432.94283528577;11855;11966.504186976628;12120.27278363301;12225.327606981702;12419.192752471421;11691.894045011157;11831.46758395857;11864.525418983489;11983.161178717406;12050.51797928073;11558.884411155781;11595.304281743123;11625.709357266136;11654.995354784585;11819.083515175766;11169.33328671101;11252.099832013255;11370.715732106433;11627.709307267385;11759.353235572125;9857.211423086279;9861.161801246973;9872;9945.204383649147;10217.13154381886;8319.958400207961;9746.366486178376;9880.654177103766;9909.504524773876;9950.800983980425 07:32:31 INFO - PROCESS | 1659 | __end_tp_report 07:32:31 INFO - PROCESS | 1659 | __start_cc_report 07:32:31 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,392 07:32:31 INFO - PROCESS | 1659 | __end_cc_report 07:32:31 INFO - PROCESS | 1659 | __startTimestamp1467037951155__endTimestamp 07:32:31 INFO - PROCESS | 1659 | 07:32:31 INFO - PROCESS | 1659 | ------- Summary: start ------- 07:32:31 INFO - PROCESS | 1659 | Number of tests: 6 07:32:31 INFO - PROCESS | 1659 | 07:32:31 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5977.57 Median:6202.69 stddev:668.64 (10.8%) stddev-sans-first:632.44 07:32:31 INFO - PROCESS | 1659 | Values: 3135.8 3711.5 3722.8 3750.6 3768.4 5974.0 6087.8 6100.4 6105.2 6120.1 4583.8 5330.4 5964.0 6100.1 6130.3 4985.8 5110.4 5423.7 5469.0 5529.2 5458.1 5497.6 5529.7 5539.5 5544.5 5536.7 5547.5 5565.8 5581.4 5619.5 4853.4 5568.1 5587.0 5594.0 5603.7 5406.7 5500.5 5510.3 5525.5 5586.0 5640.9 5791.9 6046.3 6050.4 6090.9 6458.5 6463.1 6470.6 6488.0 6491.4 6414.6 6506.3 6520.9 6535.7 6572.5 6127.5 6140.1 6141.5 6166.1 6209.4 6677.2 6715.4 6716.4 6717.6 6737.6 6372.4 6384.3 6389.2 6393.0 6404.7 5391.6 6370.8 6472.6 6481.9 6534.5 6349.1 6357.4 6358.3 6402.0 6414.4 5331.7 6365.5 6402.4 6413.4 6451.2 5068.0 5174.6 5215.5 5247.2 5264.7 4671.0 4683.9 4690.4 4691.5 4718.0 5762.9 6116.9 6175.6 6177.8 6219.8 5396.4 6410.0 6495.0 6503.9 6543.7 6151.0 6196.6 6210.8 6213.5 6216.9 5577.9 5664.3 5698.9 5703.7 5731.2 6712.1 6747.4 6755.7 6767.9 6792.7 6448.0 6456.7 6471.8 6507.1 6510.1 5659.5 6543.7 6674.5 6771.6 6789.1 6405.9 6413.9 6441.5 6442.6 6462.8 6485.7 6510.3 6518.7 6531.4 6547.7 6202.7 6262.9 6304.6 6328.3 6373.2 6287.9 6288.6 6313.7 6329.2 6331.2 5398.7 5724.8 6101.7 6174.3 6226.3 5254.8 6184.6 6278.8 6307.0 6381.9 6167.8 6198.5 6221.9 6239.0 6267.5 07:32:31 INFO - PROCESS | 1659 | 07:32:31 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:71087.26 Median:38059.93 stddev:157422.49 (413.6%) stddev-sans-first:157775.04 07:32:31 INFO - PROCESS | 1659 | Values: 557.3 566.6 567.6 584.6 607.6 30943.5 32835.0 35206.8 38847.0 40189.0 43850.7 43892.3 44240.0 44539.6 44630.6 9837.5 9973.1 10042.7 10046.5 10056.1 9786.1 9918.2 9922.6 9926.6 9943.4 8581.2 9880.8 9905.0 9940.5 10016.4 9895.8 9914.3 9941.3 9941.8 9960.1 9770.1 9878.9 9895.8 9918.9 9926.2 34126.3 39841.8 40352.4 40559.0 41218.6 3299.6 3472.4 3609.9 3813.3 3983.0 29721.4 30160.0 30252.4 30277.8 30280.0 2711.1 2790.9 2798.8 2908.0 2947.1 491488.6 493401.0 493535.0 497097.0 497962.5 38044.4 38721.2 68647.0 69868.3 69871.3 31914.5 37636.2 37736.2 37790.9 37849.4 16025.6 16051.4 16475.0 16527.2 16656.6 13911.5 14158.6 14222.9 14242.2 14247.6 8463.5 8549.3 8578.6 8711.0 8773.3 3550.4 3550.7 3552.6 3590.3 3597.8 1016.1 1053.1 1068.7 1146.0 1171.9 26662.7 31422.8 31460.8 31774.8 32012.4 1082.2 1098.8 1153.2 1184.8 1193.5 13912.9 15605.8 15966.9 15989.4 16417.6 658254.0 667417.0 670151.0 671730.0 673154.0 63983.0 64755.7 65249.3 65387.0 65562.7 1540.7 1561.8 1573.4 1579.2 1643.5 28583.6 31136.7 31373.7 31544.0 31876.0 56722.1 57685.1 58314.7 58728.7 58875.4 579699.0 587953.0 590915.0 591516.0 593088.0 29126.0 44688.8 45446.8 46619.8 46763.3 45690.0 45833.5 45914.5 46965.5 46997.1 37177.8 37190.4 38075.4 38570.2 39728.2 31220.0 37184.6 37372.3 37389.4 37519.4 34625.1 38417.4 40258.8 40834.6 40874.6 28671.7 33114.3 34689.1 34850.5 35090.8 26059.5 26364.3 26385.3 26410.9 26637.9 07:32:31 INFO - PROCESS | 1659 | 07:32:31 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:36398.70 Median:21560.12 stddev:108328.32 (502.4%) stddev-sans-first:108598.41 07:32:31 INFO - PROCESS | 1659 | Values: 357.9 412.6 421.9 427.1 437.4 20898.7 21443.7 21680.0 21945.9 22659.1 12147.1 12342.7 16315.3 20986.8 21152.4 4381.8 5657.0 5676.1 5860.6 6306.5 6162.2 6268.5 6289.7 6290.8 6296.1 5985.2 6129.9 6163.0 6230.7 6267.1 6068.8 6140.5 6167.6 6187.3 6247.3 5423.2 5477.5 5482.6 5487.9 5527.1 14149.9 14287.9 14533.0 15795.8 21119.8 2074.9 2220.5 2242.6 2355.6 2844.3 10096.0 10383.7 10441.7 10564.9 10737.5 1713.7 1731.3 1843.5 1866.9 1872.5 121020.4 122082.0 122811.0 123433.0 126593.0 11068.6 11772.1 12383.5 12512.8 12687.9 15569.0 15598.7 15974.8 15987.2 16050.2 9372.6 9394.9 9449.5 9646.2 9687.1 8164.3 9124.3 9579.5 9591.7 9697.8 4929.1 5000.2 5004.7 5015.4 5055.8 1815.4 2067.4 2125.7 2131.3 2183.5 911.7 994.9 998.2 1022.9 1078.7 17576.0 21001.0 21676.6 21804.0 22155.9 874.4 908.3 1008.4 1042.9 1126.6 11305.2 11717.9 11722.2 11739.3 11742.8 574071.0 660953.0 662619.7 676173.0 678064.0 77617.8 113790.0 131106.0 140732.0 141510.3 1038.5 1057.4 1057.6 1068.0 1075.5 18960.8 19601.9 19657.6 19724.0 19755.8 51547.5 52159.7 53719.5 54435.0 54983.5 77989.0 79076.0 79770.8 80151.2 82527.0 7202.4 8580.2 8614.4 8621.4 8937.8 13017.7 13066.1 13283.7 13297.1 13351.6 11457.6 11538.1 11652.0 11721.1 11787.7 11188.5 11298.2 11373.8 11456.3 11739.5 10341.6 11411.7 11652.9 11738.0 12025.9 7519.5 8157.3 8442.5 8484.7 8619.0 8622.4 8946.6 11529.3 11693.4 11734.6 07:32:31 INFO - PROCESS | 1659 | 07:32:31 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5920.62 Median:2731.21 stddev:3313.50 (121.3%) stddev-sans-first:3307.08 07:32:31 INFO - PROCESS | 1659 | Values: 1626.3 1641.9 1644.9 1990.9 2037.7 8304.7 8963.1 9085.4 9264.3 9272.7 8955.6 9003.8 9057.8 9062.7 9093.8 2535.2 2540.6 2560.4 2577.8 2579.8 2544.1 2562.6 2598.8 2601.3 2603.1 2537.5 2555.1 2574.9 2576.2 2591.5 2542.1 2571.1 2577.4 2607.3 2616.6 2128.7 2559.7 2583.0 2602.0 2617.8 7801.9 9252.5 9278.9 9283.8 9324.7 5656.0 5657.8 5662.8 5670.9 5690.6 3229.5 3688.2 3784.2 3832.9 3866.1 1064.4 1083.2 1093.9 1094.3 1096.0 12198.7 12392.8 12457.8 12500.0 12514.2 4121.6 4330.4 5063.1 5151.5 5204.9 10462.8 10550.2 10555.3 10686.8 10697.4 5672.8 5729.4 5748.4 5797.8 5838.7 4702.1 5098.6 5163.5 5213.7 5305.4 3647.7 4199.8 4245.9 4324.1 4357.4 1392.4 1420.8 1424.1 1425.0 1425.1 888.5 972.6 975.8 978.7 1004.2 6063.8 6074.6 6097.0 6141.7 6223.2 490.7 493.0 493.4 494.3 498.6 3967.8 4063.6 4092.3 4105.5 4147.0 10909.0 11217.9 11245.7 11342.1 11380.0 10918.6 11062.3 11071.9 11081.1 11130.3 8363.0 8555.5 8688.0 8725.0 8733.3 5047.6 5879.6 5890.9 5904.9 6008.3 9886.5 9944.3 10002.1 10005.1 10025.0 9769.3 10169.3 10255.8 10267.2 10576.5 6975.3 7470.6 7657.0 7751.0 7830.1 8449.2 8575.1 8575.7 8625.2 8656.6 7148.9 7468.9 7679.6 7688.8 7711.0 6482.3 7539.2 7550.0 7589.7 7639.9 7231.0 7280.5 7292.0 7292.6 7341.4 4963.8 5012.4 5038.6 5053.0 5060.4 5001.1 5053.4 5085.3 5165.3 5370.5 07:32:31 INFO - PROCESS | 1659 | 07:32:31 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:6096.53 Median:6886.91 stddev:1976.30 (28.7%) stddev-sans-first:1933.71 07:32:31 INFO - PROCESS | 1659 | Values: 320.5 321.9 327.2 350.0 353.6 6836.6 6872.4 6990.5 7076.9 7120.0 5525.7 6011.9 6403.1 6901.4 7004.9 4194.8 5181.4 5197.3 5197.4 5206.8 5189.3 5198.0 5199.9 5209.3 5224.5 5138.4 5138.6 5142.2 5144.4 5149.4 5014.0 5046.3 5104.6 5135.0 5143.0 4364.9 4394.9 4415.4 4416.0 4420.3 6664.7 6721.9 6723.4 6724.6 6727.0 5242.3 5997.0 6030.7 6033.8 6050.3 7339.2 7446.7 7492.7 7502.4 7539.2 4800.6 4838.4 4938.3 4941.6 4963.2 7886.3 7924.3 7930.4 7944.7 7949.6 4189.5 4946.5 5005.2 5018.7 5045.7 3889.7 4834.2 4906.3 5121.1 5124.3 6006.6 6024.7 6041.3 6049.2 6056.4 5690.7 7495.6 7517.4 7528.3 7541.3 1698.8 1709.5 1730.7 1735.1 1736.1 877.6 1076.5 1079.2 1100.3 1101.9 6246.6 7032.7 7091.4 7093.5 7127.0 7778.6 7794.9 7814.1 7888.8 7916.6 7113.1 7172.1 7172.7 7186.5 7235.0 3992.4 4111.6 4139.4 4140.4 4143.4 6443.2 8040.3 8099.9 8122.9 8123.0 7978.8 7982.8 8007.4 8063.4 8128.1 6608.6 8219.6 8225.3 8238.4 8258.5 6679.0 7546.3 7818.6 7879.9 7910.2 7701.6 7705.5 7749.2 7764.5 7765.2 8248.7 8251.6 8268.8 8270.8 8298.1 4872.6 4912.9 4924.9 4927.1 4949.1 6294.3 7580.1 7807.2 7817.7 7827.1 6995.8 7488.8 7515.9 7538.8 7549.1 7527.2 7530.6 7534.4 7548.8 7559.7 7143.7 7287.8 7347.2 7347.2 7358.3 6519.6 7118.7 7540.8 7556.7 7569.6 7077.5 7195.0 7342.3 7422.2 7443.6 07:32:31 INFO - PROCESS | 1659 | 07:32:31 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:18261.70 Median:598.11 stddev:25070.17 (4191.5%) stddev-sans-first:25105.74 07:32:31 INFO - PROCESS | 1659 | Values: 680.9 684.3 773.7 778.3 783.5 17673.3 18016.2 18016.5 18030.9 18073.6 13628.3 15926.0 16547.8 16588.8 16679.8 763.9 928.8 949.6 972.7 976.4 900.1 920.8 922.2 931.0 953.0 943.1 953.1 976.8 978.6 1001.9 942.4 944.2 958.8 975.4 1002.0 699.8 708.9 723.6 725.1 747.2 15575.2 15646.6 15720.4 15968.6 16076.7 12576.2 12723.9 13005.9 13199.4 13231.8 9962.7 10063.8 10279.9 10332.7 10404.8 3533.0 3536.2 3549.6 3607.5 3705.9 73563.5 75314.2 75417.6 75463.0 86148.1 9674.5 9740.9 9843.9 9845.7 9907.8 20856.8 20878.7 20898.7 21775.7 21777.2 6947.6 7160.6 7209.9 7344.4 7447.4 4028.8 4180.6 4203.3 4236.2 4245.6 2956.0 3729.0 3730.9 3807.2 3817.1 593.8 607.4 613.3 675.7 687.8 489.3 553.6 566.3 570.1 585.1 6879.7 8036.2 8076.4 8097.1 8176.3 552.6 561.7 578.2 594.5 601.8 3739.1 3805.9 3819.2 3988.7 4007.6 79330.6 81250.0 81654.2 81825.6 82081.6 80242.6 82356.6 82992.2 83235.3 84192.0 67470.7 68427.0 68978.0 70967.9 73190.0 8417.2 8457.5 8511.7 8556.1 8651.0 37650.4 48465.3 48677.8 50699.7 52051.0 68368.6 71595.6 72756.9 73253.6 73936.0 9441.5 10898.1 11037.9 11360.8 11432.9 11855.0 11966.5 12120.3 12225.3 12419.2 11691.9 11831.5 11864.5 11983.2 12050.5 11558.9 11595.3 11625.7 11655.0 11819.1 11169.3 11252.1 11370.7 11627.7 11759.4 9857.2 9861.2 9872.0 9945.2 10217.1 8320.0 9746.4 9880.7 9909.5 9950.8 07:32:31 INFO - PROCESS | 1659 | -------- Summary: end -------- 07:32:31 INFO - PROCESS | 1659 | 07:32:31 INFO - TEST-INFO | 1659: exit 0 07:32:31 INFO - TEST-OK | dromaeo_css | took 1109327ms 07:32:31 INFO - TEST-START | kraken 07:32:31 INFO - operating with platform_type : mac_ 07:32:31 INFO - Initialising browser for kraken test... 07:32:31 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpLEe_cD/profile http://localhost:49267/getInfo.html) 07:32:34 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 07:32:34 INFO - PROCESS | 1668 | colorDepth:24 07:32:34 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 07:32:34 INFO - PROCESS | 1668 | __metrics 07:32:34 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:32:34 INFO - TEST-INFO | 1668: exit 0 07:32:34 INFO - Browser initialized. 07:32:34 INFO - Running cycle 1/1 for kraken test... 07:32:34 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpLEe_cD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:46 INFO - PROCESS | 1672 | RSS: Main: 171110400 07:32:46 INFO - PROCESS | 1672 | 07:32:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 07:32:50 INFO - PROCESS | 1672 | RSS: Main: 184057856 07:32:50 INFO - PROCESS | 1672 | 07:32:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 07:32:53 INFO - PROCESS | 1672 | RSS: Main: 193273856 07:32:53 INFO - PROCESS | 1672 | 07:32:56 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 07:32:57 INFO - PROCESS | 1672 | RSS: Main: 196800512 07:32:57 INFO - PROCESS | 1672 | 07:32:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 07:32:59 INFO - PROCESS | 1672 | RSS: Main: 197074944 07:32:59 INFO - PROCESS | 1672 | 07:33:01 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:33:02 INFO - PROCESS | 1672 | RSS: Main: 197488640 07:33:02 INFO - PROCESS | 1672 | 07:33:05 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 07:33:05 INFO - PROCESS | 1672 | RSS: Main: 197607424 07:33:05 INFO - PROCESS | 1672 | 07:33:08 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 07:33:09 INFO - PROCESS | 1672 | RSS: Main: 197398528 07:33:09 INFO - PROCESS | 1672 | 07:33:12 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 07:33:13 INFO - PROCESS | 1672 | RSS: Main: 198754304 07:33:13 INFO - PROCESS | 1672 | 07:33:14 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:33:15 INFO - PROCESS | 1672 | RSS: Main: 198078464 07:33:15 INFO - PROCESS | 1672 | 07:33:17 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:33:17 INFO - PROCESS | 1672 | RSS: Main: 198160384 07:33:17 INFO - PROCESS | 1672 | 07:33:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:33:20 INFO - PROCESS | 1672 | RSS: Main: 198389760 07:33:20 INFO - PROCESS | 1672 | 07:33:23 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:33:23 INFO - PROCESS | 1672 | RSS: Main: 198660096 07:33:23 INFO - PROCESS | 1672 | 07:33:26 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:33:27 INFO - PROCESS | 1672 | RSS: Main: 198574080 07:33:27 INFO - PROCESS | 1672 | 07:33:28 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 07:33:29 INFO - PROCESS | 1672 | RSS: Main: 200339456 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | __start_tp_report 07:33:29 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 07:33:29 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 07:33:29 INFO - PROCESS | 1672 | |i|pagename|runs| 07:33:29 INFO - PROCESS | 1672 | |0;ai-astar;118;113;119;116;117;132;114;115;117;129 07:33:29 INFO - PROCESS | 1672 | |1;audio-beat-detection;152;123;143;159;120;139;121;176;198;147 07:33:29 INFO - PROCESS | 1672 | |2;audio-dft;195;203;197;237;191;194;197;192;196;194 07:33:29 INFO - PROCESS | 1672 | |3;audio-fft;62;69;80;147;57;56;58;62;129;57 07:33:29 INFO - PROCESS | 1672 | |4;audio-oscillator;77;80;133;113;114;131;122;76;79;121 07:33:29 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;90;87;89;86;93;86;89;86;88;84 07:33:29 INFO - PROCESS | 1672 | |6;imaging-darkroom;94;95;117;117;95;95;95;125;94;94 07:33:29 INFO - PROCESS | 1672 | |7;imaging-desaturate;96;129;91;100;77;149;147;87;144;151 07:33:29 INFO - PROCESS | 1672 | |8;json-parse-financial;58;63;64;63;64;64;62;78;64;60 07:33:29 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;61;63;65;75;68;63;62;65;64;65 07:33:29 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;83;80;81;105;103;103;85;81;83;84 07:33:29 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;128;127;126;125;144;142;136;144;171;146 07:33:29 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;156;165;160;166;163;157;163;158;161;161 07:33:29 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;67;68;65;68;73;67;68;71;87;98 07:33:29 INFO - PROCESS | 1672 | __end_tp_report 07:33:29 INFO - PROCESS | 1672 | __start_cc_report 07:33:29 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1034 07:33:29 INFO - PROCESS | 1672 | __end_cc_report 07:33:29 INFO - PROCESS | 1672 | __startTimestamp1467038009192__endTimestamp 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | ------- Summary: start ------- 07:33:29 INFO - PROCESS | 1672 | Number of tests: 14 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:119.00 Median:117.50 stddev:6.36 (5.4%) stddev-sans-first:6.74 07:33:29 INFO - PROCESS | 1672 | Values: 118.0 113.0 119.0 116.0 117.0 132.0 114.0 115.0 117.0 129.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:149.50 stddev:25.09 (16.8%) stddev-sans-first:26.57 07:33:29 INFO - PROCESS | 1672 | Values: 152.0 123.0 143.0 159.0 120.0 139.0 121.0 176.0 198.0 147.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:199.60 Median:196.50 stddev:13.55 (6.9%) stddev-sans-first:14.27 07:33:29 INFO - PROCESS | 1672 | Values: 195.0 203.0 197.0 237.0 191.0 194.0 197.0 192.0 196.0 194.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:77.70 Median:60.00 stddev:32.87 (54.8%) stddev-sans-first:34.37 07:33:29 INFO - PROCESS | 1672 | Values: 62.0 69.0 80.0 147.0 57.0 56.0 58.0 62.0 129.0 57.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:104.50 stddev:23.74 (22.7%) stddev-sans-first:22.99 07:33:29 INFO - PROCESS | 1672 | Values: 77.0 80.0 133.0 113.0 114.0 131.0 122.0 76.0 79.0 121.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.50 stddev:2.57 (2.9%) stddev-sans-first:2.60 07:33:29 INFO - PROCESS | 1672 | Values: 90.0 87.0 89.0 86.0 93.0 86.0 89.0 86.0 88.0 84.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:94.50 stddev:12.32 (13.0%) stddev-sans-first:12.72 07:33:29 INFO - PROCESS | 1672 | Values: 94.0 95.0 117.0 117.0 95.0 95.0 95.0 125.0 94.0 94.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:117.10 Median:114.00 stddev:29.55 (25.9%) stddev-sans-first:30.34 07:33:29 INFO - PROCESS | 1672 | Values: 96.0 129.0 91.0 100.0 77.0 149.0 147.0 87.0 144.0 151.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:5.31 (8.3%) stddev-sans-first:5.17 07:33:29 INFO - PROCESS | 1672 | Values: 58.0 63.0 64.0 63.0 64.0 64.0 62.0 78.0 64.0 60.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:3.98 (6.1%) stddev-sans-first:3.94 07:33:29 INFO - PROCESS | 1672 | Values: 61.0 63.0 65.0 75.0 68.0 63.0 62.0 65.0 64.0 65.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:82.00 stddev:10.38 (12.7%) stddev-sans-first:10.79 07:33:29 INFO - PROCESS | 1672 | Values: 83.0 80.0 81.0 105.0 103.0 103.0 85.0 81.0 83.0 84.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:143.00 stddev:14.03 (9.8%) stddev-sans-first:14.31 07:33:29 INFO - PROCESS | 1672 | Values: 128.0 127.0 126.0 125.0 144.0 142.0 136.0 144.0 171.0 146.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:162.00 stddev:3.33 (2.1%) stddev-sans-first:3.00 07:33:29 INFO - PROCESS | 1672 | Values: 156.0 165.0 160.0 166.0 163.0 157.0 163.0 158.0 161.0 161.0 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:69.50 stddev:10.73 (15.4%) stddev-sans-first:11.14 07:33:29 INFO - PROCESS | 1672 | Values: 67.0 68.0 65.0 68.0 73.0 67.0 68.0 71.0 87.0 98.0 07:33:29 INFO - PROCESS | 1672 | -------- Summary: end -------- 07:33:29 INFO - PROCESS | 1672 | 07:33:29 INFO - TEST-INFO | 1672: exit 0 07:33:30 INFO - TEST-OK | kraken | took 58356ms 07:33:30 INFO - SUITE-END | took 1167s 07:33:30 INFO - Completed test suite (00:19:27) 07:33:30 INFO - javascript benchmark 07:33:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.827529485877, 3711.461838033485, 3722.7580207286524, 3750.587435382106, 3768.4158955361927, 5974.014287642533, 6087.756489740411, 6100.359462256466, 6105.20632317798, 6120.051392034231, 4583.839565615204, 5330.413654498002, 5963.970180149093, 6100.084987251915, 6130.325664176937, 4985.750712464381, 5110.361204849394, 5423.701696406696, 5468.9726551367385, 5529.198266251391, 5458.072127738294, 5497.642653227547, 5529.695866727328, 5539.501444869961, 5544.528715059225, 5536.695481748502, 5547.472990065938, 5565.777368905239, 5581.413951535092, 5619.466150715696, 4853.39332583427, 5568.081266591008, 5587.0, 5593.965116453429, 5603.691796951166, 5406.729663516848, 5500.532454741352, 5510.311211098613, 5525.539295825173, 5586.0, 5640.915386269209, 5791.88416231673, 6046.304674962392, 6050.3647117052515, 6090.939090609081, 6458.515611329169, 6463.062855885917, 6470.6117632941705, 6487.967560162169, 6491.383318584727, 6414.647194404306, 6506.31683673217, 6520.93479065208, 6535.705893234815, 6572.5399222054475, 6127.4949652051, 6140.109684095781, 6141.486007784275, 6166.075088736726, 6209.441150296495, 6677.198736151693, 6715.3620406061345, 6716.361945615159, 6717.56335838169, 6737.629430381376, 6372.394622510854, 6384.265809431882, 6389.169407976933, 6393.0, 6404.7117879695525, 5391.56867450603, 6370.84072898172, 6472.611643301417, 6481.935180648227, 6534.542582019213, 6349.111124442582, 6357.364263573698, 6358.268799088164, 6402.03969404593, 6414.390632889868, 5331.653442526223, 6365.4589359904, 6402.423781859562, 6413.35866413355, 6451.1936007999, 5067.974660126676, 5174.611904107207, 5215.504527069922, 5247.160454327366, 5264.657797243167, 4670.9766451167525, 4683.906321873544, 4690.413698287714, 4691.53084691535, 4717.985633088902, 5762.884742305214, 6116.877662446726, 6175.567710260329, 6177.81466556004, 6219.813405597839, 5396.406395296514, 6410.0, 6494.9675251624385, 6503.9349606504275, 6543.705533251015, 6151.0, 6196.597221180699, 6210.844728881723, 6213.471854892385, 6216.906746398808, 5577.888442231133, 5664.26364572603, 5698.886022279531, 5703.686297253608, 5731.226284451629, 6712.12742343502, 6747.426468750211, 6755.716413881347, 6767.898481522781, 6792.694328755119, 6448.032795080588, 6456.741730330922, 6471.7734879279, 6507.12153859223, 6510.088587597835, 5659.462351076641, 6543.738250470118, 6674.499412544175, 6771.559848609824, 6789.1174147360525, 6405.943019401747, 6413.903791443226, 6441.452476539546, 6442.645654488861, 6462.773802916875, 6485.740570377321, 6510.251321097945, 6518.674066296761, 6531.379518945692, 6547.70535325902, 6202.689865506616, 6262.937370626418, 6304.5586808922935, 6328.335524770017, 6373.235211774617, 6287.937120628735, 6288.5598008138995, 6313.652749098844, 6329.208848893888, 6331.176946996861, 5398.700884673577, 5724.797792463629, 6101.674617273172, 6174.25908890936, 6226.315105338319, 5254.7898084076205, 6184.5980011299125, 6278.780242691484, 6306.9684651576445, 6381.8723625528155, 6167.753289868355, 6198.473129784019, 6221.906671399842, 6239.0, 6267.529935254783], "value": 5938.785388126661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.2699763310064, 566.6147020026382, 567.6111863373591, 584.5754779045507, 607.638455119204, 30943.535846962313, 32835.01494955149, 35206.82396588013, 38847.0, 40188.99527511813, 43850.684479465584, 43892.341614875804, 44240.0, 44539.554604453944, 44630.553694463044, 9837.458939758311, 9973.102420782128, 10042.74893127674, 10046.547905344241, 10056.094951454368, 9786.119249267564, 9918.20654347654, 9922.553485093189, 9926.602935882556, 9943.403395796238, 8581.227689507943, 9880.802383952318, 9905.0, 9940.502974851264, 10016.399016059024, 9895.802083958317, 9914.256430767722, 9941.254405919584, 9941.75145621358, 9960.05379488951, 9770.071843174957, 9878.913319534846, 9895.752606184831, 9918.851217231748, 9926.2059035277, 34126.31747365063, 39841.80079099586, 40352.39471407931, 40558.972051397315, 41218.587814121776, 3299.6205436374644, 3472.409690352621, 3609.855605775766, 3813.2957841786083, 3982.980085099556, 29721.40557188844, 30160.0, 30252.394952101055, 30277.848610757024, 30279.972002799765, 2711.064682684471, 2790.9302267443272, 2798.8040837141407, 2907.970920290791, 2947.0864032150103, 491488.62767058524, 493401.0, 493535.0, 497097.0, 497962.53056204546, 38044.429333560016, 38721.22557548833, 68647.0, 69868.30131698618, 69871.3012869875, 31914.521282180787, 37636.247275054346, 37736.24527509434, 37790.86627401182, 37849.43225851614, 16025.59936001586, 16051.43819966319, 16475.0, 16527.173641317888, 16656.583585410463, 13911.513097041556, 14158.575242742734, 14222.857771422154, 14242.216678082805, 14247.64380890486, 8463.492190468469, 8549.316054715608, 8578.571071446402, 8711.0, 8773.341999350074, 3550.4141816600486, 3550.715942724576, 3552.609212986569, 3590.2998915211283, 3597.784132951979, 1016.1413605503337, 1053.1259054984343, 1068.7488440216543, 1145.9915274558502, 1171.912106592009, 26662.733372666025, 31422.84288578588, 31460.842695786374, 31774.841125794224, 32012.359752804812, 1082.1775450657558, 1098.780243951213, 1153.1985270237271, 1184.8447763430759, 1193.540486912545, 13912.860871391156, 15605.751539876783, 15966.882318237613, 15989.360425582847, 16417.58956026109, 658254.0, 667417.0, 670151.0, 671730.0, 673154.0, 63983.0, 64755.70488590202, 65249.347506524326, 65387.0, 65562.67218663971, 1540.653352995567, 1561.789158463593, 1573.3785154863765, 1579.2103948025988, 1643.4658735910878, 28583.571246430904, 31136.68863311338, 31373.686263137075, 31544.0, 31876.0, 56722.149167761694, 57685.13472298003, 58314.7084264576, 58728.70635646794, 58875.41124588699, 579699.0, 587953.0, 590915.0454247701, 591516.0, 593088.0, 29126.0, 44688.77655611701, 45446.77276613596, 46619.766901165276, 46763.29855052109, 45690.0, 45833.541664582925, 45914.540854591025, 46965.53034469748, 46997.06005879795, 37177.81411092927, 37190.44214336841, 38075.42886856755, 38570.228595428496, 39728.2054358917, 31220.0, 37184.6281537192, 37372.25255494929, 37389.439158412104, 37519.43720844244, 34625.134371639906, 38417.4237386445, 40258.79870600745, 40834.59165408308, 40874.59125408708, 28671.713282866906, 33114.33771324608, 34689.13277168091, 34850.49784292972, 35090.824545877105, 26059.478810423305, 26364.3408914771, 26385.340366490993, 26410.943562258064, 26637.866810665822], "value": 19556.168927301027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.915889765905, 412.570926236714, 421.9071804203078, 427.0966904995933, 437.42697066842436, 20898.686519702198, 21443.67834482484, 21680.02439890205, 21945.890270548643, 22659.054322937995, 12147.088968327367, 12342.691432714186, 16315.265813038412, 20986.79013209871, 21152.365429037116, 4381.846635367763, 5657.0, 5676.063449530843, 5860.619059761123, 6306.463950564207, 6162.22972128484, 6268.49852011838, 6289.654069026202, 6290.842728931791, 6296.055591661265, 5985.221921150244, 6129.877402451948, 6162.969185154068, 6230.719617617196, 6267.091271765591, 6068.848278793022, 6140.478059364959, 6167.629942203482, 6187.319394866561, 6247.281562620311, 5423.186522021689, 5477.4796394342475, 5482.5888058395385, 5487.862803429906, 5527.060399732055, 14149.938754593344, 14287.928560357235, 14533.0, 15795.842041579552, 21119.78880211209, 2074.9273775417937, 2220.5225876436484, 2242.5963326601204, 2355.6348765941134, 2844.288927768058, 10096.040876116831, 10383.740406489898, 10441.68674939753, 10564.947175264151, 10737.463126843626, 1713.7086695261835, 1731.2988239762917, 1843.5483306589838, 1866.9439916802382, 1872.5412273992958, 121020.39489802583, 122082.0, 122811.0, 123433.0, 126593.0, 11068.612598559012, 11772.058235341152, 12383.504659813507, 12512.81230781539, 12687.873121268854, 15569.0, 15598.688026239412, 15974.76037859433, 15987.200639967956, 16050.197490125447, 9372.62509499626, 9394.90605093954, 9449.527523623792, 9646.228301735844, 9687.079727425884, 8164.346852251806, 9124.270058395312, 9579.473128977974, 9591.712248632552, 9697.757556061155, 4929.137400954819, 5000.2499625056535, 5004.699718016931, 5015.423226329019, 5055.823046193439, 1815.391843732338, 2067.3537871524472, 2125.659894416917, 2131.2860191835907, 2183.541456294164, 911.7219248129384, 994.8706668133096, 998.2463240253708, 1022.8977102289712, 1078.7141407527013, 17576.0, 21001.0, 21676.56646867054, 21803.982200022005, 22155.892205389668, 874.4447275979799, 908.3369140527452, 1008.4251976373397, 1042.8800687920834, 1126.5550107707409, 11305.15211359135, 11717.941410293064, 11722.238054526428, 11739.295642261492, 11742.823857642143, 574071.0, 660953.0, 662619.6869015624, 676173.0, 678064.0, 77617.83573246405, 113790.0, 131106.0, 140732.0, 141510.2924485371, 1038.5482315192914, 1057.4184198690843, 1057.6456886942806, 1067.9907487424464, 1075.5213929801164, 18960.810391896455, 19601.901990489958, 19657.606847863248, 19724.0, 19755.80244197597, 51547.48452515577, 52159.73920130375, 53719.46280537145, 54435.0, 54983.45016549783, 77989.0, 79076.0, 79770.80343794731, 80151.19848801437, 82527.0, 7202.351788338865, 8580.184882436159, 8614.44006139599, 8621.439606425562, 8937.776555586162, 13017.674558136123, 13066.085374023727, 13283.66790830237, 13297.135686180367, 13351.599452016455, 11457.59898403552, 11538.134639901873, 11652.0, 11721.062315014608, 11787.705307367041, 11188.496517656888, 11298.152638552307, 11373.829392559284, 11456.255343402985, 11739.530418783495, 10341.63804266847, 11411.744708082271, 11652.94173529127, 11738.0, 12025.879741202825, 7519.511231769918, 8157.306628936607, 8442.451240669583, 8484.703035393732, 8618.956905215433, 8622.396432249683, 8946.642134314554, 11529.308241505536, 11693.415329233334, 11734.647960561197], "value": 9747.93876114608, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1626.30881875203, 1641.9179041047953, 1644.9259783309749, 1990.88054716717, 2037.6943458481235, 8304.709335173271, 8963.148500892421, 9085.40944838585, 9264.305177111719, 9272.67545635903, 8955.552222388887, 9003.819923601524, 9057.773555661095, 9062.728118156449, 9093.772655683611, 2535.1887396033276, 2540.5554028045062, 2560.398306397995, 2577.8066645001604, 2579.7807186389177, 2544.134994102005, 2562.6027965665353, 2598.8440693558355, 2601.310652677042, 2603.1149409200866, 2537.5432422164004, 2555.1312553731727, 2574.884130214145, 2576.188500622298, 2591.5464793661126, 2542.072143667557, 2571.087264021264, 2577.445849142434, 2607.29603007187, 2616.6467526883816, 2128.6806978953127, 2559.6800399950007, 2582.9870850645816, 2602.0, 2617.8429294242214, 7801.882971755428, 9252.537373131316, 9278.860817087749, 9283.76790580241, 9324.720258392259, 5656.0, 5657.773689052433, 5662.8301150965535, 5670.914936275959, 5690.573207009491, 3229.54786329914, 3688.2254726507467, 3784.1674831537016, 3832.9425058624142, 3866.072142685763, 1064.446487826326, 1083.1713738989679, 1093.9006298669785, 1094.3324572011068, 1096.0354887698775, 12198.695032624166, 12392.81410778839, 12457.75084498305, 12499.999999999978, 12514.1865778725, 4121.5878412158545, 4330.41539392178, 5063.063333283354, 5151.484851514819, 5204.869878253074, 10462.790744185073, 10550.15598752098, 10555.26113172086, 10686.839697404544, 10697.411642359744, 5672.829815105553, 5729.427057294321, 5748.367679555246, 5797.826065218051, 5838.678872662044, 4702.1065997461055, 5098.59211263098, 5163.483651634881, 5213.687178769286, 5305.363356397257, 3647.6534729200685, 4199.76901270427, 4245.87262382129, 4324.113556720865, 4357.433533640607, 1392.4499822570028, 1420.8295004599515, 1424.1455126923763, 1424.9907630241516, 1425.1449130521605, 888.5379602606608, 972.5769290358717, 975.7658162041059, 978.6868202175378, 1004.2167109654481, 6063.8484037898525, 6074.605150665193, 6096.969515152396, 6141.662208578571, 6223.190985171898, 490.6663468841222, 492.99260511092365, 493.4251596889655, 494.27835360373535, 498.5961371289267, 3967.781772002568, 4063.593640635913, 4092.3452247640234, 4105.507339119325, 4147.0, 10909.0, 11217.887821121685, 11245.662630121109, 11342.149338799623, 11379.975802177843, 10918.563257469612, 11062.336259824437, 11071.889281107247, 11081.058110060574, 11130.332180069221, 8362.958185209034, 8555.486670799772, 8688.000879898766, 8725.0, 8733.257673097858, 5047.646664733434, 5879.588428810113, 5890.941090589039, 5904.852378690567, 6008.279006519246, 9886.50567471609, 9944.254180936314, 10002.149817265323, 10005.149562287286, 10025.047620476043, 9769.31614786958, 10169.288149829441, 10255.794884102126, 10267.178625710074, 10576.471176440993, 6975.3024697529845, 7470.589117598584, 7657.042869641295, 7751.0, 7830.060392752906, 8449.23956843887, 8575.142485751376, 8575.65697372123, 8625.180607842245, 8656.610452529525, 7148.892766608401, 7468.887966680612, 7679.616019199129, 7688.769336919901, 7711.0, 6482.319356467691, 7539.246075392417, 7549.962250188714, 7589.6584653689615, 7639.885401718868, 7230.9638451807405, 7280.453965952681, 7292.0, 7292.635368231461, 7341.412686985135, 4963.826266080814, 5012.448630650699, 5038.596912246938, 5053.0399224147295, 5060.443351231288, 5001.1248031593595, 5053.444121146597, 5085.338905942352, 5165.302684137593, 5370.543503802221], "value": 4715.160258537485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.5144206527111, 321.872860220213, 327.2277425276349, 350.0269251480884, 353.58453816765297, 6836.623985680785, 6872.41584465321, 6990.475714321427, 7076.867701167807, 7120.038794762699, 5525.723713814314, 6011.939880601192, 6403.103565500822, 6901.413379862718, 7004.894926576093, 4194.832206711728, 5181.35233095863, 5197.298364720771, 5197.350331208599, 5206.817761378353, 5189.325387699594, 5197.974010129963, 5199.922001169985, 5209.322788037569, 5224.50367215114, 5138.383393992707, 5138.6146039047035, 5142.228665700138, 5144.356955380577, 5149.382074151107, 5014.047331007097, 5046.26829109777, 5104.566111880495, 5134.974325128388, 5143.0, 4364.908772806798, 4394.912101757947, 4415.4259946206785, 4416.028473735773, 4420.336949457607, 6664.733410663568, 6721.932780672179, 6723.394894459522, 6724.596524208563, 6726.990951357287, 5242.344706911636, 5996.97001514994, 6030.698465076773, 6033.758649654009, 6050.334463209044, 7339.229380915034, 7446.702131914717, 7492.737754178577, 7502.399808015401, 7539.208383119748, 4800.567948884617, 4838.42751105892, 4938.283948827436, 4941.604671626261, 4963.1810751226, 7886.290233878978, 7924.286814186751, 7930.405219608552, 7944.682212711485, 7949.64226609804, 4189.539150693421, 4946.530079642428, 5005.249212618063, 5018.723970181602, 5045.722485263345, 3889.724511160946, 4834.226523756252, 4906.288588154697, 5121.07820592297, 5124.256982737482, 6006.579539432285, 6024.728887200086, 6041.2750469943885, 6049.153118563405, 6056.394360563909, 5690.687012214368, 7495.550266983998, 7517.398608111338, 7528.284812942762, 7541.283578060075, 1698.8216237295153, 1709.5213340264745, 1730.740388941669, 1735.0543953545348, 1736.053850651398, 877.6401675313091, 1076.5101878645198, 1079.169039839335, 1100.2683215661496, 1101.9338839669485, 6246.562740608114, 7032.683529241196, 7091.432685385157, 7093.467989900778, 7127.0, 7778.572178530122, 7794.92205077942, 7814.10137834145, 7888.802779930433, 7916.643751031217, 7113.110861142357, 7172.139343278735, 7172.748953786592, 7186.496945213785, 7234.987101805751, 3992.3612222044912, 4111.568285329998, 4139.4204811326435, 4140.441040459499, 4143.399207115011, 6443.194600674916, 8040.316573091236, 8099.919000809917, 8122.918770812216, 8123.025236971601, 7978.760637180894, 7982.802579613104, 8007.399445041645, 8063.435559510778, 8128.14654461273, 6608.636524991171, 8219.630116644765, 8225.259726624632, 8238.382121340923, 8258.545779982158, 6679.0, 7546.2831031051965, 7818.609069546614, 7879.881801773093, 7910.169432209535, 7701.576413297323, 7705.499142555716, 7749.186335434698, 7764.456488045783, 7765.22347765219, 8248.670053197804, 8251.587420629065, 8268.793280168044, 8270.751877443687, 8298.087210406971, 4872.561469467765, 4912.8771780705765, 4924.926126108183, 4927.088488629615, 4949.109160351028, 6294.339094395023, 7580.05249343832, 7807.219278072147, 7817.726379576688, 7827.099883513469, 6995.755148569776, 7488.812779680552, 7515.924840751742, 7538.773836784905, 7549.0563679540055, 7527.247275272429, 7530.585817780075, 7534.434917381109, 7548.811279718051, 7559.697612095674, 7143.714251429885, 7287.781366559012, 7347.191808901123, 7347.228541003117, 7358.300961408658, 6519.641419721961, 7118.715251389886, 7540.773776786705, 7556.735514256975, 7569.593682842853, 7077.504574679723, 7195.02867112933, 7342.265773422615, 7422.220666829905, 7443.590602516913], "value": 5427.037227953789, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.8638272345532, 684.3156843156846, 773.7330620935775, 778.322859112572, 783.4868161354314, 17673.29306827727, 18016.18927148278, 18016.459506214833, 18030.909845450755, 18073.638527229446, 13628.250446225478, 15925.964812287193, 16547.83452165478, 16588.834111658878, 16679.83320166798, 763.8586861430625, 928.8281667891428, 949.5632009275724, 972.7081875437376, 976.4434272464698, 900.0639335091497, 920.8020275640736, 922.2391526990226, 930.9674161404353, 952.9904700952972, 943.056943056943, 953.0755167487526, 976.799756050008, 978.5792109392958, 1001.8998100189996, 942.3544871762864, 944.1502647617165, 958.836997710391, 975.4342481360829, 1002.04304888831, 699.8460338725472, 708.9078419805393, 723.609251004457, 725.1262229014026, 747.1631772414876, 15575.221238938007, 15646.608834779108, 15720.449784257611, 15968.600784980468, 16076.678466430723, 12576.182548134342, 12723.936380318039, 13005.86994130056, 13199.40602672882, 13231.801522977163, 9962.701118966443, 10063.798724025479, 10279.897201027969, 10332.741681457948, 10404.843927341097, 3533.0, 3536.169000284931, 3549.5563054618174, 3607.5310209672575, 3705.8702945397054, 73563.52872942564, 75314.24685753127, 75417.62291188564, 75463.0, 86148.13851861464, 9674.467904265333, 9740.902590974141, 9843.852342214872, 9845.655402060893, 9907.752306192402, 20856.79143208579, 20878.686819697716, 20898.686519702216, 21775.67336489954, 21777.237796677357, 6947.617881016593, 7160.641967901584, 7209.89185162223, 7344.449166312548, 7447.44144189188, 4028.798560071985, 4180.6446452051305, 4203.348480985452, 4236.173946080547, 4245.639120674778, 2956.0, 3729.0, 3730.9067273318383, 3807.2195199983935, 3817.10298079951, 593.7862369546959, 607.3713706313944, 613.2610204703411, 675.7026908160394, 687.8211664967145, 489.307629703972, 553.5654511208681, 566.3317285602946, 570.0793218951446, 585.1369230385233, 6879.690413931385, 8036.156203598655, 8076.434649574591, 8097.109317975018, 8176.305014073751, 552.5689961829779, 561.6910699115471, 578.2078552383261, 594.4501336263938, 601.7743346245159, 3739.121306492972, 3805.923881522354, 3819.1597848473293, 3988.66096381805, 4007.579204183519, 79330.6033469829, 81250.0, 81654.18345816585, 81825.59087204526, 82081.58959205166, 80242.59878700569, 82356.58821705973, 82992.17007829965, 83235.3352932938, 84192.0, 67470.66264668645, 68427.0, 68977.999999999, 70967.93548096783, 73190.0, 8417.158284171534, 8457.450265732708, 8511.74464766058, 8556.144385561394, 8651.048384677555, 37650.43524347082, 48465.27302090542, 48677.75661121672, 50699.746501267255, 52051.0, 68368.63262734617, 71595.64202178956, 72756.90701650834, 73253.633731831, 73936.0, 9441.480718560546, 10898.103875512694, 11037.944810275898, 11360.829587556358, 11432.94283528577, 11855.0, 11966.504186976628, 12120.27278363301, 12225.327606981702, 12419.192752471421, 11691.894045011157, 11831.46758395857, 11864.525418983489, 11983.161178717406, 12050.51797928073, 11558.884411155781, 11595.304281743123, 11625.709357266136, 11654.995354784585, 11819.083515175766, 11169.33328671101, 11252.099832013255, 11370.715732106433, 11627.709307267385, 11759.353235572125, 9857.211423086279, 9861.161801246973, 9872.0, 9945.204383649147, 10217.13154381886, 8319.958400207961, 9746.366486178376, 9880.654177103766, 9909.504524773876, 9950.800983980425], "value": 7001.187877305246, "unit": "score"}], "name": "dromaeo_css", "value": 7665.253965900183, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 113.0, 119.0, 116.0, 117.0, 132.0, 114.0, 115.0, 117.0, 129.0], "value": 119.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 143.0, 159.0, 120.0, 139.0, 121.0, 176.0, 198.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 203.0, 197.0, 237.0, 191.0, 194.0, 197.0, 192.0, 196.0, 194.0], "value": 199.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 80.0, 147.0, 57.0, 56.0, 58.0, 62.0, 129.0, 57.0], "value": 77.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 133.0, 113.0, 114.0, 131.0, 122.0, 76.0, 79.0, 121.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 86.0, 93.0, 86.0, 89.0, 86.0, 88.0, 84.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 117.0, 117.0, 95.0, 95.0, 95.0, 125.0, 94.0, 94.0], "value": 102.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 129.0, 91.0, 100.0, 77.0, 149.0, 147.0, 87.0, 144.0, 151.0], "value": 117.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 64.0, 63.0, 64.0, 64.0, 62.0, 78.0, 64.0, 60.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 65.0, 75.0, 68.0, 63.0, 62.0, 65.0, 64.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 81.0, 105.0, 103.0, 103.0, 85.0, 81.0, 83.0, 84.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 126.0, 125.0, 144.0, 142.0, 136.0, 144.0, 171.0, 146.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 165.0, 160.0, 166.0, 163.0, 157.0, 163.0, 158.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 65.0, 68.0, 73.0, 67.0, 68.0, 71.0, 87.0, 98.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1546.7, "alertThreshold": 2.0}]} 07:33:30 INFO - Return code: 0 07:33:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:33:30 ERROR - # TBPL SUCCESS # 07:33:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:33:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:33:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:33:30 INFO - 2016-06-27 07:33:30.459 screenresolution[1677:10478] starting screenresolution argv=screenresolution get 07:33:30 INFO - 2016-06-27 07:33:30.462 screenresolution[1677:10478] Display 0: 1600x1200x32@60 07:33:30 INFO - 2016-06-27 07:33:30.468 screenresolution[1678:10481] starting screenresolution argv=screenresolution list 07:33:30 INFO - Available Modes on Display 0 07:33:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:33:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:33:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:33:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:33:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:33:30 INFO - Intel Iris: 07:33:30 INFO - Chipset Model: Intel Iris 07:33:30 INFO - Type: GPU 07:33:30 INFO - Bus: Built-In 07:33:30 INFO - VRAM (Dynamic, Max): 1536 MB 07:33:30 INFO - Vendor: Intel (0x8086) 07:33:30 INFO - Device ID: 0x0a2e 07:33:30 INFO - Revision ID: 0x0009 07:33:30 INFO - Displays: 07:33:30 INFO - Display: 07:33:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:33:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:33:30 INFO - Display Serial Number: 1600x1200 60 07:33:30 INFO - Main Display: Yes 07:33:30 INFO - Mirror: Off 07:33:30 INFO - Online: Yes 07:33:30 INFO - Rotation: Supported 07:33:30 INFO - Return code: 0 07:33:30 INFO - Running post-action listener: _resource_record_post_action 07:33:30 INFO - Running post-run listener: _resource_record_post_run 07:33:31 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 31600128; Write bytes: 495367168; Read time: 194; Write time: 1555 07:33:31 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193417728; Write bytes: 187389440; Read time: 17842; Write time: 399 07:33:31 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 29818368; Write bytes: 298237440; Read time: 179; Write time: 1122 07:33:31 INFO - Running post-run listener: _upload_blobber_files 07:33:31 INFO - Blob upload gear active. 07:33:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:33:31 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 07:33:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:33:32 INFO - (blobuploader) - INFO - Open directory for files ... 07:33:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:33:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:33:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:33 INFO - (blobuploader) - INFO - Done attempting. 07:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:33:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:34 INFO - (blobuploader) - INFO - Done attempting. 07:33:34 INFO - (blobuploader) - INFO - Iteration through files over. 07:33:34 INFO - Return code: 0 07:33:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:33:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:33:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c1662a33f5b9dfabcec36a846e97c8574534065832931d8bcbfb90a179e32174a267e6b24f0852d6b1116631c3e6ba5f1e2d4e77036662849bbb9491e174068", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe118d55177c558bdfda924cbf99a7904f5b7232b0bd6858c2cef655e8df7d531460ee4e5eb2790d1d0c701922c8ccbe83cb54ce4033dabc5f4aeeeff449598f"} 07:33:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:33:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:33:34 INFO - Contents: 07:33:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c1662a33f5b9dfabcec36a846e97c8574534065832931d8bcbfb90a179e32174a267e6b24f0852d6b1116631c3e6ba5f1e2d4e77036662849bbb9491e174068", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe118d55177c558bdfda924cbf99a7904f5b7232b0bd6858c2cef655e8df7d531460ee4e5eb2790d1d0c701922c8ccbe83cb54ce4033dabc5f4aeeeff449598f"} 07:33:34 INFO - Running post-run listener: copy_logs_to_upload_dir 07:33:34 INFO - Copying logs to upload dir... 07:33:34 INFO - mkdir: /builds/slave/test/build/upload/logs 07:33:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.174634 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-27 07:33:34.356679) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 07:33:34.362608) ========= 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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c1662a33f5b9dfabcec36a846e97c8574534065832931d8bcbfb90a179e32174a267e6b24f0852d6b1116631c3e6ba5f1e2d4e77036662849bbb9491e174068", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe118d55177c558bdfda924cbf99a7904f5b7232b0bd6858c2cef655e8df7d531460ee4e5eb2790d1d0c701922c8ccbe83cb54ce4033dabc5f4aeeeff449598f"} build_url:https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010752 build_url: 'https://queue.taskcluster.net/v1/task/G__wjCGmSYmoirMIRUCuvw/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c1662a33f5b9dfabcec36a846e97c8574534065832931d8bcbfb90a179e32174a267e6b24f0852d6b1116631c3e6ba5f1e2d4e77036662849bbb9491e174068", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe118d55177c558bdfda924cbf99a7904f5b7232b0bd6858c2cef655e8df7d531460ee4e5eb2790d1d0c701922c8ccbe83cb54ce4033dabc5f4aeeeff449598f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 07:33:34.401625) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:33:34.402055) ========= 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.ITwZW9UVyR/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.W7CEzDJ5Zi/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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.005011 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:33:34.451885) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 07:33:34.452206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 07:33:34.452541) ========= ========= Total master_lag: 0.42 =========