builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0345 starttime: 1467621062.43 results: success (0) buildid: 20160703183557 builduid: 8283a6f125df40c2ae12696b987fc37e revision: 344a25a1f2697c963321fe204c688d1e76a7cc01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:02.427105) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:02.428077) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:02.428835) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:02.653199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:02.653525) ========= 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.maELa5AwdE/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.6NPLIgVaQH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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-04 01:31:02-- 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% 12.9M=0.001s 2016-07-04 01:31:02 (12.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131346 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:02.831657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:02.831937) ========= 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.maELa5AwdE/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.6NPLIgVaQH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.020650 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:02.935552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 01:31:02.936298) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 344a25a1f2697c963321fe204c688d1e76a7cc01 --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 344a25a1f2697c963321fe204c688d1e76a7cc01 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.maELa5AwdE/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.6NPLIgVaQH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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-04 01:31:02,997 truncating revision to first 12 chars 2016-07-04 01:31:02,997 Setting DEBUG logging. 2016-07-04 01:31:02,997 attempt 1/10 2016-07-04 01:31:02,997 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/344a25a1f269?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 01:31:04,375 unpacking tar archive at: mozilla-beta-344a25a1f269/testing/mozharness/ program finished with exit code 0 elapsedTime=1.644789 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 01:31:04.604670) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:04.605055) ========= script_repo_revision: 344a25a1f2697c963321fe204c688d1e76a7cc01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:04.605514) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:04.605849) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 01:31:04.624134) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-04 01:31:04.624499) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.maELa5AwdE/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.6NPLIgVaQH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 01:31:04 INFO - MultiFileLogger online at 20160704 01:31:04 in /builds/slave/test 01:31:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:31:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:31:04 INFO - {'append_to_log': False, 01:31:04 INFO - 'base_work_dir': '/builds/slave/test', 01:31:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:31:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:31:04 INFO - 'branch': 'Mozilla-Beta', 01:31:04 INFO - 'buildbot_json_path': 'buildprops.json', 01:31:04 INFO - 'config_files': ('talos/mac_config.py',), 01:31:04 INFO - 'default_actions': ('clobber', 01:31:04 INFO - 'read-buildbot-config', 01:31:04 INFO - 'download-and-extract', 01:31:04 INFO - 'populate-webroot', 01:31:04 INFO - 'create-virtualenv', 01:31:04 INFO - 'install', 01:31:04 INFO - 'run-tests'), 01:31:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:31:04 INFO - 'download_minidump_stackwalk': True, 01:31:04 INFO - 'download_symbols': 'ondemand', 01:31:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:31:04 INFO - 'tooltool.py': '/tools/tooltool.py', 01:31:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:31:04 INFO - '/tools/misc-python/virtualenv.py')}, 01:31:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:31:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:31:04 INFO - 'installer_path': 'installer.exe', 01:31:04 INFO - 'log_level': 'info', 01:31:04 INFO - 'log_name': 'talos', 01:31:04 INFO - 'log_to_console': True, 01:31:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:31:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:31:04 INFO - 'opt_config_files': (), 01:31:04 INFO - 'pip_index': False, 01:31:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:31:04 INFO - 'cmd': ('bash', 01:31:04 INFO - '-c', 01:31:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:31:04 INFO - 'enabled': True, 01:31:04 INFO - 'halt_on_failure': False, 01:31:04 INFO - 'name': 'check_screen_resolution'},), 01:31:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:31:04 INFO - 'cmd': ('bash', 01:31:04 INFO - '-c', 01:31:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:31:04 INFO - 'enabled': True, 01:31:04 INFO - 'halt_on_failure': False, 01:31:04 INFO - 'name': 'check_screen_resolution'},), 01:31:04 INFO - 'run_cmd_checks_enabled': True, 01:31:04 INFO - 'sps_profile': False, 01:31:04 INFO - 'sps_profile_interval': 0, 01:31:04 INFO - 'suite': 'dromaeojs-e10s', 01:31:04 INFO - 'system_bits': '32', 01:31:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:31:04 INFO - 'title': 't-yosemite-r7-0345', 01:31:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:31:04 INFO - 'use_talos_json': True, 01:31:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:31:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:31:04 INFO - 'work_dir': 'build'} 01:31:04 INFO - ##### 01:31:04 INFO - ##### Running clobber step. 01:31:04 INFO - ##### 01:31:04 INFO - Running pre-action listener: _resource_record_pre_action 01:31:04 INFO - Running main action method: clobber 01:31:04 INFO - rmtree: /builds/slave/test/build 01:31:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:31:05 INFO - Running post-action listener: _resource_record_post_action 01:31:05 INFO - ##### 01:31:05 INFO - ##### Running read-buildbot-config step. 01:31:05 INFO - ##### 01:31:05 INFO - Running pre-action listener: _resource_record_pre_action 01:31:05 INFO - Running main action method: read_buildbot_config 01:31:05 INFO - Using buildbot properties: 01:31:05 INFO - { 01:31:05 INFO - "project": "", 01:31:05 INFO - "product": "firefox", 01:31:05 INFO - "script_repo_revision": "production", 01:31:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 01:31:05 INFO - "repository": "", 01:31:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 01:31:05 INFO - "buildid": "20160703183557", 01:31:05 INFO - "pgo_build": "False", 01:31:05 INFO - "basedir": "/builds/slave/test", 01:31:05 INFO - "buildnumber": 20, 01:31:05 INFO - "slavename": "t-yosemite-r7-0345", 01:31:05 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 01:31:05 INFO - "platform": "yosemite_r7", 01:31:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:31:05 INFO - "branch": "mozilla-beta", 01:31:05 INFO - "repo_path": "releases/mozilla-beta", 01:31:05 INFO - "revision": "344a25a1f2697c963321fe204c688d1e76a7cc01", 01:31:05 INFO - "stage_platform": "macosx64", 01:31:05 INFO - "builduid": "8283a6f125df40c2ae12696b987fc37e", 01:31:05 INFO - "slavebuilddir": "test" 01:31:05 INFO - } 01:31:05 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.dmg. 01:31:05 INFO - Running post-action listener: _resource_record_post_action 01:31:05 INFO - ##### 01:31:05 INFO - ##### Running download-and-extract step. 01:31:05 INFO - ##### 01:31:05 INFO - Running pre-action listener: _resource_record_pre_action 01:31:05 INFO - Running main action method: download_and_extract 01:31:05 INFO - mkdir: /builds/slave/test/build/tests 01:31:05 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')]} 01:31:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.test_packages.json 01:31:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:31:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/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 01:31:06 INFO - Downloaded 1165 bytes. 01:31:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:31:06 INFO - Using the following test package requirements: 01:31:06 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:31:06 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:31:06 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 01:31:06 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:31:06 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 01:31:06 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:31:06 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:31:06 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 01:31:06 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:31:06 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:31:06 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 01:31:06 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:31:06 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 01:31:06 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:31:06 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 01:31:06 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:31:06 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 01:31:06 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 01:31:06 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')]} 01:31:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.common.tests.zip 01:31:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:31:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/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 01:31:06 INFO - Downloaded 18351367 bytes. 01:31:06 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'] 01:31:06 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 01:31:09 INFO - Return code: 0 01:31:09 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 01:31:09 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')]} 01:31:09 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.common.tests.zip 01:31:09 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/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 01:31:09 INFO - Downloaded 18351367 bytes. 01:31:09 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'] 01:31:09 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 01:31:13 INFO - Return code: 0 01:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:31:13 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.talos.tests.zip 01:31:13 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 01:31:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/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 01:31:21 INFO - Downloaded 10840145 bytes. 01:31:21 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'] 01:31:21 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 01:31:21 INFO - Return code: 0 01:31:21 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')]} 01:31:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.dmg 01:31:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 01:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 01:31:22 INFO - Downloaded 86196132 bytes. 01:31:22 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.dmg 01:31:22 INFO - mkdir: /builds/slave/test/properties 01:31:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:31:22 INFO - Writing to file /builds/slave/test/properties/build_url 01:31:22 INFO - Contents: 01:31:22 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.dmg 01:31:22 INFO - Running post-action listener: _resource_record_post_action 01:31:22 INFO - Running post-action listener: set_extra_try_arguments 01:31:22 INFO - ##### 01:31:22 INFO - ##### Running populate-webroot step. 01:31:22 INFO - ##### 01:31:22 INFO - Running pre-action listener: _resource_record_pre_action 01:31:22 INFO - Running main action method: populate_webroot 01:31:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:31:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:31:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:31:22 INFO - '--tppagecycles', 01:31:22 INFO - '7'], 01:31:22 INFO - 'tests': ['tsvgm']}}, 01:31:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:31:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:31:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:31:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:31:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:31:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:31:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:22 INFO - 'talos_options': ['--disable-e10s'], 01:31:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:31:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:31:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:22 INFO - 'talos_options': ['--disable-e10s'], 01:31:22 INFO - 'tests': ['damp', 'tps']}, 01:31:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:22 INFO - 'tests': ['damp', 'tps']}, 01:31:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:31:22 INFO - 'tests': ['dromaeo_dom']}, 01:31:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:31:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:31:22 INFO - 'tests': ['a11yr', 01:31:22 INFO - 'ts_paint', 01:31:22 INFO - 'tpaint', 01:31:22 INFO - 'sessionrestore', 01:31:22 INFO - 'sessionrestore_no_auto_restore', 01:31:22 INFO - 'tabpaint']}, 01:31:22 INFO - 'other-e10s': {'tests': ['a11yr', 01:31:22 INFO - 'ts_paint', 01:31:22 INFO - 'tpaint', 01:31:22 INFO - 'sessionrestore', 01:31:22 INFO - 'sessionrestore_no_auto_restore', 01:31:22 INFO - 'tabpaint']}, 01:31:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:31:22 INFO - 'ts_paint', 01:31:22 INFO - 'tpaint', 01:31:22 INFO - 'sessionrestore', 01:31:22 INFO - 'sessionrestore_no_auto_restore', 01:31:22 INFO - 'tabpaint']}, 01:31:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:31:22 INFO - 'ts_paint', 01:31:22 INFO - 'tpaint', 01:31:22 INFO - 'sessionrestore', 01:31:22 INFO - 'sessionrestore_no_auto_restore', 01:31:22 INFO - 'tabpaint']}, 01:31:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:31:22 INFO - 'tests': ['a11yr', 01:31:22 INFO - 'ts_paint', 01:31:22 INFO - 'tpaint', 01:31:22 INFO - 'sessionrestore', 01:31:22 INFO - 'sessionrestore_no_auto_restore', 01:31:22 INFO - 'tabpaint']}, 01:31:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:31:22 INFO - 'tests': ['a11yr', 01:31:22 INFO - 'ts_paint', 01:31:22 INFO - 'tpaint', 01:31:22 INFO - 'sessionrestore', 01:31:22 INFO - 'sessionrestore_no_auto_restore', 01:31:22 INFO - 'tabpaint']}, 01:31:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:31:22 INFO - 'tests': ['tsvgx', 01:31:22 INFO - 'tsvgr_opacity', 01:31:22 INFO - 'tart', 01:31:22 INFO - 'tscrollx', 01:31:22 INFO - 'cart']}, 01:31:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:31:22 INFO - 'tsvgr_opacity', 01:31:22 INFO - 'tart', 01:31:22 INFO - 'tscrollx', 01:31:22 INFO - 'cart']}, 01:31:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:22 INFO - 'talos_options': ['--disable-e10s'], 01:31:22 INFO - 'tests': ['tp5o']}, 01:31:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:22 INFO - 'tests': ['tp5o']}, 01:31:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:22 INFO - 'talos_options': ['--disable-e10s', 01:31:22 INFO - '--xperf_path', 01:31:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:31:22 INFO - 'tests': ['tp5n']}, 01:31:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:22 INFO - 'talos_options': ['--xperf_path', 01:31:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:31:22 INFO - 'tests': ['tp5n']}}, 01:31:22 INFO - 'talos.zip': {'path': '', 01:31:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:31:22 INFO - Running post-action listener: _resource_record_post_action 01:31:22 INFO - ##### 01:31:22 INFO - ##### Running create-virtualenv step. 01:31:22 INFO - ##### 01:31:22 INFO - Running pre-action listener: _resource_record_pre_action 01:31:22 INFO - Running main action method: create_virtualenv 01:31:22 INFO - Creating virtualenv /builds/slave/test/build/venv 01:31:22 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 01:31:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:31:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:31:22 INFO - Using real prefix '/tools/python27' 01:31:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:31:23 INFO - Installing distribute.............................................................................................................................................................................................done. 01:31:26 INFO - Installing pip.................done. 01:31:26 INFO - Return code: 0 01:31:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:31: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')]} 01:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31: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')]} 01:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:26 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 0x100c98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ca8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe05949f990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b37e00>, '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 0x1009a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b32b20>, '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.maELa5AwdE/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.6NPLIgVaQH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 01:31:26 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 01:31:26 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 01:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.maELa5AwdE/Render', 01:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:26 INFO - 'HOME': '/Users/cltbld', 01:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:26 INFO - 'LOGNAME': 'cltbld', 01:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:26 INFO - 'MOZ_NO_REMOTE': '1', 01:31:26 INFO - 'NO_EM_RESTART': '1', 01:31:26 INFO - 'PAGER': '/bin/cat', 01:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:26 INFO - 'PWD': '/builds/slave/test', 01:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:26 INFO - 'SHELL': '/bin/bash', 01:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NPLIgVaQH/Listeners', 01:31:26 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 01:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:26 INFO - 'USER': 'cltbld', 01:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:26 INFO - 'XPC_FLAGS': '0x0', 01:31:26 INFO - 'XPC_SERVICE_NAME': '0', 01:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:26 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 01:31:26 INFO - Cleaning up... 01:31:26 INFO - Return code: 0 01:31:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:31: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')]} 01:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31: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')]} 01:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:26 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 0x100c98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ca8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe05949f990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b37e00>, '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 0x1009a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b32b20>, '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.maELa5AwdE/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.6NPLIgVaQH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 01:31:26 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 01:31:26 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 01:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.maELa5AwdE/Render', 01:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:26 INFO - 'HOME': '/Users/cltbld', 01:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:26 INFO - 'LOGNAME': 'cltbld', 01:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:26 INFO - 'MOZ_NO_REMOTE': '1', 01:31:26 INFO - 'NO_EM_RESTART': '1', 01:31:26 INFO - 'PAGER': '/bin/cat', 01:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:26 INFO - 'PWD': '/builds/slave/test', 01:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:26 INFO - 'SHELL': '/bin/bash', 01:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NPLIgVaQH/Listeners', 01:31:26 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 01:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:26 INFO - 'USER': 'cltbld', 01:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:26 INFO - 'XPC_FLAGS': '0x0', 01:31:26 INFO - 'XPC_SERVICE_NAME': '0', 01:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:26 INFO - Downloading/unpacking psutil>=0.7.1 01:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:31:30 INFO - Installing collected packages: psutil 01:31:30 INFO - Running setup.py install for psutil 01:31:30 INFO - building 'psutil._psutil_osx' extension 01:31:30 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 01:31:30 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 01:31:30 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 01:31:31 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 01:31:31 INFO - building 'psutil._psutil_posix' extension 01:31:31 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 01:31:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:31:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:31:31 INFO - ^ 01:31:31 INFO - 1 warning generated. 01:31:31 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 01:31:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:31:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:31:31 INFO - Successfully installed psutil 01:31:31 INFO - Cleaning up... 01:31:31 INFO - Return code: 0 01:31:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:31:31 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')]} 01:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:31 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')]} 01:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:31 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 0x100c98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ca8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe05949f990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b37e00>, '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 0x1009a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b32b20>, '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.maELa5AwdE/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.6NPLIgVaQH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 01:31:31 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 01:31:31 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 01:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.maELa5AwdE/Render', 01:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:31 INFO - 'HOME': '/Users/cltbld', 01:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:31 INFO - 'LOGNAME': 'cltbld', 01:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:31 INFO - 'MOZ_NO_REMOTE': '1', 01:31:31 INFO - 'NO_EM_RESTART': '1', 01:31:31 INFO - 'PAGER': '/bin/cat', 01:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:31 INFO - 'PWD': '/builds/slave/test', 01:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:31 INFO - 'SHELL': '/bin/bash', 01:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NPLIgVaQH/Listeners', 01:31:31 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 01:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:31 INFO - 'USER': 'cltbld', 01:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:31 INFO - 'XPC_FLAGS': '0x0', 01:31:31 INFO - 'XPC_SERVICE_NAME': '0', 01:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:31:34 INFO - Installing collected packages: mozsystemmonitor 01:31:34 INFO - Running setup.py install for mozsystemmonitor 01:31:34 INFO - Successfully installed mozsystemmonitor 01:31:34 INFO - Cleaning up... 01:31:34 INFO - Return code: 0 01:31:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:31: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')]} 01:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31: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')]} 01:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100c98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ca8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe05949f990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b37e00>, '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 0x1009a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b32b20>, '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.maELa5AwdE/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.6NPLIgVaQH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 01:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:31:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.maELa5AwdE/Render', 01:31:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:34 INFO - 'HOME': '/Users/cltbld', 01:31:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:34 INFO - 'LOGNAME': 'cltbld', 01:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:34 INFO - 'MOZ_NO_REMOTE': '1', 01:31:34 INFO - 'NO_EM_RESTART': '1', 01:31:34 INFO - 'PAGER': '/bin/cat', 01:31:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:34 INFO - 'PWD': '/builds/slave/test', 01:31:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:34 INFO - 'SHELL': '/bin/bash', 01:31:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NPLIgVaQH/Listeners', 01:31:34 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 01:31:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:34 INFO - 'USER': 'cltbld', 01:31:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:34 INFO - 'XPC_FLAGS': '0x0', 01:31:34 INFO - 'XPC_SERVICE_NAME': '0', 01:31:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:34 INFO - Downloading/unpacking blobuploader==1.2.4 01:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:37 INFO - Downloading blobuploader-1.2.4.tar.gz 01:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:31:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:31:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:38 INFO - Downloading docopt-0.6.1.tar.gz 01:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:31:38 INFO - Installing collected packages: blobuploader, requests, docopt 01:31:38 INFO - Running setup.py install for blobuploader 01:31:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:31:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:31:38 INFO - Running setup.py install for requests 01:31:39 INFO - Running setup.py install for docopt 01:31:39 INFO - Successfully installed blobuploader requests docopt 01:31:39 INFO - Cleaning up... 01:31:39 INFO - Return code: 0 01:31:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:31: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')]} 01:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31: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')]} 01:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:39 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 0x100c98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ca8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe05949f990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b37e00>, '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 0x1009a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b32b20>, '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.maELa5AwdE/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.6NPLIgVaQH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 01:31:39 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 01:31:39 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 01:31:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.maELa5AwdE/Render', 01:31:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:39 INFO - 'HOME': '/Users/cltbld', 01:31:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:39 INFO - 'LOGNAME': 'cltbld', 01:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:39 INFO - 'MOZ_NO_REMOTE': '1', 01:31:39 INFO - 'NO_EM_RESTART': '1', 01:31:39 INFO - 'PAGER': '/bin/cat', 01:31:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:39 INFO - 'PWD': '/builds/slave/test', 01:31:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:39 INFO - 'SHELL': '/bin/bash', 01:31:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NPLIgVaQH/Listeners', 01:31:39 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 01:31:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:39 INFO - 'USER': 'cltbld', 01:31:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:39 INFO - 'XPC_FLAGS': '0x0', 01:31:39 INFO - 'XPC_SERVICE_NAME': '0', 01:31:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:31:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-_tw8Qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:31:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-xWKApM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:31:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-TLq5N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:31:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-nq3IcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:31:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-eCUMUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:31:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-U2hiEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:31:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-GVmkFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:31:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-B4zIsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:31:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-rtOPCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:31:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-9qdDui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:31:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-D5rEy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:31:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-DNzv6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:31:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-9tO0xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:31:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-hSXKrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:31:41 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-5mK1Db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:31:41 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-B_kB2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:31:41 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-l2kbz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:31:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:31:41 INFO - Running setup.py install for manifestparser 01:31:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:31:41 INFO - Running setup.py install for mozcrash 01:31:41 INFO - Running setup.py install for mozdebug 01:31:41 INFO - Running setup.py install for mozdevice 01:31:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:31:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:31:41 INFO - Running setup.py install for mozfile 01:31:42 INFO - Running setup.py install for mozhttpd 01:31:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:31:42 INFO - Running setup.py install for mozinfo 01:31:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:31:42 INFO - Running setup.py install for mozInstall 01:31:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:31:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:31:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:31:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:31:42 INFO - Running setup.py install for mozleak 01:31:42 INFO - Running setup.py install for mozlog 01:31:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:31:42 INFO - Running setup.py install for moznetwork 01:31:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:31:42 INFO - Running setup.py install for mozprocess 01:31:43 INFO - Running setup.py install for mozprofile 01:31:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:31:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:31:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:31:43 INFO - Running setup.py install for mozrunner 01:31:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:31:43 INFO - Running setup.py install for mozscreenshot 01:31:43 INFO - Running setup.py install for moztest 01:31:43 INFO - Running setup.py install for mozversion 01:31:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:31:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:31:43 INFO - Cleaning up... 01:31:43 INFO - Return code: 0 01:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:43 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 0x100c98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ca8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe05949f990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b37e00>, '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 0x1009a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b32b20>, '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.maELa5AwdE/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.6NPLIgVaQH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 01:31:43 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 01:31:43 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 01:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.maELa5AwdE/Render', 01:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:43 INFO - 'HOME': '/Users/cltbld', 01:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:43 INFO - 'LOGNAME': 'cltbld', 01:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:43 INFO - 'MOZ_NO_REMOTE': '1', 01:31:43 INFO - 'NO_EM_RESTART': '1', 01:31:43 INFO - 'PAGER': '/bin/cat', 01:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:43 INFO - 'PWD': '/builds/slave/test', 01:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:43 INFO - 'SHELL': '/bin/bash', 01:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NPLIgVaQH/Listeners', 01:31:43 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 01:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:43 INFO - 'USER': 'cltbld', 01:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:43 INFO - 'XPC_FLAGS': '0x0', 01:31:43 INFO - 'XPC_SERVICE_NAME': '0', 01:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:31:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-iZXT_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:31:44 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)) 01:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:31:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-eG6R2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:31:44 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)) 01:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:31:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-heOGKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:31:44 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)) 01:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:31:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-1PFZWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:31:44 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)) 01:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:31:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-5L9hRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:31:44 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)) 01:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:31:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-41c0y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:31:44 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)) 01:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:31:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-BkKddC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:31:44 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)) 01:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:31:44 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-nYBjRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:31:45 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)) 01:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:31:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-vSaPrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:31:45 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)) 01:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:31:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-bDhP4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:31:45 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)) 01:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:31:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-txNqMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:31:45 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)) 01:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:31:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-3OjKAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:31:45 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)) 01:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:31:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-gVfAyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:31:45 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)) 01:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:31:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-6qrnfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:31:45 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)) 01:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:31:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-2EFb4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:31:45 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)) 01:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:31:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-cn8BRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:31:45 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)) 01:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:31:45 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-WAfu80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:31:46 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)) 01:31:46 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)) 01:31:46 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)) 01:31:46 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)) 01:31:46 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)) 01:31:46 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)) 01:31:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:31: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 01:31: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 01:31: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 01:31: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 01:31: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 01:31: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 01:31:48 INFO - Downloading blessings-1.6.tar.gz 01:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:31:48 INFO - Installing collected packages: blessings 01:31:48 INFO - Running setup.py install for blessings 01:31:48 INFO - Successfully installed blessings 01:31:48 INFO - Cleaning up... 01:31:48 INFO - Return code: 0 01:31:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:31:49 INFO - Reading from file tmpfile_stdout 01:31:49 INFO - Current package versions: 01:31:49 INFO - blessings == 1.6 01:31:49 INFO - blobuploader == 1.2.4 01:31:49 INFO - docopt == 0.6.1 01:31:49 INFO - manifestparser == 1.1 01:31:49 INFO - mozInstall == 1.12 01:31:49 INFO - mozcrash == 0.17 01:31:49 INFO - mozdebug == 0.1 01:31:49 INFO - mozdevice == 0.48 01:31:49 INFO - mozfile == 1.2 01:31:49 INFO - mozhttpd == 0.7 01:31:49 INFO - mozinfo == 0.9 01:31:49 INFO - mozleak == 0.1 01:31:49 INFO - mozlog == 3.1 01:31:49 INFO - moznetwork == 0.27 01:31:49 INFO - mozprocess == 0.22 01:31:49 INFO - mozprofile == 0.28 01:31:49 INFO - mozrunner == 6.11 01:31:49 INFO - mozscreenshot == 0.1 01:31:49 INFO - mozsystemmonitor == 0.0 01:31:49 INFO - moztest == 0.7 01:31:49 INFO - mozversion == 1.4 01:31:49 INFO - psutil == 3.1.1 01:31:49 INFO - requests == 1.2.3 01:31:49 INFO - wsgiref == 0.1.2 01:31:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:31:49 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')]} 01:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:49 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')]} 01:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:49 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 0x100c98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ca8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe05949f990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b37e00>, '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 0x1009a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b32b20>, '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.maELa5AwdE/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.6NPLIgVaQH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 01:31:49 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 01:31:49 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 01:31:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.maELa5AwdE/Render', 01:31:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:49 INFO - 'HOME': '/Users/cltbld', 01:31:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:49 INFO - 'LOGNAME': 'cltbld', 01:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:49 INFO - 'MOZ_NO_REMOTE': '1', 01:31:49 INFO - 'NO_EM_RESTART': '1', 01:31:49 INFO - 'PAGER': '/bin/cat', 01:31:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:49 INFO - 'PWD': '/builds/slave/test', 01:31:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:49 INFO - 'SHELL': '/bin/bash', 01:31:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NPLIgVaQH/Listeners', 01:31:49 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 01:31:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:49 INFO - 'USER': 'cltbld', 01:31:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:49 INFO - 'XPC_FLAGS': '0x0', 01:31:49 INFO - 'XPC_SERVICE_NAME': '0', 01:31:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:49 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)) 01:31:49 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)) 01:31:49 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)) 01:31:49 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)) 01:31:49 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)) 01:31:49 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)) 01:31:49 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)) 01:31:49 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)) 01:31:49 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)) 01:31:49 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)) 01:31:49 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)) 01:31:49 INFO - Cleaning up... 01:31:49 INFO - Return code: 0 01:31:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:31:49 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')]} 01:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:49 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')]} 01:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:49 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 0x100c98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ca8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe05949f990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b37e00>, '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 0x1009a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b32b20>, '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.maELa5AwdE/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.6NPLIgVaQH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 01:31:49 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 01:31:49 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 01:31:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.maELa5AwdE/Render', 01:31:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:49 INFO - 'HOME': '/Users/cltbld', 01:31:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:49 INFO - 'LOGNAME': 'cltbld', 01:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:49 INFO - 'MOZ_NO_REMOTE': '1', 01:31:49 INFO - 'NO_EM_RESTART': '1', 01:31:49 INFO - 'PAGER': '/bin/cat', 01:31:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:49 INFO - 'PWD': '/builds/slave/test', 01:31:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:49 INFO - 'SHELL': '/bin/bash', 01:31:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NPLIgVaQH/Listeners', 01:31:49 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 01:31:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:49 INFO - 'USER': 'cltbld', 01:31:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:49 INFO - 'XPC_FLAGS': '0x0', 01:31:49 INFO - 'XPC_SERVICE_NAME': '0', 01:31:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:49 INFO - Downloading/unpacking jsonschema 01:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:31:52 INFO - Downloading/unpacking functools32 (from jsonschema) 01:31:52 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 01:31:52 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 01:31:52 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 01:31:52 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 01:31:52 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 01:31:52 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 01:31:52 INFO - Downloading functools32-3.2.3-2.tar.gz 01:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:31:52 INFO - warning: no files found matching '*.txt' 01:31:52 INFO - no previously-included directories found matching 'build' 01:31:52 INFO - no previously-included directories found matching 'dist' 01:31:52 INFO - no previously-included directories found matching '.git*' 01:31:52 INFO - Installing collected packages: jsonschema, functools32 01:31:52 INFO - Running setup.py install for functools32 01:31:52 INFO - warning: no files found matching '*.txt' 01:31:52 INFO - no previously-included directories found matching 'build' 01:31:52 INFO - no previously-included directories found matching 'dist' 01:31:52 INFO - no previously-included directories found matching '.git*' 01:31:52 INFO - Successfully installed jsonschema functools32 01:31:52 INFO - Cleaning up... 01:31:52 INFO - Return code: 0 01:31:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:52 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 0x100c98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ca8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe05949f990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b37e00>, '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 0x1009a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b32b20>, '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.maELa5AwdE/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.6NPLIgVaQH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 01:31:52 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 01:31:52 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 01:31:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.maELa5AwdE/Render', 01:31:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:52 INFO - 'HOME': '/Users/cltbld', 01:31:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:52 INFO - 'LOGNAME': 'cltbld', 01:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:52 INFO - 'MOZ_NO_REMOTE': '1', 01:31:52 INFO - 'NO_EM_RESTART': '1', 01:31:52 INFO - 'PAGER': '/bin/cat', 01:31:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:52 INFO - 'PWD': '/builds/slave/test', 01:31:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:52 INFO - 'SHELL': '/bin/bash', 01:31:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NPLIgVaQH/Listeners', 01:31:52 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 01:31:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:52 INFO - 'USER': 'cltbld', 01:31:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:52 INFO - 'XPC_FLAGS': '0x0', 01:31:52 INFO - 'XPC_SERVICE_NAME': '0', 01:31:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:53 INFO - Downloading/unpacking flake8 01:31: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 01:31: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 01:31: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 01:31: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 01:31: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 01:31: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 01:31:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:31:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:31:55 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 01:31:55 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 01:31:55 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 01:31:55 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 01:31:55 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 01:31:55 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 01:31:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:31:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:31:55 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 01:31:55 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 01:31:55 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 01:31:55 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 01:31:55 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 01:31:55 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 01:31:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:31: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 01:31: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 01:31: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 01:31: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 01:31: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 01:31: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 01:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:31:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:31:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:31:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:31:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:31:56 INFO - no previously-included directories found matching 'docs/_build' 01:31:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:31:56 INFO - Running setup.py install for pep8 01:31:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:31:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:31:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:31:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:31:56 INFO - no previously-included directories found matching 'docs/_build' 01:31:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:31:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:31:57 INFO - Cleaning up... 01:31:57 INFO - Return code: 0 01:31:57 INFO - Running post-action listener: _resource_record_post_action 01:31:57 INFO - Running post-action listener: _start_resource_monitoring 01:31:57 INFO - Starting resource monitoring. 01:31:57 INFO - ##### 01:31:57 INFO - ##### Running install step. 01:31:57 INFO - ##### 01:31:57 INFO - Running pre-action listener: _resource_record_pre_action 01:31:57 INFO - Running main action method: install 01:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:31:57 INFO - Reading from file tmpfile_stdout 01:31:57 INFO - Detecting whether we're running mozinstall >=1.0... 01:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:31:57 INFO - Reading from file tmpfile_stdout 01:31:57 INFO - Output received: 01:31:57 INFO - Usage: mozinstall [options] installer 01:31:57 INFO - Options: 01:31:57 INFO - -h, --help show this help message and exit 01:31:57 INFO - -d DEST, --destination=DEST 01:31:57 INFO - Directory to install application into. [default: 01:31:57 INFO - "/builds/slave/test"] 01:31:57 INFO - --app=APP Application being installed. [default: firefox] 01:31:57 INFO - mkdir: /builds/slave/test/build/application 01:31:57 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'] 01:31:57 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 01:32:19 INFO - Reading from file tmpfile_stdout 01:32:19 INFO - Output received: 01:32:19 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:32:19 INFO - Running post-action listener: _resource_record_post_action 01:32:19 INFO - ##### 01:32:19 INFO - ##### Running run-tests step. 01:32:19 INFO - ##### 01:32:19 INFO - Running pre-action listener: _resource_record_pre_action 01:32:19 INFO - Running main action method: run_tests 01:32:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:32:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:32:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:32:19 INFO - 2016-07-04 01:32:19.174 screenresolution[2203:16597] starting screenresolution argv=screenresolution get 01:32:19 INFO - 2016-07-04 01:32:19.177 screenresolution[2203:16597] Display 0: 1600x1200x32@60 01:32:19 INFO - 2016-07-04 01:32:19.183 screenresolution[2204:16599] starting screenresolution argv=screenresolution list 01:32:19 INFO - Available Modes on Display 0 01:32:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:32:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:32:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:32:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:32:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:32:19 INFO - Intel Iris: 01:32:19 INFO - Chipset Model: Intel Iris 01:32:19 INFO - Type: GPU 01:32:19 INFO - Bus: Built-In 01:32:19 INFO - VRAM (Dynamic, Max): 1536 MB 01:32:19 INFO - Vendor: Intel (0x8086) 01:32:19 INFO - Device ID: 0x0a2e 01:32:19 INFO - Revision ID: 0x0009 01:32:19 INFO - Displays: 01:32:19 INFO - Display: 01:32:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:32:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:32:19 INFO - Display Serial Number: 1600x1200 60 01:32:19 INFO - Main Display: Yes 01:32:19 INFO - Mirror: Off 01:32:19 INFO - Online: Yes 01:32:19 INFO - Rotation: Supported 01:32:19 INFO - Return code: 0 01:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:32:19 INFO - Python 2.7.3 01:32:19 INFO - Return code: 0 01:32:19 INFO - grabbing minidump binary from tooltool 01:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:19 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 0x100b37e00>, '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 0x1009a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b32b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:32:19 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 01:32:19 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 01:32:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:32:19 INFO - Return code: 0 01:32:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:32:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:32:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:32:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:32:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:32:20 INFO - Return code: 0 01:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0345 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:32:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.maELa5AwdE/Render', 01:32:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:20 INFO - 'HOME': '/Users/cltbld', 01:32:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:20 INFO - 'LOGNAME': 'cltbld', 01:32:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:32:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:20 INFO - 'MOZ_NO_REMOTE': '1', 01:32:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:32:20 INFO - 'NO_EM_RESTART': '1', 01:32:20 INFO - 'PAGER': '/bin/cat', 01:32:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:20 INFO - 'PWD': '/builds/slave/test', 01:32:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:32:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:20 INFO - 'SHELL': '/bin/bash', 01:32:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NPLIgVaQH/Listeners', 01:32:20 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 01:32:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:20 INFO - 'USER': 'cltbld', 01:32:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:20 INFO - 'XPC_FLAGS': '0x0', 01:32:20 INFO - 'XPC_SERVICE_NAME': '0', 01:32:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:32:20 INFO - mozversion application_buildid: 20160703183557 01:32:20 INFO - mozversion application_changeset: 344a25a1f2697c963321fe204c688d1e76a7cc01 01:32:20 INFO - mozversion application_display_name: Firefox 01:32:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:32:20 INFO - mozversion application_name: Firefox 01:32:20 INFO - mozversion application_remotingname: firefox 01:32:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:32:20 INFO - mozversion application_vendor: Mozilla 01:32:20 INFO - mozversion application_version: 48.0 01:32:20 INFO - mozversion platform_buildid: 20160703183557 01:32:20 INFO - mozversion platform_changeset: 344a25a1f2697c963321fe204c688d1e76a7cc01 01:32:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:32:20 INFO - mozversion platform_version: 48.0 01:32:20 INFO - using testdate: 1467621140 01:32:20 INFO - actual date: 1467621140 01:32:20 INFO - starting webserver on 'localhost:52446' 01:32:20 INFO - SUITE-START | Running 2 tests 01:32:20 INFO - TEST-START | dromaeo_css 01:32:20 INFO - operating with platform_type : mac_ 01:32:20 INFO - Initialising browser for dromaeo_css test... 01:32:20 INFO - TEST-INFO | started process 2222 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpmzGAS5/profile http://localhost:52446/getInfo.html) 01:32:23 INFO - PROCESS | 2222 | __metrics Screen width/height:1600/1200 01:32:23 INFO - PROCESS | 2222 | colorDepth:24 01:32:23 INFO - PROCESS | 2222 | Browser inner width/height: 1024/689 01:32:23 INFO - PROCESS | 2222 | __metrics 01:32:23 ERROR - PROCESS | 2222 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 01:32:24 INFO - TEST-INFO | 2222: exit 0 01:32:24 INFO - Browser initialized. 01:32:24 INFO - Running cycle 1/1 for dromaeo_css test... 01:32:24 INFO - TEST-INFO | started process 2226 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpmzGAS5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:32:36 INFO - PROCESS | 2226 | RSS: Main: 171630592 01:32:36 INFO - PROCESS | 2226 | 01:33:25 INFO - PROCESS | 2226 | 1467621205764 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] 01:35:35 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52446/tests/dromaeo/cssquery-ext.html) 01:35:37 INFO - PROCESS | 2226 | RSS: Main: 182398976 01:35:37 INFO - PROCESS | 2226 | 01:38:39 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-ext.html (next: http://localhost:52446/tests/dromaeo/cssquery-jquery.html) 01:38:39 INFO - PROCESS | 2226 | RSS: Main: 192888832 01:38:39 INFO - PROCESS | 2226 | 01:41:41 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52446/tests/dromaeo/cssquery-mootools.html) 01:41:41 INFO - PROCESS | 2226 | RSS: Main: 195035136 01:41:41 INFO - PROCESS | 2226 | 01:44:43 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52446/tests/dromaeo/cssquery-prototype.html) 01:44:44 INFO - PROCESS | 2226 | RSS: Main: 198725632 01:44:44 INFO - PROCESS | 2226 | 01:47:46 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52446/tests/dromaeo/cssquery-yui.html) 01:47:47 INFO - PROCESS | 2226 | RSS: Main: 197922816 01:47:47 INFO - PROCESS | 2226 | 01:50:49 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-yui.html (next: http://localhost:52446/tests/dromaeo/cssquery-dojo.html) 01:50:49 INFO - PROCESS | 2226 | RSS: Main: 203493376 01:50:49 INFO - PROCESS | 2226 | 01:50:49 INFO - PROCESS | 2226 | __start_tp_report 01:50:49 INFO - PROCESS | 2226 | _x_x_mozilla_page_load 01:50:49 INFO - PROCESS | 2226 | _x_x_mozilla_page_load_details 01:50:49 INFO - PROCESS | 2226 | |i|pagename|runs| 01:50:49 INFO - PROCESS | 2226 | |0;dojo.html;2982.2842517795725;3286.950695739563;3548.201654627709;3656.2504686539255;3670.3026424979253;5799.159121927323;5920.289565252176;5933;5961.672108034068;5975.729222895299;5912.260967379078;5930.051191809312;5958.43394877487;5968;5977.342492325841;4528.954710452895;4839.322494850724;5347.438518955512;5361.276227709248;5364.141737322029;4051.817668204923;5277.366715994086;5325.866853328678;5386.703731294777;5399.9730001349935;5335.226392173133;5368.62419630626;5379.408265090837;5380.892382152374;5443.938432005761;4303.698741088125;4422.6240769534625;5171.560417364529;5303.7348132593215;5320.201969704536;4926.211806111005;5213.296205012312;5280.287161233223;5297.761600727977;5319.3616765987945;4817.927731084036;5696.515796157331;5707.942920570783;5712.485876271114;5748.7987920423;5131.794728210867;5692.8861422771315;5845.766169353264;6111.419415155553;6179.134921111048;6212.471939885115;6236.812895613139;6241.875162496724;6245.531585131133;6260.655663938482;5992.64044157352;6003.969980150158;6004.443667773406;6020.69896505173;6056.818295451144;6232.002879539252;6278.215223097113;6301.369863013753;6318.241810982711;6319.842003949846;6225.657588832567;6268.341824108403;6268.373162683695;6271.153394291803;6279.8116056517465;6277.309495955441;6281.685915704196;6288.868003759368;6291.622502649764;6297.748090076438;6150.50795936333;6166.876662466726;6216.036514340284;6274.152989346471;6282.403171698681;6203.7828675997025;6249.0938813871735;6249.843753906098;6262.843428914222;6287.842803929939;4962.727050012212;5028.421731500851;5040.36995375578;5050.949490505048;5058.089543882063;4360.302351623725;4412.3160910059;4461.955380446219;4494.910101797946;4581.65637577183;5975.970120149372;6002.039673652194;6026.035834266497;6038.667873266924;6089.482393996472;5984.880302393928;6244.344343843922;6283.560150789493;6285.685715714196;6289.96215624426;5917.822465326047;5949.226600541989;5977.760889564455;5982.162497250389;6081.908771368433;5427.728613569306;5508.3114610673665;5517.917231241535;5519.641223320471;5524.1989911462615;6345.111684364193;6381.117570316767;6400.23197216337;6420.101185833987;6437.324080971524;6228.750849966132;6250.124982502362;6250.874982500233;6259.467945224706;6272;6313.463355614824;6333.778317758856;6342.556021078481;6369.1401660777055;6374.203224596926;5245.423003469692;6204.13142160089;6217.689115544295;6295.055741638791;6296.874062518816;6265.906011409741;6270.7805226816845;6271.965125754199;6286.308506064421;6287.119803227643;6061.878762424639;6134.344744984565;6194;6264.091706702594;6287.371262873859;6169.167162433194;6256.687165641609;6273.121762953099;6276.372362763687;6296.275928268308;5830.591858569859;6051.697415129314;6120.8775824484155;6161.983272760123;6169.413905678954;6169.753209871735;6186.381361863778;6246.063090536274;6272.278687950944;6277.089821975696;6158.476529495043;6201.193844800147;6231.470325022243;6241.438270555672;6256.343083976117 01:50:49 INFO - PROCESS | 2226 | |1;ext.html;532.0688794609433;558.5294184642719;580.6342004537141;590.7814108779746;610.9583160710988;38360.23279534411;38908;39523.80238098809;39641.80179099104;39667.60332396675;40620.59379406205;41025.58974410255;41303.76088717336;41391.79304103483;41401.792991035;9639.951800241006;9829.90170098297;9831.90168098317;9842.015798420172;9893.901060989407;9754.0733630305;9907.554160062815;9908.851367229498;9910.653127140551;9929.453880036595;9384.577694003752;9992.750181245454;12146.635600931986;12155.331456769874;12442.253464792097;11908.523659053713;11909.940450297692;11981.520739170466;12088.274703517816;12138.817917731241;11785.764284714258;11808.586699465477;11850.407479625985;11910;12019.93990030053;38670.80664596687;38689.41965870486;38762.61237387618;39335.21329573393;39751.80744577667;3349.531065650811;3390.610079840825;3445.810480423576;3846.4614953906475;3950.9924969132685;28717.994870179653;28814;28820.855895720597;29292.121236362942;29395.85302073476;2792.7346902044274;2850.8432036238;2885.2354126156583;2945.484540205477;2977.6277965254344;424956;429008;430210;430662;431689;60971;62003;62234.688826555575;62699.37300626935;62732.686336568026;63989.36010639927;64089;65587.34412655812;66106;66405.33594663991;17742;18369.448916532525;18486.537836553925;18532;18541.81458185428;14185.858141418454;14219;14698.412063517553;14721.116732996055;14756.335964881606;14551.636209094857;16089.034657920562;16192;16334.264958076916;16406.1796910154;6602.207735071822;6718.462522998148;6730.293319201413;6744.156980377453;6812;1016.7712264740375;1051.5636011055326;1071.994640026795;1093.4969913839564;1123.152020224725;29587.408251834844;29634.407311853643;29860.701392986226;30141.849290753846;30281;1124.100719424457;1165.6153469355093;1187.5962172861095;1208.087893640296;1231.96920076997;15443.61390965235;15682.294296756674;15683.607909802346;15701.293441795147;16128.516144515683;505067;576709.116454415;588811;591684;600346;61072.69463652653;61302;61307.386926130166;61309;61481;1422.8008078868966;1541.46819347325;1562.3281988744948;1568.725473042213;1572.7798108264851;23935;27041.459170816866;28544.85727571349;30672.539911900894;31058.68941310558;52495.21257181222;52787;52831.735841320544;52962;53321.20018199652;509039;513023;515598;517143;519980;34796.82601586976;39138.217235654556;40882.1823563533;40919.795401022806;41601.583984160985;47047.764761175975;48008.75995620139;48191.75904120457;48292.5170748288;48473.75763121162;35533.93398198058;36538;36594.45108323431;36684.63315366919;36743.26513469769;35653.28693426169;35738.64261357353;36039;36108.81945590255;36258.8187059063;36240.818795906904;36387;37226.25547488981;37395.81302093472;39060;31216;32201.35597288088;32210.35579288448;32216.711331546474;32323;20370.79629203689;24924.875375623007;25559.872200638878;25626;25948.962041518884 01:50:49 INFO - PROCESS | 2226 | |2;jquery.html;365.65993625927877;407.5394803871625;409.08161178155046;415.6840800991247;416.4939598387958;15925;19299.903500482495;21555.922203889782;21713.02291396887;21720.565588688238;21007;21313.68029479555;21459.67810482844;21618;22013.789241591705;5972.79095231667;6058.969705151468;6116.908246376308;6246.968765156168;6252.2809876864285;5164.380274367081;6142.232220972379;6263.436290733833;6267.905981410259;6271.216097987752;5835.270591176103;6032.758689652409;6148.292946311187;6262.780802671908;6295.055741638745;5848.561357898132;6069.241344831896;6070.908936365958;6101.145839582484;6164.075388691687;5925.259342582177;5926.644401335933;5932.991391463462;6056.3338032816355;6085.148079268906;11938.403079845973;12923;13385.397657105454;13703.657408564766;14006.94947878913;2168.447046003275;2174.239016344267;2189.901454434554;2254.2673631069806;2263.5472905418983;9803.607855685765;9858.65494707689;9909.454979976099;9990.300678952477;10163.237757168243;1770.7078332075191;1806.4490330449207;1853.5458812591;1857.647047061054;1871.5414723392855;95520.52239738827;99678.50160749222;102283.48858255662;103088.48455757748;106013;11854.94072529632;11863.525458981545;11895.04839612829;12062.336571488653;12130.575429859913;15128.39486420553;15290.847091528942;15534.766978495332;15594.688106237812;15606.219689015505;7535.773926782205;8879.28965682744;9262.675806346746;9351.251899847995;9412.435253884789;7670.348020418215;9379.343445958717;9482.241420686329;9604.567794449267;9636.855447168298;4869.902601947942;4901.113071467511;4910.926336104962;4937.530934561211;4993.90012199754;1773.9645207095787;2011.185469884699;2114.6933694614504;2151.967720484194;2158.0073166343345;890.955452227386;954.4559601027348;996.4220751963844;1055.7149569616315;1085.0939465546357;14843.777343339858;21726.891365543386;22027.559448810935;22065.669014964787;22097.447563811034;998.3859926145368;1049.879263884663;1060.5439660945867;1080.8865069167782;1097.5829184909683;11075.003249707404;11307.265027773168;11805.645830625095;11810.822837657443;11811.055115590732;523277.3836130871;613405;634532;643172;645201;68646.65676671585;120676;124285.75714242923;131659;132608;904.4618452021037;948.0803620488116;1036.1141224253156;1037.801339452933;1040.1366865501616;18619.534511637317;19386.4184074478;19482.318118865773;19524;19789.01054947218;50225.74887125541;51905.7404712974;53515.4648453526;54772.45227547674;55383.446165537825;53271;72249.27750722425;75554;75965;80214.99462513484;6719.529632925648;7889.487183333065;7915.643796029078;8251.711190108317;8325.708600198965;9144.405613635092;12420;13070.738585228051;13451.865481345061;13600.04799664014;10693.786124277627;10790.67627971162;11208.327500350006;11295.265807722471;11508.94245528767;10547.841782373118;10834.133269338592;11229;11432.256903301259;11609.187356884937;11598.652040438801;11607.187496875138;11820.527178913091;11847.76304473923;11920.701982450508;8428.4942903426;8578.742637720878;8653.293697384326;8730.825383492422;8732.69435569752;8462.788430289045;9896.911339752765;10644.84032739494;11837.881621184022;11993.880061199276 01:50:49 INFO - PROCESS | 2226 | |3;mootools.html;1394.867487588679;1479.2086233864877;1586.7778511008453;1804.8195180481953;1988.1252249010424;8196.262336389724;8983.865242021358;9058.048904864985;9075.455472671645;9339.15947564719;8905.198532132106;8927.464352138877;9019.594118264677;9045.90954090459;9200.677976270832;2528.15306872198;2533.936651583707;2537.429078457351;2551.9234422967247;2567.845929244242;2519.3197836584113;2542.8474291542566;2547.8471291722462;2570.2546261584116;2572.691277046757;2270.5685919675293;2457.299669594166;2519.911803086892;2545.7581529754643;2579.703334116582;2530.0891678995545;2532.227670560478;2553.74462553745;2564.7307032761664;2570.910018149356;2421.043687743349;2441.4750828571764;2464.507098580273;2480.6279058141245;2585.7543533364487;9148.313876459226;9153.405028673114;9164.8625270621;9170;9212.769680757967;5439.972800135974;5570.498655121018;5634.239377684001;5640.097584386478;5650.26546548946;3000.3249268914537;3642.9817850910576;3668;3691.3171063353097;3733.533308336458;1057.7884423115331;1076.2251179150999;1078.9136869050458;1078.978420431587;1080.4057768227444;11909.10681698876;11945.044396448264;11963.102767292401;11997.880021199764;12014.399280035963;4109.815058322382;4368.497622773358;4841.983183531498;4860.222364421676;4865.464798872192;8837.823243535093;9949.104580587782;10187.949060254652;10247.7438064049;10256;4712.222483290218;5401.3248343957;5487.890242195213;5552.86117847049;5578.386377498472;4402.603765661106;4611.884702882455;4977.427595826454;4980.601551875841;5112.437631860493;3634.6910512606196;4184.91630167401;4224.134052519226;4251.659867210616;4335.891602709958;1378.3177327223088;1394.3376895974534;1399.657084014423;1402.4390243902317;1412.1315391034645;876.2945828608032;932.38462614674;975.9316847820585;976.1263669016191;1013.3261381181431;5281.366236051698;6091.7207386449345;6152.077188421683;6254.437100660872;6263.185785847811;457.83975608536747;471.3142377840303;472.5038709355163;479.8416522547551;481.2636665901177;4035.1035013544174;4085.7140000200293;4136.958630413717;4149.647279981175;4200.831966721358;10722.78554428907;11001.064909482624;11072.944635276772;11195;11225.887741122484;10802.67591972242;10977.83533247002;11031;11071.778564428667;11105.000549950382;8208.548529830798;8532.57337133141;8610.225079742853;8685.08806575313;8699.739007829776;6063.393660633901;6100.725467353891;6231.189945307081;6257.56197066201;6276;8828.735137945872;9699.757506062404;9711.077447642463;9822.950885245527;9863.852042219516;9471.337006409485;9796.069373409515;9813.116819485995;9823.754406139904;10150.898491014996;7042.330978557029;7506.9249307506225;7704.653290601825;7715.652795624098;7730.111037230566;8326.916730832614;8457.87313190315;8479.618417171365;8492.617832197442;8526.957365213135;7435.144958329862;7604.657790399556;7609.505382150142;7683.346915512244;7686.3082322589;7339.229380915141;7466.701331946661;7469.14104877946;7541.585212813348;7550.848983020199;7159.677814498465;7190.568565886064;7225.783226503213;7226.096737907762;7246.1666908306215;4927.507249275187;4954.752262386938;5033.496650335083;5127.769250383667;5133.204353325241;5092.567131793839;5121.436641969306;5136.30659860929;5173.1464308388695;5359.705216213146 01:50:49 INFO - PROCESS | 2226 | |4;prototype.html;291.62963036943086;304.7013926352175;315.3566723883278;339.5636606960056;345.30421201279427;7074.469414793892;7078.2921707829255;7086.881772020308;7102.360787529121;7142.785716428502;5680.403557626451;5855.76576936922;6802.605465879496;7024.508284420092;7038.753643622475;4098.098418347959;4875.317455556216;4935.506449355072;5109.718965456898;5113.769880355393;5038.412899936527;5100.84697459075;5110.514501122406;5115.795368185287;5123.948760512403;4499.280115181572;4737.289406589022;5068;5088.1095808233595;5097.745112744366;4572.199865023607;4695.201815691341;5089.7455127243675;5113.130767769489;5123.487651234846;3532.311199316134;4367.978160109179;4380.5838445347645;4387.407699960529;4413.558644135593;4862.5623693867365;6589.80230593083;6603.966980165116;6693.9289713645585;6746.932530674729;5959.880802383928;6003.579749417542;6015.308239552463;6018.1574579558455;6025.487833534155;7439.665215065281;7459.627018649046;7463;7471.91657209707;7513.211112833128;4894.094592500399;4894.437139728905;4901.362822833009;4907.576802727205;4940.2342636891335;7630.961845190794;7909.723159689441;7923.5245885246495;7936.563489008102;7992.200779922019;5003.949960500421;5006.874828129326;5007.123753343223;5008.198688209869;5042.344495215599;5049.495050494921;5099.031184075014;5127;5140;5153.742312884341;5961.105834124829;5981.401859813984;5985.40145985398;6000.129981152709;6021.6989150542295;7513.661885215179;7516.361109305661;7522.3605993491165;7551.169371369145;7560.206178351304;1641.4008886756249;1764.2413762082429;1776.5203395083256;1780.8486278666198;1788.0880750817178;994.9105729226485;1068.1614932278123;1078;1081.4268437728017;1083.766990097133;6572.408483236436;7074.610896400644;7087.291270872872;7102.538335008208;7106.324899134574;7530.359919406912;7757.4181936355;7762.495437796525;7795.5054382598155;7795.883061754078;5810.82567522975;7022.087128673342;7153.92846071543;7162.570245785269;7173;4166.749995000249;4191.476065491814;4205.369194620831;4210.810513526899;4217.198732240864;6606.669666516655;7951.244631759973;8278.213569710988;8291.917080829235;8293.419460637697;6561.507886908501;7803.609819509002;8134.59327033646;8211.137830527829;8226.588670566447;8224.588770561448;8241.175882411831;8272.710455134042;8285.62714677841;8341;6359.936400636119;7888.526688398714;7895.092064412666;7903.288704016666;7928.365730741642;7771.611419428893;7783.494072885244;7784.571848548384;7798.298153166243;7814.21857814214;8062.435629505878;8197.549134797406;8280.923479947809;8281;8284.50292982423;3972.2651309507833;4019.397090436458;4792.736399497921;4801.847556586325;4831.855044348676;7708.229177082247;7867.606619668879;7872.881906771518;7887.974563306733;7891.565963872042;7600.46796724224;7623.504472209289;7629.7329593463965;7639.236076392539;7692.92307076922;7365.410767138509;7634.160242373224;7650.1584825668015;7650.464467487445;7668.424868134801;6417.2620148681635;7028.910518869583;7320.597367144858;7441.958125862492;7454.6645400956;6330.49356051524;6424.582402144033;6781.321867813179;7435.847443646244;7641.541507509567;6016.398360163948;7086.858262834818;7371.926280737124;7483.214262502359;7538.396928245617 01:50:49 INFO - PROCESS | 2226 | |5;yui.html;733.2887099513472;772.8299774049707;775.5346791924842;785.1951749456808;792.564089750637;15261.23693815309;15369.615759606015;15495;15669.373225071013;15681.29434175462;11884.346360950145;14309.713805723904;14374.712505749905;14386.856131438682;14432.422703091865;785.1089013969157;892.0054139634326;925.8703781470599;941.5151197133448;941.868138460616;895.7088946092514;896.6144557840126;926.5135803703076;940.351157701184;971.2036130373097;880.4013270975734;945.924326053914;951.8952915179325;999.4053538144792;1020.0564477857989;940.6566603189821;971.2084651009475;988.4859872866069;994.0804755601076;1021.693491952415;741.525423728814;743.382992116542;763.1910175214235;764.3464837563914;764.7705688293489;15296.923515382463;15392.230388480531;15417.15205663688;15507.922460387626;15591.610209744733;13320.533781317705;13434.798478022838;13506.797398039038;13537.323133843269;13569.05016648825;10338.328008679488;10360.740981475448;10420.374777513374;10603.575856965712;10687.465626718633;3564.48314994327;3617.5478065241846;3700.629937006278;3705.8702945397054;3709.0254610179477;83755.58122209412;84686.72969905456;84994.57502712509;85868.57065714693;86020;9847.950760246153;9910.504474776233;9934;10035.799284014425;10264.332818366782;21518.56962860734;21940.012699428564;21945.561088778453;21992.78007219907;23025.654615180785;7681.308682218627;7730.7680769577;7738.187490313549;7876.0548734151125;7932;3490.65093490654;4237.216115018731;4257.084726783756;4333.241682705514;4395.648348132142;3694.722895782827;3698.6486283802997;3714.0900479382185;3720.2745464634136;3728.198437335986;627.7018416252243;709.3828369318622;730.1530224939045;734.5482528245197;740.6000759589762;527.6280222443169;556.5686592890461;579.5769088565287;609.1989034419723;624.5503237668871;8358.707445239388;8393.496390216607;8469.195426434602;8569.528675922884;8635.337615291493;524.5384062025394;550.9696966666792;567.1153001317957;575.9020966435716;602.7137109872775;3929.980350098231;3955.564887862333;4020.6783457323345;4067.349224124126;4228.767417792051;86442.13557864341;86857.56571217104;88047.11952880517;88374;89509;74223.88664170042;75921.62039189879;83734.06930757394;84129.73805392924;85452.57273713716;52163.95672086613;52271;69509.65245173742;69681.30318696747;70227;8445.95777021111;8483.194096560817;8802.955985220033;8843.823123537364;8981.775455613662;45339;49358.25962610492;50117.49647510581;52946.205806912156;54059;66916;71268.64365678138;73632.63183684048;74072;74930.5013899708;9670.806583868143;9813.362131461432;9946.154576861049;9956.153726933291;10008.549615267477;11790.823137652771;11805.23265987708;12051.096167787276;12343;12623.431945562288;9505.572249248939;11711.76576468483;11770.117241207116;12063.034957203578;12125.151239413157;11535.480903359537;11651.359175245103;11757.176997610086;11829.053675706095;12182.451789669309;11644.068474522188;11696.532138714356;11848.721992442146;11863.288401145024;11966.22219555726;9643.469609171563;9660.988227788877;9812.362196457207;9910.15763660097;10295.794084118426;9590.53866030599;9997.700068997941;10093.343932644355;10140.695779126343;10142.89857101449 01:50:49 INFO - PROCESS | 2226 | __end_tp_report 01:50:49 INFO - PROCESS | 2226 | __start_cc_report 01:50:49 INFO - PROCESS | 2226 | _x_x_mozilla_cycle_collect,397 01:50:49 INFO - PROCESS | 2226 | __end_cc_report 01:50:49 INFO - PROCESS | 2226 | __startTimestamp1467622249795__endTimestamp 01:50:49 INFO - PROCESS | 2226 | 01:50:49 INFO - PROCESS | 2226 | ------- Summary: start ------- 01:50:49 INFO - PROCESS | 2226 | Number of tests: 6 01:50:49 INFO - PROCESS | 2226 | 01:50:49 INFO - PROCESS | 2226 | [#0] dojo.html Cycles:165 Average:5798.67 Median:6089.48 stddev:681.43 (11.2%) stddev-sans-first:646.71 01:50:49 INFO - PROCESS | 2226 | Values: 2982.3 3287.0 3548.2 3656.3 3670.3 5799.2 5920.3 5933.0 5961.7 5975.7 5912.3 5930.1 5958.4 5968.0 5977.3 4529.0 4839.3 5347.4 5361.3 5364.1 4051.8 5277.4 5325.9 5386.7 5400.0 5335.2 5368.6 5379.4 5380.9 5443.9 4303.7 4422.6 5171.6 5303.7 5320.2 4926.2 5213.3 5280.3 5297.8 5319.4 4817.9 5696.5 5707.9 5712.5 5748.8 5131.8 5692.9 5845.8 6111.4 6179.1 6212.5 6236.8 6241.9 6245.5 6260.7 5992.6 6004.0 6004.4 6020.7 6056.8 6232.0 6278.2 6301.4 6318.2 6319.8 6225.7 6268.3 6268.4 6271.2 6279.8 6277.3 6281.7 6288.9 6291.6 6297.7 6150.5 6166.9 6216.0 6274.2 6282.4 6203.8 6249.1 6249.8 6262.8 6287.8 4962.7 5028.4 5040.4 5050.9 5058.1 4360.3 4412.3 4462.0 4494.9 4581.7 5976.0 6002.0 6026.0 6038.7 6089.5 5984.9 6244.3 6283.6 6285.7 6290.0 5917.8 5949.2 5977.8 5982.2 6081.9 5427.7 5508.3 5517.9 5519.6 5524.2 6345.1 6381.1 6400.2 6420.1 6437.3 6228.8 6250.1 6250.9 6259.5 6272.0 6313.5 6333.8 6342.6 6369.1 6374.2 5245.4 6204.1 6217.7 6295.1 6296.9 6265.9 6270.8 6272.0 6286.3 6287.1 6061.9 6134.3 6194.0 6264.1 6287.4 6169.2 6256.7 6273.1 6276.4 6296.3 5830.6 6051.7 6120.9 6162.0 6169.4 6169.8 6186.4 6246.1 6272.3 6277.1 6158.5 6201.2 6231.5 6241.4 6256.3 01:50:49 INFO - PROCESS | 2226 | 01:50:49 INFO - PROCESS | 2226 | [#1] ext.html Cycles:180 Average:65427.30 Median:36566.23 stddev:135528.71 (370.6%) stddev-sans-first:135821.32 01:50:49 INFO - PROCESS | 2226 | Values: 532.1 558.5 580.6 590.8 611.0 38360.2 38908.0 39523.8 39641.8 39667.6 40620.6 41025.6 41303.8 41391.8 41401.8 9640.0 9829.9 9831.9 9842.0 9893.9 9754.1 9907.6 9908.9 9910.7 9929.5 9384.6 9992.8 12146.6 12155.3 12442.3 11908.5 11909.9 11981.5 12088.3 12138.8 11785.8 11808.6 11850.4 11910.0 12019.9 38670.8 38689.4 38762.6 39335.2 39751.8 3349.5 3390.6 3445.8 3846.5 3951.0 28718.0 28814.0 28820.9 29292.1 29395.9 2792.7 2850.8 2885.2 2945.5 2977.6 424956.0 429008.0 430210.0 430662.0 431689.0 60971.0 62003.0 62234.7 62699.4 62732.7 63989.4 64089.0 65587.3 66106.0 66405.3 17742.0 18369.4 18486.5 18532.0 18541.8 14185.9 14219.0 14698.4 14721.1 14756.3 14551.6 16089.0 16192.0 16334.3 16406.2 6602.2 6718.5 6730.3 6744.2 6812.0 1016.8 1051.6 1072.0 1093.5 1123.2 29587.4 29634.4 29860.7 30141.8 30281.0 1124.1 1165.6 1187.6 1208.1 1232.0 15443.6 15682.3 15683.6 15701.3 16128.5 505067.0 576709.1 588811.0 591684.0 600346.0 61072.7 61302.0 61307.4 61309.0 61481.0 1422.8 1541.5 1562.3 1568.7 1572.8 23935.0 27041.5 28544.9 30672.5 31058.7 52495.2 52787.0 52831.7 52962.0 53321.2 509039.0 513023.0 515598.0 517143.0 519980.0 34796.8 39138.2 40882.2 40919.8 41601.6 47047.8 48008.8 48191.8 48292.5 48473.8 35533.9 36538.0 36594.5 36684.6 36743.3 35653.3 35738.6 36039.0 36108.8 36258.8 36240.8 36387.0 37226.3 37395.8 39060.0 31216.0 32201.4 32210.4 32216.7 32323.0 20370.8 24924.9 25559.9 25626.0 25949.0 01:50:49 INFO - PROCESS | 2226 | 01:50:49 INFO - PROCESS | 2226 | [#2] jquery.html Cycles:180 Average:34252.51 Median:22081.56 stddev:101685.13 (460.5%) stddev-sans-first:101938.55 01:50:49 INFO - PROCESS | 2226 | Values: 365.7 407.5 409.1 415.7 416.5 15925.0 19299.9 21555.9 21713.0 21720.6 21007.0 21313.7 21459.7 21618.0 22013.8 5972.8 6059.0 6116.9 6247.0 6252.3 5164.4 6142.2 6263.4 6267.9 6271.2 5835.3 6032.8 6148.3 6262.8 6295.1 5848.6 6069.2 6070.9 6101.1 6164.1 5925.3 5926.6 5933.0 6056.3 6085.1 11938.4 12923.0 13385.4 13703.7 14006.9 2168.4 2174.2 2189.9 2254.3 2263.5 9803.6 9858.7 9909.5 9990.3 10163.2 1770.7 1806.4 1853.5 1857.6 1871.5 95520.5 99678.5 102283.5 103088.5 106013.0 11854.9 11863.5 11895.0 12062.3 12130.6 15128.4 15290.8 15534.8 15594.7 15606.2 7535.8 8879.3 9262.7 9351.3 9412.4 7670.3 9379.3 9482.2 9604.6 9636.9 4869.9 4901.1 4910.9 4937.5 4993.9 1774.0 2011.2 2114.7 2152.0 2158.0 891.0 954.5 996.4 1055.7 1085.1 14843.8 21726.9 22027.6 22065.7 22097.4 998.4 1049.9 1060.5 1080.9 1097.6 11075.0 11307.3 11805.6 11810.8 11811.1 523277.4 613405.0 634532.0 643172.0 645201.0 68646.7 120676.0 124285.8 131659.0 132608.0 904.5 948.1 1036.1 1037.8 1040.1 18619.5 19386.4 19482.3 19524.0 19789.0 50225.7 51905.7 53515.5 54772.5 55383.4 53271.0 72249.3 75554.0 75965.0 80215.0 6719.5 7889.5 7915.6 8251.7 8325.7 9144.4 12420.0 13070.7 13451.9 13600.0 10693.8 10790.7 11208.3 11295.3 11508.9 10547.8 10834.1 11229.0 11432.3 11609.2 11598.7 11607.2 11820.5 11847.8 11920.7 8428.5 8578.7 8653.3 8730.8 8732.7 8462.8 9896.9 10644.8 11837.9 11993.9 01:50:49 INFO - PROCESS | 2226 | 01:50:49 INFO - PROCESS | 2226 | [#3] mootools.html Cycles:180 Average:5832.21 Median:4979.01 stddev:3246.97 (65.2%) stddev-sans-first:3238.95 01:50:49 INFO - PROCESS | 2226 | Values: 1394.9 1479.2 1586.8 1804.8 1988.1 8196.3 8983.9 9058.0 9075.5 9339.2 8905.2 8927.5 9019.6 9045.9 9200.7 2528.2 2533.9 2537.4 2551.9 2567.8 2519.3 2542.8 2547.8 2570.3 2572.7 2270.6 2457.3 2519.9 2545.8 2579.7 2530.1 2532.2 2553.7 2564.7 2570.9 2421.0 2441.5 2464.5 2480.6 2585.8 9148.3 9153.4 9164.9 9170.0 9212.8 5440.0 5570.5 5634.2 5640.1 5650.3 3000.3 3643.0 3668.0 3691.3 3733.5 1057.8 1076.2 1078.9 1079.0 1080.4 11909.1 11945.0 11963.1 11997.9 12014.4 4109.8 4368.5 4842.0 4860.2 4865.5 8837.8 9949.1 10187.9 10247.7 10256.0 4712.2 5401.3 5487.9 5552.9 5578.4 4402.6 4611.9 4977.4 4980.6 5112.4 3634.7 4184.9 4224.1 4251.7 4335.9 1378.3 1394.3 1399.7 1402.4 1412.1 876.3 932.4 975.9 976.1 1013.3 5281.4 6091.7 6152.1 6254.4 6263.2 457.8 471.3 472.5 479.8 481.3 4035.1 4085.7 4137.0 4149.6 4200.8 10722.8 11001.1 11072.9 11195.0 11225.9 10802.7 10977.8 11031.0 11071.8 11105.0 8208.5 8532.6 8610.2 8685.1 8699.7 6063.4 6100.7 6231.2 6257.6 6276.0 8828.7 9699.8 9711.1 9823.0 9863.9 9471.3 9796.1 9813.1 9823.8 10150.9 7042.3 7506.9 7704.7 7715.7 7730.1 8326.9 8457.9 8479.6 8492.6 8527.0 7435.1 7604.7 7609.5 7683.3 7686.3 7339.2 7466.7 7469.1 7541.6 7550.8 7159.7 7190.6 7225.8 7226.1 7246.2 4927.5 4954.8 5033.5 5127.8 5133.2 5092.6 5121.4 5136.3 5173.1 5359.7 01:50:49 INFO - PROCESS | 2226 | 01:50:49 INFO - PROCESS | 2226 | [#4] prototype.html Cycles:180 Average:6081.16 Median:6791.96 stddev:2000.83 (29.5%) stddev-sans-first:1958.69 01:50:49 INFO - PROCESS | 2226 | Values: 291.6 304.7 315.4 339.6 345.3 7074.5 7078.3 7086.9 7102.4 7142.8 5680.4 5855.8 6802.6 7024.5 7038.8 4098.1 4875.3 4935.5 5109.7 5113.8 5038.4 5100.8 5110.5 5115.8 5123.9 4499.3 4737.3 5068.0 5088.1 5097.7 4572.2 4695.2 5089.7 5113.1 5123.5 3532.3 4368.0 4380.6 4387.4 4413.6 4862.6 6589.8 6604.0 6693.9 6746.9 5959.9 6003.6 6015.3 6018.2 6025.5 7439.7 7459.6 7463.0 7471.9 7513.2 4894.1 4894.4 4901.4 4907.6 4940.2 7631.0 7909.7 7923.5 7936.6 7992.2 5003.9 5006.9 5007.1 5008.2 5042.3 5049.5 5099.0 5127.0 5140.0 5153.7 5961.1 5981.4 5985.4 6000.1 6021.7 7513.7 7516.4 7522.4 7551.2 7560.2 1641.4 1764.2 1776.5 1780.8 1788.1 994.9 1068.2 1078.0 1081.4 1083.8 6572.4 7074.6 7087.3 7102.5 7106.3 7530.4 7757.4 7762.5 7795.5 7795.9 5810.8 7022.1 7153.9 7162.6 7173.0 4166.7 4191.5 4205.4 4210.8 4217.2 6606.7 7951.2 8278.2 8291.9 8293.4 6561.5 7803.6 8134.6 8211.1 8226.6 8224.6 8241.2 8272.7 8285.6 8341.0 6359.9 7888.5 7895.1 7903.3 7928.4 7771.6 7783.5 7784.6 7798.3 7814.2 8062.4 8197.5 8280.9 8281.0 8284.5 3972.3 4019.4 4792.7 4801.8 4831.9 7708.2 7867.6 7872.9 7888.0 7891.6 7600.5 7623.5 7629.7 7639.2 7692.9 7365.4 7634.2 7650.2 7650.5 7668.4 6417.3 7028.9 7320.6 7442.0 7454.7 6330.5 6424.6 6781.3 7435.8 7641.5 6016.4 7086.9 7371.9 7483.2 7538.4 01:50:49 INFO - PROCESS | 2226 | 01:50:49 INFO - PROCESS | 2226 | [#5] yui.html Cycles:180 Average:18453.67 Median:577.74 stddev:25720.73 (4452.0%) stddev-sans-first:25758.47 01:50:49 INFO - PROCESS | 2226 | Values: 733.3 772.8 775.5 785.2 792.6 15261.2 15369.6 15495.0 15669.4 15681.3 11884.3 14309.7 14374.7 14386.9 14432.4 785.1 892.0 925.9 941.5 941.9 895.7 896.6 926.5 940.4 971.2 880.4 945.9 951.9 999.4 1020.1 940.7 971.2 988.5 994.1 1021.7 741.5 743.4 763.2 764.3 764.8 15296.9 15392.2 15417.2 15507.9 15591.6 13320.5 13434.8 13506.8 13537.3 13569.1 10338.3 10360.7 10420.4 10603.6 10687.5 3564.5 3617.5 3700.6 3705.9 3709.0 83755.6 84686.7 84994.6 85868.6 86020.0 9848.0 9910.5 9934.0 10035.8 10264.3 21518.6 21940.0 21945.6 21992.8 23025.7 7681.3 7730.8 7738.2 7876.1 7932.0 3490.7 4237.2 4257.1 4333.2 4395.6 3694.7 3698.6 3714.1 3720.3 3728.2 627.7 709.4 730.2 734.5 740.6 527.6 556.6 579.6 609.2 624.6 8358.7 8393.5 8469.2 8569.5 8635.3 524.5 551.0 567.1 575.9 602.7 3930.0 3955.6 4020.7 4067.3 4228.8 86442.1 86857.6 88047.1 88374.0 89509.0 74223.9 75921.6 83734.1 84129.7 85452.6 52164.0 52271.0 69509.7 69681.3 70227.0 8446.0 8483.2 8803.0 8843.8 8981.8 45339.0 49358.3 50117.5 52946.2 54059.0 66916.0 71268.6 73632.6 74072.0 74930.5 9670.8 9813.4 9946.2 9956.2 10008.5 11790.8 11805.2 12051.1 12343.0 12623.4 9505.6 11711.8 11770.1 12063.0 12125.2 11535.5 11651.4 11757.2 11829.1 12182.5 11644.1 11696.5 11848.7 11863.3 11966.2 9643.5 9661.0 9812.4 9910.2 10295.8 9590.5 9997.7 10093.3 10140.7 10142.9 01:50:49 INFO - PROCESS | 2226 | -------- Summary: end -------- 01:50:49 INFO - PROCESS | 2226 | 01:50:50 INFO - TEST-INFO | 2226: exit 0 01:50:50 INFO - TEST-OK | dromaeo_css | took 1109505ms 01:50:50 INFO - TEST-START | kraken 01:50:50 INFO - operating with platform_type : mac_ 01:50:50 INFO - Initialising browser for kraken test... 01:50:50 INFO - TEST-INFO | started process 2231 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpFgq3CS/profile http://localhost:52446/getInfo.html) 01:50:52 INFO - PROCESS | 2231 | __metrics Screen width/height:1600/1200 01:50:52 INFO - PROCESS | 2231 | colorDepth:24 01:50:52 INFO - PROCESS | 2231 | Browser inner width/height: 1024/689 01:50:52 INFO - PROCESS | 2231 | __metrics 01:50:52 ERROR - PROCESS | 2231 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 01:50:53 INFO - TEST-INFO | 2231: exit 0 01:50:53 INFO - Browser initialized. 01:50:53 INFO - Running cycle 1/1 for kraken test... 01:50:53 INFO - TEST-INFO | started process 2235 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpFgq3CS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:51:05 INFO - PROCESS | 2235 | RSS: Main: 171778048 01:51:05 INFO - PROCESS | 2235 | 01:51:08 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52446/tests/kraken/driver.html?testName=audio-beat-detection) 01:51:09 INFO - PROCESS | 2235 | RSS: Main: 184131584 01:51:09 INFO - PROCESS | 2235 | 01:51:11 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52446/tests/kraken/driver.html?testName=audio-dft) 01:51:12 INFO - PROCESS | 2235 | RSS: Main: 192761856 01:51:12 INFO - PROCESS | 2235 | 01:51:15 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52446/tests/kraken/driver.html?testName=audio-fft) 01:51:16 INFO - PROCESS | 2235 | RSS: Main: 196431872 01:51:16 INFO - PROCESS | 2235 | 01:51:18 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52446/tests/kraken/driver.html?testName=audio-oscillator) 01:51:19 INFO - PROCESS | 2235 | RSS: Main: 197124096 01:51:19 INFO - PROCESS | 2235 | 01:51:21 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:51:21 INFO - PROCESS | 2235 | RSS: Main: 198156288 01:51:21 INFO - PROCESS | 2235 | 01:51:24 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52446/tests/kraken/driver.html?testName=imaging-darkroom) 01:51:25 INFO - PROCESS | 2235 | RSS: Main: 198668288 01:51:25 INFO - PROCESS | 2235 | 01:51:28 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52446/tests/kraken/driver.html?testName=imaging-desaturate) 01:51:29 INFO - PROCESS | 2235 | RSS: Main: 198922240 01:51:29 INFO - PROCESS | 2235 | 01:51:31 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52446/tests/kraken/driver.html?testName=json-parse-financial) 01:51:32 INFO - PROCESS | 2235 | RSS: Main: 198807552 01:51:32 INFO - PROCESS | 2235 | 01:51:34 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:51:34 INFO - PROCESS | 2235 | RSS: Main: 198688768 01:51:34 INFO - PROCESS | 2235 | 01:51:36 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:51:37 INFO - PROCESS | 2235 | RSS: Main: 198787072 01:51:37 INFO - PROCESS | 2235 | 01:51:39 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:51:40 INFO - PROCESS | 2235 | RSS: Main: 198545408 01:51:40 INFO - PROCESS | 2235 | 01:51:43 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:51:43 INFO - PROCESS | 2235 | RSS: Main: 198672384 01:51:43 INFO - PROCESS | 2235 | 01:51:46 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:51:47 INFO - PROCESS | 2235 | RSS: Main: 199094272 01:51:47 INFO - PROCESS | 2235 | 01:51:48 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52446/tests/kraken/driver.html?testName=ai-astar) 01:51:49 INFO - PROCESS | 2235 | RSS: Main: 200278016 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | __start_tp_report 01:51:49 INFO - PROCESS | 2235 | _x_x_mozilla_page_load 01:51:49 INFO - PROCESS | 2235 | _x_x_mozilla_page_load_details 01:51:49 INFO - PROCESS | 2235 | |i|pagename|runs| 01:51:49 INFO - PROCESS | 2235 | |0;ai-astar;113;117;110;96;169;170;123;117;137;121 01:51:49 INFO - PROCESS | 2235 | |1;audio-beat-detection;155;120;142;165;155;142;120;154;162;122 01:51:49 INFO - PROCESS | 2235 | |2;audio-dft;199;198;283;247;199;199;197;198;195;196 01:51:49 INFO - PROCESS | 2235 | |3;audio-fft;65;72;81;152;89;83;81;89;132;57 01:51:49 INFO - PROCESS | 2235 | |4;audio-oscillator;66;122;172;115;97;86;124;81;77;125 01:51:49 INFO - PROCESS | 2235 | |5;imaging-gaussian-blur;89;79;136;131;88;101;117;121;105;75 01:51:49 INFO - PROCESS | 2235 | |6;imaging-darkroom;102;99;144;113;94;93;106;91;89;90 01:51:49 INFO - PROCESS | 2235 | |7;imaging-desaturate;115;116;89;91;93;117;117;92;92;89 01:51:49 INFO - PROCESS | 2235 | |8;json-parse-financial;58;64;65;66;65;65;63;81;61;58 01:51:49 INFO - PROCESS | 2235 | |9;json-stringify-tinderbox;53;64;79;87;106;70;77;98;97;97 01:51:49 INFO - PROCESS | 2235 | |10;stanford-crypto-aes;79;78;81;79;97;107;109;104;80;105 01:51:49 INFO - PROCESS | 2235 | |11;stanford-crypto-ccm;126;154;153;131;140;119;141;149;165;140 01:51:49 INFO - PROCESS | 2235 | |12;stanford-crypto-pbkdf2;163;163;164;163;158;174;220;200;162;160 01:51:49 INFO - PROCESS | 2235 | |13;stanford-crypto-sha256-iterative;68;67;73;72;67;73;93;99;99;68 01:51:49 INFO - PROCESS | 2235 | __end_tp_report 01:51:49 INFO - PROCESS | 2235 | __start_cc_report 01:51:49 INFO - PROCESS | 2235 | _x_x_mozilla_cycle_collect,1042 01:51:49 INFO - PROCESS | 2235 | __end_cc_report 01:51:49 INFO - PROCESS | 2235 | __startTimestamp1467622309226__endTimestamp 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | ------- Summary: start ------- 01:51:49 INFO - PROCESS | 2235 | Number of tests: 14 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#0] ai-astar Cycles:10 Average:127.30 Median:130.00 stddev:24.52 (18.9%) stddev-sans-first:25.45 01:51:49 INFO - PROCESS | 2235 | Values: 113.0 117.0 110.0 96.0 169.0 170.0 123.0 117.0 137.0 121.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:154.50 stddev:17.48 (11.3%) stddev-sans-first:18.06 01:51:49 INFO - PROCESS | 2235 | Values: 155.0 120.0 142.0 165.0 155.0 142.0 120.0 154.0 162.0 122.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#2] audio-dft Cycles:10 Average:211.10 Median:199.00 stddev:29.68 (14.9%) stddev-sans-first:31.15 01:51:49 INFO - PROCESS | 2235 | Values: 199.0 198.0 283.0 247.0 199.0 199.0 197.0 198.0 195.0 196.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#3] audio-fft Cycles:10 Average:90.10 Median:81.00 stddev:29.55 (36.5%) stddev-sans-first:29.91 01:51:49 INFO - PROCESS | 2235 | Values: 65.0 72.0 81.0 152.0 89.0 83.0 81.0 89.0 132.0 57.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:71.50 stddev:31.49 (44.0%) stddev-sans-first:29.79 01:51:49 INFO - PROCESS | 2235 | Values: 66.0 122.0 172.0 115.0 97.0 86.0 124.0 81.0 77.0 125.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#5] imaging-gaussian-blur Cycles:10 Average:104.20 Median:105.50 stddev:21.52 (20.4%) stddev-sans-first:22.11 01:51:49 INFO - PROCESS | 2235 | Values: 89.0 79.0 136.0 131.0 88.0 101.0 117.0 121.0 105.0 75.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:90.50 stddev:16.63 (18.4%) stddev-sans-first:17.64 01:51:49 INFO - PROCESS | 2235 | Values: 102.0 99.0 144.0 113.0 94.0 93.0 106.0 91.0 89.0 90.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#7] imaging-desaturate Cycles:10 Average:101.10 Median:90.00 stddev:13.11 (14.6%) stddev-sans-first:12.90 01:51:49 INFO - PROCESS | 2235 | Values: 115.0 116.0 89.0 91.0 93.0 117.0 117.0 92.0 92.0 89.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:6.45 (9.9%) stddev-sans-first:6.38 01:51:49 INFO - PROCESS | 2235 | Values: 58.0 64.0 65.0 66.0 65.0 65.0 63.0 81.0 61.0 58.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#9] json-stringify-tinderbox Cycles:10 Average:82.80 Median:83.00 stddev:17.14 (20.6%) stddev-sans-first:14.39 01:51:49 INFO - PROCESS | 2235 | Values: 53.0 64.0 79.0 87.0 106.0 70.0 77.0 98.0 97.0 97.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:79.00 stddev:13.54 (17.1%) stddev-sans-first:13.54 01:51:49 INFO - PROCESS | 2235 | Values: 79.0 78.0 81.0 79.0 97.0 107.0 109.0 104.0 80.0 105.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:145.00 stddev:13.97 (9.6%) stddev-sans-first:13.60 01:51:49 INFO - PROCESS | 2235 | Values: 126.0 154.0 153.0 131.0 140.0 119.0 141.0 149.0 165.0 140.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:163.50 stddev:20.64 (12.6%) stddev-sans-first:21.59 01:51:49 INFO - PROCESS | 2235 | Values: 163.0 163.0 164.0 163.0 158.0 174.0 220.0 200.0 162.0 160.0 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - PROCESS | 2235 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.90 Median:73.00 stddev:13.48 (18.5%) stddev-sans-first:13.81 01:51:49 INFO - PROCESS | 2235 | Values: 68.0 67.0 73.0 72.0 67.0 73.0 93.0 99.0 99.0 68.0 01:51:49 INFO - PROCESS | 2235 | -------- Summary: end -------- 01:51:49 INFO - PROCESS | 2235 | 01:51:49 INFO - TEST-INFO | 2235: exit 0 01:51:49 INFO - TEST-OK | kraken | took 59656ms 01:51:49 INFO - SUITE-END | took 1169s 01:51:50 INFO - Completed test suite (00:19:29) 01:51:50 INFO - javascript benchmark 01:51:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2982.2842517795725, 3286.950695739563, 3548.201654627709, 3656.2504686539255, 3670.3026424979253, 5799.159121927323, 5920.289565252176, 5933.0, 5961.672108034068, 5975.729222895299, 5912.260967379078, 5930.051191809312, 5958.43394877487, 5968.0, 5977.342492325841, 4528.954710452895, 4839.322494850724, 5347.438518955512, 5361.276227709248, 5364.141737322029, 4051.817668204923, 5277.366715994086, 5325.866853328678, 5386.703731294777, 5399.9730001349935, 5335.226392173133, 5368.62419630626, 5379.408265090837, 5380.892382152374, 5443.938432005761, 4303.698741088125, 4422.6240769534625, 5171.560417364529, 5303.7348132593215, 5320.201969704536, 4926.211806111005, 5213.296205012312, 5280.287161233223, 5297.761600727977, 5319.3616765987945, 4817.927731084036, 5696.515796157331, 5707.942920570783, 5712.485876271114, 5748.7987920423, 5131.794728210867, 5692.8861422771315, 5845.766169353264, 6111.419415155553, 6179.134921111048, 6212.471939885115, 6236.812895613139, 6241.875162496724, 6245.531585131133, 6260.655663938482, 5992.64044157352, 6003.969980150158, 6004.443667773406, 6020.69896505173, 6056.818295451144, 6232.002879539252, 6278.215223097113, 6301.369863013753, 6318.241810982711, 6319.842003949846, 6225.657588832567, 6268.341824108403, 6268.373162683695, 6271.153394291803, 6279.8116056517465, 6277.309495955441, 6281.685915704196, 6288.868003759368, 6291.622502649764, 6297.748090076438, 6150.50795936333, 6166.876662466726, 6216.036514340284, 6274.152989346471, 6282.403171698681, 6203.7828675997025, 6249.0938813871735, 6249.843753906098, 6262.843428914222, 6287.842803929939, 4962.727050012212, 5028.421731500851, 5040.36995375578, 5050.949490505048, 5058.089543882063, 4360.302351623725, 4412.3160910059, 4461.955380446219, 4494.910101797946, 4581.65637577183, 5975.970120149372, 6002.039673652194, 6026.035834266497, 6038.667873266924, 6089.482393996472, 5984.880302393928, 6244.344343843922, 6283.560150789493, 6285.685715714196, 6289.96215624426, 5917.822465326047, 5949.226600541989, 5977.760889564455, 5982.162497250389, 6081.908771368433, 5427.728613569306, 5508.3114610673665, 5517.917231241535, 5519.641223320471, 5524.1989911462615, 6345.111684364193, 6381.117570316767, 6400.23197216337, 6420.101185833987, 6437.324080971524, 6228.750849966132, 6250.124982502362, 6250.874982500233, 6259.467945224706, 6272.0, 6313.463355614824, 6333.778317758856, 6342.556021078481, 6369.1401660777055, 6374.203224596926, 5245.423003469692, 6204.13142160089, 6217.689115544295, 6295.055741638791, 6296.874062518816, 6265.906011409741, 6270.7805226816845, 6271.965125754199, 6286.308506064421, 6287.119803227643, 6061.878762424639, 6134.344744984565, 6194.0, 6264.091706702594, 6287.371262873859, 6169.167162433194, 6256.687165641609, 6273.121762953099, 6276.372362763687, 6296.275928268308, 5830.591858569859, 6051.697415129314, 6120.8775824484155, 6161.983272760123, 6169.413905678954, 6169.753209871735, 6186.381361863778, 6246.063090536274, 6272.278687950944, 6277.089821975696, 6158.476529495043, 6201.193844800147, 6231.470325022243, 6241.438270555672, 6256.343083976117], "value": 5755.14472153725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.0688794609433, 558.5294184642719, 580.6342004537141, 590.7814108779746, 610.9583160710988, 38360.23279534411, 38908.0, 39523.80238098809, 39641.80179099104, 39667.60332396675, 40620.59379406205, 41025.58974410255, 41303.76088717336, 41391.79304103483, 41401.792991035, 9639.951800241006, 9829.90170098297, 9831.90168098317, 9842.015798420172, 9893.901060989407, 9754.0733630305, 9907.554160062815, 9908.851367229498, 9910.653127140551, 9929.453880036595, 9384.577694003752, 9992.750181245454, 12146.635600931986, 12155.331456769874, 12442.253464792097, 11908.523659053713, 11909.940450297692, 11981.520739170466, 12088.274703517816, 12138.817917731241, 11785.764284714258, 11808.586699465477, 11850.407479625985, 11910.0, 12019.93990030053, 38670.80664596687, 38689.41965870486, 38762.61237387618, 39335.21329573393, 39751.80744577667, 3349.531065650811, 3390.610079840825, 3445.810480423576, 3846.4614953906475, 3950.9924969132685, 28717.994870179653, 28814.0, 28820.855895720597, 29292.121236362942, 29395.85302073476, 2792.7346902044274, 2850.8432036238, 2885.2354126156583, 2945.484540205477, 2977.6277965254344, 424956.0, 429008.0, 430210.0, 430662.0, 431689.0, 60971.0, 62003.0, 62234.688826555575, 62699.37300626935, 62732.686336568026, 63989.36010639927, 64089.0, 65587.34412655812, 66106.0, 66405.33594663991, 17742.0, 18369.448916532525, 18486.537836553925, 18532.0, 18541.81458185428, 14185.858141418454, 14219.0, 14698.412063517553, 14721.116732996055, 14756.335964881606, 14551.636209094857, 16089.034657920562, 16192.0, 16334.264958076916, 16406.1796910154, 6602.207735071822, 6718.462522998148, 6730.293319201413, 6744.156980377453, 6812.0, 1016.7712264740375, 1051.5636011055326, 1071.994640026795, 1093.4969913839564, 1123.152020224725, 29587.408251834844, 29634.407311853643, 29860.701392986226, 30141.849290753846, 30281.0, 1124.100719424457, 1165.6153469355093, 1187.5962172861095, 1208.087893640296, 1231.96920076997, 15443.61390965235, 15682.294296756674, 15683.607909802346, 15701.293441795147, 16128.516144515683, 505067.0, 576709.116454415, 588811.0, 591684.0, 600346.0, 61072.69463652653, 61302.0, 61307.386926130166, 61309.0, 61481.0, 1422.8008078868966, 1541.46819347325, 1562.3281988744948, 1568.725473042213, 1572.7798108264851, 23935.0, 27041.459170816866, 28544.85727571349, 30672.539911900894, 31058.68941310558, 52495.21257181222, 52787.0, 52831.735841320544, 52962.0, 53321.20018199652, 509039.0, 513023.0, 515598.0, 517143.0, 519980.0, 34796.82601586976, 39138.217235654556, 40882.1823563533, 40919.795401022806, 41601.583984160985, 47047.764761175975, 48008.75995620139, 48191.75904120457, 48292.5170748288, 48473.75763121162, 35533.93398198058, 36538.0, 36594.45108323431, 36684.63315366919, 36743.26513469769, 35653.28693426169, 35738.64261357353, 36039.0, 36108.81945590255, 36258.8187059063, 36240.818795906904, 36387.0, 37226.25547488981, 37395.81302093472, 39060.0, 31216.0, 32201.35597288088, 32210.35579288448, 32216.711331546474, 32323.0, 20370.79629203689, 24924.875375623007, 25559.872200638878, 25626.0, 25948.962041518884], "value": 20441.47025844077, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.65993625927877, 407.5394803871625, 409.08161178155046, 415.6840800991247, 416.4939598387958, 15925.0, 19299.903500482495, 21555.922203889782, 21713.02291396887, 21720.565588688238, 21007.0, 21313.68029479555, 21459.67810482844, 21618.0, 22013.789241591705, 5972.79095231667, 6058.969705151468, 6116.908246376308, 6246.968765156168, 6252.2809876864285, 5164.380274367081, 6142.232220972379, 6263.436290733833, 6267.905981410259, 6271.216097987752, 5835.270591176103, 6032.758689652409, 6148.292946311187, 6262.780802671908, 6295.055741638745, 5848.561357898132, 6069.241344831896, 6070.908936365958, 6101.145839582484, 6164.075388691687, 5925.259342582177, 5926.644401335933, 5932.991391463462, 6056.3338032816355, 6085.148079268906, 11938.403079845973, 12923.0, 13385.397657105454, 13703.657408564766, 14006.94947878913, 2168.447046003275, 2174.239016344267, 2189.901454434554, 2254.2673631069806, 2263.5472905418983, 9803.607855685765, 9858.65494707689, 9909.454979976099, 9990.300678952477, 10163.237757168243, 1770.7078332075191, 1806.4490330449207, 1853.5458812591, 1857.647047061054, 1871.5414723392855, 95520.52239738827, 99678.50160749222, 102283.48858255662, 103088.48455757748, 106013.0, 11854.94072529632, 11863.525458981545, 11895.04839612829, 12062.336571488653, 12130.575429859913, 15128.39486420553, 15290.847091528942, 15534.766978495332, 15594.688106237812, 15606.219689015505, 7535.773926782205, 8879.28965682744, 9262.675806346746, 9351.251899847995, 9412.435253884789, 7670.348020418215, 9379.343445958717, 9482.241420686329, 9604.567794449267, 9636.855447168298, 4869.902601947942, 4901.113071467511, 4910.926336104962, 4937.530934561211, 4993.90012199754, 1773.9645207095787, 2011.185469884699, 2114.6933694614504, 2151.967720484194, 2158.0073166343345, 890.955452227386, 954.4559601027348, 996.4220751963844, 1055.7149569616315, 1085.0939465546357, 14843.777343339858, 21726.891365543386, 22027.559448810935, 22065.669014964787, 22097.447563811034, 998.3859926145368, 1049.879263884663, 1060.5439660945867, 1080.8865069167782, 1097.5829184909683, 11075.003249707404, 11307.265027773168, 11805.645830625095, 11810.822837657443, 11811.055115590732, 523277.3836130871, 613405.0, 634532.0, 643172.0, 645201.0, 68646.65676671585, 120676.0, 124285.75714242923, 131659.0, 132608.0, 904.4618452021037, 948.0803620488116, 1036.1141224253156, 1037.801339452933, 1040.1366865501616, 18619.534511637317, 19386.4184074478, 19482.318118865773, 19524.0, 19789.01054947218, 50225.74887125541, 51905.7404712974, 53515.4648453526, 54772.45227547674, 55383.446165537825, 53271.0, 72249.27750722425, 75554.0, 75965.0, 80214.99462513484, 6719.529632925648, 7889.487183333065, 7915.643796029078, 8251.711190108317, 8325.708600198965, 9144.405613635092, 12420.0, 13070.738585228051, 13451.865481345061, 13600.04799664014, 10693.786124277627, 10790.67627971162, 11208.327500350006, 11295.265807722471, 11508.94245528767, 10547.841782373118, 10834.133269338592, 11229.0, 11432.256903301259, 11609.187356884937, 11598.652040438801, 11607.187496875138, 11820.527178913091, 11847.76304473923, 11920.701982450508, 8428.4942903426, 8578.742637720878, 8653.293697384326, 8730.825383492422, 8732.69435569752, 8462.788430289045, 9896.911339752765, 10644.84032739494, 11837.881621184022, 11993.880061199276], "value": 9551.212138270583, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.867487588679, 1479.2086233864877, 1586.7778511008453, 1804.8195180481953, 1988.1252249010424, 8196.262336389724, 8983.865242021358, 9058.048904864985, 9075.455472671645, 9339.15947564719, 8905.198532132106, 8927.464352138877, 9019.594118264677, 9045.90954090459, 9200.677976270832, 2528.15306872198, 2533.936651583707, 2537.429078457351, 2551.9234422967247, 2567.845929244242, 2519.3197836584113, 2542.8474291542566, 2547.8471291722462, 2570.2546261584116, 2572.691277046757, 2270.5685919675293, 2457.299669594166, 2519.911803086892, 2545.7581529754643, 2579.703334116582, 2530.0891678995545, 2532.227670560478, 2553.74462553745, 2564.7307032761664, 2570.910018149356, 2421.043687743349, 2441.4750828571764, 2464.507098580273, 2480.6279058141245, 2585.7543533364487, 9148.313876459226, 9153.405028673114, 9164.8625270621, 9170.0, 9212.769680757967, 5439.972800135974, 5570.498655121018, 5634.239377684001, 5640.097584386478, 5650.26546548946, 3000.3249268914537, 3642.9817850910576, 3668.0, 3691.3171063353097, 3733.533308336458, 1057.7884423115331, 1076.2251179150999, 1078.9136869050458, 1078.978420431587, 1080.4057768227444, 11909.10681698876, 11945.044396448264, 11963.102767292401, 11997.880021199764, 12014.399280035963, 4109.815058322382, 4368.497622773358, 4841.983183531498, 4860.222364421676, 4865.464798872192, 8837.823243535093, 9949.104580587782, 10187.949060254652, 10247.7438064049, 10256.0, 4712.222483290218, 5401.3248343957, 5487.890242195213, 5552.86117847049, 5578.386377498472, 4402.603765661106, 4611.884702882455, 4977.427595826454, 4980.601551875841, 5112.437631860493, 3634.6910512606196, 4184.91630167401, 4224.134052519226, 4251.659867210616, 4335.891602709958, 1378.3177327223088, 1394.3376895974534, 1399.657084014423, 1402.4390243902317, 1412.1315391034645, 876.2945828608032, 932.38462614674, 975.9316847820585, 976.1263669016191, 1013.3261381181431, 5281.366236051698, 6091.7207386449345, 6152.077188421683, 6254.437100660872, 6263.185785847811, 457.83975608536747, 471.3142377840303, 472.5038709355163, 479.8416522547551, 481.2636665901177, 4035.1035013544174, 4085.7140000200293, 4136.958630413717, 4149.647279981175, 4200.831966721358, 10722.78554428907, 11001.064909482624, 11072.944635276772, 11195.0, 11225.887741122484, 10802.67591972242, 10977.83533247002, 11031.0, 11071.778564428667, 11105.000549950382, 8208.548529830798, 8532.57337133141, 8610.225079742853, 8685.08806575313, 8699.739007829776, 6063.393660633901, 6100.725467353891, 6231.189945307081, 6257.56197066201, 6276.0, 8828.735137945872, 9699.757506062404, 9711.077447642463, 9822.950885245527, 9863.852042219516, 9471.337006409485, 9796.069373409515, 9813.116819485995, 9823.754406139904, 10150.898491014996, 7042.330978557029, 7506.9249307506225, 7704.653290601825, 7715.652795624098, 7730.111037230566, 8326.916730832614, 8457.87313190315, 8479.618417171365, 8492.617832197442, 8526.957365213135, 7435.144958329862, 7604.657790399556, 7609.505382150142, 7683.346915512244, 7686.3082322589, 7339.229380915141, 7466.701331946661, 7469.14104877946, 7541.585212813348, 7550.848983020199, 7159.677814498465, 7190.568565886064, 7225.783226503213, 7226.096737907762, 7246.1666908306215, 4927.507249275187, 4954.752262386938, 5033.496650335083, 5127.769250383667, 5133.204353325241, 5092.567131793839, 5121.436641969306, 5136.30659860929, 5173.1464308388695, 5359.705216213146], "value": 4639.635960470018, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.62963036943086, 304.7013926352175, 315.3566723883278, 339.5636606960056, 345.30421201279427, 7074.469414793892, 7078.2921707829255, 7086.881772020308, 7102.360787529121, 7142.785716428502, 5680.403557626451, 5855.76576936922, 6802.605465879496, 7024.508284420092, 7038.753643622475, 4098.098418347959, 4875.317455556216, 4935.506449355072, 5109.718965456898, 5113.769880355393, 5038.412899936527, 5100.84697459075, 5110.514501122406, 5115.795368185287, 5123.948760512403, 4499.280115181572, 4737.289406589022, 5068.0, 5088.1095808233595, 5097.745112744366, 4572.199865023607, 4695.201815691341, 5089.7455127243675, 5113.130767769489, 5123.487651234846, 3532.311199316134, 4367.978160109179, 4380.5838445347645, 4387.407699960529, 4413.558644135593, 4862.5623693867365, 6589.80230593083, 6603.966980165116, 6693.9289713645585, 6746.932530674729, 5959.880802383928, 6003.579749417542, 6015.308239552463, 6018.1574579558455, 6025.487833534155, 7439.665215065281, 7459.627018649046, 7463.0, 7471.91657209707, 7513.211112833128, 4894.094592500399, 4894.437139728905, 4901.362822833009, 4907.576802727205, 4940.2342636891335, 7630.961845190794, 7909.723159689441, 7923.5245885246495, 7936.563489008102, 7992.200779922019, 5003.949960500421, 5006.874828129326, 5007.123753343223, 5008.198688209869, 5042.344495215599, 5049.495050494921, 5099.031184075014, 5127.0, 5140.0, 5153.742312884341, 5961.105834124829, 5981.401859813984, 5985.40145985398, 6000.129981152709, 6021.6989150542295, 7513.661885215179, 7516.361109305661, 7522.3605993491165, 7551.169371369145, 7560.206178351304, 1641.4008886756249, 1764.2413762082429, 1776.5203395083256, 1780.8486278666198, 1788.0880750817178, 994.9105729226485, 1068.1614932278123, 1078.0, 1081.4268437728017, 1083.766990097133, 6572.408483236436, 7074.610896400644, 7087.291270872872, 7102.538335008208, 7106.324899134574, 7530.359919406912, 7757.4181936355, 7762.495437796525, 7795.5054382598155, 7795.883061754078, 5810.82567522975, 7022.087128673342, 7153.92846071543, 7162.570245785269, 7173.0, 4166.749995000249, 4191.476065491814, 4205.369194620831, 4210.810513526899, 4217.198732240864, 6606.669666516655, 7951.244631759973, 8278.213569710988, 8291.917080829235, 8293.419460637697, 6561.507886908501, 7803.609819509002, 8134.59327033646, 8211.137830527829, 8226.588670566447, 8224.588770561448, 8241.175882411831, 8272.710455134042, 8285.62714677841, 8341.0, 6359.936400636119, 7888.526688398714, 7895.092064412666, 7903.288704016666, 7928.365730741642, 7771.611419428893, 7783.494072885244, 7784.571848548384, 7798.298153166243, 7814.21857814214, 8062.435629505878, 8197.549134797406, 8280.923479947809, 8281.0, 8284.50292982423, 3972.2651309507833, 4019.397090436458, 4792.736399497921, 4801.847556586325, 4831.855044348676, 7708.229177082247, 7867.606619668879, 7872.881906771518, 7887.974563306733, 7891.565963872042, 7600.46796724224, 7623.504472209289, 7629.7329593463965, 7639.236076392539, 7692.92307076922, 7365.410767138509, 7634.160242373224, 7650.1584825668015, 7650.464467487445, 7668.424868134801, 6417.2620148681635, 7028.910518869583, 7320.597367144858, 7441.958125862492, 7454.6645400956, 6330.49356051524, 6424.582402144033, 6781.321867813179, 7435.847443646244, 7641.541507509567, 6016.398360163948, 7086.858262834818, 7371.926280737124, 7483.214262502359, 7538.396928245617], "value": 5403.440992206053, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.2887099513472, 772.8299774049707, 775.5346791924842, 785.1951749456808, 792.564089750637, 15261.23693815309, 15369.615759606015, 15495.0, 15669.373225071013, 15681.29434175462, 11884.346360950145, 14309.713805723904, 14374.712505749905, 14386.856131438682, 14432.422703091865, 785.1089013969157, 892.0054139634326, 925.8703781470599, 941.5151197133448, 941.868138460616, 895.7088946092514, 896.6144557840126, 926.5135803703076, 940.351157701184, 971.2036130373097, 880.4013270975734, 945.924326053914, 951.8952915179325, 999.4053538144792, 1020.0564477857989, 940.6566603189821, 971.2084651009475, 988.4859872866069, 994.0804755601076, 1021.693491952415, 741.525423728814, 743.382992116542, 763.1910175214235, 764.3464837563914, 764.7705688293489, 15296.923515382463, 15392.230388480531, 15417.15205663688, 15507.922460387626, 15591.610209744733, 13320.533781317705, 13434.798478022838, 13506.797398039038, 13537.323133843269, 13569.05016648825, 10338.328008679488, 10360.740981475448, 10420.374777513374, 10603.575856965712, 10687.465626718633, 3564.48314994327, 3617.5478065241846, 3700.629937006278, 3705.8702945397054, 3709.0254610179477, 83755.58122209412, 84686.72969905456, 84994.57502712509, 85868.57065714693, 86020.0, 9847.950760246153, 9910.504474776233, 9934.0, 10035.799284014425, 10264.332818366782, 21518.56962860734, 21940.012699428564, 21945.561088778453, 21992.78007219907, 23025.654615180785, 7681.308682218627, 7730.7680769577, 7738.187490313549, 7876.0548734151125, 7932.0, 3490.65093490654, 4237.216115018731, 4257.084726783756, 4333.241682705514, 4395.648348132142, 3694.722895782827, 3698.6486283802997, 3714.0900479382185, 3720.2745464634136, 3728.198437335986, 627.7018416252243, 709.3828369318622, 730.1530224939045, 734.5482528245197, 740.6000759589762, 527.6280222443169, 556.5686592890461, 579.5769088565287, 609.1989034419723, 624.5503237668871, 8358.707445239388, 8393.496390216607, 8469.195426434602, 8569.528675922884, 8635.337615291493, 524.5384062025394, 550.9696966666792, 567.1153001317957, 575.9020966435716, 602.7137109872775, 3929.980350098231, 3955.564887862333, 4020.6783457323345, 4067.349224124126, 4228.767417792051, 86442.13557864341, 86857.56571217104, 88047.11952880517, 88374.0, 89509.0, 74223.88664170042, 75921.62039189879, 83734.06930757394, 84129.73805392924, 85452.57273713716, 52163.95672086613, 52271.0, 69509.65245173742, 69681.30318696747, 70227.0, 8445.95777021111, 8483.194096560817, 8802.955985220033, 8843.823123537364, 8981.775455613662, 45339.0, 49358.25962610492, 50117.49647510581, 52946.205806912156, 54059.0, 66916.0, 71268.64365678138, 73632.63183684048, 74072.0, 74930.5013899708, 9670.806583868143, 9813.362131461432, 9946.154576861049, 9956.153726933291, 10008.549615267477, 11790.823137652771, 11805.23265987708, 12051.096167787276, 12343.0, 12623.431945562288, 9505.572249248939, 11711.76576468483, 11770.117241207116, 12063.034957203578, 12125.151239413157, 11535.480903359537, 11651.359175245103, 11757.176997610086, 11829.053675706095, 12182.451789669309, 11644.068474522188, 11696.532138714356, 11848.721992442146, 11863.288401145024, 11966.22219555726, 9643.469609171563, 9660.988227788877, 9812.362196457207, 9910.15763660097, 10295.794084118426, 9590.53866030599, 9997.700068997941, 10093.343932644355, 10140.695779126343, 10142.89857101449], "value": 7067.489992349158, "unit": "score"}], "name": "dromaeo_css", "value": 7641.53308755942, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 110.0, 96.0, 169.0, 170.0, 123.0, 117.0, 137.0, 121.0], "value": 127.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 120.0, 142.0, 165.0, 155.0, 142.0, 120.0, 154.0, 162.0, 122.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 198.0, 283.0, 247.0, 199.0, 199.0, 197.0, 198.0, 195.0, 196.0], "value": 211.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 81.0, 152.0, 89.0, 83.0, 81.0, 89.0, 132.0, 57.0], "value": 90.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 122.0, 172.0, 115.0, 97.0, 86.0, 124.0, 81.0, 77.0, 125.0], "value": 106.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 79.0, 136.0, 131.0, 88.0, 101.0, 117.0, 121.0, 105.0, 75.0], "value": 104.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 99.0, 144.0, 113.0, 94.0, 93.0, 106.0, 91.0, 89.0, 90.0], "value": 102.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 89.0, 91.0, 93.0, 117.0, 117.0, 92.0, 92.0, 89.0], "value": 101.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 65.0, 66.0, 65.0, 65.0, 63.0, 81.0, 61.0, 58.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 64.0, 79.0, 87.0, 106.0, 70.0, 77.0, 98.0, 97.0, 97.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 81.0, 79.0, 97.0, 107.0, 109.0, 104.0, 80.0, 105.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 154.0, 153.0, 131.0, 140.0, 119.0, 141.0, 149.0, 165.0, 140.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 158.0, 174.0, 220.0, 200.0, 162.0, 160.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 73.0, 72.0, 67.0, 73.0, 93.0, 99.0, 99.0, 68.0], "value": 77.9, "unit": "score"}], "name": "kraken", "value": 1617.8000000000002, "alertThreshold": 2.0}]} 01:51:50 INFO - Return code: 0 01:51:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:51:50 ERROR - # TBPL SUCCESS # 01:51:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:51:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:51:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:51:50 INFO - 2016-07-04 01:51:50.521 screenresolution[2240:19341] starting screenresolution argv=screenresolution get 01:51:50 INFO - 2016-07-04 01:51:50.524 screenresolution[2240:19341] Display 0: 1600x1200x32@60 01:51:50 INFO - 2016-07-04 01:51:50.530 screenresolution[2241:19344] starting screenresolution argv=screenresolution list 01:51:50 INFO - Available Modes on Display 0 01:51:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:51:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:51:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:51:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:51:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:51:50 INFO - Intel Iris: 01:51:50 INFO - Chipset Model: Intel Iris 01:51:50 INFO - Type: GPU 01:51:50 INFO - Bus: Built-In 01:51:50 INFO - VRAM (Dynamic, Max): 1536 MB 01:51:50 INFO - Vendor: Intel (0x8086) 01:51:50 INFO - Device ID: 0x0a2e 01:51:50 INFO - Revision ID: 0x0009 01:51:50 INFO - Displays: 01:51:50 INFO - Display: 01:51:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:51:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:51:50 INFO - Display Serial Number: 1600x1200 60 01:51:50 INFO - Main Display: Yes 01:51:50 INFO - Mirror: Off 01:51:50 INFO - Online: Yes 01:51:50 INFO - Rotation: Supported 01:51:50 INFO - Return code: 0 01:51:50 INFO - Running post-action listener: _resource_record_post_action 01:51:50 INFO - Running post-run listener: _resource_record_post_run 01:51:51 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 487424; Write bytes: 495537152; Read time: 6; Write time: 1551 01:51:51 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 182776320; Write bytes: 174370816; Read time: 16543; Write time: 385 01:51:51 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 487424; Write bytes: 300731392; Read time: 6; Write time: 1110 01:51:51 INFO - Running post-run listener: _upload_blobber_files 01:51:51 INFO - Blob upload gear active. 01:51:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:51:51 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 01:51:51 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'] 01:51:51 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 01:51:52 INFO - (blobuploader) - INFO - Open directory for files ... 01:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:51:52 INFO - (blobuploader) - INFO - Done attempting. 01:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:51:53 INFO - (blobuploader) - INFO - Done attempting. 01:51:53 INFO - (blobuploader) - INFO - Iteration through files over. 01:51:53 INFO - Return code: 0 01:51:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:51:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:51:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9cb35a129e27d87080fc0062238c0572282c0d74e1ffa7eb3dcd87605b41ee2e662b9880090ea01b14ea13c9b17dc016cdc96b177703f1effc7b618194e322c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/700acd7e9c8f05f5367a518e312f80cdb426a3345a8e37c9647307b20633ca0d8bc75f30728d84897167320f7befc85346f7161f50ab467291f5caf2cf2c688a"} 01:51:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:51:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:51:53 INFO - Contents: 01:51:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9cb35a129e27d87080fc0062238c0572282c0d74e1ffa7eb3dcd87605b41ee2e662b9880090ea01b14ea13c9b17dc016cdc96b177703f1effc7b618194e322c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/700acd7e9c8f05f5367a518e312f80cdb426a3345a8e37c9647307b20633ca0d8bc75f30728d84897167320f7befc85346f7161f50ab467291f5caf2cf2c688a"} 01:51:53 INFO - Running post-run listener: copy_logs_to_upload_dir 01:51:53 INFO - Copying logs to upload dir... 01:51:53 INFO - mkdir: /builds/slave/test/build/upload/logs 01:51:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.310118 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-04 01:51:53.971019) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 01:51:53.974873) ========= 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.maELa5AwdE/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.6NPLIgVaQH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9cb35a129e27d87080fc0062238c0572282c0d74e1ffa7eb3dcd87605b41ee2e662b9880090ea01b14ea13c9b17dc016cdc96b177703f1effc7b618194e322c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/700acd7e9c8f05f5367a518e312f80cdb426a3345a8e37c9647307b20633ca0d8bc75f30728d84897167320f7befc85346f7161f50ab467291f5caf2cf2c688a"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011622 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467596157/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9cb35a129e27d87080fc0062238c0572282c0d74e1ffa7eb3dcd87605b41ee2e662b9880090ea01b14ea13c9b17dc016cdc96b177703f1effc7b618194e322c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/700acd7e9c8f05f5367a518e312f80cdb426a3345a8e37c9647307b20633ca0d8bc75f30728d84897167320f7befc85346f7161f50ab467291f5caf2cf2c688a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 01:51:54.011886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 01:51:54.012637) ========= 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.maELa5AwdE/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.6NPLIgVaQH/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.005264 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 01:51:54.064871) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 01:51:54.065605) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 01:51:54.066334) ========= ========= Total master_lag: 0.26 =========