builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0059 starttime: 1467863123.61 results: success (0) buildid: 20160705080857 builduid: 2e83ae63cadd457d98f8b4a31ff72eac revision: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:23.605411) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:23.605866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:23.606139) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:23.630390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:23.630791) ========= 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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-06 20:45:23-- 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% 7.90M=0.001s 2016-07-06 20:45:23 (7.90 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119681 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:23.776137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:23.776706) ========= 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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.019811 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:23.827874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-06 20:45:23.828291) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 274a291aa2c85528ffeb988f0b1b0b61c12136b8 --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 274a291aa2c85528ffeb988f0b1b0b61c12136b8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-06 20:45:23,892 truncating revision to first 12 chars 2016-07-06 20:45:23,892 Setting DEBUG logging. 2016-07-06 20:45:23,892 attempt 1/10 2016-07-06 20:45:23,892 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/274a291aa2c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 20:45:25,631 unpacking tar archive at: mozilla-beta-274a291aa2c8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.991875 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-06 20:45:25.842725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:25.843058) ========= script_repo_revision: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:25.843462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:25.843797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 20:45:25.859576) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-06 20:45:25.859872) ========= /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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 20:45:26 INFO - MultiFileLogger online at 20160706 20:45:26 in /builds/slave/test 20:45:26 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 20:45:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:45:26 INFO - {'append_to_log': False, 20:45:26 INFO - 'base_work_dir': '/builds/slave/test', 20:45:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:45:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:45:26 INFO - 'branch': 'Mozilla-Beta', 20:45:26 INFO - 'buildbot_json_path': 'buildprops.json', 20:45:26 INFO - 'config_files': ('talos/mac_config.py',), 20:45:26 INFO - 'default_actions': ('clobber', 20:45:26 INFO - 'read-buildbot-config', 20:45:26 INFO - 'download-and-extract', 20:45:26 INFO - 'populate-webroot', 20:45:26 INFO - 'create-virtualenv', 20:45:26 INFO - 'install', 20:45:26 INFO - 'run-tests'), 20:45:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:45:26 INFO - 'download_minidump_stackwalk': True, 20:45:26 INFO - 'download_symbols': 'ondemand', 20:45:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:45:26 INFO - 'tooltool.py': '/tools/tooltool.py', 20:45:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:45:26 INFO - '/tools/misc-python/virtualenv.py')}, 20:45:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:45:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:45:26 INFO - 'installer_path': 'installer.exe', 20:45:26 INFO - 'log_level': 'info', 20:45:26 INFO - 'log_name': 'talos', 20:45:26 INFO - 'log_to_console': True, 20:45:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:45:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:45:26 INFO - 'opt_config_files': (), 20:45:26 INFO - 'pip_index': False, 20:45:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:45:26 INFO - 'cmd': ('bash', 20:45:26 INFO - '-c', 20:45:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:45:26 INFO - 'enabled': True, 20:45:26 INFO - 'halt_on_failure': False, 20:45:26 INFO - 'name': 'check_screen_resolution'},), 20:45:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:45:26 INFO - 'cmd': ('bash', 20:45:26 INFO - '-c', 20:45:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:45:26 INFO - 'enabled': True, 20:45:26 INFO - 'halt_on_failure': False, 20:45:26 INFO - 'name': 'check_screen_resolution'},), 20:45:26 INFO - 'run_cmd_checks_enabled': True, 20:45:26 INFO - 'sps_profile': False, 20:45:26 INFO - 'sps_profile_interval': 0, 20:45:26 INFO - 'suite': 'dromaeojs', 20:45:26 INFO - 'system_bits': '32', 20:45:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:45:26 INFO - 'title': 't-yosemite-r7-0059', 20:45:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:45:26 INFO - 'use_talos_json': True, 20:45:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:45:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:45:26 INFO - 'work_dir': 'build'} 20:45:26 INFO - ##### 20:45:26 INFO - ##### Running clobber step. 20:45:26 INFO - ##### 20:45:26 INFO - Running pre-action listener: _resource_record_pre_action 20:45:26 INFO - Running main action method: clobber 20:45:26 INFO - rmtree: /builds/slave/test/build 20:45:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:45:26 INFO - Running post-action listener: _resource_record_post_action 20:45:26 INFO - ##### 20:45:26 INFO - ##### Running read-buildbot-config step. 20:45:26 INFO - ##### 20:45:26 INFO - Running pre-action listener: _resource_record_pre_action 20:45:26 INFO - Running main action method: read_buildbot_config 20:45:26 INFO - Using buildbot properties: 20:45:26 INFO - { 20:45:26 INFO - "project": "", 20:45:26 INFO - "product": "firefox", 20:45:26 INFO - "script_repo_revision": "production", 20:45:26 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 20:45:26 INFO - "repository": "", 20:45:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 20:45:26 INFO - "buildid": "20160705080857", 20:45:26 INFO - "pgo_build": "False", 20:45:26 INFO - "basedir": "/builds/slave/test", 20:45:26 INFO - "buildnumber": 25, 20:45:26 INFO - "slavename": "t-yosemite-r7-0059", 20:45:26 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 20:45:26 INFO - "platform": "yosemite_r7", 20:45:26 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:45:26 INFO - "branch": "mozilla-beta", 20:45:26 INFO - "repo_path": "releases/mozilla-beta", 20:45:26 INFO - "revision": "274a291aa2c85528ffeb988f0b1b0b61c12136b8", 20:45:26 INFO - "stage_platform": "macosx64", 20:45:26 INFO - "builduid": "2e83ae63cadd457d98f8b4a31ff72eac", 20:45:26 INFO - "slavebuilddir": "test" 20:45:26 INFO - } 20:45:26 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.dmg. 20:45:26 INFO - Running post-action listener: _resource_record_post_action 20:45:26 INFO - ##### 20:45:26 INFO - ##### Running download-and-extract step. 20:45:26 INFO - ##### 20:45:26 INFO - Running pre-action listener: _resource_record_pre_action 20:45:26 INFO - Running main action method: download_and_extract 20:45:26 INFO - mkdir: /builds/slave/test/build/tests 20:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:45:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.test_packages.json 20:45:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 20:45:26 INFO - Downloaded 1165 bytes. 20:45:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:45:26 INFO - Using the following test package requirements: 20:45:26 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:45:26 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:45:26 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 20:45:26 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:45:26 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 20:45:26 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:45:26 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:45:26 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 20:45:26 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:45:26 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:45:26 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 20:45:26 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:45:26 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 20:45:26 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:45:26 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 20:45:26 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:45:26 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 20:45:26 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 20:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:45:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.common.tests.zip 20:45:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 20:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 20:45:26 INFO - Downloaded 18351407 bytes. 20:45:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:45:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:45:29 INFO - Return code: 0 20:45:29 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 20:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:45:29 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.common.tests.zip 20:45:29 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 20:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 20:45:30 INFO - Downloaded 18351407 bytes. 20:45:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:45:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:45:33 INFO - Return code: 0 20:45:33 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')]} 20:45:33 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.talos.tests.zip 20:45:33 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 20:45:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 20:45:33 INFO - Downloaded 10840145 bytes. 20:45:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:45:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 20:45:34 INFO - Return code: 0 20:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:45:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.dmg 20:45:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 20:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 20:45:41 INFO - Downloaded 86189668 bytes. 20:45:41 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.dmg 20:45:41 INFO - mkdir: /builds/slave/test/properties 20:45:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:45:41 INFO - Writing to file /builds/slave/test/properties/build_url 20:45:41 INFO - Contents: 20:45:41 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.dmg 20:45:41 INFO - Running post-action listener: _resource_record_post_action 20:45:41 INFO - Running post-action listener: set_extra_try_arguments 20:45:41 INFO - ##### 20:45:41 INFO - ##### Running populate-webroot step. 20:45:41 INFO - ##### 20:45:41 INFO - Running pre-action listener: _resource_record_pre_action 20:45:41 INFO - Running main action method: populate_webroot 20:45:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:45:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:45:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:45:41 INFO - '--tppagecycles', 20:45:41 INFO - '7'], 20:45:41 INFO - 'tests': ['tsvgm']}}, 20:45:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:45:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:45:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:45:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:45:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:45:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:45:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:41 INFO - 'talos_options': ['--disable-e10s'], 20:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:41 INFO - 'talos_options': ['--disable-e10s'], 20:45:41 INFO - 'tests': ['damp', 'tps']}, 20:45:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:41 INFO - 'tests': ['damp', 'tps']}, 20:45:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:45:41 INFO - 'tests': ['dromaeo_dom']}, 20:45:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:45:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:45:41 INFO - 'tests': ['a11yr', 20:45:41 INFO - 'ts_paint', 20:45:41 INFO - 'tpaint', 20:45:41 INFO - 'sessionrestore', 20:45:41 INFO - 'sessionrestore_no_auto_restore', 20:45:41 INFO - 'tabpaint']}, 20:45:41 INFO - 'other-e10s': {'tests': ['a11yr', 20:45:41 INFO - 'ts_paint', 20:45:41 INFO - 'tpaint', 20:45:41 INFO - 'sessionrestore', 20:45:41 INFO - 'sessionrestore_no_auto_restore', 20:45:41 INFO - 'tabpaint']}, 20:45:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:45:41 INFO - 'ts_paint', 20:45:41 INFO - 'tpaint', 20:45:41 INFO - 'sessionrestore', 20:45:41 INFO - 'sessionrestore_no_auto_restore', 20:45:41 INFO - 'tabpaint']}, 20:45:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:45:41 INFO - 'ts_paint', 20:45:41 INFO - 'tpaint', 20:45:41 INFO - 'sessionrestore', 20:45:41 INFO - 'sessionrestore_no_auto_restore', 20:45:41 INFO - 'tabpaint']}, 20:45:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:45:41 INFO - 'tests': ['a11yr', 20:45:41 INFO - 'ts_paint', 20:45:41 INFO - 'tpaint', 20:45:41 INFO - 'sessionrestore', 20:45:41 INFO - 'sessionrestore_no_auto_restore', 20:45:41 INFO - 'tabpaint']}, 20:45:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:45:41 INFO - 'tests': ['a11yr', 20:45:41 INFO - 'ts_paint', 20:45:41 INFO - 'tpaint', 20:45:41 INFO - 'sessionrestore', 20:45:41 INFO - 'sessionrestore_no_auto_restore', 20:45:41 INFO - 'tabpaint']}, 20:45:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:45:41 INFO - 'tests': ['tsvgx', 20:45:41 INFO - 'tsvgr_opacity', 20:45:41 INFO - 'tart', 20:45:41 INFO - 'tscrollx', 20:45:41 INFO - 'cart']}, 20:45:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:45:41 INFO - 'tsvgr_opacity', 20:45:41 INFO - 'tart', 20:45:41 INFO - 'tscrollx', 20:45:41 INFO - 'cart']}, 20:45:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:41 INFO - 'talos_options': ['--disable-e10s'], 20:45:41 INFO - 'tests': ['tp5o']}, 20:45:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:41 INFO - 'tests': ['tp5o']}, 20:45:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:41 INFO - 'talos_options': ['--disable-e10s', 20:45:41 INFO - '--xperf_path', 20:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:41 INFO - 'tests': ['tp5n']}, 20:45:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:41 INFO - 'talos_options': ['--xperf_path', 20:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:41 INFO - 'tests': ['tp5n']}}, 20:45:41 INFO - 'talos.zip': {'path': '', 20:45:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:45:41 INFO - Running post-action listener: _resource_record_post_action 20:45:41 INFO - ##### 20:45:41 INFO - ##### Running create-virtualenv step. 20:45:41 INFO - ##### 20:45:41 INFO - Running pre-action listener: _resource_record_pre_action 20:45:41 INFO - Running main action method: create_virtualenv 20:45:41 INFO - Creating virtualenv /builds/slave/test/build/venv 20:45:41 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 20:45:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:45:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:45:42 INFO - Using real prefix '/tools/python27' 20:45:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:45:42 INFO - Installing distribute.............................................................................................................................................................................................done. 20:45:45 INFO - Installing pip.................done. 20:45:45 INFO - Return code: 0 20:45:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:45: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')]} 20:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45: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')]} 20:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:45 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 0x101221a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101231420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde92da8290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010c0e00>, '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 0x100f29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbb20>, '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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 20:45:45 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 20:45:45 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 20:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg2ct6Wxkf/Render', 20:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:45 INFO - 'HOME': '/Users/cltbld', 20:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:45 INFO - 'LOGNAME': 'cltbld', 20:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:45 INFO - 'MOZ_NO_REMOTE': '1', 20:45:45 INFO - 'NO_EM_RESTART': '1', 20:45:45 INFO - 'PAGER': '/bin/cat', 20:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:45 INFO - 'PWD': '/builds/slave/test', 20:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:45 INFO - 'SHELL': '/bin/bash', 20:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zsbOL1hDmY/Listeners', 20:45:45 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 20:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:45 INFO - 'USER': 'cltbld', 20:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:45 INFO - 'XPC_FLAGS': '0x0', 20:45:45 INFO - 'XPC_SERVICE_NAME': '0', 20:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:45 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 20:45:45 INFO - Cleaning up... 20:45:45 INFO - Return code: 0 20:45:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:45: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')]} 20:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45: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')]} 20:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:45 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 0x101221a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101231420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde92da8290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010c0e00>, '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 0x100f29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbb20>, '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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 20:45:45 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 20:45:45 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 20:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg2ct6Wxkf/Render', 20:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:45 INFO - 'HOME': '/Users/cltbld', 20:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:45 INFO - 'LOGNAME': 'cltbld', 20:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:45 INFO - 'MOZ_NO_REMOTE': '1', 20:45:45 INFO - 'NO_EM_RESTART': '1', 20:45:45 INFO - 'PAGER': '/bin/cat', 20:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:45 INFO - 'PWD': '/builds/slave/test', 20:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:45 INFO - 'SHELL': '/bin/bash', 20:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zsbOL1hDmY/Listeners', 20:45:45 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 20:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:45 INFO - 'USER': 'cltbld', 20:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:45 INFO - 'XPC_FLAGS': '0x0', 20:45:45 INFO - 'XPC_SERVICE_NAME': '0', 20:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:46 INFO - Downloading/unpacking psutil>=0.7.1 20:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:45:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:49 INFO - Installing collected packages: psutil 20:45:49 INFO - Running setup.py install for psutil 20:45:49 INFO - building 'psutil._psutil_osx' extension 20:45:49 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 20:45:49 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 20:45:49 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 20:45:50 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 20:45:50 INFO - building 'psutil._psutil_posix' extension 20:45:50 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 20:45:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:45:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:45:50 INFO - ^ 20:45:50 INFO - 1 warning generated. 20:45:50 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 20:45:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:50 INFO - Successfully installed psutil 20:45:50 INFO - Cleaning up... 20:45:50 INFO - Return code: 0 20:45:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:45: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')]} 20:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45: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')]} 20:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:50 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 0x101221a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101231420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde92da8290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010c0e00>, '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 0x100f29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbb20>, '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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 20:45:50 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 20:45:50 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 20:45:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg2ct6Wxkf/Render', 20:45:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:50 INFO - 'HOME': '/Users/cltbld', 20:45:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:50 INFO - 'LOGNAME': 'cltbld', 20:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:50 INFO - 'MOZ_NO_REMOTE': '1', 20:45:50 INFO - 'NO_EM_RESTART': '1', 20:45:50 INFO - 'PAGER': '/bin/cat', 20:45:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:50 INFO - 'PWD': '/builds/slave/test', 20:45:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:50 INFO - 'SHELL': '/bin/bash', 20:45:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zsbOL1hDmY/Listeners', 20:45:50 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 20:45:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:50 INFO - 'USER': 'cltbld', 20:45:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:50 INFO - 'XPC_FLAGS': '0x0', 20:45:50 INFO - 'XPC_SERVICE_NAME': '0', 20:45:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:45:53 INFO - Installing collected packages: mozsystemmonitor 20:45:53 INFO - Running setup.py install for mozsystemmonitor 20:45:53 INFO - Successfully installed mozsystemmonitor 20:45:53 INFO - Cleaning up... 20:45:53 INFO - Return code: 0 20:45:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:53 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 0x101221a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101231420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde92da8290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010c0e00>, '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 0x100f29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbb20>, '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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 20:45:53 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 20:45:53 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 20:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg2ct6Wxkf/Render', 20:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:53 INFO - 'HOME': '/Users/cltbld', 20:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:53 INFO - 'LOGNAME': 'cltbld', 20:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:53 INFO - 'MOZ_NO_REMOTE': '1', 20:45:53 INFO - 'NO_EM_RESTART': '1', 20:45:53 INFO - 'PAGER': '/bin/cat', 20:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:53 INFO - 'PWD': '/builds/slave/test', 20:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:53 INFO - 'SHELL': '/bin/bash', 20:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zsbOL1hDmY/Listeners', 20:45:53 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 20:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:53 INFO - 'USER': 'cltbld', 20:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:53 INFO - 'XPC_FLAGS': '0x0', 20:45:53 INFO - 'XPC_SERVICE_NAME': '0', 20:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:53 INFO - Downloading/unpacking blobuploader==1.2.4 20:45:53 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 20:45:53 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 20:45:53 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 20:45:53 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 20:45:53 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 20:45:53 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 20:45:56 INFO - Downloading blobuploader-1.2.4.tar.gz 20:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:45:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:45: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 20:45: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 20:45: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 20:45: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 20:45: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 20:45: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 20:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:45:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:45: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 20:45: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 20:45: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 20:45: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 20:45: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 20:45: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 20:45:57 INFO - Downloading docopt-0.6.1.tar.gz 20:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:45:57 INFO - Installing collected packages: blobuploader, requests, docopt 20:45:57 INFO - Running setup.py install for blobuploader 20:45:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:45:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:45:57 INFO - Running setup.py install for requests 20:45:58 INFO - Running setup.py install for docopt 20:45:58 INFO - Successfully installed blobuploader requests docopt 20:45:58 INFO - Cleaning up... 20:45:58 INFO - Return code: 0 20:45:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:58 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 0x101221a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101231420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde92da8290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010c0e00>, '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 0x100f29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbb20>, '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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 20:45:58 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 20:45:58 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 20:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg2ct6Wxkf/Render', 20:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:58 INFO - 'HOME': '/Users/cltbld', 20:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:58 INFO - 'LOGNAME': 'cltbld', 20:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:58 INFO - 'MOZ_NO_REMOTE': '1', 20:45:58 INFO - 'NO_EM_RESTART': '1', 20:45:58 INFO - 'PAGER': '/bin/cat', 20:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:58 INFO - 'PWD': '/builds/slave/test', 20:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:58 INFO - 'SHELL': '/bin/bash', 20:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zsbOL1hDmY/Listeners', 20:45:58 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 20:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:58 INFO - 'USER': 'cltbld', 20:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:58 INFO - 'XPC_FLAGS': '0x0', 20:45:58 INFO - 'XPC_SERVICE_NAME': '0', 20:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:45:58 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-GG3pWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:45:58 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-i86HSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:45:58 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-87cK4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:45:58 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-r5WZyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:45:59 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-NdAREV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:45:59 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-u2Vz9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:45:59 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-vV2BBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:45:59 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-mdT2ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:45:59 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-KZ7TuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:45:59 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-OlkSfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:45:59 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-4CJbq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:45:59 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-uMspoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:45:59 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-SmWSeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:45:59 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-6P1kJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:00 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-ErWhiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:00 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-tgqm3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:00 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-h2oo8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:46:00 INFO - Running setup.py install for manifestparser 20:46:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:46:00 INFO - Running setup.py install for mozcrash 20:46:00 INFO - Running setup.py install for mozdebug 20:46:00 INFO - Running setup.py install for mozdevice 20:46:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:46:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:46:00 INFO - Running setup.py install for mozfile 20:46:01 INFO - Running setup.py install for mozhttpd 20:46:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:46:01 INFO - Running setup.py install for mozinfo 20:46:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:46:01 INFO - Running setup.py install for mozInstall 20:46:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:46:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:46:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:46:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:46:01 INFO - Running setup.py install for mozleak 20:46:01 INFO - Running setup.py install for mozlog 20:46:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:46:01 INFO - Running setup.py install for moznetwork 20:46:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Running setup.py install for mozprocess 20:46:02 INFO - Running setup.py install for mozprofile 20:46:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Running setup.py install for mozrunner 20:46:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Running setup.py install for mozscreenshot 20:46:02 INFO - Running setup.py install for moztest 20:46:02 INFO - Running setup.py install for mozversion 20:46:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:46:02 INFO - Cleaning up... 20:46:02 INFO - Return code: 0 20:46:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:02 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 0x101221a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101231420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde92da8290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010c0e00>, '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 0x100f29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbb20>, '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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 20:46:02 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 20:46:02 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 20:46:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg2ct6Wxkf/Render', 20:46:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:02 INFO - 'HOME': '/Users/cltbld', 20:46:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:02 INFO - 'LOGNAME': 'cltbld', 20:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:02 INFO - 'MOZ_NO_REMOTE': '1', 20:46:02 INFO - 'NO_EM_RESTART': '1', 20:46:02 INFO - 'PAGER': '/bin/cat', 20:46:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:02 INFO - 'PWD': '/builds/slave/test', 20:46:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:02 INFO - 'SHELL': '/bin/bash', 20:46:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zsbOL1hDmY/Listeners', 20:46:02 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 20:46:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:02 INFO - 'USER': 'cltbld', 20:46:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:02 INFO - 'XPC_FLAGS': '0x0', 20:46:02 INFO - 'XPC_SERVICE_NAME': '0', 20:46:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:46:03 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-eBgw6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:03 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)) 20:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:03 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-2PySkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:03 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)) 20:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:03 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-PiFPeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:03 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)) 20:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:03 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-8uyxn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:03 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)) 20:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:03 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-OY724b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:03 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)) 20:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:03 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-qcwGfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:03 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)) 20:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:03 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-As47KO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:46:03 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)) 20:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:46:03 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-QF4sWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:46:04 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)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:46:04 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-EujtKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:46:04 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)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:46:04 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-g6RUJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:46:04 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)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:46:04 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-dHLN5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:04 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)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:04 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-a5bi2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:04 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)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:04 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-CFxddo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:04 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)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:04 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-Tb4a6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:04 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)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:04 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-GlR2y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:04 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)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:04 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-OkX5hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:04 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)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:04 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-MT28H5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:05 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)) 20:46:05 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)) 20:46:05 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)) 20:46:05 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)) 20:46:05 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)) 20:46:05 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)) 20:46:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:46:05 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 20:46:05 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 20:46:05 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 20:46:05 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 20:46:05 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 20:46:05 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 20:46:07 INFO - Downloading blessings-1.6.tar.gz 20:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:46:07 INFO - Installing collected packages: blessings 20:46:07 INFO - Running setup.py install for blessings 20:46:07 INFO - Successfully installed blessings 20:46:07 INFO - Cleaning up... 20:46:07 INFO - Return code: 0 20:46:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:08 INFO - Reading from file tmpfile_stdout 20:46:08 INFO - Current package versions: 20:46:08 INFO - blessings == 1.6 20:46:08 INFO - blobuploader == 1.2.4 20:46:08 INFO - docopt == 0.6.1 20:46:08 INFO - manifestparser == 1.1 20:46:08 INFO - mozInstall == 1.12 20:46:08 INFO - mozcrash == 0.17 20:46:08 INFO - mozdebug == 0.1 20:46:08 INFO - mozdevice == 0.48 20:46:08 INFO - mozfile == 1.2 20:46:08 INFO - mozhttpd == 0.7 20:46:08 INFO - mozinfo == 0.9 20:46:08 INFO - mozleak == 0.1 20:46:08 INFO - mozlog == 3.1 20:46:08 INFO - moznetwork == 0.27 20:46:08 INFO - mozprocess == 0.22 20:46:08 INFO - mozprofile == 0.28 20:46:08 INFO - mozrunner == 6.11 20:46:08 INFO - mozscreenshot == 0.1 20:46:08 INFO - mozsystemmonitor == 0.0 20:46:08 INFO - moztest == 0.7 20:46:08 INFO - mozversion == 1.4 20:46:08 INFO - psutil == 3.1.1 20:46:08 INFO - requests == 1.2.3 20:46:08 INFO - wsgiref == 0.1.2 20:46:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46: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')]} 20:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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')]} 20:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:08 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 0x101221a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101231420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde92da8290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010c0e00>, '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 0x100f29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbb20>, '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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 20:46:08 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 20:46:08 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 20:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg2ct6Wxkf/Render', 20:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:08 INFO - 'HOME': '/Users/cltbld', 20:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:08 INFO - 'LOGNAME': 'cltbld', 20:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:08 INFO - 'MOZ_NO_REMOTE': '1', 20:46:08 INFO - 'NO_EM_RESTART': '1', 20:46:08 INFO - 'PAGER': '/bin/cat', 20:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:08 INFO - 'PWD': '/builds/slave/test', 20:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:08 INFO - 'SHELL': '/bin/bash', 20:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zsbOL1hDmY/Listeners', 20:46:08 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 20:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:08 INFO - 'USER': 'cltbld', 20:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:08 INFO - 'XPC_FLAGS': '0x0', 20:46:08 INFO - 'XPC_SERVICE_NAME': '0', 20:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:08 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)) 20:46:08 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)) 20:46:08 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)) 20:46:08 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)) 20:46:08 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)) 20:46:08 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)) 20:46:08 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)) 20:46:08 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)) 20:46:08 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)) 20:46:08 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)) 20:46:08 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)) 20:46:08 INFO - Cleaning up... 20:46:08 INFO - Return code: 0 20:46:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:46: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')]} 20:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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')]} 20:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101221a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101231420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde92da8290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010c0e00>, '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 0x100f29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbb20>, '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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 20:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg2ct6Wxkf/Render', 20:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:08 INFO - 'HOME': '/Users/cltbld', 20:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:08 INFO - 'LOGNAME': 'cltbld', 20:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:08 INFO - 'MOZ_NO_REMOTE': '1', 20:46:08 INFO - 'NO_EM_RESTART': '1', 20:46:08 INFO - 'PAGER': '/bin/cat', 20:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:08 INFO - 'PWD': '/builds/slave/test', 20:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:08 INFO - 'SHELL': '/bin/bash', 20:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zsbOL1hDmY/Listeners', 20:46:08 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 20:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:08 INFO - 'USER': 'cltbld', 20:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:08 INFO - 'XPC_FLAGS': '0x0', 20:46:08 INFO - 'XPC_SERVICE_NAME': '0', 20:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:08 INFO - Downloading/unpacking jsonschema 20:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:46:11 INFO - Downloading/unpacking functools32 (from jsonschema) 20:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:11 INFO - Downloading functools32-3.2.3-2.tar.gz 20:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:46:11 INFO - warning: no files found matching '*.txt' 20:46:11 INFO - no previously-included directories found matching 'build' 20:46:11 INFO - no previously-included directories found matching 'dist' 20:46:11 INFO - no previously-included directories found matching '.git*' 20:46:11 INFO - Installing collected packages: jsonschema, functools32 20:46:11 INFO - Running setup.py install for functools32 20:46:11 INFO - warning: no files found matching '*.txt' 20:46:11 INFO - no previously-included directories found matching 'build' 20:46:11 INFO - no previously-included directories found matching 'dist' 20:46:11 INFO - no previously-included directories found matching '.git*' 20:46:11 INFO - Successfully installed jsonschema functools32 20:46:11 INFO - Cleaning up... 20:46:11 INFO - Return code: 0 20:46:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101221a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101231420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde92da8290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010c0e00>, '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 0x100f29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbb20>, '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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 20:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:46:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg2ct6Wxkf/Render', 20:46:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:11 INFO - 'HOME': '/Users/cltbld', 20:46:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:11 INFO - 'LOGNAME': 'cltbld', 20:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:11 INFO - 'MOZ_NO_REMOTE': '1', 20:46:11 INFO - 'NO_EM_RESTART': '1', 20:46:11 INFO - 'PAGER': '/bin/cat', 20:46:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:11 INFO - 'PWD': '/builds/slave/test', 20:46:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:11 INFO - 'SHELL': '/bin/bash', 20:46:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zsbOL1hDmY/Listeners', 20:46:11 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 20:46:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:11 INFO - 'USER': 'cltbld', 20:46:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:11 INFO - 'XPC_FLAGS': '0x0', 20:46:11 INFO - 'XPC_SERVICE_NAME': '0', 20:46:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:12 INFO - Downloading/unpacking flake8 20:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:46:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:46:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:46:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:46:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:46:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:46:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:46:16 INFO - no previously-included directories found matching 'docs/_build' 20:46:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:46:16 INFO - Running setup.py install for pep8 20:46:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:46:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:46:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:46:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:46:16 INFO - no previously-included directories found matching 'docs/_build' 20:46:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:46:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:46:16 INFO - Cleaning up... 20:46:16 INFO - Return code: 0 20:46:16 INFO - Running post-action listener: _resource_record_post_action 20:46:16 INFO - Running post-action listener: _start_resource_monitoring 20:46:16 INFO - Starting resource monitoring. 20:46:16 INFO - ##### 20:46:16 INFO - ##### Running install step. 20:46:16 INFO - ##### 20:46:16 INFO - Running pre-action listener: _resource_record_pre_action 20:46:16 INFO - Running main action method: install 20:46:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:16 INFO - Reading from file tmpfile_stdout 20:46:16 INFO - Detecting whether we're running mozinstall >=1.0... 20:46:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:46:16 INFO - Reading from file tmpfile_stdout 20:46:16 INFO - Output received: 20:46:16 INFO - Usage: mozinstall [options] installer 20:46:16 INFO - Options: 20:46:16 INFO - -h, --help show this help message and exit 20:46:16 INFO - -d DEST, --destination=DEST 20:46:16 INFO - Directory to install application into. [default: 20:46:16 INFO - "/builds/slave/test"] 20:46:16 INFO - --app=APP Application being installed. [default: firefox] 20:46:16 INFO - mkdir: /builds/slave/test/build/application 20:46:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 20:46:38 INFO - Reading from file tmpfile_stdout 20:46:38 INFO - Output received: 20:46:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:46:38 INFO - Running post-action listener: _resource_record_post_action 20:46:38 INFO - ##### 20:46:38 INFO - ##### Running run-tests step. 20:46:38 INFO - ##### 20:46:38 INFO - Running pre-action listener: _resource_record_pre_action 20:46:38 INFO - Running main action method: run_tests 20:46:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:46:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:46:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:46:38 INFO - 2016-07-06 20:46:38.877 screenresolution[1996:277427] starting screenresolution argv=screenresolution get 20:46:38 INFO - 2016-07-06 20:46:38.880 screenresolution[1996:277427] Display 0: 1600x1200x32@60 20:46:38 INFO - 2016-07-06 20:46:38.886 screenresolution[1997:277430] starting screenresolution argv=screenresolution list 20:46:38 INFO - Available Modes on Display 0 20:46:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:46:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:46:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:46:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:46:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:46:39 INFO - Intel Iris: 20:46:39 INFO - Chipset Model: Intel Iris 20:46:39 INFO - Type: GPU 20:46:39 INFO - Bus: Built-In 20:46:39 INFO - VRAM (Dynamic, Max): 1536 MB 20:46:39 INFO - Vendor: Intel (0x8086) 20:46:39 INFO - Device ID: 0x0a2e 20:46:39 INFO - Revision ID: 0x0009 20:46:39 INFO - Displays: 20:46:39 INFO - Display: 20:46:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:46:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:46:39 INFO - Display Serial Number: 1600x1200 60 20:46:39 INFO - Main Display: Yes 20:46:39 INFO - Mirror: Off 20:46:39 INFO - Online: Yes 20:46:39 INFO - Rotation: Supported 20:46:39 INFO - Return code: 0 20:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:46:39 INFO - Python 2.7.3 20:46:39 INFO - Return code: 0 20:46:39 INFO - grabbing minidump binary from tooltool 20:46: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')]} 20:46:39 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 0x1010c0e00>, '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 0x100f29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:46:39 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 20:46:39 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 20:46:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:46:39 INFO - Return code: 0 20:46:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:46:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:46:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:46:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:46:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:46:40 INFO - Return code: 0 20:46:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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 20:46:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0059 --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 20:46:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg2ct6Wxkf/Render', 20:46:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:40 INFO - 'HOME': '/Users/cltbld', 20:46:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:40 INFO - 'LOGNAME': 'cltbld', 20:46:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:46:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:40 INFO - 'MOZ_NO_REMOTE': '1', 20:46:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:46:40 INFO - 'NO_EM_RESTART': '1', 20:46:40 INFO - 'PAGER': '/bin/cat', 20:46:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:40 INFO - 'PWD': '/builds/slave/test', 20:46:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:46:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:40 INFO - 'SHELL': '/bin/bash', 20:46:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zsbOL1hDmY/Listeners', 20:46:40 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 20:46:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:40 INFO - 'USER': 'cltbld', 20:46:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:40 INFO - 'XPC_FLAGS': '0x0', 20:46:40 INFO - 'XPC_SERVICE_NAME': '0', 20:46:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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 20:46:40 INFO - mozversion application_buildid: 20160705080857 20:46:40 INFO - mozversion application_changeset: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 20:46:40 INFO - mozversion application_display_name: Firefox 20:46:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:46:40 INFO - mozversion application_name: Firefox 20:46:40 INFO - mozversion application_remotingname: firefox 20:46:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:46:40 INFO - mozversion application_vendor: Mozilla 20:46:40 INFO - mozversion application_version: 48.0 20:46:40 INFO - mozversion platform_buildid: 20160705080857 20:46:40 INFO - mozversion platform_changeset: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 20:46:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:46:40 INFO - mozversion platform_version: 48.0 20:46:40 INFO - using testdate: 1467863200 20:46:40 INFO - actual date: 1467863200 20:46:40 INFO - starting webserver on 'localhost:49380' 20:46:40 INFO - SUITE-START | Running 2 tests 20:46:40 INFO - TEST-START | dromaeo_css 20:46:40 INFO - operating with platform_type : mac_ 20:46:40 INFO - Initialising browser for dromaeo_css test... 20:46:40 INFO - TEST-INFO | started process 2015 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmppp90VA/profile http://localhost:49380/getInfo.html) 20:46:42 INFO - PROCESS | 2015 | __metrics Screen width/height:1600/1200 20:46:42 INFO - PROCESS | 2015 | colorDepth:24 20:46:42 INFO - PROCESS | 2015 | Browser inner width/height: 1024/689 20:46:42 INFO - PROCESS | 2015 | __metrics 20:46:43 INFO - PROCESS | 2015 | 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" 20:46:43 ERROR - PROCESS | 2015 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:46:43 INFO - TEST-INFO | 2015: exit 0 20:46:43 INFO - Browser initialized. 20:46:43 INFO - Running cycle 1/1 for dromaeo_css test... 20:46:43 INFO - TEST-INFO | started process 2020 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmppp90VA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:46:55 INFO - PROCESS | 2020 | RSS: Main: 161742848 20:46:55 INFO - PROCESS | 2020 | 20:47:46 INFO - PROCESS | 2020 | 1467863266633 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] 20:49:56 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49380/tests/dromaeo/cssquery-ext.html) 20:49:57 INFO - PROCESS | 2020 | RSS: Main: 252989440 20:49:57 INFO - PROCESS | 2020 | 20:53:00 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49380/tests/dromaeo/cssquery-ext.html (next: http://localhost:49380/tests/dromaeo/cssquery-jquery.html) 20:53:00 INFO - PROCESS | 2020 | RSS: Main: 309882880 20:53:00 INFO - PROCESS | 2020 | 20:56:02 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49380/tests/dromaeo/cssquery-mootools.html) 20:56:03 INFO - PROCESS | 2020 | RSS: Main: 311652352 20:56:03 INFO - PROCESS | 2020 | 20:59:05 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49380/tests/dromaeo/cssquery-prototype.html) 20:59:05 INFO - PROCESS | 2020 | RSS: Main: 305799168 20:59:05 INFO - PROCESS | 2020 | 21:02:09 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49380/tests/dromaeo/cssquery-yui.html) 21:02:09 INFO - PROCESS | 2020 | RSS: Main: 270942208 21:02:09 INFO - PROCESS | 2020 | 21:05:12 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49380/tests/dromaeo/cssquery-yui.html (next: http://localhost:49380/tests/dromaeo/cssquery-dojo.html) 21:05:12 INFO - PROCESS | 2020 | RSS: Main: 315817984 21:05:12 INFO - PROCESS | 2020 | 21:05:12 INFO - PROCESS | 2020 | __start_tp_report 21:05:12 INFO - PROCESS | 2020 | _x_x_mozilla_page_load 21:05:12 INFO - PROCESS | 2020 | _x_x_mozilla_page_load_details 21:05:12 INFO - PROCESS | 2020 | |i|pagename|runs| 21:05:12 INFO - PROCESS | 2020 | |0;dojo.html;3532.540769699939;3595.658412450817;3616.1321282892113;3628.564572251332;3698.2048859495203;5880.411958804118;5900.3214630317525;5960.523158147349;5961.254843144607;5966.403359664031;5886.175935369041;5937.999999999989;5946.791862284821;5959.761609535624;5971.164037034819;5207.0887594670785;5287.788488460466;5334.279872217259;5359.464053594648;5400.29796126505;5421.9457805422035;5463.153211252262;5474.972625136888;5476.17857321403;5485.122380419134;5350.946490535103;5400.729963501809;5409.161579955094;5432.456754324556;5452.700101494416;5386;5408.45915408456;5409.161579955114;5417;5446.509814116748;5187;5226.92159617606;5320.17537281722;5349.5720342372515;5352.91970620441;5680.914786278209;5730.9426905730825;5751.539876809845;5758.049921762904;5779.566532510036;6253.093301471306;6298;6311.96844015777;6314.273858506284;6367.204099487564;6234.220722409699;6245.687715614246;6272.968635156795;6314;6322.304546499881;5993.760249589967;6000.219971403733;6002.159697642377;6002.189704389895;6041.516678665696;5385.761274906715;6458.451031662361;6460.870782584416;6476.060971159155;6479.8056058318325;6183.907241391383;6254.124422580842;6302.1177035215105;6319.210098737658;6372;6296.937030629727;6313.652749098752;6315.526335524854;6322.336154703782;6344.904826427607;6216.968915155486;6306.684665766693;6312.274088479883;6331.461825744863;6380.457661098859;6198.101275315054;6262.248530176408;6300.684965751694;6364.872702546016;6389.9680501597195;5018.071656743514;5047.091523525801;5053.823116190915;5068.695878247317;5074.594032477393;4490.989527356319;4506.301523263899;4512.5261847505535;4537.137943790669;4592.402987611589;5952.5833191676165;6032.438773430602;6052.303985041688;6073.331933487313;6110.29731580865;5048.974755126274;5678.432156784371;5977.345859193694;6240;6291.716872740738;6062.878742425127;6069.848253793691;6070.908936365958;6087.573869829158;6095.3904609538695;5450.863728406822;5465.480779325958;5518.641288316247;5550.750216240279;5569.610127291051;6503.25212600557;6569.934300657028;6612.8346791330605;6614.007898815216;6662.100616416722;5234.659747116425;6258.249010118815;6279.529035322278;6282.151909492343;6294.874102518015;6355.3326900674765;6483.124778155077;6539.280679125388;6552.1154644124335;6578.703958321791;6259.436650701458;6284.591501552384;6312.400321969406;6323.114763932961;6335.176427064452;6302.65335406557;6309.810705678837;6316.178896743394;6320.873582528416;6325.7153428094925;5244.842654720364;6181.690915454299;6210.627362358273;6299.559030867796;6311.842203944938;6326.272478665012;6343.365663433619;6350.7142178603;6351.650659213788;6351.872962540816;6208.534359923115;6234.906476402948;6237.376262373727;6237.407446292595;6243.843903902439;6168.383161683796;6244.812655620339;6250.312465628868;6301.117843502005;6313.779017734358;6240.032794916795;6240.157578726996;6254.781082662085;6260.154879091447;6271.592346497463 21:05:12 INFO - PROCESS | 2020 | |1;ext.html;522.2114606943516;553.4797290546883;592.2596754057427;602.5691630484203;626.4111734969129;32044.839775801116;32625.18437039075;32640.67359326406;32746.181345466317;32781;31831.52252716211;40559;40617.39073913894;40651.186976260455;40730;8183.9590802045905;9896.901030989706;9906.702798916043;9914.950425247864;9917.256205784559;9222.492762898039;9712.465814380206;9838.163756080741;9851.113399794018;11869.881301187008;9871.407715537054;11766.47050882708;11843;11847.466863991098;11866.466009029615;9799.657012004582;11836.88163118375;11847.763044739144;11847.992920601717;11854.288742675468;11524.423778811026;11585.884141158565;11645.592404265895;11646.475908584134;11651.533938642444;38502.42246366307;38681;38750;40706;40816.183676326604;3311.718503927169;3341.248219150696;3411.249525104473;3493.406120959443;3547.5565554305713;28411;28815.279618009718;29460.852695736598;30231;30648.846755766303;2740.657417822772;2775.084222206687;2777.125205560242;2847.2739451439957;2867.8709458074227;365203;365382;365415;365463;365492;36712.449313260324;37140.07149821276;37174.81412592974;57568.4243157563;58028.70985645045;35670.46494302587;36034.639653603655;36165;36171.819140904125;36179;15035.624109397353;15136.772948405784;15152.393904243927;15155.090694558361;15157.848421515864;13144.34278286101;13180.406881690347;13205.47178112884;13206.735865282833;13209.603711888658;7959;8084.070331911906;8088.676452941816;8099.757007289791;8389.706360277361;3527.3827080260853;3576.159602493412;3590.551181102362;3590.622984586581;3640.5631324241263;1003.6587560229557;1013.6062913493946;1017.1354348803605;1059.359087751899;1104.3981030338484;28908;29381.412371752445;29540.852295738812;30185;30249.09252722422;899.7840518275698;1124.2973141786383;1181.0374544746005;1182.8757980412106;1242.372601836067;13715;15032.513387131543;15897.52307430779;16037.199277567706;16133.193340332937;658945;668549;670340;671452;671629;55302.72348638312;55687.72156139193;60934.085988710205;63420.68289658614;64286.357136428036;1554.4792494514463;1555.5022392834185;1558.1196623907456;1567.3182165757703;1572.7798108264851;28178.29554261078;29332.853335733183;29410.705892940798;30061.248468788453;30127.849360753054;46528.302075468215;46762.532374675815;46762.532374675815;46780.7660961693;46963;443218;453841;454178;454417;454809;27454.588181177696;27838.443231134857;27841.860790695915;27885.581716273868;27915.720842791314;45915;47894.04211915672;47911.520884790705;49172.50827491679;49651.50348496613;35447.64552354546;35537;36573.817130914176;37143.814280928425;37364.6263537372;26181.869090655186;28522.57216141801;35917;36440;36567.63432365642;34241.65758342385;35386;36324.09189770277;36332.63667363292;36368.27263454769;32012;33091.172720682174;33243;33356;33596.66403336033;25015.749842501344;25229.621555676313;25390.873045634653;25525.87237063803;25850.61224081678 21:05:12 INFO - PROCESS | 2020 | |2;jquery.html;413.2561389498901;414.66205042890044;415.25876310785253;419.64539963730635;425.58718043497794;19148.234070637158;20573.279935202252;21135.894320528416;21275.14899404024;21333.35999920001;21008.05463754131;21187;22334.77665223347;22349.888250558724;22352.10591576339;5063.873403164914;6130.969345153268;6267.467265282434;6282.24613046435;6319.399657032574;6206.813795586139;6291.937080629204;6296.685165741695;6312.116303717483;6312.3372045934975;5965.254343207099;6257.874842503147;6264.718087686065;6266.780662676807;6268.185135932323;5920.79277225295;6137.7851775187655;6201.658908760016;6226.128342032119;6232.407921247452;6083.391660833925;6093.177421048191;6097.3597772233725;6103.084537319393;6104.26748790148;15121.319540620589;24953.5009299813;25126.748732512806;26264.080757173597;26300.21099367022;2269.863808171515;2325.174563030117;2369.2536850891915;2653.973460265392;2880.9916529214815;10464.581416743322;10568.313059651098;12118.939405302917;13000.479980800852;15706.214689265491;1829.7804263488333;1858.5353661584604;1871.4666320098706;1892.5647101166671;1906.5710215201468;120276;121807;122647;123290;126813;11848.407579621156;11904.107191960464;12067.939660301643;12180.81728774069;12285.754284914252;15725.764113538306;15740.92129539345;15773.526794196192;15773.763393549107;15797.68404631901;8756.605952732143;9093.090690930854;9131.315151363675;9187.678431254873;9245;7476.738314158978;9118.179363857285;9122.680706175252;9132.589033493508;9237.584308706124;3981.5222173338807;4751.904961900812;4833.637477189225;4888.291197776302;4914.599339188386;1995.1819753900832;2035.4809523571691;2037.8267847232855;2042.4893776555862;2046.8464865134877;887.6316328723508;958.2860768727343;990.2721499697716;1004.8492726090999;1059.903000394588;15755.212239387985;18637.90681046586;19707.40877773669;20304.28934987298;20621.58756824855;855.2132038524572;964.9228061755183;1007.5314978535016;1008.566316483919;1035.166690813887;10975.670729877957;11239.66281011571;11249.987501124939;11274;11285.37930413835;473044;478832;479183;539303;616818;121918.17122743165;123941;125795.37102314613;134603;139787;1034.6792494326783;1065.9786804263872;1069.9197560183018;1077.5097330714507;1078.4122653153893;18377;18645;18830.905845471232;19099.8090019098;19173.90413047926;34070.40049593273;48190.759046205945;54052.055383169754;54861.35415937369;55158.62103447285;79837;79890.00549972361;80014.59992699999;81180.5940970315;81217.59391203006;8348.457350272212;8349.206825351583;8397.832043358976;8434.367422443464;8776.517291549026;10131.442770647685;12874.098813082994;13111.344432778515;13419.932900335436;13446.865531344562;11204.551817927517;11541.653750387502;11775.76448471043;11836.82244766312;11879.287242765462;10492.160627149962;10516.211284153873;11185.888141118485;11388.430578471209;11718.062554995751;11657.650270491898;11724.648260552198;11775.823362649739;11958.760824783281;12309;8600.78498037554;8651.048384677555;8696.347773917108;8762.255208307366;8765.298776098025;8846.823063538823;11863.34751588671;11870.287782733063;12057.397130143283;12127.696807579528 21:05:12 INFO - PROCESS | 2020 | |3;mootools.html;1490.5230326295589;1622.326734405222;1647.7445995870642;1926.1139875657198;2034.8372130229584;8268.049174344944;8545.529995850233;8547.10255423181;8549.52977586234;8555.272801811845;8724.781880452992;8916.777080572989;8966.551672416386;8975.910240897589;8989.82020359594;2430.234476140019;2459.938501537458;2460.1143588308196;2461.6307553866973;2463.9137630182945;2079.948001299972;2468.0868078810777;2502.5245203411387;2511.61070034145;2511.660925775015;2501.69979602448;2509.6737424134926;2525.7095434025046;2545.325488745484;2546.821722479418;2500.0749722602663;2522.810789190818;2528.2288901884917;2536;2537.974620253792;2481.739417361169;2515.886785094675;2525.8231923765343;2527.9747202528106;2533.050106210171;9108.362414630978;9164.129407706258;9164.8625270621;9176;9215.262778977665;5561.138023606348;5572.60991730579;5720.113382425689;5726.3700992890745;5751.396103409165;3624.4382120771324;3692.7230457715777;3723.106454450912;3755.924881502382;3763.73653844231;1046.142163425991;1050.0969166516788;1086.1853609792656;1090.2695194219891;1098.1434481104752;12439;12512.499500019989;12512.81230781539;12513.186642868184;12544.937275313747;4098.856540021085;4575.839845605455;4827.951720482821;4828.275758636232;4861.562459378673;9557.952210238904;9643.228541716646;9657;9662.420254784736;9676.70969870891;5576.860578485489;5578.63738856973;5579.721013949367;5589.776408943597;5595.300587426572;4640.375868446017;4736.431628204568;4968.850934471971;5061.342025536656;5151.922721159186;3982.4623675803973;4015.799210039545;4078.225137223918;4091.1817636472824;4111.506619205715;1267.9683007924875;1273.8344015277955;1281.62192153315;1282.589571337163;1286.202554416249;956.9952150239204;968.1190116993503;972.9659461918941;993.4536005197112;1011.9407006741393;6107.908381374283;6142;6208.689565521796;6315.778947736899;6385.776497822647;477.6155195067934;487.70006446036143;495.97768100435565;501.56865096017395;503.25015726567153;4025.0943537703783;4094.1197642507004;4134.586541345841;4135.110951145518;4201.70588058833;10924.945375273073;11340.20618556693;11451.912068353493;11468.598599048993;11482.253653512495;9327.673531426368;11279.928406801504;11296.491657875415;11299.943500282447;11305.152113591514;8574.828503429897;8677.783055423664;8759.34304927133;8763.123687631314;8772.605232764414;4867.3915760529935;5859.5019423349495;5994.130851026664;6095.420935011167;6214.658193799384;7949.364050875801;9761.853572196565;9817.4600396976;9975.950120249352;9994;9872.851907221253;9923;10077.445740484343;10079.949600251952;10105.090541851268;7120.465965052538;7297.416206703557;7644.426668000034;7726.304632583095;7842.098158711821;8560.357973151915;8569.40014199025;8623.784405389915;8637.740867773977;8656.350773691873;6500.707468164039;7549.962250188714;7692.8461430772195;7747.147813740371;7798.454108212371;7569.924300757142;7588.658510367157;7597.050368703912;7667.808304792202;7743.760998240255;7161.57030578167;7227.2772722729405;7265.636718163965;7271.745488907863;7275.272472752682;4999.175136102503;5010.624203184849;5132.5124113209185;5156.664816787047;5230.11088115029;5040.319556859777;5088.542031217208;5145.264583727584;5145.485451454824;5257.447967963309 21:05:12 INFO - PROCESS | 2020 | |4;prototype.html;333.9382214290356;335.689303056616;344.71733178793386;350.98596056157754;351.9771214871033;5900.380460051697;6455.903161452582;6764.086848275481;6833.555818871776;6843.692033858482;6377.234731832186;6634.402903738663;6647.933520664792;6703.530752847302;6888.380045795878;4994.250862370655;5013.949860501385;5018.372703412074;5022.271770593262;5043.470435604255;5023.271625614284;5039.395272567297;5048.066107770074;5059.569936555397;5069.062223488666;4759.809607615709;4866.659333846632;4875.756212189394;4919.040787046527;4973.204287314031;4811.374521312225;4911.8772030699165;4912.656114072016;4918.262260660894;4948.7278199699;3499.422595271777;3687.6128006559193;4112.547619761824;4269.573042695737;4287.764172970486;6532.738690452376;6545.05096760967;6561.540692151551;6574.145361103026;6713.765018224339;5893.882122357529;5917.349091599964;5926.288845338587;5943.732532036069;5974.312954010301;5608.523275521545;6859.348361905611;6991.755288564927;7076;7094.11323584552;4220.493540775126;4479.3057076153245;4792.760361981887;4795.064962332347;4813.302071199656;6022.698865056774;6133.202683651141;7520.09758828944;7576.469647124703;7580.355669768076;4882.121218180761;4882.170031094723;4894.11905856942;4907.288443175719;4907.631927605444;4046.9392959105635;4965.677230979974;4966.701997880139;4968.22992436173;4989.975050124726;5702.9990246675325;5783.421657834183;5881.558883083786;5912.260967379078;5924.8815023700145;7116.181639111465;7145.1068616422945;7156.892646610305;7180.964095179491;7183.964080179566;1709;1744.1192197939959;1745.4763570928671;1746.9825301747073;1754.6929287374658;939.52553960251;1052.710504611238;1106.6403418888892;1128.4245035032193;1131.8585176852894;6687.465002799764;6760.763373281911;6944.930550694529;6952.165740111118;6956.513044086966;7477.588732619649;7486.925130748623;7487.625618719151;7495.138059123271;7500.099988001475;6900.482463815234;6916.827079322957;6925.168979722364;6939.93060069403;7090.716371345088;3812.504374431306;3917.0794863207125;3959.089409435846;3964.365701487806;3973;6292.276388215322;7874.763757087297;7890.763277101696;7893;8074.677012919417;7638.236176382317;7677.961610191914;7678.193789652118;7682.385409167253;7697.730579429693;7803.726869559651;7823.943767591302;7827.92172078272;7830.686772529263;7831.216878312123;7152.713891444284;7448.1807001228735;7454.329110380092;7485.026946496921;7513.098428188652;7308.451866110169;7331.156916954618;7369.115706115301;7386.815329616803;7410.147832999274;7908.920910790818;7911.604419778873;7911.683532658629;7914.722984695508;7935.880961785693;4728.0780247851335;4763.499832517536;4775.689580177277;4780.6414518911915;4785.066911952136;6041.395860413923;7177.2463891292755;7469.477136600386;7507.512011719221;7511.521198004754;5754.6547207167705;7206.89189662166;7223.422126229784;7262.273772622695;7286.089238845145;7237.493375463667;7237.963810180915;7242.96378518104;7251.057362542836;7258.0927384076995;7067.869140937425;7068.787936361918;7073.964630176816;7078.68145933424;7078.964605176941;6928.237893831775;7226.530275532284;7237.190702324418;7241.637918103968;7273.054502914587;6721.831954201184;6893.414059804973;6926.238113807376;7012.1935977363255;7142.321479459443 21:05:12 INFO - PROCESS | 2020 | |5;yui.html;646.1115965547373;682.9658517074151;700.8633316503282;718.8382613911871;726.2519604807051;15490.922545387271;15500.767488487681;15682.529524114267;15746.685066298667;15960.680786384266;14327.64180895478;14484.710305793878;14511.927440362784;14519.637009074779;14536.781948270784;793.9325157361632;943.3019565521499;951.1962391778935;951.6859436385976;954.8758661374029;799.4284086877881;945.3618807305076;983.6360546597733;984.9556769945369;986.6990567876795;1023.825949588568;1026.4457193115709;1028.1671845804885;1032.4528000159928;1033.2095946600857;815.0667485728867;1003.603576587244;1023.6263763726223;1024.0578667625764;1025.943573103479;775.5656832173944;775.7284950267361;776.2121446731516;776.5845272779093;778.5095389904324;13812.240326782023;14479.986400951937;15309.234538273042;15412.614684632861;15440.536783896388;12778.297193654345;12813;13022;13087.149335293176;13203.40584673692;10248.897511024868;10259.743506412326;10306.123979461754;10362.844557331646;10472.581096756121;3508.5965114011706;3544.7164226861787;3564.1624218308934;3584.17563960288;3649.1424515238896;84471.57764211201;86514;86666;86722;86769.13230867674;9479.715608531755;9606.711798646053;9722.562484688206;9913.950430247802;10084.394936303845;22288.442788930406;22533;22555.323340299816;22627.886860565923;22725.431864203198;6659.300773418721;7561.2060733623275;7612.200718924544;7627.656755446018;7940.841183176304;4100.6924480664065;4152.418661387408;4161.771102589387;4177.143685544456;4326.632236259953;3746.5691445484117;3781.1870447853844;3804.2771873343977;3818.007318097259;3823.8279277432584;670.2861452553016;675.152683382352;682.4847240333517;690.4752388185016;706.3184027413571;556.2240674259385;590.8020813027684;619.7211254935207;623.7193263031654;632.7310892870512;7664.425168112302;8301.709440169565;8346.081930987586;8479.406441549156;8511.106333834981;474.6582460628342;508.4229399631371;587.9941200587939;591.5120025978584;614.4531367083299;3737.9252414952093;3792.7724336539895;3839.6160383961937;3846.6921246776233;4014.0968282136287;79799.40401191944;80630;80706.59646701728;85181.14818851856;86087;70970.2902970974;71326.64336678387;78558;79046;79868.60065699635;65757.67121164364;66152.33847661654;66421;66740.6662966682;67079.66460167668;7629.38964882797;8021.87693722891;8437.325013998989;8485.448445851;8547.786305342168;30744;45036;45454.54545454635;48368.51631483781;48795.5120448791;65444.67277663581;68768;69166.30833691599;69817.65091174714;70291.64854175696;10840.45797710127;10985.560577577127;11055.889441105486;11276.985071343619;11435.59975400857;11726;12020;12055.638330850088;12248.938755306166;12389.318587477776;9707.854382184414;10025.74935626586;10618.991195836383;11788.941055294668;11863.169578129447;10980.945095274472;11299.548018079513;11382.203245772716;11551.133664975328;11670.299782013106;11480.540778369106;11486.770264594828;11585.710357241136;11637.53449861996;11708.88291117112;8165;9495.66765163216;9688.951555242178;9834.459104749021;9960.651377201762;9711.125998660154;9919;9950.800983980425;9959.402435853872;9974.102330790263 21:05:12 INFO - PROCESS | 2020 | __end_tp_report 21:05:12 INFO - PROCESS | 2020 | __start_cc_report 21:05:12 INFO - PROCESS | 2020 | _x_x_mozilla_cycle_collect,1188 21:05:12 INFO - PROCESS | 2020 | __end_cc_report 21:05:12 INFO - PROCESS | 2020 | __startTimestamp1467864312599__endTimestamp 21:05:12 INFO - PROCESS | 2020 | 21:05:12 INFO - PROCESS | 2020 | ------- Summary: start ------- 21:05:12 INFO - PROCESS | 2020 | Number of tests: 6 21:05:12 INFO - PROCESS | 2020 | 21:05:12 INFO - PROCESS | 2020 | [#0] dojo.html Cycles:165 Average:5883.74 Median:6181.69 stddev:632.13 (10.2%) stddev-sans-first:606.56 21:05:12 INFO - PROCESS | 2020 | Values: 3532.5 3595.7 3616.1 3628.6 3698.2 5880.4 5900.3 5960.5 5961.3 5966.4 5886.2 5938.0 5946.8 5959.8 5971.2 5207.1 5287.8 5334.3 5359.5 5400.3 5421.9 5463.2 5475.0 5476.2 5485.1 5350.9 5400.7 5409.2 5432.5 5452.7 5386.0 5408.5 5409.2 5417.0 5446.5 5187.0 5226.9 5320.2 5349.6 5352.9 5680.9 5730.9 5751.5 5758.0 5779.6 6253.1 6298.0 6312.0 6314.3 6367.2 6234.2 6245.7 6273.0 6314.0 6322.3 5993.8 6000.2 6002.2 6002.2 6041.5 5385.8 6458.5 6460.9 6476.1 6479.8 6183.9 6254.1 6302.1 6319.2 6372.0 6296.9 6313.7 6315.5 6322.3 6344.9 6217.0 6306.7 6312.3 6331.5 6380.5 6198.1 6262.2 6300.7 6364.9 6390.0 5018.1 5047.1 5053.8 5068.7 5074.6 4491.0 4506.3 4512.5 4537.1 4592.4 5952.6 6032.4 6052.3 6073.3 6110.3 5049.0 5678.4 5977.3 6240.0 6291.7 6062.9 6069.8 6070.9 6087.6 6095.4 5450.9 5465.5 5518.6 5550.8 5569.6 6503.3 6569.9 6612.8 6614.0 6662.1 5234.7 6258.2 6279.5 6282.2 6294.9 6355.3 6483.1 6539.3 6552.1 6578.7 6259.4 6284.6 6312.4 6323.1 6335.2 6302.7 6309.8 6316.2 6320.9 6325.7 5244.8 6181.7 6210.6 6299.6 6311.8 6326.3 6343.4 6350.7 6351.7 6351.9 6208.5 6234.9 6237.4 6237.4 6243.8 6168.4 6244.8 6250.3 6301.1 6313.8 6240.0 6240.2 6254.8 6260.2 6271.6 21:05:12 INFO - PROCESS | 2020 | 21:05:12 INFO - PROCESS | 2020 | [#1] ext.html Cycles:180 Average:62015.08 Median:3510.39 stddev:136989.50 (3902.4%) stddev-sans-first:137295.99 21:05:12 INFO - PROCESS | 2020 | Values: 522.2 553.5 592.3 602.6 626.4 32044.8 32625.2 32640.7 32746.2 32781.0 31831.5 40559.0 40617.4 40651.2 40730.0 8184.0 9896.9 9906.7 9915.0 9917.3 9222.5 9712.5 9838.2 9851.1 11869.9 9871.4 11766.5 11843.0 11847.5 11866.5 9799.7 11836.9 11847.8 11848.0 11854.3 11524.4 11585.9 11645.6 11646.5 11651.5 38502.4 38681.0 38750.0 40706.0 40816.2 3311.7 3341.2 3411.2 3493.4 3547.6 28411.0 28815.3 29460.9 30231.0 30648.8 2740.7 2775.1 2777.1 2847.3 2867.9 365203.0 365382.0 365415.0 365463.0 365492.0 36712.4 37140.1 37174.8 57568.4 58028.7 35670.5 36034.6 36165.0 36171.8 36179.0 15035.6 15136.8 15152.4 15155.1 15157.8 13144.3 13180.4 13205.5 13206.7 13209.6 7959.0 8084.1 8088.7 8099.8 8389.7 3527.4 3576.2 3590.6 3590.6 3640.6 1003.7 1013.6 1017.1 1059.4 1104.4 28908.0 29381.4 29540.9 30185.0 30249.1 899.8 1124.3 1181.0 1182.9 1242.4 13715.0 15032.5 15897.5 16037.2 16133.2 658945.0 668549.0 670340.0 671452.0 671629.0 55302.7 55687.7 60934.1 63420.7 64286.4 1554.5 1555.5 1558.1 1567.3 1572.8 28178.3 29332.9 29410.7 30061.2 30127.8 46528.3 46762.5 46762.5 46780.8 46963.0 443218.0 453841.0 454178.0 454417.0 454809.0 27454.6 27838.4 27841.9 27885.6 27915.7 45915.0 47894.0 47911.5 49172.5 49651.5 35447.6 35537.0 36573.8 37143.8 37364.6 26181.9 28522.6 35917.0 36440.0 36567.6 34241.7 35386.0 36324.1 36332.6 36368.3 32012.0 33091.2 33243.0 33356.0 33596.7 25015.7 25229.6 25390.9 25525.9 25850.6 21:05:12 INFO - PROCESS | 2020 | 21:05:12 INFO - PROCESS | 2020 | [#2] jquery.html Cycles:180 Average:33152.26 Median:21304.25 stddev:87828.85 (412.3%) stddev-sans-first:88040.83 21:05:12 INFO - PROCESS | 2020 | Values: 413.3 414.7 415.3 419.6 425.6 19148.2 20573.3 21135.9 21275.1 21333.4 21008.1 21187.0 22334.8 22349.9 22352.1 5063.9 6131.0 6267.5 6282.2 6319.4 6206.8 6291.9 6296.7 6312.1 6312.3 5965.3 6257.9 6264.7 6266.8 6268.2 5920.8 6137.8 6201.7 6226.1 6232.4 6083.4 6093.2 6097.4 6103.1 6104.3 15121.3 24953.5 25126.7 26264.1 26300.2 2269.9 2325.2 2369.3 2654.0 2881.0 10464.6 10568.3 12118.9 13000.5 15706.2 1829.8 1858.5 1871.5 1892.6 1906.6 120276.0 121807.0 122647.0 123290.0 126813.0 11848.4 11904.1 12067.9 12180.8 12285.8 15725.8 15740.9 15773.5 15773.8 15797.7 8756.6 9093.1 9131.3 9187.7 9245.0 7476.7 9118.2 9122.7 9132.6 9237.6 3981.5 4751.9 4833.6 4888.3 4914.6 1995.2 2035.5 2037.8 2042.5 2046.8 887.6 958.3 990.3 1004.8 1059.9 15755.2 18637.9 19707.4 20304.3 20621.6 855.2 964.9 1007.5 1008.6 1035.2 10975.7 11239.7 11250.0 11274.0 11285.4 473044.0 478832.0 479183.0 539303.0 616818.0 121918.2 123941.0 125795.4 134603.0 139787.0 1034.7 1066.0 1069.9 1077.5 1078.4 18377.0 18645.0 18830.9 19099.8 19173.9 34070.4 48190.8 54052.1 54861.4 55158.6 79837.0 79890.0 80014.6 81180.6 81217.6 8348.5 8349.2 8397.8 8434.4 8776.5 10131.4 12874.1 13111.3 13419.9 13446.9 11204.6 11541.7 11775.8 11836.8 11879.3 10492.2 10516.2 11185.9 11388.4 11718.1 11657.7 11724.6 11775.8 11958.8 12309.0 8600.8 8651.0 8696.3 8762.3 8765.3 8846.8 11863.3 11870.3 12057.4 12127.7 21:05:12 INFO - PROCESS | 2020 | 21:05:12 INFO - PROCESS | 2020 | [#3] mootools.html Cycles:180 Average:5850.44 Median:5074.94 stddev:3277.69 (64.6%) stddev-sans-first:3270.50 21:05:12 INFO - PROCESS | 2020 | Values: 1490.5 1622.3 1647.7 1926.1 2034.8 8268.0 8545.5 8547.1 8549.5 8555.3 8724.8 8916.8 8966.6 8975.9 8989.8 2430.2 2459.9 2460.1 2461.6 2463.9 2079.9 2468.1 2502.5 2511.6 2511.7 2501.7 2509.7 2525.7 2545.3 2546.8 2500.1 2522.8 2528.2 2536.0 2538.0 2481.7 2515.9 2525.8 2528.0 2533.1 9108.4 9164.1 9164.9 9176.0 9215.3 5561.1 5572.6 5720.1 5726.4 5751.4 3624.4 3692.7 3723.1 3755.9 3763.7 1046.1 1050.1 1086.2 1090.3 1098.1 12439.0 12512.5 12512.8 12513.2 12544.9 4098.9 4575.8 4828.0 4828.3 4861.6 9558.0 9643.2 9657.0 9662.4 9676.7 5576.9 5578.6 5579.7 5589.8 5595.3 4640.4 4736.4 4968.9 5061.3 5151.9 3982.5 4015.8 4078.2 4091.2 4111.5 1268.0 1273.8 1281.6 1282.6 1286.2 957.0 968.1 973.0 993.5 1011.9 6107.9 6142.0 6208.7 6315.8 6385.8 477.6 487.7 496.0 501.6 503.3 4025.1 4094.1 4134.6 4135.1 4201.7 10924.9 11340.2 11451.9 11468.6 11482.3 9327.7 11279.9 11296.5 11299.9 11305.2 8574.8 8677.8 8759.3 8763.1 8772.6 4867.4 5859.5 5994.1 6095.4 6214.7 7949.4 9761.9 9817.5 9976.0 9994.0 9872.9 9923.0 10077.4 10079.9 10105.1 7120.5 7297.4 7644.4 7726.3 7842.1 8560.4 8569.4 8623.8 8637.7 8656.4 6500.7 7550.0 7692.8 7747.1 7798.5 7569.9 7588.7 7597.1 7667.8 7743.8 7161.6 7227.3 7265.6 7271.7 7275.3 4999.2 5010.6 5132.5 5156.7 5230.1 5040.3 5088.5 5145.3 5145.5 5257.4 21:05:12 INFO - PROCESS | 2020 | 21:05:12 INFO - PROCESS | 2020 | [#4] prototype.html Cycles:180 Average:5889.09 Median:6708.65 stddev:1880.15 (28.0%) stddev-sans-first:1838.61 21:05:12 INFO - PROCESS | 2020 | Values: 333.9 335.7 344.7 351.0 352.0 5900.4 6455.9 6764.1 6833.6 6843.7 6377.2 6634.4 6647.9 6703.5 6888.4 4994.3 5013.9 5018.4 5022.3 5043.5 5023.3 5039.4 5048.1 5059.6 5069.1 4759.8 4866.7 4875.8 4919.0 4973.2 4811.4 4911.9 4912.7 4918.3 4948.7 3499.4 3687.6 4112.5 4269.6 4287.8 6532.7 6545.1 6561.5 6574.1 6713.8 5893.9 5917.3 5926.3 5943.7 5974.3 5608.5 6859.3 6991.8 7076.0 7094.1 4220.5 4479.3 4792.8 4795.1 4813.3 6022.7 6133.2 7520.1 7576.5 7580.4 4882.1 4882.2 4894.1 4907.3 4907.6 4046.9 4965.7 4966.7 4968.2 4990.0 5703.0 5783.4 5881.6 5912.3 5924.9 7116.2 7145.1 7156.9 7181.0 7184.0 1709.0 1744.1 1745.5 1747.0 1754.7 939.5 1052.7 1106.6 1128.4 1131.9 6687.5 6760.8 6944.9 6952.2 6956.5 7477.6 7486.9 7487.6 7495.1 7500.1 6900.5 6916.8 6925.2 6939.9 7090.7 3812.5 3917.1 3959.1 3964.4 3973.0 6292.3 7874.8 7890.8 7893.0 8074.7 7638.2 7678.0 7678.2 7682.4 7697.7 7803.7 7823.9 7827.9 7830.7 7831.2 7152.7 7448.2 7454.3 7485.0 7513.1 7308.5 7331.2 7369.1 7386.8 7410.1 7908.9 7911.6 7911.7 7914.7 7935.9 4728.1 4763.5 4775.7 4780.6 4785.1 6041.4 7177.2 7469.5 7507.5 7511.5 5754.7 7206.9 7223.4 7262.3 7286.1 7237.5 7238.0 7243.0 7251.1 7258.1 7067.9 7068.8 7074.0 7078.7 7079.0 6928.2 7226.5 7237.2 7241.6 7273.1 6721.8 6893.4 6926.2 7012.2 7142.3 21:05:12 INFO - PROCESS | 2020 | 21:05:12 INFO - PROCESS | 2020 | [#5] yui.html Cycles:180 Average:17971.44 Median:532.32 stddev:24870.33 (4672.0%) stddev-sans-first:24906.07 21:05:12 INFO - PROCESS | 2020 | Values: 646.1 683.0 700.9 718.8 726.3 15490.9 15500.8 15682.5 15746.7 15960.7 14327.6 14484.7 14511.9 14519.6 14536.8 793.9 943.3 951.2 951.7 954.9 799.4 945.4 983.6 985.0 986.7 1023.8 1026.4 1028.2 1032.5 1033.2 815.1 1003.6 1023.6 1024.1 1025.9 775.6 775.7 776.2 776.6 778.5 13812.2 14480.0 15309.2 15412.6 15440.5 12778.3 12813.0 13022.0 13087.1 13203.4 10248.9 10259.7 10306.1 10362.8 10472.6 3508.6 3544.7 3564.2 3584.2 3649.1 84471.6 86514.0 86666.0 86722.0 86769.1 9479.7 9606.7 9722.6 9914.0 10084.4 22288.4 22533.0 22555.3 22627.9 22725.4 6659.3 7561.2 7612.2 7627.7 7940.8 4100.7 4152.4 4161.8 4177.1 4326.6 3746.6 3781.2 3804.3 3818.0 3823.8 670.3 675.2 682.5 690.5 706.3 556.2 590.8 619.7 623.7 632.7 7664.4 8301.7 8346.1 8479.4 8511.1 474.7 508.4 588.0 591.5 614.5 3737.9 3792.8 3839.6 3846.7 4014.1 79799.4 80630.0 80706.6 85181.1 86087.0 70970.3 71326.6 78558.0 79046.0 79868.6 65757.7 66152.3 66421.0 66740.7 67079.7 7629.4 8021.9 8437.3 8485.4 8547.8 30744.0 45036.0 45454.5 48368.5 48795.5 65444.7 68768.0 69166.3 69817.7 70291.6 10840.5 10985.6 11055.9 11277.0 11435.6 11726.0 12020.0 12055.6 12248.9 12389.3 9707.9 10025.7 10619.0 11788.9 11863.2 10980.9 11299.5 11382.2 11551.1 11670.3 11480.5 11486.8 11585.7 11637.5 11708.9 8165.0 9495.7 9689.0 9834.5 9960.7 9711.1 9919.0 9950.8 9959.4 9974.1 21:05:12 INFO - PROCESS | 2020 | -------- Summary: end -------- 21:05:12 INFO - PROCESS | 2020 | 21:05:13 INFO - TEST-INFO | 2020: exit 0 21:05:13 INFO - TEST-OK | dromaeo_css | took 1112549ms 21:05:13 INFO - TEST-START | kraken 21:05:13 INFO - operating with platform_type : mac_ 21:05:13 INFO - Initialising browser for kraken test... 21:05:13 INFO - TEST-INFO | started process 2024 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpJbCnsT/profile http://localhost:49380/getInfo.html) 21:05:15 INFO - PROCESS | 2024 | __metrics Screen width/height:1600/1200 21:05:15 INFO - PROCESS | 2024 | colorDepth:24 21:05:15 INFO - PROCESS | 2024 | Browser inner width/height: 1024/689 21:05:15 INFO - PROCESS | 2024 | __metrics 21:05:15 INFO - PROCESS | 2024 | 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" 21:05:15 ERROR - PROCESS | 2024 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:05:15 INFO - TEST-INFO | 2024: exit 0 21:05:15 INFO - Browser initialized. 21:05:15 INFO - Running cycle 1/1 for kraken test... 21:05:15 INFO - TEST-INFO | started process 2028 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpJbCnsT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:05:27 INFO - PROCESS | 2028 | RSS: Main: 162226176 21:05:27 INFO - PROCESS | 2028 | 21:05:30 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49380/tests/kraken/driver.html?testName=audio-beat-detection) 21:05:31 INFO - PROCESS | 2028 | RSS: Main: 224575488 21:05:31 INFO - PROCESS | 2028 | 21:05:33 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49380/tests/kraken/driver.html?testName=audio-dft) 21:05:34 INFO - PROCESS | 2028 | RSS: Main: 239804416 21:05:34 INFO - PROCESS | 2028 | 21:05:37 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49380/tests/kraken/driver.html?testName=audio-fft) 21:05:38 INFO - PROCESS | 2028 | RSS: Main: 324526080 21:05:38 INFO - PROCESS | 2028 | 21:05:40 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49380/tests/kraken/driver.html?testName=audio-oscillator) 21:05:40 INFO - PROCESS | 2028 | RSS: Main: 230793216 21:05:40 INFO - PROCESS | 2028 | 21:05:43 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:05:43 INFO - PROCESS | 2028 | RSS: Main: 231206912 21:05:43 INFO - PROCESS | 2028 | 21:05:46 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49380/tests/kraken/driver.html?testName=imaging-darkroom) 21:05:47 INFO - PROCESS | 2028 | RSS: Main: 270888960 21:05:47 INFO - PROCESS | 2028 | 21:05:49 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49380/tests/kraken/driver.html?testName=imaging-desaturate) 21:05:50 INFO - PROCESS | 2028 | RSS: Main: 270897152 21:05:50 INFO - PROCESS | 2028 | 21:05:53 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49380/tests/kraken/driver.html?testName=json-parse-financial) 21:05:53 INFO - PROCESS | 2028 | RSS: Main: 269242368 21:05:53 INFO - PROCESS | 2028 | 21:05:55 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:05:55 INFO - PROCESS | 2028 | RSS: Main: 261115904 21:05:55 INFO - PROCESS | 2028 | 21:05:57 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49380/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:05:58 INFO - PROCESS | 2028 | RSS: Main: 268103680 21:05:58 INFO - PROCESS | 2028 | 21:06:00 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:06:01 INFO - PROCESS | 2028 | RSS: Main: 271458304 21:06:01 INFO - PROCESS | 2028 | 21:06:03 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:06:04 INFO - PROCESS | 2028 | RSS: Main: 278716416 21:06:04 INFO - PROCESS | 2028 | 21:06:07 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:06:08 INFO - PROCESS | 2028 | RSS: Main: 275906560 21:06:08 INFO - PROCESS | 2028 | 21:06:09 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:49380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49380/tests/kraken/driver.html?testName=ai-astar) 21:06:10 INFO - PROCESS | 2028 | RSS: Main: 337027072 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | __start_tp_report 21:06:10 INFO - PROCESS | 2028 | _x_x_mozilla_page_load 21:06:10 INFO - PROCESS | 2028 | _x_x_mozilla_page_load_details 21:06:10 INFO - PROCESS | 2028 | |i|pagename|runs| 21:06:10 INFO - PROCESS | 2028 | |0;ai-astar;113;114;122;114;112;111;112;115;112;134 21:06:10 INFO - PROCESS | 2028 | |1;audio-beat-detection;163;116;146;165;117;142;142;117;167;117 21:06:10 INFO - PROCESS | 2028 | |2;audio-dft;184;181;186;183;181;185;183;184;182;195 21:06:10 INFO - PROCESS | 2028 | |3;audio-fft;69;82;82;193;81;82;57;61;127;56 21:06:10 INFO - PROCESS | 2028 | |4;audio-oscillator;90;91;147;79;78;78;127;80;76;129 21:06:10 INFO - PROCESS | 2028 | |5;imaging-gaussian-blur;89;86;88;86;88;85;89;87;88;84 21:06:10 INFO - PROCESS | 2028 | |6;imaging-darkroom;93;93;93;94;91;93;93;93;93;93 21:06:10 INFO - PROCESS | 2028 | |7;imaging-desaturate;84;83;83;85;90;84;83;82;83;82 21:06:10 INFO - PROCESS | 2028 | |8;json-parse-financial;61;63;65;62;62;62;60;79;60;56 21:06:10 INFO - PROCESS | 2028 | |9;json-stringify-tinderbox;61;64;65;77;76;72;68;64;64;66 21:06:10 INFO - PROCESS | 2028 | |10;stanford-crypto-aes;79;79;76;79;80;79;79;80;80;83 21:06:10 INFO - PROCESS | 2028 | |11;stanford-crypto-ccm;124;124;128;147;143;140;135;112;174;170 21:06:10 INFO - PROCESS | 2028 | |12;stanford-crypto-pbkdf2;166;209;201;165;166;166;158;162;175;163 21:06:10 INFO - PROCESS | 2028 | |13;stanford-crypto-sha256-iterative;67;67;70;74;92;79;86;58;85;90 21:06:10 INFO - PROCESS | 2028 | __end_tp_report 21:06:10 INFO - PROCESS | 2028 | __start_cc_report 21:06:10 INFO - PROCESS | 2028 | _x_x_mozilla_cycle_collect,1923 21:06:10 INFO - PROCESS | 2028 | __end_cc_report 21:06:10 INFO - PROCESS | 2028 | __startTimestamp1467864370162__endTimestamp 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | ------- Summary: start ------- 21:06:10 INFO - PROCESS | 2028 | Number of tests: 14 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#0] ai-astar Cycles:10 Average:115.90 Median:114.00 stddev:7.08 (6.2%) stddev-sans-first:7.43 21:06:10 INFO - PROCESS | 2028 | Values: 113.0 114.0 122.0 114.0 112.0 111.0 112.0 115.0 112.0 134.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:144.00 stddev:21.30 (14.8%) stddev-sans-first:20.78 21:06:10 INFO - PROCESS | 2028 | Values: 163.0 116.0 146.0 165.0 117.0 142.0 142.0 117.0 167.0 117.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.00 stddev:4.06 (2.2%) stddev-sans-first:4.30 21:06:10 INFO - PROCESS | 2028 | Values: 184.0 181.0 186.0 183.0 181.0 185.0 183.0 184.0 182.0 195.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#3] audio-fft Cycles:10 Average:89.00 Median:75.00 stddev:41.86 (55.8%) stddev-sans-first:43.77 21:06:10 INFO - PROCESS | 2028 | Values: 69.0 82.0 82.0 193.0 81.0 82.0 57.0 61.0 127.0 56.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:78.50 stddev:26.42 (33.7%) stddev-sans-first:27.88 21:06:10 INFO - PROCESS | 2028 | Values: 90.0 91.0 147.0 79.0 78.0 78.0 127.0 80.0 76.0 129.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:1.70 (1.9%) stddev-sans-first:1.64 21:06:10 INFO - PROCESS | 2028 | Values: 89.0 86.0 88.0 86.0 88.0 85.0 89.0 87.0 88.0 84.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 21:06:10 INFO - PROCESS | 2028 | Values: 93.0 93.0 93.0 94.0 91.0 93.0 93.0 93.0 93.0 93.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:83.50 stddev:2.33 (2.8%) stddev-sans-first:2.47 21:06:10 INFO - PROCESS | 2028 | Values: 84.0 83.0 83.0 85.0 90.0 84.0 83.0 82.0 83.0 82.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:62.00 stddev:6.09 (9.8%) stddev-sans-first:6.42 21:06:10 INFO - PROCESS | 2028 | Values: 61.0 63.0 65.0 62.0 62.0 62.0 60.0 79.0 60.0 56.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:5.48 (8.2%) stddev-sans-first:5.25 21:06:10 INFO - PROCESS | 2028 | Values: 61.0 64.0 65.0 77.0 76.0 72.0 68.0 64.0 64.0 66.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.50 stddev:1.71 (2.2%) stddev-sans-first:1.81 21:06:10 INFO - PROCESS | 2028 | Values: 79.0 79.0 76.0 79.0 80.0 79.0 79.0 80.0 80.0 83.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:141.50 stddev:19.94 (14.1%) stddev-sans-first:20.32 21:06:10 INFO - PROCESS | 2028 | Values: 124.0 124.0 128.0 147.0 143.0 140.0 135.0 112.0 174.0 170.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:166.00 stddev:17.45 (10.5%) stddev-sans-first:18.32 21:06:10 INFO - PROCESS | 2028 | Values: 166.0 209.0 201.0 165.0 166.0 166.0 158.0 162.0 175.0 163.0 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - PROCESS | 2028 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:82.00 stddev:11.36 (13.9%) stddev-sans-first:11.48 21:06:10 INFO - PROCESS | 2028 | Values: 67.0 67.0 70.0 74.0 92.0 79.0 86.0 58.0 85.0 90.0 21:06:10 INFO - PROCESS | 2028 | -------- Summary: end -------- 21:06:10 INFO - PROCESS | 2028 | 21:06:10 INFO - TEST-INFO | 2028: exit 0 21:06:10 INFO - TEST-OK | kraken | took 57784ms 21:06:10 INFO - SUITE-END | took 1170s 21:06:11 INFO - Completed test suite (00:19:30) 21:06:11 INFO - javascript benchmark 21:06:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3532.540769699939, 3595.658412450817, 3616.1321282892113, 3628.564572251332, 3698.2048859495203, 5880.411958804118, 5900.3214630317525, 5960.523158147349, 5961.254843144607, 5966.403359664031, 5886.175935369041, 5937.999999999989, 5946.791862284821, 5959.761609535624, 5971.164037034819, 5207.0887594670785, 5287.788488460466, 5334.279872217259, 5359.464053594648, 5400.29796126505, 5421.9457805422035, 5463.153211252262, 5474.972625136888, 5476.17857321403, 5485.122380419134, 5350.946490535103, 5400.729963501809, 5409.161579955094, 5432.456754324556, 5452.700101494416, 5386.0, 5408.45915408456, 5409.161579955114, 5417.0, 5446.509814116748, 5187.0, 5226.92159617606, 5320.17537281722, 5349.5720342372515, 5352.91970620441, 5680.914786278209, 5730.9426905730825, 5751.539876809845, 5758.049921762904, 5779.566532510036, 6253.093301471306, 6298.0, 6311.96844015777, 6314.273858506284, 6367.204099487564, 6234.220722409699, 6245.687715614246, 6272.968635156795, 6314.0, 6322.304546499881, 5993.760249589967, 6000.219971403733, 6002.159697642377, 6002.189704389895, 6041.516678665696, 5385.761274906715, 6458.451031662361, 6460.870782584416, 6476.060971159155, 6479.8056058318325, 6183.907241391383, 6254.124422580842, 6302.1177035215105, 6319.210098737658, 6372.0, 6296.937030629727, 6313.652749098752, 6315.526335524854, 6322.336154703782, 6344.904826427607, 6216.968915155486, 6306.684665766693, 6312.274088479883, 6331.461825744863, 6380.457661098859, 6198.101275315054, 6262.248530176408, 6300.684965751694, 6364.872702546016, 6389.9680501597195, 5018.071656743514, 5047.091523525801, 5053.823116190915, 5068.695878247317, 5074.594032477393, 4490.989527356319, 4506.301523263899, 4512.5261847505535, 4537.137943790669, 4592.402987611589, 5952.5833191676165, 6032.438773430602, 6052.303985041688, 6073.331933487313, 6110.29731580865, 5048.974755126274, 5678.432156784371, 5977.345859193694, 6240.0, 6291.716872740738, 6062.878742425127, 6069.848253793691, 6070.908936365958, 6087.573869829158, 6095.3904609538695, 5450.863728406822, 5465.480779325958, 5518.641288316247, 5550.750216240279, 5569.610127291051, 6503.25212600557, 6569.934300657028, 6612.8346791330605, 6614.007898815216, 6662.100616416722, 5234.659747116425, 6258.249010118815, 6279.529035322278, 6282.151909492343, 6294.874102518015, 6355.3326900674765, 6483.124778155077, 6539.280679125388, 6552.1154644124335, 6578.703958321791, 6259.436650701458, 6284.591501552384, 6312.400321969406, 6323.114763932961, 6335.176427064452, 6302.65335406557, 6309.810705678837, 6316.178896743394, 6320.873582528416, 6325.7153428094925, 5244.842654720364, 6181.690915454299, 6210.627362358273, 6299.559030867796, 6311.842203944938, 6326.272478665012, 6343.365663433619, 6350.7142178603, 6351.650659213788, 6351.872962540816, 6208.534359923115, 6234.906476402948, 6237.376262373727, 6237.407446292595, 6243.843903902439, 6168.383161683796, 6244.812655620339, 6250.312465628868, 6301.117843502005, 6313.779017734358, 6240.032794916795, 6240.157578726996, 6254.781082662085, 6260.154879091447, 6271.592346497463], "value": 5846.398652785162, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.2114606943516, 553.4797290546883, 592.2596754057427, 602.5691630484203, 626.4111734969129, 32044.839775801116, 32625.18437039075, 32640.67359326406, 32746.181345466317, 32781.0, 31831.52252716211, 40559.0, 40617.39073913894, 40651.186976260455, 40730.0, 8183.9590802045905, 9896.901030989706, 9906.702798916043, 9914.950425247864, 9917.256205784559, 9222.492762898039, 9712.465814380206, 9838.163756080741, 9851.113399794018, 11869.881301187008, 9871.407715537054, 11766.47050882708, 11843.0, 11847.466863991098, 11866.466009029615, 9799.657012004582, 11836.88163118375, 11847.763044739144, 11847.992920601717, 11854.288742675468, 11524.423778811026, 11585.884141158565, 11645.592404265895, 11646.475908584134, 11651.533938642444, 38502.42246366307, 38681.0, 38750.0, 40706.0, 40816.183676326604, 3311.718503927169, 3341.248219150696, 3411.249525104473, 3493.406120959443, 3547.5565554305713, 28411.0, 28815.279618009718, 29460.852695736598, 30231.0, 30648.846755766303, 2740.657417822772, 2775.084222206687, 2777.125205560242, 2847.2739451439957, 2867.8709458074227, 365203.0, 365382.0, 365415.0, 365463.0, 365492.0, 36712.449313260324, 37140.07149821276, 37174.81412592974, 57568.4243157563, 58028.70985645045, 35670.46494302587, 36034.639653603655, 36165.0, 36171.819140904125, 36179.0, 15035.624109397353, 15136.772948405784, 15152.393904243927, 15155.090694558361, 15157.848421515864, 13144.34278286101, 13180.406881690347, 13205.47178112884, 13206.735865282833, 13209.603711888658, 7959.0, 8084.070331911906, 8088.676452941816, 8099.757007289791, 8389.706360277361, 3527.3827080260853, 3576.159602493412, 3590.551181102362, 3590.622984586581, 3640.5631324241263, 1003.6587560229557, 1013.6062913493946, 1017.1354348803605, 1059.359087751899, 1104.3981030338484, 28908.0, 29381.412371752445, 29540.852295738812, 30185.0, 30249.09252722422, 899.7840518275698, 1124.2973141786383, 1181.0374544746005, 1182.8757980412106, 1242.372601836067, 13715.0, 15032.513387131543, 15897.52307430779, 16037.199277567706, 16133.193340332937, 658945.0, 668549.0, 670340.0, 671452.0, 671629.0, 55302.72348638312, 55687.72156139193, 60934.085988710205, 63420.68289658614, 64286.357136428036, 1554.4792494514463, 1555.5022392834185, 1558.1196623907456, 1567.3182165757703, 1572.7798108264851, 28178.29554261078, 29332.853335733183, 29410.705892940798, 30061.248468788453, 30127.849360753054, 46528.302075468215, 46762.532374675815, 46762.532374675815, 46780.7660961693, 46963.0, 443218.0, 453841.0, 454178.0, 454417.0, 454809.0, 27454.588181177696, 27838.443231134857, 27841.860790695915, 27885.581716273868, 27915.720842791314, 45915.0, 47894.04211915672, 47911.520884790705, 49172.50827491679, 49651.50348496613, 35447.64552354546, 35537.0, 36573.817130914176, 37143.814280928425, 37364.6263537372, 26181.869090655186, 28522.57216141801, 35917.0, 36440.0, 36567.63432365642, 34241.65758342385, 35386.0, 36324.09189770277, 36332.63667363292, 36368.27263454769, 32012.0, 33091.172720682174, 33243.0, 33356.0, 33596.66403336033, 25015.749842501344, 25229.621555676313, 25390.873045634653, 25525.87237063803, 25850.61224081678], "value": 18500.328310440556, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.2561389498901, 414.66205042890044, 415.25876310785253, 419.64539963730635, 425.58718043497794, 19148.234070637158, 20573.279935202252, 21135.894320528416, 21275.14899404024, 21333.35999920001, 21008.05463754131, 21187.0, 22334.77665223347, 22349.888250558724, 22352.10591576339, 5063.873403164914, 6130.969345153268, 6267.467265282434, 6282.24613046435, 6319.399657032574, 6206.813795586139, 6291.937080629204, 6296.685165741695, 6312.116303717483, 6312.3372045934975, 5965.254343207099, 6257.874842503147, 6264.718087686065, 6266.780662676807, 6268.185135932323, 5920.79277225295, 6137.7851775187655, 6201.658908760016, 6226.128342032119, 6232.407921247452, 6083.391660833925, 6093.177421048191, 6097.3597772233725, 6103.084537319393, 6104.26748790148, 15121.319540620589, 24953.5009299813, 25126.748732512806, 26264.080757173597, 26300.21099367022, 2269.863808171515, 2325.174563030117, 2369.2536850891915, 2653.973460265392, 2880.9916529214815, 10464.581416743322, 10568.313059651098, 12118.939405302917, 13000.479980800852, 15706.214689265491, 1829.7804263488333, 1858.5353661584604, 1871.4666320098706, 1892.5647101166671, 1906.5710215201468, 120276.0, 121807.0, 122647.0, 123290.0, 126813.0, 11848.407579621156, 11904.107191960464, 12067.939660301643, 12180.81728774069, 12285.754284914252, 15725.764113538306, 15740.92129539345, 15773.526794196192, 15773.763393549107, 15797.68404631901, 8756.605952732143, 9093.090690930854, 9131.315151363675, 9187.678431254873, 9245.0, 7476.738314158978, 9118.179363857285, 9122.680706175252, 9132.589033493508, 9237.584308706124, 3981.5222173338807, 4751.904961900812, 4833.637477189225, 4888.291197776302, 4914.599339188386, 1995.1819753900832, 2035.4809523571691, 2037.8267847232855, 2042.4893776555862, 2046.8464865134877, 887.6316328723508, 958.2860768727343, 990.2721499697716, 1004.8492726090999, 1059.903000394588, 15755.212239387985, 18637.90681046586, 19707.40877773669, 20304.28934987298, 20621.58756824855, 855.2132038524572, 964.9228061755183, 1007.5314978535016, 1008.566316483919, 1035.166690813887, 10975.670729877957, 11239.66281011571, 11249.987501124939, 11274.0, 11285.37930413835, 473044.0, 478832.0, 479183.0, 539303.0, 616818.0, 121918.17122743165, 123941.0, 125795.37102314613, 134603.0, 139787.0, 1034.6792494326783, 1065.9786804263872, 1069.9197560183018, 1077.5097330714507, 1078.4122653153893, 18377.0, 18645.0, 18830.905845471232, 19099.8090019098, 19173.90413047926, 34070.40049593273, 48190.759046205945, 54052.055383169754, 54861.35415937369, 55158.62103447285, 79837.0, 79890.00549972361, 80014.59992699999, 81180.5940970315, 81217.59391203006, 8348.457350272212, 8349.206825351583, 8397.832043358976, 8434.367422443464, 8776.517291549026, 10131.442770647685, 12874.098813082994, 13111.344432778515, 13419.932900335436, 13446.865531344562, 11204.551817927517, 11541.653750387502, 11775.76448471043, 11836.82244766312, 11879.287242765462, 10492.160627149962, 10516.211284153873, 11185.888141118485, 11388.430578471209, 11718.062554995751, 11657.650270491898, 11724.648260552198, 11775.823362649739, 11958.760824783281, 12309.0, 8600.78498037554, 8651.048384677555, 8696.347773917108, 8762.255208307366, 8765.298776098025, 8846.823063538823, 11863.34751588671, 11870.287782733063, 12057.397130143283, 12127.696807579528], "value": 9902.696618275248, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.5230326295589, 1622.326734405222, 1647.7445995870642, 1926.1139875657198, 2034.8372130229584, 8268.049174344944, 8545.529995850233, 8547.10255423181, 8549.52977586234, 8555.272801811845, 8724.781880452992, 8916.777080572989, 8966.551672416386, 8975.910240897589, 8989.82020359594, 2430.234476140019, 2459.938501537458, 2460.1143588308196, 2461.6307553866973, 2463.9137630182945, 2079.948001299972, 2468.0868078810777, 2502.5245203411387, 2511.61070034145, 2511.660925775015, 2501.69979602448, 2509.6737424134926, 2525.7095434025046, 2545.325488745484, 2546.821722479418, 2500.0749722602663, 2522.810789190818, 2528.2288901884917, 2536.0, 2537.974620253792, 2481.739417361169, 2515.886785094675, 2525.8231923765343, 2527.9747202528106, 2533.050106210171, 9108.362414630978, 9164.129407706258, 9164.8625270621, 9176.0, 9215.262778977665, 5561.138023606348, 5572.60991730579, 5720.113382425689, 5726.3700992890745, 5751.396103409165, 3624.4382120771324, 3692.7230457715777, 3723.106454450912, 3755.924881502382, 3763.73653844231, 1046.142163425991, 1050.0969166516788, 1086.1853609792656, 1090.2695194219891, 1098.1434481104752, 12439.0, 12512.499500019989, 12512.81230781539, 12513.186642868184, 12544.937275313747, 4098.856540021085, 4575.839845605455, 4827.951720482821, 4828.275758636232, 4861.562459378673, 9557.952210238904, 9643.228541716646, 9657.0, 9662.420254784736, 9676.70969870891, 5576.860578485489, 5578.63738856973, 5579.721013949367, 5589.776408943597, 5595.300587426572, 4640.375868446017, 4736.431628204568, 4968.850934471971, 5061.342025536656, 5151.922721159186, 3982.4623675803973, 4015.799210039545, 4078.225137223918, 4091.1817636472824, 4111.506619205715, 1267.9683007924875, 1273.8344015277955, 1281.62192153315, 1282.589571337163, 1286.202554416249, 956.9952150239204, 968.1190116993503, 972.9659461918941, 993.4536005197112, 1011.9407006741393, 6107.908381374283, 6142.0, 6208.689565521796, 6315.778947736899, 6385.776497822647, 477.6155195067934, 487.70006446036143, 495.97768100435565, 501.56865096017395, 503.25015726567153, 4025.0943537703783, 4094.1197642507004, 4134.586541345841, 4135.110951145518, 4201.70588058833, 10924.945375273073, 11340.20618556693, 11451.912068353493, 11468.598599048993, 11482.253653512495, 9327.673531426368, 11279.928406801504, 11296.491657875415, 11299.943500282447, 11305.152113591514, 8574.828503429897, 8677.783055423664, 8759.34304927133, 8763.123687631314, 8772.605232764414, 4867.3915760529935, 5859.5019423349495, 5994.130851026664, 6095.420935011167, 6214.658193799384, 7949.364050875801, 9761.853572196565, 9817.4600396976, 9975.950120249352, 9994.0, 9872.851907221253, 9923.0, 10077.445740484343, 10079.949600251952, 10105.090541851268, 7120.465965052538, 7297.416206703557, 7644.426668000034, 7726.304632583095, 7842.098158711821, 8560.357973151915, 8569.40014199025, 8623.784405389915, 8637.740867773977, 8656.350773691873, 6500.707468164039, 7549.962250188714, 7692.8461430772195, 7747.147813740371, 7798.454108212371, 7569.924300757142, 7588.658510367157, 7597.050368703912, 7667.808304792202, 7743.760998240255, 7161.57030578167, 7227.2772722729405, 7265.636718163965, 7271.745488907863, 7275.272472752682, 4999.175136102503, 5010.624203184849, 5132.5124113209185, 5156.664816787047, 5230.11088115029, 5040.319556859777, 5088.542031217208, 5145.264583727584, 5145.485451454824, 5257.447967963309], "value": 4650.676136316165, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.9382214290356, 335.689303056616, 344.71733178793386, 350.98596056157754, 351.9771214871033, 5900.380460051697, 6455.903161452582, 6764.086848275481, 6833.555818871776, 6843.692033858482, 6377.234731832186, 6634.402903738663, 6647.933520664792, 6703.530752847302, 6888.380045795878, 4994.250862370655, 5013.949860501385, 5018.372703412074, 5022.271770593262, 5043.470435604255, 5023.271625614284, 5039.395272567297, 5048.066107770074, 5059.569936555397, 5069.062223488666, 4759.809607615709, 4866.659333846632, 4875.756212189394, 4919.040787046527, 4973.204287314031, 4811.374521312225, 4911.8772030699165, 4912.656114072016, 4918.262260660894, 4948.7278199699, 3499.422595271777, 3687.6128006559193, 4112.547619761824, 4269.573042695737, 4287.764172970486, 6532.738690452376, 6545.05096760967, 6561.540692151551, 6574.145361103026, 6713.765018224339, 5893.882122357529, 5917.349091599964, 5926.288845338587, 5943.732532036069, 5974.312954010301, 5608.523275521545, 6859.348361905611, 6991.755288564927, 7076.0, 7094.11323584552, 4220.493540775126, 4479.3057076153245, 4792.760361981887, 4795.064962332347, 4813.302071199656, 6022.698865056774, 6133.202683651141, 7520.09758828944, 7576.469647124703, 7580.355669768076, 4882.121218180761, 4882.170031094723, 4894.11905856942, 4907.288443175719, 4907.631927605444, 4046.9392959105635, 4965.677230979974, 4966.701997880139, 4968.22992436173, 4989.975050124726, 5702.9990246675325, 5783.421657834183, 5881.558883083786, 5912.260967379078, 5924.8815023700145, 7116.181639111465, 7145.1068616422945, 7156.892646610305, 7180.964095179491, 7183.964080179566, 1709.0, 1744.1192197939959, 1745.4763570928671, 1746.9825301747073, 1754.6929287374658, 939.52553960251, 1052.710504611238, 1106.6403418888892, 1128.4245035032193, 1131.8585176852894, 6687.465002799764, 6760.763373281911, 6944.930550694529, 6952.165740111118, 6956.513044086966, 7477.588732619649, 7486.925130748623, 7487.625618719151, 7495.138059123271, 7500.099988001475, 6900.482463815234, 6916.827079322957, 6925.168979722364, 6939.93060069403, 7090.716371345088, 3812.504374431306, 3917.0794863207125, 3959.089409435846, 3964.365701487806, 3973.0, 6292.276388215322, 7874.763757087297, 7890.763277101696, 7893.0, 8074.677012919417, 7638.236176382317, 7677.961610191914, 7678.193789652118, 7682.385409167253, 7697.730579429693, 7803.726869559651, 7823.943767591302, 7827.92172078272, 7830.686772529263, 7831.216878312123, 7152.713891444284, 7448.1807001228735, 7454.329110380092, 7485.026946496921, 7513.098428188652, 7308.451866110169, 7331.156916954618, 7369.115706115301, 7386.815329616803, 7410.147832999274, 7908.920910790818, 7911.604419778873, 7911.683532658629, 7914.722984695508, 7935.880961785693, 4728.0780247851335, 4763.499832517536, 4775.689580177277, 4780.6414518911915, 4785.066911952136, 6041.395860413923, 7177.2463891292755, 7469.477136600386, 7507.512011719221, 7511.521198004754, 5754.6547207167705, 7206.89189662166, 7223.422126229784, 7262.273772622695, 7286.089238845145, 7237.493375463667, 7237.963810180915, 7242.96378518104, 7251.057362542836, 7258.0927384076995, 7067.869140937425, 7068.787936361918, 7073.964630176816, 7078.68145933424, 7078.964605176941, 6928.237893831775, 7226.530275532284, 7237.190702324418, 7241.637918103968, 7273.054502914587, 6721.831954201184, 6893.414059804973, 6926.238113807376, 7012.1935977363255, 7142.321479459443], "value": 5264.82148718443, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.1115965547373, 682.9658517074151, 700.8633316503282, 718.8382613911871, 726.2519604807051, 15490.922545387271, 15500.767488487681, 15682.529524114267, 15746.685066298667, 15960.680786384266, 14327.64180895478, 14484.710305793878, 14511.927440362784, 14519.637009074779, 14536.781948270784, 793.9325157361632, 943.3019565521499, 951.1962391778935, 951.6859436385976, 954.8758661374029, 799.4284086877881, 945.3618807305076, 983.6360546597733, 984.9556769945369, 986.6990567876795, 1023.825949588568, 1026.4457193115709, 1028.1671845804885, 1032.4528000159928, 1033.2095946600857, 815.0667485728867, 1003.603576587244, 1023.6263763726223, 1024.0578667625764, 1025.943573103479, 775.5656832173944, 775.7284950267361, 776.2121446731516, 776.5845272779093, 778.5095389904324, 13812.240326782023, 14479.986400951937, 15309.234538273042, 15412.614684632861, 15440.536783896388, 12778.297193654345, 12813.0, 13022.0, 13087.149335293176, 13203.40584673692, 10248.897511024868, 10259.743506412326, 10306.123979461754, 10362.844557331646, 10472.581096756121, 3508.5965114011706, 3544.7164226861787, 3564.1624218308934, 3584.17563960288, 3649.1424515238896, 84471.57764211201, 86514.0, 86666.0, 86722.0, 86769.13230867674, 9479.715608531755, 9606.711798646053, 9722.562484688206, 9913.950430247802, 10084.394936303845, 22288.442788930406, 22533.0, 22555.323340299816, 22627.886860565923, 22725.431864203198, 6659.300773418721, 7561.2060733623275, 7612.200718924544, 7627.656755446018, 7940.841183176304, 4100.6924480664065, 4152.418661387408, 4161.771102589387, 4177.143685544456, 4326.632236259953, 3746.5691445484117, 3781.1870447853844, 3804.2771873343977, 3818.007318097259, 3823.8279277432584, 670.2861452553016, 675.152683382352, 682.4847240333517, 690.4752388185016, 706.3184027413571, 556.2240674259385, 590.8020813027684, 619.7211254935207, 623.7193263031654, 632.7310892870512, 7664.425168112302, 8301.709440169565, 8346.081930987586, 8479.406441549156, 8511.106333834981, 474.6582460628342, 508.4229399631371, 587.9941200587939, 591.5120025978584, 614.4531367083299, 3737.9252414952093, 3792.7724336539895, 3839.6160383961937, 3846.6921246776233, 4014.0968282136287, 79799.40401191944, 80630.0, 80706.59646701728, 85181.14818851856, 86087.0, 70970.2902970974, 71326.64336678387, 78558.0, 79046.0, 79868.60065699635, 65757.67121164364, 66152.33847661654, 66421.0, 66740.6662966682, 67079.66460167668, 7629.38964882797, 8021.87693722891, 8437.325013998989, 8485.448445851, 8547.786305342168, 30744.0, 45036.0, 45454.54545454635, 48368.51631483781, 48795.5120448791, 65444.67277663581, 68768.0, 69166.30833691599, 69817.65091174714, 70291.64854175696, 10840.45797710127, 10985.560577577127, 11055.889441105486, 11276.985071343619, 11435.59975400857, 11726.0, 12020.0, 12055.638330850088, 12248.938755306166, 12389.318587477776, 9707.854382184414, 10025.74935626586, 10618.991195836383, 11788.941055294668, 11863.169578129447, 10980.945095274472, 11299.548018079513, 11382.203245772716, 11551.133664975328, 11670.299782013106, 11480.540778369106, 11486.770264594828, 11585.710357241136, 11637.53449861996, 11708.88291117112, 8165.0, 9495.66765163216, 9688.951555242178, 9834.459104749021, 9960.651377201762, 9711.125998660154, 9919.0, 9950.800983980425, 9959.402435853872, 9974.102330790263], "value": 6973.641492833355, "unit": "score"}], "name": "dromaeo_css", "value": 7534.176084197562, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 122.0, 114.0, 112.0, 111.0, 112.0, 115.0, 112.0, 134.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 116.0, 146.0, 165.0, 117.0, 142.0, 142.0, 117.0, 167.0, 117.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 186.0, 183.0, 181.0, 185.0, 183.0, 184.0, 182.0, 195.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 82.0, 193.0, 81.0, 82.0, 57.0, 61.0, 127.0, 56.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 147.0, 79.0, 78.0, 78.0, 127.0, 80.0, 76.0, 129.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 88.0, 85.0, 89.0, 87.0, 88.0, 84.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 94.0, 91.0, 93.0, 93.0, 93.0, 93.0, 93.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 85.0, 90.0, 84.0, 83.0, 82.0, 83.0, 82.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 65.0, 62.0, 62.0, 62.0, 60.0, 79.0, 60.0, 56.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 65.0, 77.0, 76.0, 72.0, 68.0, 64.0, 64.0, 66.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 76.0, 79.0, 80.0, 79.0, 79.0, 80.0, 80.0, 83.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 128.0, 147.0, 143.0, 140.0, 135.0, 112.0, 174.0, 170.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 209.0, 201.0, 165.0, 166.0, 166.0, 158.0, 162.0, 175.0, 163.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 74.0, 92.0, 79.0, 86.0, 58.0, 85.0, 90.0], "value": 76.8, "unit": "score"}], "name": "kraken", "value": 1489.5, "alertThreshold": 2.0}]} 21:06:11 INFO - Return code: 0 21:06:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:06:11 ERROR - # TBPL SUCCESS # 21:06:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:06:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:06:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:06:11 INFO - 2016-07-06 21:06:11.416 screenresolution[2032:279441] starting screenresolution argv=screenresolution get 21:06:11 INFO - 2016-07-06 21:06:11.418 screenresolution[2032:279441] Display 0: 1600x1200x32@60 21:06:11 INFO - 2016-07-06 21:06:11.424 screenresolution[2033:279443] starting screenresolution argv=screenresolution list 21:06:11 INFO - Available Modes on Display 0 21:06:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:06:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:06:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:06:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:06:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:06:11 INFO - Intel Iris: 21:06:11 INFO - Chipset Model: Intel Iris 21:06:11 INFO - Type: GPU 21:06:11 INFO - Bus: Built-In 21:06:11 INFO - VRAM (Dynamic, Max): 1536 MB 21:06:11 INFO - Vendor: Intel (0x8086) 21:06:11 INFO - Device ID: 0x0a2e 21:06:11 INFO - Revision ID: 0x0009 21:06:11 INFO - Displays: 21:06:11 INFO - Display: 21:06:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:06:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:06:11 INFO - Display Serial Number: 1600x1200 60 21:06:11 INFO - Main Display: Yes 21:06:11 INFO - Mirror: Off 21:06:11 INFO - Online: Yes 21:06:11 INFO - Rotation: Supported 21:06:11 INFO - Return code: 0 21:06:11 INFO - Running post-action listener: _resource_record_post_action 21:06:11 INFO - Running post-run listener: _resource_record_post_run 21:06:12 INFO - Total resource usage - Wall time: 1194s; CPU: 52.0%; Read bytes: 9445376; Write bytes: 492459008; Read time: 84; Write time: 1707 21:06:12 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 189006336; Write bytes: 184766464; Read time: 17542; Write time: 375 21:06:12 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 9420800; Write bytes: 295001600; Read time: 83; Write time: 1276 21:06:12 INFO - Running post-run listener: _upload_blobber_files 21:06:12 INFO - Blob upload gear active. 21:06:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:06:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:06:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:06:13 INFO - (blobuploader) - INFO - Open directory for files ... 21:06:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:06:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:06:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:13 INFO - (blobuploader) - INFO - Done attempting. 21:06:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:06:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:06:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:14 INFO - (blobuploader) - INFO - Done attempting. 21:06:14 INFO - (blobuploader) - INFO - Iteration through files over. 21:06:14 INFO - Return code: 0 21:06:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:06:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:06:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b57e2983787735dabedd9c7ea30cdc3ff985af00d48a0de2e84299c5191ea8b48ceea3835774b657647e5c96453c3bba2996c6bbcd2d922709c1bce2dd1c45a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3d1d536441c102dca085da48f2862d0c9ef4a7649d217d1d09fa4aab2aa0fae984b0a32a21752fc0cb07f0c2f2fd811bf571e335f44b5f2e79f5ffbd23bed56"} 21:06:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:06:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:06:14 INFO - Contents: 21:06:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b57e2983787735dabedd9c7ea30cdc3ff985af00d48a0de2e84299c5191ea8b48ceea3835774b657647e5c96453c3bba2996c6bbcd2d922709c1bce2dd1c45a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3d1d536441c102dca085da48f2862d0c9ef4a7649d217d1d09fa4aab2aa0fae984b0a32a21752fc0cb07f0c2f2fd811bf571e335f44b5f2e79f5ffbd23bed56"} 21:06:14 INFO - Running post-run listener: copy_logs_to_upload_dir 21:06:14 INFO - Copying logs to upload dir... 21:06:14 INFO - mkdir: /builds/slave/test/build/upload/logs 21:06:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.855543 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-06 21:06:14.756000) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 21:06:14.759110) ========= 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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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/3b57e2983787735dabedd9c7ea30cdc3ff985af00d48a0de2e84299c5191ea8b48ceea3835774b657647e5c96453c3bba2996c6bbcd2d922709c1bce2dd1c45a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3d1d536441c102dca085da48f2862d0c9ef4a7649d217d1d09fa4aab2aa0fae984b0a32a21752fc0cb07f0c2f2fd811bf571e335f44b5f2e79f5ffbd23bed56"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011196 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731337/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b57e2983787735dabedd9c7ea30cdc3ff985af00d48a0de2e84299c5191ea8b48ceea3835774b657647e5c96453c3bba2996c6bbcd2d922709c1bce2dd1c45a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3d1d536441c102dca085da48f2862d0c9ef4a7649d217d1d09fa4aab2aa0fae984b0a32a21752fc0cb07f0c2f2fd811bf571e335f44b5f2e79f5ffbd23bed56"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 21:06:14.792498) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 21:06:14.792849) ========= 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.Kg2ct6Wxkf/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.zsbOL1hDmY/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005204 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 21:06:14.843383) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 21:06:14.843833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 21:06:14.844164) ========= ========= Total master_lag: 0.19 =========