builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0096 starttime: 1463433793.81 results: success (0) buildid: 20160516121842 builduid: 201ee31ef59d4ceaa6796632ed8a6d05 revision: 82c2c2940a016c0bc2693a2eca4a66effe739813 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:13.806116) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:13.806713) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:13.806983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:13.862484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:13.862738) ========= 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.H2gMqkB3zH/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.VegqCx43Yc/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-16 14:23:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 36.8M=0s 2016-05-16 14:23:14 (36.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.455611 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:14.337857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:14.338144) ========= 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.H2gMqkB3zH/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.VegqCx43Yc/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.026578 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:14.387365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:14.387661) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 82c2c2940a016c0bc2693a2eca4a66effe739813 --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 82c2c2940a016c0bc2693a2eca4a66effe739813 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H2gMqkB3zH/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.VegqCx43Yc/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-16 14:23:14,462 truncating revision to first 12 chars 2016-05-16 14:23:14,462 Setting DEBUG logging. 2016-05-16 14:23:14,462 attempt 1/10 2016-05-16 14:23:14,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/82c2c2940a01?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 14:23:15,089 unpacking tar archive at: mozilla-beta-82c2c2940a01/testing/mozharness/ program finished with exit code 0 elapsedTime=0.874471 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:15.279242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:15.279504) ========= script_repo_revision: 82c2c2940a016c0bc2693a2eca4a66effe739813 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:15.279855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:15.280129) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:15.304070) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-05-16 14:23:15.304344) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H2gMqkB3zH/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.VegqCx43Yc/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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 14:23:15 INFO - MultiFileLogger online at 20160516 14:23:15 in /builds/slave/test 14:23:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:23:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:15 INFO - {'append_to_log': False, 14:23:15 INFO - 'base_work_dir': '/builds/slave/test', 14:23:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:23:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:15 INFO - 'branch': 'Mozilla-Beta', 14:23:15 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:15 INFO - 'config_files': ('talos/mac_config.py',), 14:23:15 INFO - 'default_actions': ('clobber', 14:23:15 INFO - 'read-buildbot-config', 14:23:15 INFO - 'download-and-extract', 14:23:15 INFO - 'populate-webroot', 14:23:15 INFO - 'create-virtualenv', 14:23:15 INFO - 'install', 14:23:15 INFO - 'run-tests'), 14:23:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:15 INFO - 'download_minidump_stackwalk': True, 14:23:15 INFO - 'download_symbols': 'ondemand', 14:23:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:15 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:15 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:15 INFO - 'installer_path': 'installer.exe', 14:23:15 INFO - 'log_level': 'info', 14:23:15 INFO - 'log_name': 'talos', 14:23:15 INFO - 'log_to_console': True, 14:23:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:23:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:23:15 INFO - 'opt_config_files': (), 14:23:15 INFO - 'pip_index': False, 14:23:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:15 INFO - 'cmd': ('bash', 14:23:15 INFO - '-c', 14:23:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:15 INFO - 'enabled': True, 14:23:15 INFO - 'halt_on_failure': False, 14:23:15 INFO - 'name': 'check_screen_resolution'},), 14:23:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:15 INFO - 'cmd': ('bash', 14:23:15 INFO - '-c', 14:23:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:15 INFO - 'enabled': True, 14:23:15 INFO - 'halt_on_failure': False, 14:23:15 INFO - 'name': 'check_screen_resolution'},), 14:23:15 INFO - 'run_cmd_checks_enabled': True, 14:23:15 INFO - 'sps_profile': False, 14:23:15 INFO - 'sps_profile_interval': 0, 14:23:15 INFO - 'suite': 'dromaeojs', 14:23:15 INFO - 'system_bits': '32', 14:23:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:15 INFO - 'title': 't-yosemite-r7-0096', 14:23:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:15 INFO - 'use_talos_json': True, 14:23:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:15 INFO - 'work_dir': 'build'} 14:23:15 INFO - ##### 14:23:15 INFO - ##### Running clobber step. 14:23:15 INFO - ##### 14:23:15 INFO - Running pre-action listener: _resource_record_pre_action 14:23:15 INFO - Running main action method: clobber 14:23:15 INFO - rmtree: /builds/slave/test/build 14:23:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:17 INFO - Running post-action listener: _resource_record_post_action 14:23:17 INFO - ##### 14:23:17 INFO - ##### Running read-buildbot-config step. 14:23:17 INFO - ##### 14:23:17 INFO - Running pre-action listener: _resource_record_pre_action 14:23:17 INFO - Running main action method: read_buildbot_config 14:23:17 INFO - Using buildbot properties: 14:23:17 INFO - { 14:23:17 INFO - "project": "", 14:23:17 INFO - "product": "firefox", 14:23:17 INFO - "script_repo_revision": "production", 14:23:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:23:17 INFO - "repository": "", 14:23:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:23:17 INFO - "buildid": "20160516121842", 14:23:17 INFO - "pgo_build": "False", 14:23:17 INFO - "basedir": "/builds/slave/test", 14:23:17 INFO - "buildnumber": 13, 14:23:17 INFO - "slavename": "t-yosemite-r7-0096", 14:23:17 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:23:17 INFO - "platform": "yosemite_r7", 14:23:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:23:17 INFO - "branch": "mozilla-beta", 14:23:17 INFO - "repo_path": "releases/mozilla-beta", 14:23:17 INFO - "revision": "82c2c2940a016c0bc2693a2eca4a66effe739813", 14:23:17 INFO - "stage_platform": "macosx64", 14:23:17 INFO - "builduid": "201ee31ef59d4ceaa6796632ed8a6d05", 14:23:17 INFO - "slavebuilddir": "test" 14:23:17 INFO - } 14:23:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 14:23:17 INFO - Running post-action listener: _resource_record_post_action 14:23:17 INFO - ##### 14:23:17 INFO - ##### Running download-and-extract step. 14:23:17 INFO - ##### 14:23:17 INFO - Running pre-action listener: _resource_record_pre_action 14:23:17 INFO - Running main action method: download_and_extract 14:23:17 INFO - mkdir: /builds/slave/test/build/tests 14:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:17 INFO - https://queue.taskcluster.net/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:23:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:23:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:23:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 14:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 14:23:20 INFO - Downloaded 1241 bytes. 14:23:20 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 14:23:20 INFO - Using the following test package requirements: 14:23:20 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:23:20 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:23:20 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 14:23:20 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:23:20 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 14:23:20 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:23:20 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:23:20 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 14:23:20 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:23:20 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:23:20 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 14:23:20 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:23:20 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 14:23:20 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:23:20 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 14:23:20 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:23:20 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:23:20 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 14:23:20 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 14:23:20 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')]} 14:23:20 INFO - https://queue.taskcluster.net/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:23:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:23:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:23:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 14:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 14:23:36 INFO - Downloaded 17747774 bytes. 14:23:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:23:39 INFO - Return code: 0 14:23:39 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:39 INFO - https://queue.taskcluster.net/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:23:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:23:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:23:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 14:23:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 14:23:41 INFO - Downloaded 17747774 bytes. 14:23:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:23:45 INFO - Return code: 0 14:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:45 INFO - https://queue.taskcluster.net/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:23:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:23:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:23:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 14:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 14:23:46 INFO - Downloaded 10845194 bytes. 14:23:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:23:46 INFO - Return code: 0 14:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:46 INFO - https://queue.taskcluster.net/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 14:23:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:23:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:23:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 14:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 14:23:51 INFO - Downloaded 88287452 bytes. 14:23:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:23:51 INFO - mkdir: /builds/slave/test/properties 14:23:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:23:51 INFO - Writing to file /builds/slave/test/properties/build_url 14:23:51 INFO - Contents: 14:23:51 INFO - build_url:https://queue.taskcluster.net/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:23:52 WARNING - Can't figure out symbols_url from installer_url: https://queue.taskcluster.net/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.dmg! 14:23:52 INFO - Running post-action listener: _resource_record_post_action 14:23:52 INFO - Running post-action listener: set_extra_try_arguments 14:23:52 INFO - ##### 14:23:52 INFO - ##### Running populate-webroot step. 14:23:52 INFO - ##### 14:23:52 INFO - Running pre-action listener: _resource_record_pre_action 14:23:52 INFO - Running main action method: populate_webroot 14:23:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:23:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:23:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:23:52 INFO - '--tppagecycles', 14:23:52 INFO - '7'], 14:23:52 INFO - 'tests': ['tsvgm']}}, 14:23:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:23:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:23:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:23:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:23:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:23:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:23:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:52 INFO - 'talos_options': ['--e10s'], 14:23:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:52 INFO - 'tests': ['damp', 'tps']}, 14:23:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:52 INFO - 'talos_options': ['--e10s'], 14:23:52 INFO - 'tests': ['damp', 'tps']}, 14:23:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:23:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:23:52 INFO - 'other': {'tests': ['a11yr', 14:23:52 INFO - 'ts_paint', 14:23:52 INFO - 'tpaint', 14:23:52 INFO - 'sessionrestore', 14:23:52 INFO - 'sessionrestore_no_auto_restore', 14:23:52 INFO - 'tabpaint']}, 14:23:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:23:52 INFO - 'tests': ['a11yr', 14:23:52 INFO - 'ts_paint', 14:23:52 INFO - 'tpaint', 14:23:52 INFO - 'sessionrestore', 14:23:52 INFO - 'sessionrestore_no_auto_restore', 14:23:52 INFO - 'tabpaint']}, 14:23:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:23:52 INFO - 'tests': ['a11yr', 14:23:52 INFO - 'ts_paint', 14:23:52 INFO - 'tpaint', 14:23:52 INFO - 'sessionrestore', 14:23:52 INFO - 'sessionrestore_no_auto_restore', 14:23:52 INFO - 'tabpaint']}, 14:23:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:23:52 INFO - 'tests': ['a11yr', 14:23:52 INFO - 'ts_paint', 14:23:52 INFO - 'tpaint', 14:23:52 INFO - 'sessionrestore', 14:23:52 INFO - 'sessionrestore_no_auto_restore', 14:23:52 INFO - 'tabpaint']}, 14:23:52 INFO - 'other_l64': {'tests': ['a11yr', 14:23:52 INFO - 'ts_paint', 14:23:52 INFO - 'tpaint', 14:23:52 INFO - 'sessionrestore', 14:23:52 INFO - 'sessionrestore_no_auto_restore', 14:23:52 INFO - 'tabpaint']}, 14:23:52 INFO - 'other_nol64': {'tests': ['a11yr', 14:23:52 INFO - 'ts_paint', 14:23:52 INFO - 'tpaint', 14:23:52 INFO - 'sessionrestore', 14:23:52 INFO - 'sessionrestore_no_auto_restore', 14:23:52 INFO - 'tabpaint']}, 14:23:52 INFO - 'svgr': {'tests': ['tsvgx', 14:23:52 INFO - 'tsvgr_opacity', 14:23:52 INFO - 'tart', 14:23:52 INFO - 'tscrollx', 14:23:52 INFO - 'cart']}, 14:23:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:23:52 INFO - 'tests': ['tsvgx', 14:23:52 INFO - 'tsvgr_opacity', 14:23:52 INFO - 'tart', 14:23:52 INFO - 'tscrollx', 14:23:52 INFO - 'cart']}, 14:23:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:52 INFO - 'tests': ['tp5o']}, 14:23:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:52 INFO - 'talos_options': ['--e10s'], 14:23:52 INFO - 'tests': ['tp5o']}, 14:23:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:52 INFO - 'talos_options': ['--xperf_path', 14:23:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:52 INFO - 'tests': ['tp5n']}, 14:23:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:52 INFO - 'talos_options': ['--e10s', 14:23:52 INFO - '--xperf_path', 14:23:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:52 INFO - 'tests': ['tp5n']}}, 14:23:52 INFO - 'talos.zip': {'path': '', 14:23:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:23:52 INFO - Running post-action listener: _resource_record_post_action 14:23:52 INFO - ##### 14:23:52 INFO - ##### Running create-virtualenv step. 14:23:52 INFO - ##### 14:23:52 INFO - Running pre-action listener: _resource_record_pre_action 14:23:52 INFO - Running main action method: create_virtualenv 14:23:52 INFO - Creating virtualenv /builds/slave/test/build/venv 14:23:52 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 14:23:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:23:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:23:52 INFO - Using real prefix '/tools/python27' 14:23:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:23:53 INFO - Installing distribute.............................................................................................................................................................................................done. 14:23:55 INFO - Installing pip.................done. 14:23:55 INFO - Return code: 0 14:23:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:23:55 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')]} 14:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:55 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')]} 14:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:55 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 0x10fe0aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84246d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcaed30>, '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 0x10fb12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fca5b20>, '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.H2gMqkB3zH/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.VegqCx43Yc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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 14:23:55 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 14:23:55 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 14:23:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2gMqkB3zH/Render', 14:23:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:55 INFO - 'HOME': '/Users/cltbld', 14:23:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:55 INFO - 'LOGNAME': 'cltbld', 14:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:55 INFO - 'MOZ_NO_REMOTE': '1', 14:23:55 INFO - 'NO_EM_RESTART': '1', 14:23:55 INFO - 'PAGER': '/bin/cat', 14:23:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:55 INFO - 'PWD': '/builds/slave/test', 14:23:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:55 INFO - 'SHELL': '/bin/bash', 14:23:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VegqCx43Yc/Listeners', 14:23:55 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 14:23:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:55 INFO - 'USER': 'cltbld', 14:23:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:55 INFO - 'XPC_FLAGS': '0x0', 14:23:55 INFO - 'XPC_SERVICE_NAME': '0', 14:23:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:56 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 14:23:56 INFO - Cleaning up... 14:23:56 INFO - Return code: 0 14:23:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fe0aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84246d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcaed30>, '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 0x10fb12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fca5b20>, '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.H2gMqkB3zH/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.VegqCx43Yc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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 14:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:23:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2gMqkB3zH/Render', 14:23:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:56 INFO - 'HOME': '/Users/cltbld', 14:23:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:56 INFO - 'LOGNAME': 'cltbld', 14:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:56 INFO - 'MOZ_NO_REMOTE': '1', 14:23:56 INFO - 'NO_EM_RESTART': '1', 14:23:56 INFO - 'PAGER': '/bin/cat', 14:23:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:56 INFO - 'PWD': '/builds/slave/test', 14:23:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:56 INFO - 'SHELL': '/bin/bash', 14:23:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VegqCx43Yc/Listeners', 14:23:56 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 14:23:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:56 INFO - 'USER': 'cltbld', 14:23:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:56 INFO - 'XPC_FLAGS': '0x0', 14:23:56 INFO - 'XPC_SERVICE_NAME': '0', 14:23:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:56 INFO - Downloading/unpacking psutil>=0.7.1 14:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:23:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:59 INFO - Installing collected packages: psutil 14:23:59 INFO - Running setup.py install for psutil 14:23:59 INFO - building 'psutil._psutil_osx' extension 14:23:59 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 14:24:00 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 14:24:00 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 14:24:00 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 14:24:00 INFO - building 'psutil._psutil_posix' extension 14:24:00 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 14:24:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:24:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:24:00 INFO - ^ 14:24:00 INFO - 1 warning generated. 14:24:00 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 14:24:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:00 INFO - Successfully installed psutil 14:24:00 INFO - Cleaning up... 14:24:00 INFO - Return code: 0 14:24:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:00 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 0x10fe0aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84246d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcaed30>, '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 0x10fb12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fca5b20>, '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.H2gMqkB3zH/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.VegqCx43Yc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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 14:24:00 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 14:24:00 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 14:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2gMqkB3zH/Render', 14:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:00 INFO - 'HOME': '/Users/cltbld', 14:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:00 INFO - 'LOGNAME': 'cltbld', 14:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:00 INFO - 'MOZ_NO_REMOTE': '1', 14:24:00 INFO - 'NO_EM_RESTART': '1', 14:24:00 INFO - 'PAGER': '/bin/cat', 14:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:00 INFO - 'PWD': '/builds/slave/test', 14:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:00 INFO - 'SHELL': '/bin/bash', 14:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VegqCx43Yc/Listeners', 14:24:00 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 14:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:00 INFO - 'USER': 'cltbld', 14:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:00 INFO - 'XPC_FLAGS': '0x0', 14:24:00 INFO - 'XPC_SERVICE_NAME': '0', 14:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:24:01 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 14:24:01 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 14:24:01 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 14:24:01 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 14:24:01 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 14:24:01 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 14:24:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:24:03 INFO - Installing collected packages: mozsystemmonitor 14:24:03 INFO - Running setup.py install for mozsystemmonitor 14:24:03 INFO - Successfully installed mozsystemmonitor 14:24:03 INFO - Cleaning up... 14:24:03 INFO - Return code: 0 14:24:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24:03 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')]} 14:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:03 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')]} 14:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:03 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 0x10fe0aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84246d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcaed30>, '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 0x10fb12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fca5b20>, '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.H2gMqkB3zH/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.VegqCx43Yc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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 14:24:03 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 14:24:03 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 14:24:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2gMqkB3zH/Render', 14:24:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:03 INFO - 'HOME': '/Users/cltbld', 14:24:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:03 INFO - 'LOGNAME': 'cltbld', 14:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:03 INFO - 'MOZ_NO_REMOTE': '1', 14:24:03 INFO - 'NO_EM_RESTART': '1', 14:24:03 INFO - 'PAGER': '/bin/cat', 14:24:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:03 INFO - 'PWD': '/builds/slave/test', 14:24:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:03 INFO - 'SHELL': '/bin/bash', 14:24:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VegqCx43Yc/Listeners', 14:24:03 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 14:24:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:03 INFO - 'USER': 'cltbld', 14:24:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:03 INFO - 'XPC_FLAGS': '0x0', 14:24:03 INFO - 'XPC_SERVICE_NAME': '0', 14:24:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:04 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:06 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24:06 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 14:24:06 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 14:24:06 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 14:24:06 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 14:24:06 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 14:24:06 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 14:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:07 INFO - Downloading docopt-0.6.1.tar.gz 14:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:07 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:07 INFO - Running setup.py install for blobuploader 14:24:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:08 INFO - Running setup.py install for requests 14:24:08 INFO - Running setup.py install for docopt 14:24:08 INFO - Successfully installed blobuploader requests docopt 14:24:08 INFO - Cleaning up... 14:24:08 INFO - Return code: 0 14:24:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:08 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 0x10fe0aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84246d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcaed30>, '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 0x10fb12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fca5b20>, '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.H2gMqkB3zH/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.VegqCx43Yc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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 14:24:08 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 14:24:08 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 14:24:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2gMqkB3zH/Render', 14:24:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:08 INFO - 'HOME': '/Users/cltbld', 14:24:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:08 INFO - 'LOGNAME': 'cltbld', 14:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:08 INFO - 'MOZ_NO_REMOTE': '1', 14:24:08 INFO - 'NO_EM_RESTART': '1', 14:24:08 INFO - 'PAGER': '/bin/cat', 14:24:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:08 INFO - 'PWD': '/builds/slave/test', 14:24:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:08 INFO - 'SHELL': '/bin/bash', 14:24:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VegqCx43Yc/Listeners', 14:24:08 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 14:24:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:08 INFO - 'USER': 'cltbld', 14:24:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:08 INFO - 'XPC_FLAGS': '0x0', 14:24:08 INFO - 'XPC_SERVICE_NAME': '0', 14:24:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-yXwv6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-w2wsei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-G_2Zwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Ps9wkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-y2zzB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-tdk4KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-b_b2eR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-ClsnIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-VKc82V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-oHTtGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:10 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-CULrdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:10 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-2BFcZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:10 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-zTOlAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:10 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-M0o7iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:10 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-PVyn_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:10 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-TNQfT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:10 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-LYuoWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:10 INFO - Running setup.py install for manifestparser 14:24:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:10 INFO - Running setup.py install for mozcrash 14:24:11 INFO - Running setup.py install for mozdebug 14:24:11 INFO - Running setup.py install for mozdevice 14:24:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:24:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:11 INFO - Running setup.py install for mozfile 14:24:11 INFO - Running setup.py install for mozhttpd 14:24:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:11 INFO - Running setup.py install for mozinfo 14:24:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:11 INFO - Running setup.py install for mozInstall 14:24:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:11 INFO - Running setup.py install for mozleak 14:24:12 INFO - Running setup.py install for mozlog 14:24:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:12 INFO - Running setup.py install for moznetwork 14:24:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:12 INFO - Running setup.py install for mozprocess 14:24:12 INFO - Running setup.py install for mozprofile 14:24:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:12 INFO - Running setup.py install for mozrunner 14:24:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:12 INFO - Running setup.py install for mozscreenshot 14:24:12 INFO - Running setup.py install for moztest 14:24:13 INFO - Running setup.py install for mozversion 14:24:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:13 INFO - Cleaning up... 14:24:13 INFO - Return code: 0 14:24:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:13 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 0x10fe0aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84246d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcaed30>, '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 0x10fb12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fca5b20>, '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.H2gMqkB3zH/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.VegqCx43Yc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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 14:24:13 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 14:24:13 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 14:24:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2gMqkB3zH/Render', 14:24:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:13 INFO - 'HOME': '/Users/cltbld', 14:24:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:13 INFO - 'LOGNAME': 'cltbld', 14:24:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:13 INFO - 'MOZ_NO_REMOTE': '1', 14:24:13 INFO - 'NO_EM_RESTART': '1', 14:24:13 INFO - 'PAGER': '/bin/cat', 14:24:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:13 INFO - 'PWD': '/builds/slave/test', 14:24:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:13 INFO - 'SHELL': '/bin/bash', 14:24:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VegqCx43Yc/Listeners', 14:24:13 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 14:24:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:13 INFO - 'USER': 'cltbld', 14:24:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:13 INFO - 'XPC_FLAGS': '0x0', 14:24:13 INFO - 'XPC_SERVICE_NAME': '0', 14:24:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-I4RwSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:13 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)) 14:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-DcpgMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:13 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)) 14:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Z011ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:13 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)) 14:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-1mgLZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:13 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)) 14:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-K3bEVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:14 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)) 14:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:14 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-hHhTBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:14 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)) 14:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:14 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-TN76jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:14 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)) 14:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:14 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-GJtLBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:14 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)) 14:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:14 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-7_HSS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:14 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)) 14:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:14 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-E6L2gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:14 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)) 14:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:14 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-dYP7Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:14 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)) 14:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:14 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-isOltt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:14 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)) 14:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:14 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-niXqQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:14 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)) 14:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:14 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-kMJEh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:15 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)) 14:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:15 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-77XIgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:15 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)) 14:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:15 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-aeMfki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:15 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)) 14:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:15 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-ylMgP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:15 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)) 14:24:15 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)) 14:24:15 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)) 14:24:15 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)) 14:24:15 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)) 14:24:15 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)) 14:24:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:17 INFO - Downloading blessings-1.6.tar.gz 14:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:24:17 INFO - Installing collected packages: blessings 14:24:17 INFO - Running setup.py install for blessings 14:24:18 INFO - Successfully installed blessings 14:24:18 INFO - Cleaning up... 14:24:18 INFO - Return code: 0 14:24:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:24:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:18 INFO - Reading from file tmpfile_stdout 14:24:18 INFO - Current package versions: 14:24:18 INFO - blessings == 1.6 14:24:18 INFO - blobuploader == 1.2.4 14:24:18 INFO - docopt == 0.6.1 14:24:18 INFO - manifestparser == 1.1 14:24:18 INFO - mozInstall == 1.12 14:24:18 INFO - mozcrash == 0.17 14:24:18 INFO - mozdebug == 0.1 14:24:18 INFO - mozdevice == 0.48 14:24:18 INFO - mozfile == 1.2 14:24:18 INFO - mozhttpd == 0.7 14:24:18 INFO - mozinfo == 0.9 14:24:18 INFO - mozleak == 0.1 14:24:18 INFO - mozlog == 3.1 14:24:18 INFO - moznetwork == 0.27 14:24:18 INFO - mozprocess == 0.22 14:24:18 INFO - mozprofile == 0.28 14:24:18 INFO - mozrunner == 6.11 14:24:18 INFO - mozscreenshot == 0.1 14:24:18 INFO - mozsystemmonitor == 0.0 14:24:18 INFO - moztest == 0.7 14:24:18 INFO - mozversion == 1.4 14:24:18 INFO - psutil == 3.1.1 14:24:18 INFO - requests == 1.2.3 14:24:18 INFO - wsgiref == 0.1.2 14:24:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:18 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')]} 14:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:18 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')]} 14:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:18 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 0x10fe0aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84246d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcaed30>, '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 0x10fb12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fca5b20>, '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.H2gMqkB3zH/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.VegqCx43Yc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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 14:24:18 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 14:24:18 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 14:24:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2gMqkB3zH/Render', 14:24:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:18 INFO - 'HOME': '/Users/cltbld', 14:24:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:18 INFO - 'LOGNAME': 'cltbld', 14:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:18 INFO - 'MOZ_NO_REMOTE': '1', 14:24:18 INFO - 'NO_EM_RESTART': '1', 14:24:18 INFO - 'PAGER': '/bin/cat', 14:24:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:18 INFO - 'PWD': '/builds/slave/test', 14:24:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:18 INFO - 'SHELL': '/bin/bash', 14:24:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VegqCx43Yc/Listeners', 14:24:18 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 14:24:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:18 INFO - 'USER': 'cltbld', 14:24:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:18 INFO - 'XPC_FLAGS': '0x0', 14:24:18 INFO - 'XPC_SERVICE_NAME': '0', 14:24:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:19 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)) 14:24:19 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)) 14:24:19 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)) 14:24:19 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)) 14:24:19 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)) 14:24:19 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)) 14:24:19 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)) 14:24:19 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)) 14:24:19 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)) 14:24:19 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)) 14:24:19 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)) 14:24:19 INFO - Cleaning up... 14:24:19 INFO - Return code: 0 14:24:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:19 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 0x10fe0aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84246d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcaed30>, '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 0x10fb12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fca5b20>, '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.H2gMqkB3zH/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.VegqCx43Yc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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 14:24:19 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 14:24:19 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 14:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2gMqkB3zH/Render', 14:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:19 INFO - 'HOME': '/Users/cltbld', 14:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:19 INFO - 'LOGNAME': 'cltbld', 14:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:19 INFO - 'MOZ_NO_REMOTE': '1', 14:24:19 INFO - 'NO_EM_RESTART': '1', 14:24:19 INFO - 'PAGER': '/bin/cat', 14:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:19 INFO - 'PWD': '/builds/slave/test', 14:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:19 INFO - 'SHELL': '/bin/bash', 14:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VegqCx43Yc/Listeners', 14:24:19 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 14:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:19 INFO - 'USER': 'cltbld', 14:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:19 INFO - 'XPC_FLAGS': '0x0', 14:24:19 INFO - 'XPC_SERVICE_NAME': '0', 14:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:19 INFO - Downloading/unpacking jsonschema 14:24:19 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 14:24:19 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 14:24:19 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 14:24:19 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 14:24:19 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 14:24:19 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 14:24:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:22 INFO - Downloading/unpacking functools32 (from jsonschema) 14:24:22 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 14:24:22 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 14:24:22 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 14:24:22 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 14:24:22 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 14:24:22 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 14:24:22 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:22 INFO - warning: no files found matching '*.txt' 14:24:22 INFO - no previously-included directories found matching 'build' 14:24:22 INFO - no previously-included directories found matching 'dist' 14:24:22 INFO - no previously-included directories found matching '.git*' 14:24:22 INFO - Installing collected packages: jsonschema, functools32 14:24:22 INFO - Running setup.py install for functools32 14:24:22 INFO - warning: no files found matching '*.txt' 14:24:22 INFO - no previously-included directories found matching 'build' 14:24:22 INFO - no previously-included directories found matching 'dist' 14:24:22 INFO - no previously-included directories found matching '.git*' 14:24:22 INFO - Successfully installed jsonschema functools32 14:24:22 INFO - Cleaning up... 14:24:22 INFO - Return code: 0 14:24:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:24:22 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')]} 14:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:22 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')]} 14:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:22 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 0x10fe0aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84246d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcaed30>, '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 0x10fb12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fca5b20>, '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.H2gMqkB3zH/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.VegqCx43Yc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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 14:24:22 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 14:24:22 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 14:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2gMqkB3zH/Render', 14:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:22 INFO - 'HOME': '/Users/cltbld', 14:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:22 INFO - 'LOGNAME': 'cltbld', 14:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:22 INFO - 'MOZ_NO_REMOTE': '1', 14:24:22 INFO - 'NO_EM_RESTART': '1', 14:24:22 INFO - 'PAGER': '/bin/cat', 14:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:22 INFO - 'PWD': '/builds/slave/test', 14:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:22 INFO - 'SHELL': '/bin/bash', 14:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VegqCx43Yc/Listeners', 14:24:22 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 14:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:22 INFO - 'USER': 'cltbld', 14:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:22 INFO - 'XPC_FLAGS': '0x0', 14:24:22 INFO - 'XPC_SERVICE_NAME': '0', 14:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:23 INFO - Downloading/unpacking flake8 14:24:23 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 14:24:23 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 14:24:23 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 14:24:23 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 14:24:23 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 14:24:23 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 14:24:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:24:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:24:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:24:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:24:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:24:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:24:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:24:26 INFO - no previously-included directories found matching 'docs/_build' 14:24:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:24:26 INFO - Running setup.py install for pep8 14:24:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:24:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:24:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:24:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:24:27 INFO - no previously-included directories found matching 'docs/_build' 14:24:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:24:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:24:27 INFO - Cleaning up... 14:24:27 INFO - Return code: 0 14:24:27 INFO - Running post-action listener: _resource_record_post_action 14:24:27 INFO - Running post-action listener: _start_resource_monitoring 14:24:27 INFO - Starting resource monitoring. 14:24:27 INFO - ##### 14:24:27 INFO - ##### Running install step. 14:24:27 INFO - ##### 14:24:27 INFO - Running pre-action listener: _resource_record_pre_action 14:24:27 INFO - Running main action method: install 14:24:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:27 INFO - Reading from file tmpfile_stdout 14:24:27 INFO - Detecting whether we're running mozinstall >=1.0... 14:24:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:24:27 INFO - Reading from file tmpfile_stdout 14:24:27 INFO - Output received: 14:24:27 INFO - Usage: mozinstall [options] installer 14:24:27 INFO - Options: 14:24:27 INFO - -h, --help show this help message and exit 14:24:27 INFO - -d DEST, --destination=DEST 14:24:27 INFO - Directory to install application into. [default: 14:24:27 INFO - "/builds/slave/test"] 14:24:27 INFO - --app=APP Application being installed. [default: firefox] 14:24:27 INFO - mkdir: /builds/slave/test/build/application 14:24:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:24:49 INFO - Reading from file tmpfile_stdout 14:24:49 INFO - Output received: 14:24:49 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:24:49 INFO - Running post-action listener: _resource_record_post_action 14:24:49 INFO - ##### 14:24:49 INFO - ##### Running run-tests step. 14:24:49 INFO - ##### 14:24:49 INFO - Running pre-action listener: _resource_record_pre_action 14:24:49 INFO - Running main action method: run_tests 14:24:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:24:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:24:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:24:49 INFO - 2016-05-16 14:24:49.922 screenresolution[1649:8315] starting screenresolution argv=screenresolution get 14:24:49 INFO - 2016-05-16 14:24:49.924 screenresolution[1649:8315] Display 0: 1600x1200x32@60 14:24:49 INFO - 2016-05-16 14:24:49.930 screenresolution[1650:8317] starting screenresolution argv=screenresolution list 14:24:49 INFO - Available Modes on Display 0 14:24:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:24:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:24:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:24:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:24:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:24:50 INFO - Intel Iris: 14:24:50 INFO - Chipset Model: Intel Iris 14:24:50 INFO - Type: GPU 14:24:50 INFO - Bus: Built-In 14:24:50 INFO - VRAM (Dynamic, Max): 1536 MB 14:24:50 INFO - Vendor: Intel (0x8086) 14:24:50 INFO - Device ID: 0x0a2e 14:24:50 INFO - Revision ID: 0x0009 14:24:50 INFO - Displays: 14:24:50 INFO - Display: 14:24:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:24:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:24:50 INFO - Display Serial Number: 1600x1200 60 14:24:50 INFO - Main Display: Yes 14:24:50 INFO - Mirror: Off 14:24:50 INFO - Online: Yes 14:24:50 INFO - Rotation: Supported 14:24:50 INFO - Return code: 0 14:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:24:50 INFO - Python 2.7.3 14:24:50 INFO - Return code: 0 14:24:50 INFO - grabbing minidump binary from tooltool 14:24:50 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')]} 14:24:50 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 0x10fcaed30>, '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 0x10fb12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fca5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:24:50 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 14:24:50 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 14:24:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:24:50 INFO - Return code: 0 14:24:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:24:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:24:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:24:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:24:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:24:51 INFO - Return code: 0 14:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--title', 't-yosemite-r7-0096', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --title t-yosemite-r7-0096 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:24:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2gMqkB3zH/Render', 14:24:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:51 INFO - 'HOME': '/Users/cltbld', 14:24:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:51 INFO - 'LOGNAME': 'cltbld', 14:24:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:24:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:51 INFO - 'MOZ_NO_REMOTE': '1', 14:24:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:24:51 INFO - 'NO_EM_RESTART': '1', 14:24:51 INFO - 'PAGER': '/bin/cat', 14:24:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:51 INFO - 'PWD': '/builds/slave/test', 14:24:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:24:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:51 INFO - 'SHELL': '/bin/bash', 14:24:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VegqCx43Yc/Listeners', 14:24:51 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 14:24:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:51 INFO - 'USER': 'cltbld', 14:24:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:51 INFO - 'XPC_FLAGS': '0x0', 14:24:51 INFO - 'XPC_SERVICE_NAME': '0', 14:24:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--title', 't-yosemite-r7-0096', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:24:51 INFO - mozversion application_buildid: 20160516121842 14:24:51 INFO - mozversion application_changeset: 82c2c2940a016c0bc2693a2eca4a66effe739813 14:24:51 INFO - mozversion application_display_name: Firefox 14:24:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:24:51 INFO - mozversion application_name: Firefox 14:24:51 INFO - mozversion application_remotingname: firefox 14:24:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:24:51 INFO - mozversion application_vendor: Mozilla 14:24:51 INFO - mozversion application_version: 47.0 14:24:51 INFO - mozversion platform_buildid: 20160516121842 14:24:51 INFO - mozversion platform_changeset: 82c2c2940a016c0bc2693a2eca4a66effe739813 14:24:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:24:51 INFO - mozversion platform_version: 47.0 14:24:51 INFO - using testdate: 1463433891 14:24:51 INFO - actual date: 1463433891 14:24:51 INFO - starting webserver on 'localhost:49275' 14:24:51 INFO - SUITE-START | Running 2 tests 14:24:51 INFO - TEST-START | dromaeo_css 14:24:51 INFO - operating with platform_type : mac_ 14:24:51 INFO - Initialising browser for dromaeo_css test... 14:24:51 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpvJplb3/profile http://localhost:49275/getInfo.html) 14:24:53 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 14:24:53 INFO - PROCESS | 1668 | colorDepth:24 14:24:53 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 14:24:53 INFO - PROCESS | 1668 | __metrics 14:24:54 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:24:54 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:54 INFO - TEST-INFO | 1668: exit 0 14:24:54 INFO - Browser initialized. 14:24:54 INFO - Running cycle 1/1 for dromaeo_css test... 14:24:54 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpvJplb3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:06 INFO - PROCESS | 1672 | RSS: Main: 157024256 14:25:06 INFO - PROCESS | 1672 | 14:25:57 INFO - PROCESS | 1672 | 1463433957548 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] 14:28:07 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 14:28:08 INFO - PROCESS | 1672 | RSS: Main: 271314944 14:28:08 INFO - PROCESS | 1672 | 14:31:11 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 14:31:11 INFO - PROCESS | 1672 | RSS: Main: 289607680 14:31:11 INFO - PROCESS | 1672 | 14:34:13 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 14:34:14 INFO - PROCESS | 1672 | RSS: Main: 292859904 14:34:14 INFO - PROCESS | 1672 | 14:37:16 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 14:37:16 INFO - PROCESS | 1672 | RSS: Main: 253042688 14:37:16 INFO - PROCESS | 1672 | 14:40:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 14:40:20 INFO - PROCESS | 1672 | RSS: Main: 255324160 14:40:20 INFO - PROCESS | 1672 | 14:43:22 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 14:43:22 INFO - PROCESS | 1672 | RSS: Main: 304013312 14:43:22 INFO - PROCESS | 1672 | 14:43:22 INFO - PROCESS | 1672 | __start_tp_report 14:43:22 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 14:43:22 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 14:43:22 INFO - PROCESS | 1672 | |i|pagename|runs| 14:43:22 INFO - PROCESS | 1672 | |0;dojo.html;3108.3627856289463;3529.241213139175;3637.9090522736947;3649.6167902370266;3728.2916245913275;5880.67656278905;5915.70421478926;5922.822315330536;5937.881242375155;5939.67331796751;5882;5952.107183922414;5953.3748956359605;5971.283445986488;5978.133170690258;5184.637075404723;5250.763715632796;5283.418823929364;5297.258383826267;5351.491608297225;5384.138537833947;5413.512783849453;5414.242006119146;5414.7834086636485;5415.675059496442;5269.578433725293;5326.987872304269;5347.197920311945;5355.892882142355;5399.136138217886;5388.407275199745;5402.729863506809;5409.134538473864;5414.862878795458;5432.945670543283;5153.2785410042625;5311.787528498855;5312.203169524563;5319.813806516792;5332.946670533283;4723.36234608327;5787.913181302284;5818.912716309259;5820.708964551755;5826.766929322822;6197.101420294077;6277.96861015692;6299;6299.212598425197;6310.400511951358;5338.866528336784;6243.500519958392;6265.780697675559;6320.525960552977;6333.524985626096;6099.786507472261;6110.114033465167;6117.755289788448;6132.202813634199;6137.555566654994;6265.8120256392385;6471.482281417475;6476.222853257545;6487;6520.445762110274;6216.471599914058;6288.308286088527;6306.180196574416;6307.306196318401;6307.653079080695;6268.561200715906;6280.434760871543;6297.4017468340435;6303.716332765037;6309.337519560472;6178.69106544671;6180.134781130645;6213.502919766408;6291.874162516816;6308.337624549448;5173.405058418255;6256.7810126645345;6271.560990730696;6276.905846412307;6295.685215739195;5002.89994200114;5004.47453017428;5005.1491246488185;5018.774155163026;5030.748462576857;4504.887377815516;4551.499335073139;4592.540745925381;4594;4617.907641847144;6076.997295446202;6151.861905547488;6153.538484613672;6166.105914642351;6168.9691551541955;6339;6351.618902865843;6352.460040896483;6370.713317900706;6390.105385246069;5959.612625179349;6098.14625952367;6141.84645383869;6165.537584681167;6176.227971503562;5532.197831314517;5534;5534.142207957692;5535.975844468786;5565.805196818092;6543.5419520633095;6556.901646475307;6564.868702626016;6580.012998050331;6586.670666466754;5620.943790562205;6141.631502109888;6189.938100618936;6303.495720342454;6327.525435592257;6521.119648847345;6543.1821022372205;6558.606483610999;6560.114384558024;6564.6389448580785;6270.529710271657;6270.561060725706;6270.717817698306;6270.811875643738;6286.779962701284;6181.289151747426;6231.376862313732;6287.402696743802;6306.46395056407;6346.079818426395;6091.543134265036;6279.152314437675;6290.402411770874;6305.5901366411035;6313.936860631335;6272.655003974825;6281.309056003744;6287.622742635456;6292.433680968735;6305.274893387319;6080.48315893154;6129.633877546871;6210.5652604317265;6220.222472190976;6229.221347331583;6262.405071518198;6278.183836101278;6282.968585157045;6284;6302.842428939313;6042.3655516170165;6122.204113465221;6137.815865524041;6196.0705894116245;6201.472874805692 14:43:22 INFO - PROCESS | 1672 | |1;ext.html;501.38329854279215;590.6957916672915;597.9864130299145;669.3741351836032;675.9831004224894;32170.67829321706;40046;40331.79834100825;40378.59621403789;40474.79762601183;43203.56796432035;43753.124937501234;43774.78112609441;43790.56209437905;43932.78033609827;9733.610655573786;9987.800243995116;9988.200943924468;9994.850077248848;10005.749856253615;9767.218622510181;9916.355436896578;9922.255830812683;9930.30487865846;9937.006299370041;9890.505474726271;10066.69799906004;10077.496125193748;10079.69760907174;10080.193584513258;9976.50117494126;10064.144547713453;10065;10066;10068.194544436428;9865.1614612758;9963.15313198379;9985.400875947467;10000.39997600139;10015.949920250425;42353;42794.35808462876;42817.57182428167;42869;42984;3359.5296658467832;3418.67522585354;3520.489529018278;3540.8760693375607;3551.254236610315;28121.01576444835;28215.57676634852;29093.272668183254;30527.77888884442;31328.8433557833;2749.670039595241;2802.8738706758245;2806.410653762712;2828.2222388843234;2865.770738340928;469942;498445;499745;500141.49929250486;501580;47525.52474475211;48731.75634121807;71261.64369178121;71596.64201678958;71838.64080679668;45816.625501235016;46495.53504464912;46669.066618667435;46759;46845;17902.91048544749;18065.367712130013;18091.276348945896;18091.638167236582;18128.365507207185;14434.133951962916;14539.27303634814;14553;14563.199024053778;14566.4901728439;15065.418131096296;15104.54686359411;15153;15162.545123646309;15222.619434514225;6392;6485.416312531895;6529.183852018497;6543;6557.196770887948;950.9857352139724;982.4400091947522;987.5161171026145;1032.4373216596973;1047.3925123428394;27597.75810088551;27837.443251134864;30047.399052018838;30373.39253214923;30440.84779576132;1109.7724966382034;1172.7654469106212;1192.8449301590738;1200.5497938273147;1262.2426544073483;12802.80795788064;16091.597710057107;16522.83477165237;16710.164491775362;16917.49247522576;481764;487932;489523;490230;490932;61666;62150.0677489838;62205;62244.755104898555;62268.82059127909;1445.0823726933472;1536.2088524409937;1561.9453319133777;1587.8650314723377;1591.2441590244541;29244.41511169722;29781.70218297876;29818;29939.251518712208;30499.390012199186;47758;48138.03723925572;48167.5183248163;48225.27662085001;48229.794255143905;238507;258116;283422;284715;285746;33995;34440.48339274963;34462;34835.9549213524;34850.78022269208;45824.312635311166;45895.623131304776;46368.53631463777;46677;46945.765271173426;38221.2355752889;38611.806940965114;38800.80599596984;38801.805990969864;39155.021124472114;37849;37965.050873727276;38097.80951095227;38416.423753644274;38737.225255495294;39087.80456097701;39344.80327598344;39346.409803852395;39356.80321598374;40270.59729402669;29717.105755091023;32199;33034.339313214085;33067;33228;22792.544149117257;23186.536269274184;24337.634935476337;24629;25085.74914250907 14:43:22 INFO - PROCESS | 1672 | |2;jquery.html;382.9004458840701;386.0830527497194;386.1446895127293;390.39293897988637;392.1725159912586;17125.400610978617;17522.999999999967;20282.29011984581;22267;22916.197933072366;21031;21460.678089828627;21815.454613634665;21919.232826851065;21954.780452195475;5888.11678248263;6074.939250607504;6092.45167934888;6098.847528811771;6099.146119543268;5720.313562372521;6002.249718785152;6008.789692360769;6009.669468179249;6011.398860113975;5929.555283353744;5954.017587098124;5966.701664916758;5976.850578735544;5979.312379076418;5885.205497257858;6126.417990290915;6150.753969841201;6152.815415537541;6153.4154255345675;5824.068149096167;5862.38444963277;5868.530517558628;5887.8233652990475;5889.411058894077;14076.718465630733;14386.856131438657;14415.063020903608;14453.566393008226;14462.566123016326;2103.610831996086;2514.1326242446326;2555.923322300334;2616.5682662360687;2630.93422664433;10252.436116013616;10552.314099583502;10619.41593212373;11813.881861181364;15788.842111578966;1730.2041061111904;1853.5829438376393;1861;1882.595242022958;1915.7317975483443;106536;109731.77339168194;110858;112964.99999999919;114178;11415.42922853854;11625.418729063513;11792.41037948099;11828.822567661491;11927.522899083939;14623.707525849424;14666.413343466142;14671.486497972519;14698.118112913045;14717.337719802634;8937.73186804397;9182.449053056838;9194.724158275263;9255.305852061123;9326.253899688008;9403.43579385239;9411.341206115643;9425.38734982224;9512.762180945532;9514.619415223451;4568.817247310137;4636.698614590108;4650.302454631832;4671.462781780138;4694.671373003857;1840.4754644926131;1951.2780271299425;1951.8340941019887;1980.960380792405;1981.682930731076;868.748063061705;973.99026009739;974.0503009565617;1007.808516381885;1062.792755412687;20178.29375971834;20828.895855520626;21200.04599793013;21515.67726484104;21540.569188616453;945.6359301668907;999.9250056245811;1014.7564584499814;1045.0646671229208;1075.800976819291;11529.884701152881;11606.767864642828;12520.123591348518;12543.24740515572;12661.860432561114;660242.6987865126;686163;686919;697988;704913;75481.24518754851;96708.51645741727;129908;130897.34551327182;134303.65696343107;1066.1577353890495;1121.7980763462656;1132.4281237974935;1137.3573930729112;1139.9202055856176;18779;19038.524036899187;19432.4170274892;19460.221591136196;19791.80208197957;50908.74545627248;50992.49007510026;51537.7423112882;52567.737161315476;52698.736506317226;59259.703701481216;62910.74178516496;73329.6333518329;74561;79688.60155699184;7176.533525320838;8055.7583272501915;8324.583770811556;8476.406651534333;8625.051244362989;9747.512624368896;13157.60527184186;13233.735325293248;13614.727705445637;13636.795448068486;11469.311841289216;11963;12112.031037517154;12192.451339689558;12195.634130976085;5470;10629.468526573795;11656.358900260568;11669.957757392593;11794.053981093024;6211.689415529296;9404.529773511435;11643.301401915913;11785.646430607096;12185.2331411943;8284;8313.542755148525;8423.157684231528;8652.610632521426;8792.604332805167;10631.893681063091;11891.464884080064;12012.279263244232;12044.939775301067;12076.51693932233 14:43:22 INFO - PROCESS | 1672 | |3;mootools.html;1482.7108713800799;1665.5836040989752;1691.3319238900635;2043.1010355443605;2108.968365474517;8236.83526329473;8815.823683526334;9001.72994810155;9015.774605634871;9018.14327638875;8708.651653933835;8982.146696063879;8991.190792828644;9011.774705632362;9014.143656352637;2541.758532939368;2572.0354866924904;2575.4720282342073;2576.5233431815172;2578.3682997665505;2497.063601149569;2556.8593727344987;2561.5005074010573;2565.7819085377764;2568.25520599027;2502.2368177705794;2528.5954247320433;2529.2791554407;2532.936676583082;2537.2261460254613;2496.9375765605823;2527.3555243412998;2530.051230788454;2534.4931013797222;2549.2989427907287;2532.2529853693204;2546.732593077719;2549.337172335206;2552.680914885639;2572.344052266679;8860.68987585438;9048.592813323416;9124.133207345292;9126.361154719172;9149.22231610314;4906.190478571031;5645.2096706461125;5772.884542309131;5803.854903627401;5819.7963071292725;3203.343314620497;3690.9665293717803;3772.4718539404507;3772.5472943246714;3818.427235914635;1069.6897899609105;1081.8269076947652;1084.143526613974;1094.5238821112841;1095.1239008792934;10894.836577451344;11800.055995520252;12271.38643067852;12397.566085186974;12451.93774031133;4025.4163146344204;4727.834525791581;4753.904921901542;4774.212254977959;4899.681520701143;9665.371750836313;9667.46828924416;9684.370515916444;9687.418754874589;9689.467079310565;5595.720213989365;5602.355729091125;5647.689377084218;5686.886262274814;5689.402612725604;4554.134714404318;4650.232711602615;4992.6255530834605;5116.718580478035;5263.0000299942885;3899.512560929884;3946.8026598669953;3961.8811435656976;3987.322155233617;4001.3597824347967;1049.302214027663;1227.5948936850818;1239.8512178538633;1247.9126461147632;1256.4597223193932;1413.8586141385986;1423.4662001749343;1446.378057435313;1457.358762144653;1477.7044591081826;8456.154384561618;8553.61508732096;8575.656973721107;8589.355798315151;8590.398672092893;542.6798189068469;543.2584522127268;553.6235359955189;556.0408295689903;556.1601981008706;6472.741090356427;6497.772577959749;6550.901736473957;6564.081028655896;6582.572132811448;10678.946605266923;11052.226344155832;11208.439578021229;11210.719732006602;11221.831672524919;10786.676399708022;10870.293430926964;10999;11059.557617695364;11066.778664426827;8660.523671198145;8691.174338437839;8739.519326437106;8753.912460875437;8755.343349248831;7933.801654958672;8161.3062889652665;8168.346532277523;8190.549519776469;8197.057338406159;9468.905310946802;9684.75788105303;9729.4648794317;9799.608015679292;9894.208463322773;9576.712698619052;9948.154406875497;9971.202303815822;9977.351472154287;10185.643502477378;8216.09622941464;8356.415050946376;8411.621477033426;8442.240198382175;8455.873161902453;8448.619812108347;8452.32381409498;8507.276881465144;8514.872276915976;8525.976882774106;6519.576227545194;7341.522801017917;7414.184439711736;7502.774916752506;7613.543187408552;7395.334419902235;7396.445266604918;7495.587742674205;7554.206808285271;7583.7724868254045;8010.158933311918;8052.919470805451;8057.5165490070785;8062.677492900219;8084.9489566356;7199.1361036675935;7245;7249.275072492708;7275.126984761862;7320.560766354036;7323.890141647986;7328.377087947584;7348.191698913222;7360.705571777283;7384.040074790243 14:43:22 INFO - PROCESS | 1672 | |4;prototype.html;342.81487996481894;345.3628056236243;350.2522115283869;351.4991137628878;356.94824250483697;6821.420179284761;6836.931630683692;6919.965400172992;6926.757563485279;6936.202336731278;6840.726370945169;6843.931560684392;6845;6864.107666003412;6879.449644028478;4854.854354369375;4940.4318503372215;4966.677165984218;5025.045241404122;5085.491450854922;4969.105560999019;4990.950090499085;4998.40019197695;5010.849674509771;5014.423341315759;4938.580220681247;4964.67729597575;4976.0296742135115;4986.351774269358;5021.723805190713;4783.928241076369;4843.564079232869;4967.552920237196;4972.453030166679;4987.226979818134;4283.550227226127;4314.78426078698;4319.352097185416;4322.113966636864;4341.696081274312;6565.770198043046;6574.967125164391;6585.078089067534;6590.418299608107;6603.042558828991;5976.521878249773;5977.641341519523;5987.580869339148;5991.340952495222;5995.160677505153;7041.718331266743;7194.568325900463;7264.673089710976;7270.854582908365;7276.927230727731;4591.196540605414;4890.339804126468;4891.510848915115;4894.755262236874;4903.338049363326;7685.538867667958;7692.730754423625;7701.845963080707;7707.997960265129;7716.228377162295;4918.967016926414;4942.827001055018;4952.479989601112;4961.652684312064;4970;5023.196288593807;5031.547160755549;5039.622028347815;5041.8487445376695;5055.545000949932;5162.741862906914;5607.682194684246;5743.827685169452;5825.155352473867;5960.880782384328;7265.200827908926;7300.342969132804;7324.816879578053;7327.303906128909;7328.083989501312;1727.740838874179;1761.9030953297436;1762.048493813352;1766.2316892151955;1768.2484943898792;939.1406862720535;1079.6976846482996;1110.35044498969;1138.385271953136;1152.0898490192653;5593.972030139905;7042.260562640951;7050.189228238715;7072.222055573883;7075.115610548682;7592.240775922363;7665.156832748393;7681.61591920413;7697.615119244016;7733.883991740128;7096.396806271525;7099.2545782693105;7104.644767761694;7112.075430194145;7125.394341480928;3888.3778595424596;4013.3177359848896;4045.433639290443;4055.4930633670792;4057.229126465962;6351;6402.551821372553;7966.6415011324625;8052.396070294752;8056.154103819014;7864;7879.881801772978;7906.051273847175;7907.841843163104;7912.7339625659615;6423.550351475352;8010.5994700264755;8013.6794528218215;8019.599020048974;8032.437729359006;7336.119665640157;7620.314171724572;7650.885236721565;7654.081510218809;7665.195154508696;6381.8723625528155;7163.421168379484;7499.212582678741;7500.36246919018;7501.737439189602;6667.299933506912;7709.498882572839;7969.442139050211;7975.282224599814;7977.521348719096;3941.9553818238765;4757.119932812441;4798.784054717616;4807.759612019315;4821.373221481325;7272;7535.321821036133;7548.773536793905;7558.395328373607;7603.163651998165;7291.744788932362;7298.598577078312;7304.5252058616015;7321;7330.303621155982;7310.561366318038;7313.634318284171;7333.669984850588;7334;7356.154042285206;7177.605231712306;7181.06646135999;7186.173590037212;7186.60473673932;7193.748218812317;7056.6471676417;7302.233265507045;7319.670614822452;7323.560586364835;7335.119785625546;6865.073215115895;7007;7019.894701579378;7118.786436406916;7125.714971401086 14:43:22 INFO - PROCESS | 1672 | |5;yui.html;708.0759608710633;758.647229038497;777.5334799120532;795.014182413807;801.3949468151545;15196.544103676893;15504.767428488567;15515.379384824608;15527.534173974771;15531.37874485022;11398.25911315766;14716.424625690488;14743.115413075224;14857;14864.256787160653;759.290063790355;810.4286478032973;970.864079028933;993.3741742702124;993.4138858073735;981.5484876956608;982.0964712464549;992.8659630949802;993.3493561717087;993.359283262299;856.8586183279751;1026.9794604107913;1036.9637062702807;1037.4086770540796;1038.3043360948145;858.8797568340437;861.5347712235417;1026.5585798106774;1042.0777611813523;1043.6816770884952;770.8342706318113;774.6707649249103;775.4223103787658;775.9456838021341;776.0570906348813;15602.907796454252;15638.296276667577;15670.294836732375;15686;15708.52874413758;12945.676358091028;13075.476980920752;13127.343632818322;13286.468541258435;13639.103212277281;10222.513348815957;10251.692449226535;10450.947745261301;10602.416867072308;11050.502727377287;3589.7128229741556;3590.407582748843;3623.9275214495824;3633.5458067741533;3732.6267373262726;76152;76735.6163219186;76954;78963;79367;9705.417674939526;9742.07450292221;10055.245856560641;10151.1371533419;10263.897361026295;23576.528469430516;23576.7642323578;23603.40991475227;23630.527389452458;23646;7639.923600764032;7734.729284475016;7820.569868657165;7930.920690793134;8032.558209298428;4254.595813397722;4255.000074982377;4274;4318.870433886988;4327.632151267115;3624.7462677612843;3659.579148397915;3665.2119794244363;3683.797391143513;3685.1708365618056;635.8569321902535;639.7600899662626;653.8038588423454;655.9016147577902;663.8705452436825;545.6835035679296;599.8123715044237;602.5932495565476;603.9250134760134;611.6819253987901;8457.118938823847;8464.280536154496;8510.276626486819;8512.40413171072;8654.394192406471;595.3659352789352;613.6348872420903;615.0497481391261;633.5881676909953;634.2104080419815;3768.453574231721;3836.865709700147;3920.3923391874305;3947.4276229946495;4027.6173763493007;90408;90820;92086.53956730173;92207.5389623061;92357.53821230851;77876;78031.60984195156;78242.21757782463;78990.6050469744;80427;65821.6835663284;66242.66878665576;66384;68493.65753171203;69577.30422695809;7847.058352997677;7873.180739250479;7916;7956.5226086435;7988.440809143304;37391;45684.40104596323;46097.078058439314;47653;49265.014699706524;50595.49404506055;55078.72460637671;58144.2556723299;65011.34988650053;67045.99431008636;10412.947935260578;10570.978785077026;10708.464576771286;10770.838437423601;11382.601608943647;10458.790824183321;10587.523561439908;10668.413237271714;10854.782904342026;10962.506687198937;10109.747256318651;10349.482525873525;10519.474026298807;10537.841932371173;10968.122550195805;10241.84637230457;10466.529006194587;10632.84050739255;10817.783644327226;11464.598739044093;10127.139193168663;10246.026627470379;10261.9486902565;10387.68836934893;10735.0338469535;9099.54502274897;9122.452652840851;9277.443353398548;9302.581383837878;9523.952365239957;9175.724728258163;9177.54112294396;9224.953875230582;9291.535423228675;9395.577199026196 14:43:22 INFO - PROCESS | 1672 | __end_tp_report 14:43:22 INFO - PROCESS | 1672 | __start_cc_report 14:43:22 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1051 14:43:22 INFO - PROCESS | 1672 | __end_cc_report 14:43:22 INFO - PROCESS | 1672 | __startTimestamp1463435002907__endTimestamp 14:43:22 INFO - PROCESS | 1672 | 14:43:22 INFO - PROCESS | 1672 | ------- Summary: start ------- 14:43:22 INFO - PROCESS | 1672 | Number of tests: 6 14:43:22 INFO - PROCESS | 1672 | 14:43:22 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5884.01 Median:6166.11 stddev:645.59 (10.5%) stddev-sans-first:609.74 14:43:22 INFO - PROCESS | 1672 | Values: 3108.4 3529.2 3637.9 3649.6 3728.3 5880.7 5915.7 5922.8 5937.9 5939.7 5882.0 5952.1 5953.4 5971.3 5978.1 5184.6 5250.8 5283.4 5297.3 5351.5 5384.1 5413.5 5414.2 5414.8 5415.7 5269.6 5327.0 5347.2 5355.9 5399.1 5388.4 5402.7 5409.1 5414.9 5432.9 5153.3 5311.8 5312.2 5319.8 5332.9 4723.4 5787.9 5818.9 5820.7 5826.8 6197.1 6278.0 6299.0 6299.2 6310.4 5338.9 6243.5 6265.8 6320.5 6333.5 6099.8 6110.1 6117.8 6132.2 6137.6 6265.8 6471.5 6476.2 6487.0 6520.4 6216.5 6288.3 6306.2 6307.3 6307.7 6268.6 6280.4 6297.4 6303.7 6309.3 6178.7 6180.1 6213.5 6291.9 6308.3 5173.4 6256.8 6271.6 6276.9 6295.7 5002.9 5004.5 5005.1 5018.8 5030.7 4504.9 4551.5 4592.5 4594.0 4617.9 6077.0 6151.9 6153.5 6166.1 6169.0 6339.0 6351.6 6352.5 6370.7 6390.1 5959.6 6098.1 6141.8 6165.5 6176.2 5532.2 5534.0 5534.1 5536.0 5565.8 6543.5 6556.9 6564.9 6580.0 6586.7 5620.9 6141.6 6189.9 6303.5 6327.5 6521.1 6543.2 6558.6 6560.1 6564.6 6270.5 6270.6 6270.7 6270.8 6286.8 6181.3 6231.4 6287.4 6306.5 6346.1 6091.5 6279.2 6290.4 6305.6 6313.9 6272.7 6281.3 6287.6 6292.4 6305.3 6080.5 6129.6 6210.6 6220.2 6229.2 6262.4 6278.2 6283.0 6284.0 6302.8 6042.4 6122.2 6137.8 6196.1 6201.5 14:43:22 INFO - PROCESS | 1672 | 14:43:22 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:57468.29 Median:38031.43 stddev:114342.53 (300.7%) stddev-sans-first:114583.30 14:43:22 INFO - PROCESS | 1672 | Values: 501.4 590.7 598.0 669.4 676.0 32170.7 40046.0 40331.8 40378.6 40474.8 43203.6 43753.1 43774.8 43790.6 43932.8 9733.6 9987.8 9988.2 9994.9 10005.7 9767.2 9916.4 9922.3 9930.3 9937.0 9890.5 10066.7 10077.5 10079.7 10080.2 9976.5 10064.1 10065.0 10066.0 10068.2 9865.2 9963.2 9985.4 10000.4 10015.9 42353.0 42794.4 42817.6 42869.0 42984.0 3359.5 3418.7 3520.5 3540.9 3551.3 28121.0 28215.6 29093.3 30527.8 31328.8 2749.7 2802.9 2806.4 2828.2 2865.8 469942.0 498445.0 499745.0 500141.5 501580.0 47525.5 48731.8 71261.6 71596.6 71838.6 45816.6 46495.5 46669.1 46759.0 46845.0 17902.9 18065.4 18091.3 18091.6 18128.4 14434.1 14539.3 14553.0 14563.2 14566.5 15065.4 15104.5 15153.0 15162.5 15222.6 6392.0 6485.4 6529.2 6543.0 6557.2 951.0 982.4 987.5 1032.4 1047.4 27597.8 27837.4 30047.4 30373.4 30440.8 1109.8 1172.8 1192.8 1200.5 1262.2 12802.8 16091.6 16522.8 16710.2 16917.5 481764.0 487932.0 489523.0 490230.0 490932.0 61666.0 62150.1 62205.0 62244.8 62268.8 1445.1 1536.2 1561.9 1587.9 1591.2 29244.4 29781.7 29818.0 29939.3 30499.4 47758.0 48138.0 48167.5 48225.3 48229.8 238507.0 258116.0 283422.0 284715.0 285746.0 33995.0 34440.5 34462.0 34836.0 34850.8 45824.3 45895.6 46368.5 46677.0 46945.8 38221.2 38611.8 38800.8 38801.8 39155.0 37849.0 37965.1 38097.8 38416.4 38737.2 39087.8 39344.8 39346.4 39356.8 40270.6 29717.1 32199.0 33034.3 33067.0 33228.0 22792.5 23186.5 24337.6 24629.0 25085.7 14:43:22 INFO - PROCESS | 1672 | 14:43:22 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:36568.82 Median:21867.34 stddev:113535.93 (519.2%) stddev-sans-first:113821.91 14:43:22 INFO - PROCESS | 1672 | Values: 382.9 386.1 386.1 390.4 392.2 17125.4 17523.0 20282.3 22267.0 22916.2 21031.0 21460.7 21815.5 21919.2 21954.8 5888.1 6074.9 6092.5 6098.8 6099.1 5720.3 6002.2 6008.8 6009.7 6011.4 5929.6 5954.0 5966.7 5976.9 5979.3 5885.2 6126.4 6150.8 6152.8 6153.4 5824.1 5862.4 5868.5 5887.8 5889.4 14076.7 14386.9 14415.1 14453.6 14462.6 2103.6 2514.1 2555.9 2616.6 2630.9 10252.4 10552.3 10619.4 11813.9 15788.8 1730.2 1853.6 1861.0 1882.6 1915.7 106536.0 109731.8 110858.0 112965.0 114178.0 11415.4 11625.4 11792.4 11828.8 11927.5 14623.7 14666.4 14671.5 14698.1 14717.3 8937.7 9182.4 9194.7 9255.3 9326.3 9403.4 9411.3 9425.4 9512.8 9514.6 4568.8 4636.7 4650.3 4671.5 4694.7 1840.5 1951.3 1951.8 1981.0 1981.7 868.7 974.0 974.1 1007.8 1062.8 20178.3 20828.9 21200.0 21515.7 21540.6 945.6 999.9 1014.8 1045.1 1075.8 11529.9 11606.8 12520.1 12543.2 12661.9 660242.7 686163.0 686919.0 697988.0 704913.0 75481.2 96708.5 129908.0 130897.3 134303.7 1066.2 1121.8 1132.4 1137.4 1139.9 18779.0 19038.5 19432.4 19460.2 19791.8 50908.7 50992.5 51537.7 52567.7 52698.7 59259.7 62910.7 73329.6 74561.0 79688.6 7176.5 8055.8 8324.6 8476.4 8625.1 9747.5 13157.6 13233.7 13614.7 13636.8 11469.3 11963.0 12112.0 12192.5 12195.6 5470.0 10629.5 11656.4 11670.0 11794.1 6211.7 9404.5 11643.3 11785.6 12185.2 8284.0 8313.5 8423.2 8652.6 8792.6 10631.9 11891.5 12012.3 12044.9 12076.5 14:43:22 INFO - PROCESS | 1672 | 14:43:22 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:6210.26 Median:5667.29 stddev:3276.10 (57.8%) stddev-sans-first:3266.02 14:43:22 INFO - PROCESS | 1672 | Values: 1482.7 1665.6 1691.3 2043.1 2109.0 8236.8 8815.8 9001.7 9015.8 9018.1 8708.7 8982.1 8991.2 9011.8 9014.1 2541.8 2572.0 2575.5 2576.5 2578.4 2497.1 2556.9 2561.5 2565.8 2568.3 2502.2 2528.6 2529.3 2532.9 2537.2 2496.9 2527.4 2530.1 2534.5 2549.3 2532.3 2546.7 2549.3 2552.7 2572.3 8860.7 9048.6 9124.1 9126.4 9149.2 4906.2 5645.2 5772.9 5803.9 5819.8 3203.3 3691.0 3772.5 3772.5 3818.4 1069.7 1081.8 1084.1 1094.5 1095.1 10894.8 11800.1 12271.4 12397.6 12451.9 4025.4 4727.8 4753.9 4774.2 4899.7 9665.4 9667.5 9684.4 9687.4 9689.5 5595.7 5602.4 5647.7 5686.9 5689.4 4554.1 4650.2 4992.6 5116.7 5263.0 3899.5 3946.8 3961.9 3987.3 4001.4 1049.3 1227.6 1239.9 1247.9 1256.5 1413.9 1423.5 1446.4 1457.4 1477.7 8456.2 8553.6 8575.7 8589.4 8590.4 542.7 543.3 553.6 556.0 556.2 6472.7 6497.8 6550.9 6564.1 6582.6 10678.9 11052.2 11208.4 11210.7 11221.8 10786.7 10870.3 10999.0 11059.6 11066.8 8660.5 8691.2 8739.5 8753.9 8755.3 7933.8 8161.3 8168.3 8190.5 8197.1 9468.9 9684.8 9729.5 9799.6 9894.2 9576.7 9948.2 9971.2 9977.4 10185.6 8216.1 8356.4 8411.6 8442.2 8455.9 8448.6 8452.3 8507.3 8514.9 8526.0 6519.6 7341.5 7414.2 7502.8 7613.5 7395.3 7396.4 7495.6 7554.2 7583.8 8010.2 8052.9 8057.5 8062.7 8084.9 7199.1 7245.0 7249.3 7275.1 7320.6 7323.9 7328.4 7348.2 7360.7 7384.0 14:43:22 INFO - PROCESS | 1672 | 14:43:22 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5988.96 Median:6864.59 stddev:1906.62 (27.8%) stddev-sans-first:1864.27 14:43:22 INFO - PROCESS | 1672 | Values: 342.8 345.4 350.3 351.5 356.9 6821.4 6836.9 6920.0 6926.8 6936.2 6840.7 6843.9 6845.0 6864.1 6879.4 4854.9 4940.4 4966.7 5025.0 5085.5 4969.1 4991.0 4998.4 5010.8 5014.4 4938.6 4964.7 4976.0 4986.4 5021.7 4783.9 4843.6 4967.6 4972.5 4987.2 4283.6 4314.8 4319.4 4322.1 4341.7 6565.8 6575.0 6585.1 6590.4 6603.0 5976.5 5977.6 5987.6 5991.3 5995.2 7041.7 7194.6 7264.7 7270.9 7276.9 4591.2 4890.3 4891.5 4894.8 4903.3 7685.5 7692.7 7701.8 7708.0 7716.2 4919.0 4942.8 4952.5 4961.7 4970.0 5023.2 5031.5 5039.6 5041.8 5055.5 5162.7 5607.7 5743.8 5825.2 5960.9 7265.2 7300.3 7324.8 7327.3 7328.1 1727.7 1761.9 1762.0 1766.2 1768.2 939.1 1079.7 1110.4 1138.4 1152.1 5594.0 7042.3 7050.2 7072.2 7075.1 7592.2 7665.2 7681.6 7697.6 7733.9 7096.4 7099.3 7104.6 7112.1 7125.4 3888.4 4013.3 4045.4 4055.5 4057.2 6351.0 6402.6 7966.6 8052.4 8056.2 7864.0 7879.9 7906.1 7907.8 7912.7 6423.6 8010.6 8013.7 8019.6 8032.4 7336.1 7620.3 7650.9 7654.1 7665.2 6381.9 7163.4 7499.2 7500.4 7501.7 6667.3 7709.5 7969.4 7975.3 7977.5 3942.0 4757.1 4798.8 4807.8 4821.4 7272.0 7535.3 7548.8 7558.4 7603.2 7291.7 7298.6 7304.5 7321.0 7330.3 7310.6 7313.6 7333.7 7334.0 7356.2 7177.6 7181.1 7186.2 7186.6 7193.7 7056.6 7302.2 7319.7 7323.6 7335.1 6865.1 7007.0 7019.9 7118.8 7125.7 14:43:22 INFO - PROCESS | 1672 | 14:43:22 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:17798.78 Median:25570.59 stddev:24770.30 (96.9%) stddev-sans-first:24806.55 14:43:22 INFO - PROCESS | 1672 | Values: 708.1 758.6 777.5 795.0 801.4 15196.5 15504.8 15515.4 15527.5 15531.4 11398.3 14716.4 14743.1 14857.0 14864.3 759.3 810.4 970.9 993.4 993.4 981.5 982.1 992.9 993.3 993.4 856.9 1027.0 1037.0 1037.4 1038.3 858.9 861.5 1026.6 1042.1 1043.7 770.8 774.7 775.4 775.9 776.1 15602.9 15638.3 15670.3 15686.0 15708.5 12945.7 13075.5 13127.3 13286.5 13639.1 10222.5 10251.7 10450.9 10602.4 11050.5 3589.7 3590.4 3623.9 3633.5 3732.6 76152.0 76735.6 76954.0 78963.0 79367.0 9705.4 9742.1 10055.2 10151.1 10263.9 23576.5 23576.8 23603.4 23630.5 23646.0 7639.9 7734.7 7820.6 7930.9 8032.6 4254.6 4255.0 4274.0 4318.9 4327.6 3624.7 3659.6 3665.2 3683.8 3685.2 635.9 639.8 653.8 655.9 663.9 545.7 599.8 602.6 603.9 611.7 8457.1 8464.3 8510.3 8512.4 8654.4 595.4 613.6 615.0 633.6 634.2 3768.5 3836.9 3920.4 3947.4 4027.6 90408.0 90820.0 92086.5 92207.5 92357.5 77876.0 78031.6 78242.2 78990.6 80427.0 65821.7 66242.7 66384.0 68493.7 69577.3 7847.1 7873.2 7916.0 7956.5 7988.4 37391.0 45684.4 46097.1 47653.0 49265.0 50595.5 55078.7 58144.3 65011.3 67046.0 10412.9 10571.0 10708.5 10770.8 11382.6 10458.8 10587.5 10668.4 10854.8 10962.5 10109.7 10349.5 10519.5 10537.8 10968.1 10241.8 10466.5 10632.8 10817.8 11464.6 10127.1 10246.0 10261.9 10387.7 10735.0 9099.5 9122.5 9277.4 9302.6 9524.0 9175.7 9177.5 9225.0 9291.5 9395.6 14:43:22 INFO - PROCESS | 1672 | -------- Summary: end -------- 14:43:22 INFO - PROCESS | 1672 | 14:43:23 INFO - TEST-INFO | 1672: exit 0 14:43:23 INFO - TEST-OK | dromaeo_css | took 1111759ms 14:43:23 INFO - TEST-START | kraken 14:43:23 INFO - operating with platform_type : mac_ 14:43:23 INFO - Initialising browser for kraken test... 14:43:23 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpjqHOrH/profile http://localhost:49275/getInfo.html) 14:43:25 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 14:43:25 INFO - PROCESS | 1678 | colorDepth:24 14:43:25 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 14:43:25 INFO - PROCESS | 1678 | __metrics 14:43:25 INFO - PROCESS | 1678 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:43:25 INFO - PROCESS | 1678 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:43:26 INFO - TEST-INFO | 1678: exit 0 14:43:26 INFO - Browser initialized. 14:43:26 INFO - Running cycle 1/1 for kraken test... 14:43:26 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpjqHOrH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:43:37 INFO - PROCESS | 1681 | RSS: Main: 156737536 14:43:37 INFO - PROCESS | 1681 | 14:43:40 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 14:43:41 INFO - PROCESS | 1681 | RSS: Main: 213180416 14:43:41 INFO - PROCESS | 1681 | 14:43:43 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 14:43:44 INFO - PROCESS | 1681 | RSS: Main: 223404032 14:43:44 INFO - PROCESS | 1681 | 14:43:47 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 14:43:47 INFO - PROCESS | 1681 | RSS: Main: 213532672 14:43:47 INFO - PROCESS | 1681 | 14:43:49 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 14:43:50 INFO - PROCESS | 1681 | RSS: Main: 214904832 14:43:50 INFO - PROCESS | 1681 | 14:43:52 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:43:53 INFO - PROCESS | 1681 | RSS: Main: 214708224 14:43:53 INFO - PROCESS | 1681 | 14:43:55 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 14:43:56 INFO - PROCESS | 1681 | RSS: Main: 215814144 14:43:56 INFO - PROCESS | 1681 | 14:43:59 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 14:43:59 INFO - PROCESS | 1681 | RSS: Main: 215916544 14:43:59 INFO - PROCESS | 1681 | 14:44:02 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 14:44:03 INFO - PROCESS | 1681 | RSS: Main: 216289280 14:44:03 INFO - PROCESS | 1681 | 14:44:04 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:05 INFO - PROCESS | 1681 | RSS: Main: 249085952 14:44:05 INFO - PROCESS | 1681 | 14:44:07 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:07 INFO - PROCESS | 1681 | RSS: Main: 249012224 14:44:07 INFO - PROCESS | 1681 | 14:44:10 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:10 INFO - PROCESS | 1681 | RSS: Main: 254078976 14:44:10 INFO - PROCESS | 1681 | 14:44:13 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:13 INFO - PROCESS | 1681 | RSS: Main: 255385600 14:44:13 INFO - PROCESS | 1681 | 14:44:16 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:16 INFO - PROCESS | 1681 | RSS: Main: 255430656 14:44:16 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 14:44:18 INFO - PROCESS | 1681 | RSS: Main: 318636032 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | __start_tp_report 14:44:18 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 14:44:18 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 14:44:18 INFO - PROCESS | 1681 | |i|pagename|runs| 14:44:18 INFO - PROCESS | 1681 | |0;ai-astar;112;107;110;110;112;112;121;111;109;109 14:44:18 INFO - PROCESS | 1681 | |1;audio-beat-detection;153;118;152;150;118;138;116;149;148;100 14:44:18 INFO - PROCESS | 1681 | |2;audio-dft;182;185;183;183;183;187;184;182;186;182 14:44:18 INFO - PROCESS | 1681 | |3;audio-fft;73;83;72;113;55;57;56;57;121;63 14:44:18 INFO - PROCESS | 1681 | |4;audio-oscillator;90;91;124;80;78;82;115;76;77;116 14:44:18 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;88;84;87;84;86;84;87;85;87;83 14:44:18 INFO - PROCESS | 1681 | |6;imaging-darkroom;92;93;93;92;92;107;148;94;92;93 14:44:18 INFO - PROCESS | 1681 | |7;imaging-desaturate;109;130;132;135;85;86;85;85;84;85 14:44:18 INFO - PROCESS | 1681 | |8;json-parse-financial;55;58;57;56;56;56;57;56;53;50 14:44:18 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;63;62;75;72;70;69;86;93;93;77 14:44:18 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;80;82;81;79;95;98;103;89;83;84 14:44:18 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;117;128;119;115;124;126;122;126;128;116 14:44:18 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;132;122;132;132;130;155;166;144;130;151 14:44:18 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;66;67;66;66;66;66;64;67;84;92 14:44:18 INFO - PROCESS | 1681 | __end_tp_report 14:44:18 INFO - PROCESS | 1681 | __start_cc_report 14:44:18 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1183 14:44:18 INFO - PROCESS | 1681 | __end_cc_report 14:44:18 INFO - PROCESS | 1681 | __startTimestamp1463435058842__endTimestamp 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | ------- Summary: start ------- 14:44:18 INFO - PROCESS | 1681 | Number of tests: 14 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.50 stddev:3.77 (3.4%) stddev-sans-first:3.99 14:44:18 INFO - PROCESS | 1681 | Values: 112.0 107.0 110.0 110.0 112.0 112.0 121.0 111.0 109.0 109.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:148.50 stddev:19.35 (13.0%) stddev-sans-first:19.29 14:44:18 INFO - PROCESS | 1681 | Values: 153.0 118.0 152.0 150.0 118.0 138.0 116.0 149.0 148.0 100.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:183.70 Median:183.50 stddev:1.77 (1.0%) stddev-sans-first:1.76 14:44:18 INFO - PROCESS | 1681 | Values: 182.0 185.0 183.0 183.0 183.0 187.0 184.0 182.0 186.0 182.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:75.00 Median:60.00 stddev:24.01 (40.0%) stddev-sans-first:25.46 14:44:18 INFO - PROCESS | 1681 | Values: 73.0 83.0 72.0 113.0 55.0 57.0 56.0 57.0 121.0 63.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:79.00 stddev:18.40 (23.3%) stddev-sans-first:19.49 14:44:18 INFO - PROCESS | 1681 | Values: 90.0 91.0 124.0 80.0 78.0 82.0 115.0 76.0 77.0 116.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.50 stddev:1.72 (2.0%) stddev-sans-first:1.56 14:44:18 INFO - PROCESS | 1681 | Values: 88.0 84.0 87.0 84.0 86.0 84.0 87.0 85.0 87.0 83.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:99.60 Median:92.50 stddev:17.61 (19.0%) stddev-sans-first:18.46 14:44:18 INFO - PROCESS | 1681 | Values: 92.0 93.0 93.0 92.0 92.0 107.0 148.0 94.0 92.0 93.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:101.60 Median:85.00 stddev:22.50 (26.5%) stddev-sans-first:23.71 14:44:18 INFO - PROCESS | 1681 | Values: 109.0 130.0 132.0 135.0 85.0 86.0 85.0 85.0 84.0 85.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:2.32 (4.1%) stddev-sans-first:2.46 14:44:18 INFO - PROCESS | 1681 | Values: 55.0 58.0 57.0 56.0 56.0 56.0 57.0 56.0 53.0 50.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:76.00 Median:76.00 stddev:11.28 (14.8%) stddev-sans-first:10.94 14:44:18 INFO - PROCESS | 1681 | Values: 63.0 62.0 75.0 72.0 70.0 69.0 86.0 93.0 93.0 77.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:83.50 stddev:8.45 (10.1%) stddev-sans-first:8.53 14:44:18 INFO - PROCESS | 1681 | Values: 80.0 82.0 81.0 79.0 95.0 98.0 103.0 89.0 83.0 84.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:125.00 stddev:5.02 (4.0%) stddev-sans-first:4.97 14:44:18 INFO - PROCESS | 1681 | Values: 117.0 128.0 119.0 115.0 124.0 126.0 122.0 126.0 128.0 116.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.40 Median:138.00 stddev:13.95 (10.1%) stddev-sans-first:14.53 14:44:18 INFO - PROCESS | 1681 | Values: 132.0 122.0 132.0 132.0 130.0 155.0 166.0 144.0 130.0 151.0 14:44:18 INFO - PROCESS | 1681 | 14:44:18 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:66.50 stddev:9.50 (14.3%) stddev-sans-first:9.94 14:44:18 INFO - PROCESS | 1681 | Values: 66.0 67.0 66.0 66.0 66.0 66.0 64.0 67.0 84.0 92.0 14:44:18 INFO - PROCESS | 1681 | -------- Summary: end -------- 14:44:18 INFO - PROCESS | 1681 | 14:44:19 INFO - TEST-INFO | 1681: exit 0 14:44:19 INFO - TEST-OK | kraken | took 56088ms 14:44:19 INFO - SUITE-END | took 1167s 14:44:19 INFO - Completed test suite (00:19:28) 14:44:19 INFO - javascript benchmark 14:44:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3108.3627856289463, 3529.241213139175, 3637.9090522736947, 3649.6167902370266, 3728.2916245913275, 5880.67656278905, 5915.70421478926, 5922.822315330536, 5937.881242375155, 5939.67331796751, 5882.0, 5952.107183922414, 5953.3748956359605, 5971.283445986488, 5978.133170690258, 5184.637075404723, 5250.763715632796, 5283.418823929364, 5297.258383826267, 5351.491608297225, 5384.138537833947, 5413.512783849453, 5414.242006119146, 5414.7834086636485, 5415.675059496442, 5269.578433725293, 5326.987872304269, 5347.197920311945, 5355.892882142355, 5399.136138217886, 5388.407275199745, 5402.729863506809, 5409.134538473864, 5414.862878795458, 5432.945670543283, 5153.2785410042625, 5311.787528498855, 5312.203169524563, 5319.813806516792, 5332.946670533283, 4723.36234608327, 5787.913181302284, 5818.912716309259, 5820.708964551755, 5826.766929322822, 6197.101420294077, 6277.96861015692, 6299.0, 6299.212598425197, 6310.400511951358, 5338.866528336784, 6243.500519958392, 6265.780697675559, 6320.525960552977, 6333.524985626096, 6099.786507472261, 6110.114033465167, 6117.755289788448, 6132.202813634199, 6137.555566654994, 6265.8120256392385, 6471.482281417475, 6476.222853257545, 6487.0, 6520.445762110274, 6216.471599914058, 6288.308286088527, 6306.180196574416, 6307.306196318401, 6307.653079080695, 6268.561200715906, 6280.434760871543, 6297.4017468340435, 6303.716332765037, 6309.337519560472, 6178.69106544671, 6180.134781130645, 6213.502919766408, 6291.874162516816, 6308.337624549448, 5173.405058418255, 6256.7810126645345, 6271.560990730696, 6276.905846412307, 6295.685215739195, 5002.89994200114, 5004.47453017428, 5005.1491246488185, 5018.774155163026, 5030.748462576857, 4504.887377815516, 4551.499335073139, 4592.540745925381, 4594.0, 4617.907641847144, 6076.997295446202, 6151.861905547488, 6153.538484613672, 6166.105914642351, 6168.9691551541955, 6339.0, 6351.618902865843, 6352.460040896483, 6370.713317900706, 6390.105385246069, 5959.612625179349, 6098.14625952367, 6141.84645383869, 6165.537584681167, 6176.227971503562, 5532.197831314517, 5534.0, 5534.142207957692, 5535.975844468786, 5565.805196818092, 6543.5419520633095, 6556.901646475307, 6564.868702626016, 6580.012998050331, 6586.670666466754, 5620.943790562205, 6141.631502109888, 6189.938100618936, 6303.495720342454, 6327.525435592257, 6521.119648847345, 6543.1821022372205, 6558.606483610999, 6560.114384558024, 6564.6389448580785, 6270.529710271657, 6270.561060725706, 6270.717817698306, 6270.811875643738, 6286.779962701284, 6181.289151747426, 6231.376862313732, 6287.402696743802, 6306.46395056407, 6346.079818426395, 6091.543134265036, 6279.152314437675, 6290.402411770874, 6305.5901366411035, 6313.936860631335, 6272.655003974825, 6281.309056003744, 6287.622742635456, 6292.433680968735, 6305.274893387319, 6080.48315893154, 6129.633877546871, 6210.5652604317265, 6220.222472190976, 6229.221347331583, 6262.405071518198, 6278.183836101278, 6282.968585157045, 6284.0, 6302.842428939313, 6042.3655516170165, 6122.204113465221, 6137.815865524041, 6196.0705894116245, 6201.472874805692], "unit": "score", "name": "dojo.html", "value": 5844.390080777804}, {"lowerIsBetter": false, "replicates": [501.38329854279215, 590.6957916672915, 597.9864130299145, 669.3741351836032, 675.9831004224894, 32170.67829321706, 40046.0, 40331.79834100825, 40378.59621403789, 40474.79762601183, 43203.56796432035, 43753.124937501234, 43774.78112609441, 43790.56209437905, 43932.78033609827, 9733.610655573786, 9987.800243995116, 9988.200943924468, 9994.850077248848, 10005.749856253615, 9767.218622510181, 9916.355436896578, 9922.255830812683, 9930.30487865846, 9937.006299370041, 9890.505474726271, 10066.69799906004, 10077.496125193748, 10079.69760907174, 10080.193584513258, 9976.50117494126, 10064.144547713453, 10065.0, 10066.0, 10068.194544436428, 9865.1614612758, 9963.15313198379, 9985.400875947467, 10000.39997600139, 10015.949920250425, 42353.0, 42794.35808462876, 42817.57182428167, 42869.0, 42984.0, 3359.5296658467832, 3418.67522585354, 3520.489529018278, 3540.8760693375607, 3551.254236610315, 28121.01576444835, 28215.57676634852, 29093.272668183254, 30527.77888884442, 31328.8433557833, 2749.670039595241, 2802.8738706758245, 2806.410653762712, 2828.2222388843234, 2865.770738340928, 469942.0, 498445.0, 499745.0, 500141.49929250486, 501580.0, 47525.52474475211, 48731.75634121807, 71261.64369178121, 71596.64201678958, 71838.64080679668, 45816.625501235016, 46495.53504464912, 46669.066618667435, 46759.0, 46845.0, 17902.91048544749, 18065.367712130013, 18091.276348945896, 18091.638167236582, 18128.365507207185, 14434.133951962916, 14539.27303634814, 14553.0, 14563.199024053778, 14566.4901728439, 15065.418131096296, 15104.54686359411, 15153.0, 15162.545123646309, 15222.619434514225, 6392.0, 6485.416312531895, 6529.183852018497, 6543.0, 6557.196770887948, 950.9857352139724, 982.4400091947522, 987.5161171026145, 1032.4373216596973, 1047.3925123428394, 27597.75810088551, 27837.443251134864, 30047.399052018838, 30373.39253214923, 30440.84779576132, 1109.7724966382034, 1172.7654469106212, 1192.8449301590738, 1200.5497938273147, 1262.2426544073483, 12802.80795788064, 16091.597710057107, 16522.83477165237, 16710.164491775362, 16917.49247522576, 481764.0, 487932.0, 489523.0, 490230.0, 490932.0, 61666.0, 62150.0677489838, 62205.0, 62244.755104898555, 62268.82059127909, 1445.0823726933472, 1536.2088524409937, 1561.9453319133777, 1587.8650314723377, 1591.2441590244541, 29244.41511169722, 29781.70218297876, 29818.0, 29939.251518712208, 30499.390012199186, 47758.0, 48138.03723925572, 48167.5183248163, 48225.27662085001, 48229.794255143905, 238507.0, 258116.0, 283422.0, 284715.0, 285746.0, 33995.0, 34440.48339274963, 34462.0, 34835.9549213524, 34850.78022269208, 45824.312635311166, 45895.623131304776, 46368.53631463777, 46677.0, 46945.765271173426, 38221.2355752889, 38611.806940965114, 38800.80599596984, 38801.805990969864, 39155.021124472114, 37849.0, 37965.050873727276, 38097.80951095227, 38416.423753644274, 38737.225255495294, 39087.80456097701, 39344.80327598344, 39346.409803852395, 39356.80321598374, 40270.59729402669, 29717.105755091023, 32199.0, 33034.339313214085, 33067.0, 33228.0, 22792.544149117257, 23186.536269274184, 24337.634935476337, 24629.0, 25085.74914250907], "unit": "score", "name": "ext.html", "value": 19603.68157527209}, {"lowerIsBetter": false, "replicates": [382.9004458840701, 386.0830527497194, 386.1446895127293, 390.39293897988637, 392.1725159912586, 17125.400610978617, 17522.999999999967, 20282.29011984581, 22267.0, 22916.197933072366, 21031.0, 21460.678089828627, 21815.454613634665, 21919.232826851065, 21954.780452195475, 5888.11678248263, 6074.939250607504, 6092.45167934888, 6098.847528811771, 6099.146119543268, 5720.313562372521, 6002.249718785152, 6008.789692360769, 6009.669468179249, 6011.398860113975, 5929.555283353744, 5954.017587098124, 5966.701664916758, 5976.850578735544, 5979.312379076418, 5885.205497257858, 6126.417990290915, 6150.753969841201, 6152.815415537541, 6153.4154255345675, 5824.068149096167, 5862.38444963277, 5868.530517558628, 5887.8233652990475, 5889.411058894077, 14076.718465630733, 14386.856131438657, 14415.063020903608, 14453.566393008226, 14462.566123016326, 2103.610831996086, 2514.1326242446326, 2555.923322300334, 2616.5682662360687, 2630.93422664433, 10252.436116013616, 10552.314099583502, 10619.41593212373, 11813.881861181364, 15788.842111578966, 1730.2041061111904, 1853.5829438376393, 1861.0, 1882.595242022958, 1915.7317975483443, 106536.0, 109731.77339168194, 110858.0, 112964.99999999919, 114178.0, 11415.42922853854, 11625.418729063513, 11792.41037948099, 11828.822567661491, 11927.522899083939, 14623.707525849424, 14666.413343466142, 14671.486497972519, 14698.118112913045, 14717.337719802634, 8937.73186804397, 9182.449053056838, 9194.724158275263, 9255.305852061123, 9326.253899688008, 9403.43579385239, 9411.341206115643, 9425.38734982224, 9512.762180945532, 9514.619415223451, 4568.817247310137, 4636.698614590108, 4650.302454631832, 4671.462781780138, 4694.671373003857, 1840.4754644926131, 1951.2780271299425, 1951.8340941019887, 1980.960380792405, 1981.682930731076, 868.748063061705, 973.99026009739, 974.0503009565617, 1007.808516381885, 1062.792755412687, 20178.29375971834, 20828.895855520626, 21200.04599793013, 21515.67726484104, 21540.569188616453, 945.6359301668907, 999.9250056245811, 1014.7564584499814, 1045.0646671229208, 1075.800976819291, 11529.884701152881, 11606.767864642828, 12520.123591348518, 12543.24740515572, 12661.860432561114, 660242.6987865126, 686163.0, 686919.0, 697988.0, 704913.0, 75481.24518754851, 96708.51645741727, 129908.0, 130897.34551327182, 134303.65696343107, 1066.1577353890495, 1121.7980763462656, 1132.4281237974935, 1137.3573930729112, 1139.9202055856176, 18779.0, 19038.524036899187, 19432.4170274892, 19460.221591136196, 19791.80208197957, 50908.74545627248, 50992.49007510026, 51537.7423112882, 52567.737161315476, 52698.736506317226, 59259.703701481216, 62910.74178516496, 73329.6333518329, 74561.0, 79688.60155699184, 7176.533525320838, 8055.7583272501915, 8324.583770811556, 8476.406651534333, 8625.051244362989, 9747.512624368896, 13157.60527184186, 13233.735325293248, 13614.727705445637, 13636.795448068486, 11469.311841289216, 11963.0, 12112.031037517154, 12192.451339689558, 12195.634130976085, 5470.0, 10629.468526573795, 11656.358900260568, 11669.957757392593, 11794.053981093024, 6211.689415529296, 9404.529773511435, 11643.301401915913, 11785.646430607096, 12185.2331411943, 8284.0, 8313.542755148525, 8423.157684231528, 8652.610632521426, 8792.604332805167, 10631.893681063091, 11891.464884080064, 12012.279263244232, 12044.939775301067, 12076.51693932233], "unit": "score", "name": "jquery.html", "value": 9672.675143644941}, {"lowerIsBetter": false, "replicates": [1482.7108713800799, 1665.5836040989752, 1691.3319238900635, 2043.1010355443605, 2108.968365474517, 8236.83526329473, 8815.823683526334, 9001.72994810155, 9015.774605634871, 9018.14327638875, 8708.651653933835, 8982.146696063879, 8991.190792828644, 9011.774705632362, 9014.143656352637, 2541.758532939368, 2572.0354866924904, 2575.4720282342073, 2576.5233431815172, 2578.3682997665505, 2497.063601149569, 2556.8593727344987, 2561.5005074010573, 2565.7819085377764, 2568.25520599027, 2502.2368177705794, 2528.5954247320433, 2529.2791554407, 2532.936676583082, 2537.2261460254613, 2496.9375765605823, 2527.3555243412998, 2530.051230788454, 2534.4931013797222, 2549.2989427907287, 2532.2529853693204, 2546.732593077719, 2549.337172335206, 2552.680914885639, 2572.344052266679, 8860.68987585438, 9048.592813323416, 9124.133207345292, 9126.361154719172, 9149.22231610314, 4906.190478571031, 5645.2096706461125, 5772.884542309131, 5803.854903627401, 5819.7963071292725, 3203.343314620497, 3690.9665293717803, 3772.4718539404507, 3772.5472943246714, 3818.427235914635, 1069.6897899609105, 1081.8269076947652, 1084.143526613974, 1094.5238821112841, 1095.1239008792934, 10894.836577451344, 11800.055995520252, 12271.38643067852, 12397.566085186974, 12451.93774031133, 4025.4163146344204, 4727.834525791581, 4753.904921901542, 4774.212254977959, 4899.681520701143, 9665.371750836313, 9667.46828924416, 9684.370515916444, 9687.418754874589, 9689.467079310565, 5595.720213989365, 5602.355729091125, 5647.689377084218, 5686.886262274814, 5689.402612725604, 4554.134714404318, 4650.232711602615, 4992.6255530834605, 5116.718580478035, 5263.0000299942885, 3899.512560929884, 3946.8026598669953, 3961.8811435656976, 3987.322155233617, 4001.3597824347967, 1049.302214027663, 1227.5948936850818, 1239.8512178538633, 1247.9126461147632, 1256.4597223193932, 1413.8586141385986, 1423.4662001749343, 1446.378057435313, 1457.358762144653, 1477.7044591081826, 8456.154384561618, 8553.61508732096, 8575.656973721107, 8589.355798315151, 8590.398672092893, 542.6798189068469, 543.2584522127268, 553.6235359955189, 556.0408295689903, 556.1601981008706, 6472.741090356427, 6497.772577959749, 6550.901736473957, 6564.081028655896, 6582.572132811448, 10678.946605266923, 11052.226344155832, 11208.439578021229, 11210.719732006602, 11221.831672524919, 10786.676399708022, 10870.293430926964, 10999.0, 11059.557617695364, 11066.778664426827, 8660.523671198145, 8691.174338437839, 8739.519326437106, 8753.912460875437, 8755.343349248831, 7933.801654958672, 8161.3062889652665, 8168.346532277523, 8190.549519776469, 8197.057338406159, 9468.905310946802, 9684.75788105303, 9729.4648794317, 9799.608015679292, 9894.208463322773, 9576.712698619052, 9948.154406875497, 9971.202303815822, 9977.351472154287, 10185.643502477378, 8216.09622941464, 8356.415050946376, 8411.621477033426, 8442.240198382175, 8455.873161902453, 8448.619812108347, 8452.32381409498, 8507.276881465144, 8514.872276915976, 8525.976882774106, 6519.576227545194, 7341.522801017917, 7414.184439711736, 7502.774916752506, 7613.543187408552, 7395.334419902235, 7396.445266604918, 7495.587742674205, 7554.206808285271, 7583.7724868254045, 8010.158933311918, 8052.919470805451, 8057.5165490070785, 8062.677492900219, 8084.9489566356, 7199.1361036675935, 7245.0, 7249.275072492708, 7275.126984761862, 7320.560766354036, 7323.890141647986, 7328.377087947584, 7348.191698913222, 7360.705571777283, 7384.040074790243], "unit": "score", "name": "mootools.html", "value": 4987.147368755311}, {"lowerIsBetter": false, "replicates": [342.81487996481894, 345.3628056236243, 350.2522115283869, 351.4991137628878, 356.94824250483697, 6821.420179284761, 6836.931630683692, 6919.965400172992, 6926.757563485279, 6936.202336731278, 6840.726370945169, 6843.931560684392, 6845.0, 6864.107666003412, 6879.449644028478, 4854.854354369375, 4940.4318503372215, 4966.677165984218, 5025.045241404122, 5085.491450854922, 4969.105560999019, 4990.950090499085, 4998.40019197695, 5010.849674509771, 5014.423341315759, 4938.580220681247, 4964.67729597575, 4976.0296742135115, 4986.351774269358, 5021.723805190713, 4783.928241076369, 4843.564079232869, 4967.552920237196, 4972.453030166679, 4987.226979818134, 4283.550227226127, 4314.78426078698, 4319.352097185416, 4322.113966636864, 4341.696081274312, 6565.770198043046, 6574.967125164391, 6585.078089067534, 6590.418299608107, 6603.042558828991, 5976.521878249773, 5977.641341519523, 5987.580869339148, 5991.340952495222, 5995.160677505153, 7041.718331266743, 7194.568325900463, 7264.673089710976, 7270.854582908365, 7276.927230727731, 4591.196540605414, 4890.339804126468, 4891.510848915115, 4894.755262236874, 4903.338049363326, 7685.538867667958, 7692.730754423625, 7701.845963080707, 7707.997960265129, 7716.228377162295, 4918.967016926414, 4942.827001055018, 4952.479989601112, 4961.652684312064, 4970.0, 5023.196288593807, 5031.547160755549, 5039.622028347815, 5041.8487445376695, 5055.545000949932, 5162.741862906914, 5607.682194684246, 5743.827685169452, 5825.155352473867, 5960.880782384328, 7265.200827908926, 7300.342969132804, 7324.816879578053, 7327.303906128909, 7328.083989501312, 1727.740838874179, 1761.9030953297436, 1762.048493813352, 1766.2316892151955, 1768.2484943898792, 939.1406862720535, 1079.6976846482996, 1110.35044498969, 1138.385271953136, 1152.0898490192653, 5593.972030139905, 7042.260562640951, 7050.189228238715, 7072.222055573883, 7075.115610548682, 7592.240775922363, 7665.156832748393, 7681.61591920413, 7697.615119244016, 7733.883991740128, 7096.396806271525, 7099.2545782693105, 7104.644767761694, 7112.075430194145, 7125.394341480928, 3888.3778595424596, 4013.3177359848896, 4045.433639290443, 4055.4930633670792, 4057.229126465962, 6351.0, 6402.551821372553, 7966.6415011324625, 8052.396070294752, 8056.154103819014, 7864.0, 7879.881801772978, 7906.051273847175, 7907.841843163104, 7912.7339625659615, 6423.550351475352, 8010.5994700264755, 8013.6794528218215, 8019.599020048974, 8032.437729359006, 7336.119665640157, 7620.314171724572, 7650.885236721565, 7654.081510218809, 7665.195154508696, 6381.8723625528155, 7163.421168379484, 7499.212582678741, 7500.36246919018, 7501.737439189602, 6667.299933506912, 7709.498882572839, 7969.442139050211, 7975.282224599814, 7977.521348719096, 3941.9553818238765, 4757.119932812441, 4798.784054717616, 4807.759612019315, 4821.373221481325, 7272.0, 7535.321821036133, 7548.773536793905, 7558.395328373607, 7603.163651998165, 7291.744788932362, 7298.598577078312, 7304.5252058616015, 7321.0, 7330.303621155982, 7310.561366318038, 7313.634318284171, 7333.669984850588, 7334.0, 7356.154042285206, 7177.605231712306, 7181.06646135999, 7186.173590037212, 7186.60473673932, 7193.748218812317, 7056.6471676417, 7302.233265507045, 7319.670614822452, 7323.560586364835, 7335.119785625546, 6865.073215115895, 7007.0, 7019.894701579378, 7118.786436406916, 7125.714971401086], "unit": "score", "name": "prototype.html", "value": 5354.083178636067}, {"lowerIsBetter": false, "replicates": [708.0759608710633, 758.647229038497, 777.5334799120532, 795.014182413807, 801.3949468151545, 15196.544103676893, 15504.767428488567, 15515.379384824608, 15527.534173974771, 15531.37874485022, 11398.25911315766, 14716.424625690488, 14743.115413075224, 14857.0, 14864.256787160653, 759.290063790355, 810.4286478032973, 970.864079028933, 993.3741742702124, 993.4138858073735, 981.5484876956608, 982.0964712464549, 992.8659630949802, 993.3493561717087, 993.359283262299, 856.8586183279751, 1026.9794604107913, 1036.9637062702807, 1037.4086770540796, 1038.3043360948145, 858.8797568340437, 861.5347712235417, 1026.5585798106774, 1042.0777611813523, 1043.6816770884952, 770.8342706318113, 774.6707649249103, 775.4223103787658, 775.9456838021341, 776.0570906348813, 15602.907796454252, 15638.296276667577, 15670.294836732375, 15686.0, 15708.52874413758, 12945.676358091028, 13075.476980920752, 13127.343632818322, 13286.468541258435, 13639.103212277281, 10222.513348815957, 10251.692449226535, 10450.947745261301, 10602.416867072308, 11050.502727377287, 3589.7128229741556, 3590.407582748843, 3623.9275214495824, 3633.5458067741533, 3732.6267373262726, 76152.0, 76735.6163219186, 76954.0, 78963.0, 79367.0, 9705.417674939526, 9742.07450292221, 10055.245856560641, 10151.1371533419, 10263.897361026295, 23576.528469430516, 23576.7642323578, 23603.40991475227, 23630.527389452458, 23646.0, 7639.923600764032, 7734.729284475016, 7820.569868657165, 7930.920690793134, 8032.558209298428, 4254.595813397722, 4255.000074982377, 4274.0, 4318.870433886988, 4327.632151267115, 3624.7462677612843, 3659.579148397915, 3665.2119794244363, 3683.797391143513, 3685.1708365618056, 635.8569321902535, 639.7600899662626, 653.8038588423454, 655.9016147577902, 663.8705452436825, 545.6835035679296, 599.8123715044237, 602.5932495565476, 603.9250134760134, 611.6819253987901, 8457.118938823847, 8464.280536154496, 8510.276626486819, 8512.40413171072, 8654.394192406471, 595.3659352789352, 613.6348872420903, 615.0497481391261, 633.5881676909953, 634.2104080419815, 3768.453574231721, 3836.865709700147, 3920.3923391874305, 3947.4276229946495, 4027.6173763493007, 90408.0, 90820.0, 92086.53956730173, 92207.5389623061, 92357.53821230851, 77876.0, 78031.60984195156, 78242.21757782463, 78990.6050469744, 80427.0, 65821.6835663284, 66242.66878665576, 66384.0, 68493.65753171203, 69577.30422695809, 7847.058352997677, 7873.180739250479, 7916.0, 7956.5226086435, 7988.440809143304, 37391.0, 45684.40104596323, 46097.078058439314, 47653.0, 49265.014699706524, 50595.49404506055, 55078.72460637671, 58144.2556723299, 65011.34988650053, 67045.99431008636, 10412.947935260578, 10570.978785077026, 10708.464576771286, 10770.838437423601, 11382.601608943647, 10458.790824183321, 10587.523561439908, 10668.413237271714, 10854.782904342026, 10962.506687198937, 10109.747256318651, 10349.482525873525, 10519.474026298807, 10537.841932371173, 10968.122550195805, 10241.84637230457, 10466.529006194587, 10632.84050739255, 10817.783644327226, 11464.598739044093, 10127.139193168663, 10246.026627470379, 10261.9486902565, 10387.68836934893, 10735.0338469535, 9099.54502274897, 9122.452652840851, 9277.443353398548, 9302.581383837878, 9523.952365239957, 9175.724728258163, 9177.54112294396, 9224.953875230582, 9291.535423228675, 9395.577199026196], "unit": "score", "name": "yui.html", "value": 6934.288412236724}], "name": "dromaeo_css", "value": 7680.083191730185}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 110.0, 110.0, 112.0, 112.0, 121.0, 111.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [153.0, 118.0, 152.0, 150.0, 118.0, 138.0, 116.0, 149.0, 148.0, 100.0], "unit": "score", "name": "audio-beat-detection", "value": 134.2}, {"lowerIsBetter": true, "replicates": [182.0, 185.0, 183.0, 183.0, 183.0, 187.0, 184.0, 182.0, 186.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.7}, {"lowerIsBetter": true, "replicates": [73.0, 83.0, 72.0, 113.0, 55.0, 57.0, 56.0, 57.0, 121.0, 63.0], "unit": "score", "name": "audio-fft", "value": 75.0}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 124.0, 80.0, 78.0, 82.0, 115.0, 76.0, 77.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 87.0, 84.0, 86.0, 84.0, 87.0, 85.0, 87.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.5}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 92.0, 92.0, 107.0, 148.0, 94.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 99.6}, {"lowerIsBetter": true, "replicates": [109.0, 130.0, 132.0, 135.0, 85.0, 86.0, 85.0, 85.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 101.6}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 53.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 75.0, 72.0, 70.0, 69.0, 86.0, 93.0, 93.0, 77.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.0}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 81.0, 79.0, 95.0, 98.0, 103.0, 89.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [117.0, 128.0, 119.0, 115.0, 124.0, 126.0, 122.0, 126.0, 128.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.1}, {"lowerIsBetter": true, "replicates": [132.0, 122.0, 132.0, 132.0, 130.0, 155.0, 166.0, 144.0, 130.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.4}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 64.0, 67.0, 84.0, 92.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1434.5000000000002}]} 14:44:20 INFO - Return code: 0 14:44:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:44:20 INFO - # TBPL SUCCESS # 14:44:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:44:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:44:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:44:20 INFO - 2016-05-16 14:44:20.146 screenresolution[1685:10494] starting screenresolution argv=screenresolution get 14:44:20 INFO - 2016-05-16 14:44:20.149 screenresolution[1685:10494] Display 0: 1600x1200x32@60 14:44:20 INFO - 2016-05-16 14:44:20.155 screenresolution[1686:10497] starting screenresolution argv=screenresolution list 14:44:20 INFO - Available Modes on Display 0 14:44:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:44:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:44:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:44:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:44:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:44:20 INFO - Intel Iris: 14:44:20 INFO - Chipset Model: Intel Iris 14:44:20 INFO - Type: GPU 14:44:20 INFO - Bus: Built-In 14:44:20 INFO - VRAM (Dynamic, Max): 1536 MB 14:44:20 INFO - Vendor: Intel (0x8086) 14:44:20 INFO - Device ID: 0x0a2e 14:44:20 INFO - Revision ID: 0x0009 14:44:20 INFO - Displays: 14:44:20 INFO - Display: 14:44:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:44:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:44:20 INFO - Display Serial Number: 1600x1200 60 14:44:20 INFO - Main Display: Yes 14:44:20 INFO - Mirror: Off 14:44:20 INFO - Online: Yes 14:44:20 INFO - Rotation: Supported 14:44:20 INFO - Return code: 0 14:44:20 INFO - Running post-action listener: _resource_record_post_action 14:44:20 INFO - Running post-run listener: _resource_record_post_run 14:44:21 INFO - Total resource usage - Wall time: 1192s; CPU: 52.0%; Read bytes: 32484864; Write bytes: 511264256; Read time: 323; Write time: 1726 14:44:21 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198560256; Write bytes: 198133760; Read time: 17994; Write time: 394 14:44:21 INFO - run-tests - Wall time: 1170s; CPU: 52.0%; Read bytes: 30727680; Write bytes: 302337536; Read time: 306; Write time: 1298 14:44:21 INFO - Running post-run listener: _upload_blobber_files 14:44:21 INFO - Blob upload gear active. 14:44:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:44:21 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:44:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:44:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:23 INFO - (blobuploader) - INFO - Done attempting. 14:44:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:44:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:24 INFO - (blobuploader) - INFO - Done attempting. 14:44:24 INFO - (blobuploader) - INFO - Iteration through files over. 14:44:24 INFO - Return code: 0 14:44:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:44:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:44:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2eddcfc3180a6d51b54ae5a51817b78334191c1374fe0d41d17bb38b3f6ad9067a309208df634a3a35ac8aa3c99a2b5badefe2f3296de37fcc4a0d4ae2b23faa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a465e297513c58adc4e3502ab1391ef773e2f9a1f57aa08b168eae55f33c9eab5dc4dc9385711ba4b8d6c462f82f38213ac5d7001de468ff24581d25ffe61356"} 14:44:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:44:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:44:24 INFO - Contents: 14:44:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2eddcfc3180a6d51b54ae5a51817b78334191c1374fe0d41d17bb38b3f6ad9067a309208df634a3a35ac8aa3c99a2b5badefe2f3296de37fcc4a0d4ae2b23faa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a465e297513c58adc4e3502ab1391ef773e2f9a1f57aa08b168eae55f33c9eab5dc4dc9385711ba4b8d6c462f82f38213ac5d7001de468ff24581d25ffe61356"} 14:44:24 INFO - Running post-run listener: copy_logs_to_upload_dir 14:44:24 INFO - Copying logs to upload dir... 14:44:24 INFO - mkdir: /builds/slave/test/build/upload/logs 14:44:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.847055 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-05-16 14:44:24.516937) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 14:44:24.520400) ========= 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.H2gMqkB3zH/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.VegqCx43Yc/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2eddcfc3180a6d51b54ae5a51817b78334191c1374fe0d41d17bb38b3f6ad9067a309208df634a3a35ac8aa3c99a2b5badefe2f3296de37fcc4a0d4ae2b23faa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a465e297513c58adc4e3502ab1391ef773e2f9a1f57aa08b168eae55f33c9eab5dc4dc9385711ba4b8d6c462f82f38213ac5d7001de468ff24581d25ffe61356"} build_url:https://queue.taskcluster.net/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010969 build_url: 'https://queue.taskcluster.net/v1/task/I819YojcTomLSqIKZ3uOiA/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2eddcfc3180a6d51b54ae5a51817b78334191c1374fe0d41d17bb38b3f6ad9067a309208df634a3a35ac8aa3c99a2b5badefe2f3296de37fcc4a0d4ae2b23faa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a465e297513c58adc4e3502ab1391ef773e2f9a1f57aa08b168eae55f33c9eab5dc4dc9385711ba4b8d6c462f82f38213ac5d7001de468ff24581d25ffe61356"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 14:44:24.550437) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:44:24.550715) ========= 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.H2gMqkB3zH/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.VegqCx43Yc/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.005106 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:44:24.598424) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 14:44:24.598693) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 14:44:24.598974) ========= ========= Total master_lag: 0.49 =========