builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0318 starttime: 1468785555.39 results: success (0) buildid: 20160715100158 builduid: 169fdda1c4bd408d8deca56bc0cdf73e revision: b9a4d34cb07363b0616321353610e47c1ddaa2ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:15.390790) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:15.391223) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:15.391787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:15.758428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:15.758723) ========= 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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners TMPDIR=/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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-17 12:59:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.0M=0.001s 2016-07-17 12:59:16 (21.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.488102 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:16.335386) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:16.335657) ========= 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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners TMPDIR=/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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.020954 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:16.403396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-17 12:59:16.403695) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b9a4d34cb07363b0616321353610e47c1ddaa2ae --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 b9a4d34cb07363b0616321353610e47c1ddaa2ae --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners TMPDIR=/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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-17 12:59:16,493 truncating revision to first 12 chars 2016-07-17 12:59:16,494 Setting DEBUG logging. 2016-07-17 12:59:16,494 attempt 1/10 2016-07-17 12:59:16,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b9a4d34cb073?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-17 12:59:18,180 unpacking tar archive at: mozilla-beta-b9a4d34cb073/testing/mozharness/ program finished with exit code 0 elapsedTime=1.960745 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-17 12:59:18.394908) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:18.395196) ========= script_repo_revision: b9a4d34cb07363b0616321353610e47c1ddaa2ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:18.395566) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:18.395825) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 12:59:18.421534) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-17 12:59:18.421822) ========= /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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners TMPDIR=/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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 12:59:18 INFO - MultiFileLogger online at 20160717 12:59:18 in /builds/slave/test 12:59:18 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 12:59:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:59:18 INFO - {'append_to_log': False, 12:59:18 INFO - 'base_work_dir': '/builds/slave/test', 12:59:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:59:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:59:18 INFO - 'branch': 'Mozilla-Beta', 12:59:18 INFO - 'buildbot_json_path': 'buildprops.json', 12:59:18 INFO - 'config_files': ('talos/mac_config.py',), 12:59:18 INFO - 'default_actions': ('clobber', 12:59:18 INFO - 'read-buildbot-config', 12:59:18 INFO - 'download-and-extract', 12:59:18 INFO - 'populate-webroot', 12:59:18 INFO - 'create-virtualenv', 12:59:18 INFO - 'install', 12:59:18 INFO - 'run-tests'), 12:59:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:59:18 INFO - 'download_minidump_stackwalk': True, 12:59:18 INFO - 'download_symbols': 'ondemand', 12:59:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:59:18 INFO - 'tooltool.py': '/tools/tooltool.py', 12:59:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:59:18 INFO - '/tools/misc-python/virtualenv.py')}, 12:59:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:59:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:59:18 INFO - 'installer_path': 'installer.exe', 12:59:18 INFO - 'log_level': 'info', 12:59:18 INFO - 'log_name': 'talos', 12:59:18 INFO - 'log_to_console': True, 12:59:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:59:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:59:18 INFO - 'opt_config_files': (), 12:59:18 INFO - 'pip_index': False, 12:59:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:59:18 INFO - 'cmd': ('bash', 12:59:18 INFO - '-c', 12:59:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:59:18 INFO - 'enabled': True, 12:59:18 INFO - 'halt_on_failure': False, 12:59:18 INFO - 'name': 'check_screen_resolution'},), 12:59:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:59:18 INFO - 'cmd': ('bash', 12:59:18 INFO - '-c', 12:59:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:59:18 INFO - 'enabled': True, 12:59:18 INFO - 'halt_on_failure': False, 12:59:18 INFO - 'name': 'check_screen_resolution'},), 12:59:18 INFO - 'run_cmd_checks_enabled': True, 12:59:18 INFO - 'sps_profile': False, 12:59:18 INFO - 'sps_profile_interval': 0, 12:59:18 INFO - 'suite': 'dromaeojs-e10s', 12:59:18 INFO - 'system_bits': '32', 12:59:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:59:18 INFO - 'title': 't-yosemite-r7-0318', 12:59:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:59:18 INFO - 'use_talos_json': True, 12:59:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:59:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:59:18 INFO - 'work_dir': 'build'} 12:59:18 INFO - ##### 12:59:18 INFO - ##### Running clobber step. 12:59:18 INFO - ##### 12:59:18 INFO - Running pre-action listener: _resource_record_pre_action 12:59:18 INFO - Running main action method: clobber 12:59:18 INFO - rmtree: /builds/slave/test/build 12:59:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:59:20 INFO - Running post-action listener: _resource_record_post_action 12:59:20 INFO - ##### 12:59:20 INFO - ##### Running read-buildbot-config step. 12:59:20 INFO - ##### 12:59:20 INFO - Running pre-action listener: _resource_record_pre_action 12:59:20 INFO - Running main action method: read_buildbot_config 12:59:20 INFO - Using buildbot properties: 12:59:20 INFO - { 12:59:20 INFO - "project": "", 12:59:20 INFO - "product": "firefox", 12:59:20 INFO - "script_repo_revision": "production", 12:59:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 12:59:20 INFO - "repository": "", 12:59:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 12:59:20 INFO - "buildid": "20160715100158", 12:59:20 INFO - "pgo_build": "False", 12:59:20 INFO - "basedir": "/builds/slave/test", 12:59:20 INFO - "buildnumber": 50, 12:59:20 INFO - "slavename": "t-yosemite-r7-0318", 12:59:20 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:59:20 INFO - "platform": "yosemite_r7", 12:59:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:59:20 INFO - "branch": "mozilla-beta", 12:59:20 INFO - "repo_path": "releases/mozilla-beta", 12:59:20 INFO - "revision": "b9a4d34cb07363b0616321353610e47c1ddaa2ae", 12:59:20 INFO - "stage_platform": "macosx64", 12:59:20 INFO - "builduid": "169fdda1c4bd408d8deca56bc0cdf73e", 12:59:20 INFO - "slavebuilddir": "test" 12:59:20 INFO - } 12:59:20 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.dmg. 12:59:20 INFO - Running post-action listener: _resource_record_post_action 12:59:20 INFO - ##### 12:59:20 INFO - ##### Running download-and-extract step. 12:59:20 INFO - ##### 12:59:20 INFO - Running pre-action listener: _resource_record_pre_action 12:59:20 INFO - Running main action method: download_and_extract 12:59:20 INFO - mkdir: /builds/slave/test/build/tests 12:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.test_packages.json 12:59:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 12:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/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 12:59:20 INFO - Downloaded 1165 bytes. 12:59:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 12:59:20 INFO - Using the following test package requirements: 12:59:20 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 12:59:20 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:59:20 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 12:59:20 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:59:20 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 12:59:20 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:59:20 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:59:20 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 12:59:20 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 12:59:20 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:59:20 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 12:59:20 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:59:20 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 12:59:20 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:59:20 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 12:59:20 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:59:20 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 12:59:20 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 12:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.common.tests.zip 12:59:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 12:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/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 12:59:32 INFO - Downloaded 18314857 bytes. 12:59:32 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'] 12:59:32 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 12:59:36 INFO - Return code: 0 12:59:36 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 12:59:36 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')]} 12:59:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.common.tests.zip 12:59:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 12:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/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 12:59:36 INFO - Downloaded 18314857 bytes. 12:59:36 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'] 12:59:36 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 12:59:40 INFO - Return code: 0 12:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:40 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.talos.tests.zip 12:59:40 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 12:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/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 12:59:42 INFO - Downloaded 10840145 bytes. 12:59:42 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'] 12:59:42 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 12:59:42 INFO - Return code: 0 12:59:42 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')]} 12:59:42 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.dmg 12:59:42 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 12:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 12:59:43 INFO - Downloaded 86189429 bytes. 12:59:43 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.dmg 12:59:43 INFO - mkdir: /builds/slave/test/properties 12:59:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:59:43 INFO - Writing to file /builds/slave/test/properties/build_url 12:59:43 INFO - Contents: 12:59:43 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.dmg 12:59:43 INFO - Running post-action listener: _resource_record_post_action 12:59:43 INFO - Running post-action listener: set_extra_try_arguments 12:59:43 INFO - ##### 12:59:43 INFO - ##### Running populate-webroot step. 12:59:43 INFO - ##### 12:59:43 INFO - Running pre-action listener: _resource_record_pre_action 12:59:43 INFO - Running main action method: populate_webroot 12:59:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:59:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:59:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:59:43 INFO - '--tppagecycles', 12:59:43 INFO - '7'], 12:59:43 INFO - 'tests': ['tsvgm']}}, 12:59:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:59:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:59:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:59:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:59:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:59:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:59:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:43 INFO - 'talos_options': ['--disable-e10s'], 12:59:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:43 INFO - 'talos_options': ['--disable-e10s'], 12:59:43 INFO - 'tests': ['damp', 'tps']}, 12:59:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:43 INFO - 'tests': ['damp', 'tps']}, 12:59:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:59:43 INFO - 'tests': ['dromaeo_dom']}, 12:59:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:59:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:59:43 INFO - 'tests': ['a11yr', 12:59:43 INFO - 'ts_paint', 12:59:43 INFO - 'tpaint', 12:59:43 INFO - 'sessionrestore', 12:59:43 INFO - 'sessionrestore_no_auto_restore', 12:59:43 INFO - 'tabpaint']}, 12:59:43 INFO - 'other-e10s': {'tests': ['a11yr', 12:59:43 INFO - 'ts_paint', 12:59:43 INFO - 'tpaint', 12:59:43 INFO - 'sessionrestore', 12:59:43 INFO - 'sessionrestore_no_auto_restore', 12:59:43 INFO - 'tabpaint']}, 12:59:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:59:43 INFO - 'ts_paint', 12:59:43 INFO - 'tpaint', 12:59:43 INFO - 'sessionrestore', 12:59:43 INFO - 'sessionrestore_no_auto_restore', 12:59:43 INFO - 'tabpaint']}, 12:59:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:59:43 INFO - 'ts_paint', 12:59:43 INFO - 'tpaint', 12:59:43 INFO - 'sessionrestore', 12:59:43 INFO - 'sessionrestore_no_auto_restore', 12:59:43 INFO - 'tabpaint']}, 12:59:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:59:43 INFO - 'tests': ['a11yr', 12:59:43 INFO - 'ts_paint', 12:59:43 INFO - 'tpaint', 12:59:43 INFO - 'sessionrestore', 12:59:43 INFO - 'sessionrestore_no_auto_restore', 12:59:43 INFO - 'tabpaint']}, 12:59:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:59:43 INFO - 'tests': ['a11yr', 12:59:43 INFO - 'ts_paint', 12:59:43 INFO - 'tpaint', 12:59:43 INFO - 'sessionrestore', 12:59:43 INFO - 'sessionrestore_no_auto_restore', 12:59:43 INFO - 'tabpaint']}, 12:59:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:59:43 INFO - 'tests': ['tsvgx', 12:59:43 INFO - 'tsvgr_opacity', 12:59:43 INFO - 'tart', 12:59:43 INFO - 'tscrollx', 12:59:43 INFO - 'cart']}, 12:59:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:59:43 INFO - 'tsvgr_opacity', 12:59:43 INFO - 'tart', 12:59:43 INFO - 'tscrollx', 12:59:43 INFO - 'cart']}, 12:59:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:43 INFO - 'talos_options': ['--disable-e10s'], 12:59:43 INFO - 'tests': ['tp5o']}, 12:59:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:43 INFO - 'tests': ['tp5o']}, 12:59:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:43 INFO - 'talos_options': ['--disable-e10s', 12:59:43 INFO - '--xperf_path', 12:59:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:59:43 INFO - 'tests': ['tp5n']}, 12:59:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:43 INFO - 'talos_options': ['--xperf_path', 12:59:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:59:43 INFO - 'tests': ['tp5n']}}, 12:59:43 INFO - 'talos.zip': {'path': '', 12:59:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:59:43 INFO - Running post-action listener: _resource_record_post_action 12:59:43 INFO - ##### 12:59:43 INFO - ##### Running create-virtualenv step. 12:59:43 INFO - ##### 12:59:43 INFO - Running pre-action listener: _resource_record_pre_action 12:59:43 INFO - Running main action method: create_virtualenv 12:59:43 INFO - Creating virtualenv /builds/slave/test/build/venv 12:59:43 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 12:59:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:59:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:59:44 INFO - Using real prefix '/tools/python27' 12:59:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:59:44 INFO - Installing distribute.............................................................................................................................................................................................done. 12:59:47 INFO - Installing pip.................done. 12:59:47 INFO - Return code: 0 12:59:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:47 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 0x10cd5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9feac995c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbfae00>, '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 0x10ca63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf5b20>, '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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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 12:59:47 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 12:59:47 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 12:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Xg3pzhfdx/Render', 12:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:47 INFO - 'HOME': '/Users/cltbld', 12:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:47 INFO - 'LOGNAME': 'cltbld', 12:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:47 INFO - 'MOZ_NO_REMOTE': '1', 12:59:47 INFO - 'NO_EM_RESTART': '1', 12:59:47 INFO - 'PAGER': '/bin/cat', 12:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:47 INFO - 'PWD': '/builds/slave/test', 12:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:47 INFO - 'SHELL': '/bin/bash', 12:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYaSGfY8y1/Listeners', 12:59:47 INFO - 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/', 12:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:47 INFO - 'USER': 'cltbld', 12:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:47 INFO - 'XPC_FLAGS': '0x0', 12:59:47 INFO - 'XPC_SERVICE_NAME': '0', 12:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:47 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 12:59:47 INFO - Cleaning up... 12:59:47 INFO - Return code: 0 12:59:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:47 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 0x10cd5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9feac995c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbfae00>, '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 0x10ca63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf5b20>, '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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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 12:59:47 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 12:59:47 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 12:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Xg3pzhfdx/Render', 12:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:47 INFO - 'HOME': '/Users/cltbld', 12:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:47 INFO - 'LOGNAME': 'cltbld', 12:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:47 INFO - 'MOZ_NO_REMOTE': '1', 12:59:47 INFO - 'NO_EM_RESTART': '1', 12:59:47 INFO - 'PAGER': '/bin/cat', 12:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:47 INFO - 'PWD': '/builds/slave/test', 12:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:47 INFO - 'SHELL': '/bin/bash', 12:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYaSGfY8y1/Listeners', 12:59:47 INFO - 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/', 12:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:47 INFO - 'USER': 'cltbld', 12:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:47 INFO - 'XPC_FLAGS': '0x0', 12:59:47 INFO - 'XPC_SERVICE_NAME': '0', 12:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:48 INFO - Downloading/unpacking psutil>=0.7.1 12:59:48 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 12:59:48 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 12:59:48 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 12:59:48 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 12:59:48 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 12:59:48 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 12:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:59:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:51 INFO - Installing collected packages: psutil 12:59:51 INFO - Running setup.py install for psutil 12:59:51 INFO - building 'psutil._psutil_osx' extension 12:59:51 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 12:59:52 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 12:59:52 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 12:59:52 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 12:59:52 INFO - building 'psutil._psutil_posix' extension 12:59:52 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 12:59:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:59:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:59:52 INFO - ^ 12:59:52 INFO - 1 warning generated. 12:59:52 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 12:59:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:52 INFO - Successfully installed psutil 12:59:52 INFO - Cleaning up... 12:59:52 INFO - Return code: 0 12:59:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:59: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')]} 12:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59: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')]} 12:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59: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', '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 0x10cd5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9feac995c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbfae00>, '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 0x10ca63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf5b20>, '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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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 12:59: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:59: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 mozsystemmonitor==0.0.0 12:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Xg3pzhfdx/Render', 12:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:52 INFO - 'HOME': '/Users/cltbld', 12:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:52 INFO - 'LOGNAME': 'cltbld', 12:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:52 INFO - 'MOZ_NO_REMOTE': '1', 12:59:52 INFO - 'NO_EM_RESTART': '1', 12:59:52 INFO - 'PAGER': '/bin/cat', 12:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:52 INFO - 'PWD': '/builds/slave/test', 12:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:52 INFO - 'SHELL': '/bin/bash', 12:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYaSGfY8y1/Listeners', 12:59:52 INFO - 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/', 12:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:52 INFO - 'USER': 'cltbld', 12:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:52 INFO - 'XPC_FLAGS': '0x0', 12:59:52 INFO - 'XPC_SERVICE_NAME': '0', 12:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:59: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 12:59: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 12:59: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 12:59: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 12:59: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 12:59: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 12:59:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:59:55 INFO - Installing collected packages: mozsystemmonitor 12:59:55 INFO - Running setup.py install for mozsystemmonitor 12:59:55 INFO - Successfully installed mozsystemmonitor 12:59:55 INFO - Cleaning up... 12:59:55 INFO - Return code: 0 12:59:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cd5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9feac995c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbfae00>, '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 0x10ca63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf5b20>, '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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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 12:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:59:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Xg3pzhfdx/Render', 12:59:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:55 INFO - 'HOME': '/Users/cltbld', 12:59:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:55 INFO - 'LOGNAME': 'cltbld', 12:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:55 INFO - 'MOZ_NO_REMOTE': '1', 12:59:55 INFO - 'NO_EM_RESTART': '1', 12:59:55 INFO - 'PAGER': '/bin/cat', 12:59:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:55 INFO - 'PWD': '/builds/slave/test', 12:59:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:55 INFO - 'SHELL': '/bin/bash', 12:59:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYaSGfY8y1/Listeners', 12:59:55 INFO - 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/', 12:59:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:55 INFO - 'USER': 'cltbld', 12:59:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:55 INFO - 'XPC_FLAGS': '0x0', 12:59:55 INFO - 'XPC_SERVICE_NAME': '0', 12:59:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:55 INFO - Downloading/unpacking blobuploader==1.2.4 12:59: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 12:59: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 12:59: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 12:59: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 12:59: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 12:59: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 12:59:58 INFO - Downloading blobuploader-1.2.4.tar.gz 12:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:59:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:59:58 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 12:59:58 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 12:59:58 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 12:59:58 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 12:59:58 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 12:59:58 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 12:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:59:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:59:58 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 12:59:58 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 12:59:58 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 12:59:58 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 12:59:58 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 12:59:58 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 12:59:59 INFO - Downloading docopt-0.6.1.tar.gz 12:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:59:59 INFO - Installing collected packages: blobuploader, requests, docopt 12:59:59 INFO - Running setup.py install for blobuploader 12:59:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:59:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:59:59 INFO - Running setup.py install for requests 13:00:00 INFO - Running setup.py install for docopt 13:00:00 INFO - Successfully installed blobuploader requests docopt 13:00:00 INFO - Cleaning up... 13:00:00 INFO - Return code: 0 13:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:00 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 0x10cd5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9feac995c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbfae00>, '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 0x10ca63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf5b20>, '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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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 13:00:00 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 13:00:00 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 13:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Xg3pzhfdx/Render', 13:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:00 INFO - 'HOME': '/Users/cltbld', 13:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:00 INFO - 'LOGNAME': 'cltbld', 13:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:00 INFO - 'MOZ_NO_REMOTE': '1', 13:00:00 INFO - 'NO_EM_RESTART': '1', 13:00:00 INFO - 'PAGER': '/bin/cat', 13:00:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:00 INFO - 'PWD': '/builds/slave/test', 13:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:00 INFO - 'SHELL': '/bin/bash', 13:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYaSGfY8y1/Listeners', 13:00:00 INFO - 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/', 13:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:00 INFO - 'USER': 'cltbld', 13:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:00 INFO - 'XPC_FLAGS': '0x0', 13:00:00 INFO - 'XPC_SERVICE_NAME': '0', 13:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:00 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-DnxQ7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:00 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-VF_j6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:00 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-MEFpVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:01 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-NIi19W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:01 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-Z0E80C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:01 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-2GUh2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:01 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-uZlJu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:01 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-Sj_3N2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:01 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-2kk_VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:01 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-8iPdfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:01 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-SIvWz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:01 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-B13xxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:02 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-xlTn_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:02 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-4ht3oN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:02 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-xyOo1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:02 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-imivBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:02 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-fsKeEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:00:02 INFO - Running setup.py install for manifestparser 13:00:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:00:02 INFO - Running setup.py install for mozcrash 13:00:02 INFO - Running setup.py install for mozdebug 13:00:02 INFO - Running setup.py install for mozdevice 13:00:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:00:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:00:03 INFO - Running setup.py install for mozfile 13:00:03 INFO - Running setup.py install for mozhttpd 13:00:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:00:03 INFO - Running setup.py install for mozinfo 13:00:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:00:03 INFO - Running setup.py install for mozInstall 13:00:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:00:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:00:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:00:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:00:03 INFO - Running setup.py install for mozleak 13:00:03 INFO - Running setup.py install for mozlog 13:00:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:00:04 INFO - Running setup.py install for moznetwork 13:00:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:00:04 INFO - Running setup.py install for mozprocess 13:00:04 INFO - Running setup.py install for mozprofile 13:00:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:00:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:00:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:00:04 INFO - Running setup.py install for mozrunner 13:00:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:00:04 INFO - Running setup.py install for mozscreenshot 13:00:04 INFO - Running setup.py install for moztest 13:00:04 INFO - Running setup.py install for mozversion 13:00:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:00:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:00:05 INFO - Cleaning up... 13:00:05 INFO - Return code: 0 13:00:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00: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')]} 13:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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')]} 13:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:05 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 0x10cd5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9feac995c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbfae00>, '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 0x10ca63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf5b20>, '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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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 13:00:05 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 13:00:05 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 13:00:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Xg3pzhfdx/Render', 13:00:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:05 INFO - 'HOME': '/Users/cltbld', 13:00:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:05 INFO - 'LOGNAME': 'cltbld', 13:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:05 INFO - 'MOZ_NO_REMOTE': '1', 13:00:05 INFO - 'NO_EM_RESTART': '1', 13:00:05 INFO - 'PAGER': '/bin/cat', 13:00:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:05 INFO - 'PWD': '/builds/slave/test', 13:00:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:05 INFO - 'SHELL': '/bin/bash', 13:00:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYaSGfY8y1/Listeners', 13:00:05 INFO - 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/', 13:00:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:05 INFO - 'USER': 'cltbld', 13:00:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:05 INFO - 'XPC_FLAGS': '0x0', 13:00:05 INFO - 'XPC_SERVICE_NAME': '0', 13:00:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:05 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-kJG_Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:05 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)) 13:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:05 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-WC5wfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:05 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)) 13:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:05 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-nkAM69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:05 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)) 13:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:05 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-pXQIci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:05 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)) 13:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:05 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-WxP9vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:05 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)) 13:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:05 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-pA8l4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:05 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)) 13:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:05 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-JyjDNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:06 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)) 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:06 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-OsJwYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:06 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)) 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:06 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-Nxqs3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:06 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)) 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:06 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-k2NpbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:06 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)) 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:06 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-E7S84q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:06 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)) 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:06 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-aXoKdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:06 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)) 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:06 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-S79_ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:06 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)) 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:06 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-LkbjXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:06 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)) 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:06 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-akOq8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:06 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)) 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:06 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-NNjVRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:07 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)) 13:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:07 INFO - Running setup.py (path:/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/pip-nSJG2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:07 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)) 13:00:07 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)) 13:00:07 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)) 13:00:07 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)) 13:00:07 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)) 13:00:07 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)) 13:00:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:09 INFO - Downloading blessings-1.6.tar.gz 13:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:00:09 INFO - Installing collected packages: blessings 13:00:09 INFO - Running setup.py install for blessings 13:00:09 INFO - Successfully installed blessings 13:00:09 INFO - Cleaning up... 13:00:09 INFO - Return code: 0 13:00:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:10 INFO - Reading from file tmpfile_stdout 13:00:10 INFO - Current package versions: 13:00:10 INFO - blessings == 1.6 13:00:10 INFO - blobuploader == 1.2.4 13:00:10 INFO - docopt == 0.6.1 13:00:10 INFO - manifestparser == 1.1 13:00:10 INFO - mozInstall == 1.12 13:00:10 INFO - mozcrash == 0.17 13:00:10 INFO - mozdebug == 0.1 13:00:10 INFO - mozdevice == 0.48 13:00:10 INFO - mozfile == 1.2 13:00:10 INFO - mozhttpd == 0.7 13:00:10 INFO - mozinfo == 0.9 13:00:10 INFO - mozleak == 0.1 13:00:10 INFO - mozlog == 3.1 13:00:10 INFO - moznetwork == 0.27 13:00:10 INFO - mozprocess == 0.22 13:00:10 INFO - mozprofile == 0.28 13:00:10 INFO - mozrunner == 6.11 13:00:10 INFO - mozscreenshot == 0.1 13:00:10 INFO - mozsystemmonitor == 0.0 13:00:10 INFO - moztest == 0.7 13:00:10 INFO - mozversion == 1.4 13:00:10 INFO - psutil == 3.1.1 13:00:10 INFO - requests == 1.2.3 13:00:10 INFO - wsgiref == 0.1.2 13:00:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:10 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 0x10cd5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9feac995c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbfae00>, '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 0x10ca63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf5b20>, '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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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 13:00:10 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 13:00:10 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 13:00:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Xg3pzhfdx/Render', 13:00:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:10 INFO - 'HOME': '/Users/cltbld', 13:00:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:10 INFO - 'LOGNAME': 'cltbld', 13:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:10 INFO - 'MOZ_NO_REMOTE': '1', 13:00:10 INFO - 'NO_EM_RESTART': '1', 13:00:10 INFO - 'PAGER': '/bin/cat', 13:00:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:10 INFO - 'PWD': '/builds/slave/test', 13:00:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:10 INFO - 'SHELL': '/bin/bash', 13:00:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYaSGfY8y1/Listeners', 13:00:10 INFO - 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/', 13:00:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:10 INFO - 'USER': 'cltbld', 13:00:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:10 INFO - 'XPC_FLAGS': '0x0', 13:00:10 INFO - 'XPC_SERVICE_NAME': '0', 13:00:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:10 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)) 13:00:10 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)) 13:00:10 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)) 13:00:10 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)) 13:00:10 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)) 13:00:10 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)) 13:00:10 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)) 13:00:10 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)) 13:00:10 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)) 13:00:10 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)) 13:00:10 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)) 13:00:10 INFO - Cleaning up... 13:00:10 INFO - Return code: 0 13:00:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9feac995c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbfae00>, '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 0x10ca63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf5b20>, '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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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 13:00:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:00:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Xg3pzhfdx/Render', 13:00:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:10 INFO - 'HOME': '/Users/cltbld', 13:00:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:10 INFO - 'LOGNAME': 'cltbld', 13:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:10 INFO - 'MOZ_NO_REMOTE': '1', 13:00:10 INFO - 'NO_EM_RESTART': '1', 13:00:10 INFO - 'PAGER': '/bin/cat', 13:00:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:10 INFO - 'PWD': '/builds/slave/test', 13:00:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:10 INFO - 'SHELL': '/bin/bash', 13:00:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYaSGfY8y1/Listeners', 13:00:10 INFO - 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/', 13:00:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:10 INFO - 'USER': 'cltbld', 13:00:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:10 INFO - 'XPC_FLAGS': '0x0', 13:00:10 INFO - 'XPC_SERVICE_NAME': '0', 13:00:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:10 INFO - Downloading/unpacking jsonschema 13:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:00:13 INFO - Downloading/unpacking functools32 (from jsonschema) 13:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:13 INFO - Downloading functools32-3.2.3-2.tar.gz 13:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:00:13 INFO - warning: no files found matching '*.txt' 13:00:13 INFO - no previously-included directories found matching 'build' 13:00:13 INFO - no previously-included directories found matching 'dist' 13:00:13 INFO - no previously-included directories found matching '.git*' 13:00:13 INFO - Installing collected packages: jsonschema, functools32 13:00:13 INFO - Running setup.py install for functools32 13:00:13 INFO - warning: no files found matching '*.txt' 13:00:13 INFO - no previously-included directories found matching 'build' 13:00:13 INFO - no previously-included directories found matching 'dist' 13:00:13 INFO - no previously-included directories found matching '.git*' 13:00:13 INFO - Successfully installed jsonschema functools32 13:00:13 INFO - Cleaning up... 13:00:13 INFO - Return code: 0 13:00:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:00: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')]} 13:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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')]} 13:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9feac995c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbfae00>, '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 0x10ca63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf5b20>, '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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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 13:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Xg3pzhfdx/Render', 13:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:14 INFO - 'HOME': '/Users/cltbld', 13:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:14 INFO - 'LOGNAME': 'cltbld', 13:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:14 INFO - 'MOZ_NO_REMOTE': '1', 13:00:14 INFO - 'NO_EM_RESTART': '1', 13:00:14 INFO - 'PAGER': '/bin/cat', 13:00:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:14 INFO - 'PWD': '/builds/slave/test', 13:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:14 INFO - 'SHELL': '/bin/bash', 13:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYaSGfY8y1/Listeners', 13:00:14 INFO - 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/', 13:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:14 INFO - 'USER': 'cltbld', 13:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:14 INFO - 'XPC_FLAGS': '0x0', 13:00:14 INFO - 'XPC_SERVICE_NAME': '0', 13:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:14 INFO - Downloading/unpacking flake8 13:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:00:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:00:16 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 13:00:16 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 13:00:16 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 13:00:16 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 13:00:16 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 13:00:16 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 13:00:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:00:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:00:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:00:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:00:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:00:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:00:18 INFO - no previously-included directories found matching 'docs/_build' 13:00:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:00:18 INFO - Running setup.py install for pep8 13:00:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:00:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:00:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:00:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:00:18 INFO - no previously-included directories found matching 'docs/_build' 13:00:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:00:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:00:18 INFO - Cleaning up... 13:00:18 INFO - Return code: 0 13:00:18 INFO - Running post-action listener: _resource_record_post_action 13:00:18 INFO - Running post-action listener: _start_resource_monitoring 13:00:18 INFO - Starting resource monitoring. 13:00:18 INFO - ##### 13:00:18 INFO - ##### Running install step. 13:00:18 INFO - ##### 13:00:18 INFO - Running pre-action listener: _resource_record_pre_action 13:00:18 INFO - Running main action method: install 13:00:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:18 INFO - Reading from file tmpfile_stdout 13:00:18 INFO - Detecting whether we're running mozinstall >=1.0... 13:00:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:00:18 INFO - Reading from file tmpfile_stdout 13:00:18 INFO - Output received: 13:00:18 INFO - Usage: mozinstall [options] installer 13:00:18 INFO - Options: 13:00:18 INFO - -h, --help show this help message and exit 13:00:18 INFO - -d DEST, --destination=DEST 13:00:18 INFO - Directory to install application into. [default: 13:00:18 INFO - "/builds/slave/test"] 13:00:18 INFO - --app=APP Application being installed. [default: firefox] 13:00:18 INFO - mkdir: /builds/slave/test/build/application 13:00:18 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'] 13:00:18 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 13:00:40 INFO - Reading from file tmpfile_stdout 13:00:40 INFO - Output received: 13:00:40 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:00:40 INFO - Running post-action listener: _resource_record_post_action 13:00:40 INFO - ##### 13:00:40 INFO - ##### Running run-tests step. 13:00:40 INFO - ##### 13:00:40 INFO - Running pre-action listener: _resource_record_pre_action 13:00:40 INFO - Running main action method: run_tests 13:00:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:00:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:00:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:00:40 INFO - 2016-07-17 13:00:40.527 screenresolution[2205:30125] starting screenresolution argv=screenresolution get 13:00:40 INFO - 2016-07-17 13:00:40.530 screenresolution[2205:30125] Display 0: 1600x1200x32@60 13:00:40 INFO - 2016-07-17 13:00:40.536 screenresolution[2206:30128] starting screenresolution argv=screenresolution list 13:00:40 INFO - Available Modes on Display 0 13:00:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:00:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:00:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:00:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:00:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:00:40 INFO - Intel Iris: 13:00:40 INFO - Chipset Model: Intel Iris 13:00:40 INFO - Type: GPU 13:00:40 INFO - Bus: Built-In 13:00:40 INFO - VRAM (Dynamic, Max): 1536 MB 13:00:40 INFO - Vendor: Intel (0x8086) 13:00:40 INFO - Device ID: 0x0a2e 13:00:40 INFO - Revision ID: 0x0009 13:00:40 INFO - Displays: 13:00:40 INFO - Display: 13:00:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:00:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:00:40 INFO - Display Serial Number: 1600x1200 60 13:00:40 INFO - Main Display: Yes 13:00:40 INFO - Mirror: Off 13:00:40 INFO - Online: Yes 13:00:40 INFO - Rotation: Supported 13:00:40 INFO - Return code: 0 13:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:00:40 INFO - Python 2.7.3 13:00:40 INFO - Return code: 0 13:00:40 INFO - grabbing minidump binary from tooltool 13:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:40 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 0x10cbfae00>, '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 0x10ca63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:00:40 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 13:00:40 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 13:00:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:00:40 INFO - Return code: 0 13:00:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:00:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:00:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:00:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:00:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:00:41 INFO - Return code: 0 13:00:41 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/1468602118/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0318', '--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 13:00:41 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/1468602118/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0318 --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 13:00:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Xg3pzhfdx/Render', 13:00:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:41 INFO - 'HOME': '/Users/cltbld', 13:00:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:41 INFO - 'LOGNAME': 'cltbld', 13:00:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:00:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:41 INFO - 'MOZ_NO_REMOTE': '1', 13:00:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:00:41 INFO - 'NO_EM_RESTART': '1', 13:00:41 INFO - 'PAGER': '/bin/cat', 13:00:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:41 INFO - 'PWD': '/builds/slave/test', 13:00:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:00:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:41 INFO - 'SHELL': '/bin/bash', 13:00:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYaSGfY8y1/Listeners', 13:00:41 INFO - 'TMPDIR': '/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/', 13:00:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:41 INFO - 'USER': 'cltbld', 13:00:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:41 INFO - 'XPC_FLAGS': '0x0', 13:00:41 INFO - 'XPC_SERVICE_NAME': '0', 13:00:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:41 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/1468602118/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0318', '--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 13:00:42 INFO - mozversion application_buildid: 20160715100158 13:00:42 INFO - mozversion application_changeset: b9a4d34cb07363b0616321353610e47c1ddaa2ae 13:00:42 INFO - mozversion application_display_name: Firefox 13:00:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:00:42 INFO - mozversion application_name: Firefox 13:00:42 INFO - mozversion application_remotingname: firefox 13:00:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:00:42 INFO - mozversion application_vendor: Mozilla 13:00:42 INFO - mozversion application_version: 48.0 13:00:42 INFO - mozversion platform_buildid: 20160715100158 13:00:42 INFO - mozversion platform_changeset: b9a4d34cb07363b0616321353610e47c1ddaa2ae 13:00:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:00:42 INFO - mozversion platform_version: 48.0 13:00:42 INFO - using testdate: 1468785642 13:00:42 INFO - actual date: 1468785642 13:00:42 INFO - starting webserver on 'localhost:59765' 13:00:42 INFO - SUITE-START | Running 2 tests 13:00:42 INFO - TEST-START | dromaeo_css 13:00:42 INFO - operating with platform_type : mac_ 13:00:42 INFO - Initialising browser for dromaeo_css test... 13:00:42 INFO - TEST-INFO | started process 2224 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/tmpnMJgep/profile http://localhost:59765/getInfo.html) 13:00:44 INFO - PROCESS | 2224 | __metrics Screen width/height:1600/1200 13:00:44 INFO - PROCESS | 2224 | colorDepth:24 13:00:44 INFO - PROCESS | 2224 | Browser inner width/height: 1024/689 13:00:44 INFO - PROCESS | 2224 | __metrics 13:00:44 ERROR - PROCESS | 2224 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 13:00:45 INFO - TEST-INFO | 2224: exit 0 13:00:45 INFO - Browser initialized. 13:00:45 INFO - Running cycle 1/1 for dromaeo_css test... 13:00:45 INFO - TEST-INFO | started process 2227 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/tmpnMJgep/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:00:57 INFO - PROCESS | 2227 | RSS: Main: 171073536 13:00:57 INFO - PROCESS | 2227 | 13:01:47 INFO - PROCESS | 2227 | 1468785707144 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] 13:03:57 INFO - PROCESS | 2227 | Cycle 1(1): loaded http://localhost:59765/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59765/tests/dromaeo/cssquery-ext.html) 13:03:58 INFO - PROCESS | 2227 | RSS: Main: 181972992 13:03:58 INFO - PROCESS | 2227 | 13:07:00 INFO - PROCESS | 2227 | Cycle 1(1): loaded http://localhost:59765/tests/dromaeo/cssquery-ext.html (next: http://localhost:59765/tests/dromaeo/cssquery-jquery.html) 13:07:01 INFO - PROCESS | 2227 | RSS: Main: 192479232 13:07:01 INFO - PROCESS | 2227 | 13:10:03 INFO - PROCESS | 2227 | Cycle 1(1): loaded http://localhost:59765/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59765/tests/dromaeo/cssquery-mootools.html) 13:10:03 INFO - PROCESS | 2227 | RSS: Main: 194756608 13:10:03 INFO - PROCESS | 2227 | 13:13:05 INFO - PROCESS | 2227 | Cycle 1(1): loaded http://localhost:59765/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59765/tests/dromaeo/cssquery-prototype.html) 13:13:06 INFO - PROCESS | 2227 | RSS: Main: 198520832 13:13:06 INFO - PROCESS | 2227 | 13:16:08 INFO - PROCESS | 2227 | Cycle 1(1): loaded http://localhost:59765/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59765/tests/dromaeo/cssquery-yui.html) 13:16:09 INFO - PROCESS | 2227 | RSS: Main: 197529600 13:16:09 INFO - PROCESS | 2227 | 13:19:11 INFO - PROCESS | 2227 | Cycle 1(1): loaded http://localhost:59765/tests/dromaeo/cssquery-yui.html (next: http://localhost:59765/tests/dromaeo/cssquery-dojo.html) 13:19:11 INFO - PROCESS | 2227 | RSS: Main: 203112448 13:19:11 INFO - PROCESS | 2227 | 13:19:11 INFO - PROCESS | 2227 | __start_tp_report 13:19:11 INFO - PROCESS | 2227 | _x_x_mozilla_page_load 13:19:11 INFO - PROCESS | 2227 | _x_x_mozilla_page_load_details 13:19:11 INFO - PROCESS | 2227 | |i|pagename|runs| 13:19:11 INFO - PROCESS | 2227 | |0;dojo.html;3396.354692608404;3677.485152078711;3678.411454167334;3721.5534135903695;3723.4042553191484;5725.45608167224;5940.138679891413;6012.398760123985;6093.086037094438;6099.024156135019;6052.42501962314;6081.270247570298;6110.388961103888;6110.755569777215;6120.867639486698;5457.290552228214;5493.807716729915;5504.532114770229;5508.476694713996;5588.273524441837;4529.365888775574;5432.994895944244;5518.91721624176;5587.580931430159;5596.552275817925;5008.5993120550265;5089.541941225289;5536.861578460551;5568.3596386415475;5574.9721251393685;5486.3690675572025;5491.121420572729;5559.580857772461;5561.58288128392;5587.8603034924245;4536.432945881765;5339.519443250126;5349.063913815066;5383.407825139271;5459;5824.767009319622;5913.408659134096;5928.49607783339;5930.822075337704;5997.190379298826;6255;6310.337414571496;6339.492840572743;6397.744090236385;6400.9359906400805;5640.351359593658;6178.783742568989;6482.837929051764;6483.7730679425995;6499.512536559777;6106.572539922163;6178.598391104564;6182.6599537024995;6192.442680158762;6202.472789812871;6456.806295811133;6509.1863517060365;6638.86722265552;6653.667316634149;6698.5980841149685;6241.656708881055;6311.495080393557;6328.240611126695;6348.984162534065;6359.236891573041;6434.099226108348;6474.741010359533;6490.513211509156;6507.219133703986;6518.934810651833;6206.410391012847;6235.812925612239;6299.7795077173;6299.874002519924;6388.968055159788;6357.396047375492;6366.904496432558;6374.84062898422;6383.585066970632;6387.680615969183;5041.117804384291;5117.718525481134;5119.667221630582;5122.308488354024;5179.430262671103;4507.616852567503;4581;4608.239640459354;4614.607758340511;4691.6863278282135;5954;6042.1540984261355;6079.513638908877;6115.181368569397;6148.1085242639565;5732.337622089547;6392.904106438407;6412.935870641327;6445.291017988017;6488.2538508072175;5963.940360596425;6111.205543279345;6130.734471166763;6150.600210986271;6170.352113028068;5586.301712285965;5595.63628364155;5600;5611.410801865827;5622.409646987007;6688.565243259172;6693.431058360094;6707.798766037026;6730.798076057824;6746.807287631539;6324.620522768649;6363.109164717036;6421.5825971311715;6457;6460.45086167681;6726.125603671491;6727.428168605723;6731.697073631601;6741.696623651849;6759.831004224934;4975;6383.393577610305;6389;6393.6163830170335;6398.904016439664;6229.3770622937345;6377.96811015942;6421.389967953037;6428.903566446601;6461.0954466373805;6228.906566401417;6244.625322480666;6254.562180647311;6257.4994000480765;6258.624482531062;5264.578833693372;6264.561480696308;6266.843328916813;6270.686465676789;6279;6075.422834830684;6093.29927058394;6132.967444181115;6188.226471691039;6233.937660623335;6232.5948813328805;6254.343293954252;6287.591306565058;6289.371062893857;6289.7169627365965;6067.848303792441;6112.868254062901;6146.108814221823;6196.938030619636;6231.906521402092 13:19:11 INFO - PROCESS | 2227 | |1;ext.html;512.743628185907;561.9884208424836;562.0279321647429;564.0777329066976;596.3261514488627;30432.39135217297;39893.8005309973;40278.39582406262;40455.393169102485;40520.39219411704;41634.959126021866;41715;42307;42525.14949701004;42577.787111064405;9539.236861051098;9694.36986595869;9771.609135634566;9784.608615655365;9798.755031124243;9770.804583908317;9888.060634239735;9943.850842237336;9954.552045157949;9963.651272205474;9847.11375976162;9858.90141098587;9892.604295828194;9900.25748068894;9918.752031199241;9819.165370943478;9863;9880.35777674456;9906.257030722689;9938;9714.75713107178;9797;9845.753856153582;9846.803063938682;9863.50682465881;34487.4826877597;39634.20731585381;40219.39670904939;40645.390319145234;40789;3068.248279171617;3204.788354151912;3389.8305084745666;3504.9474257886154;3895.9870433687447;27477;28320.575191372147;28668.713312866814;28720.425591488263;29075.709242907724;2675.8260713053587;2688.7714544263763;2743.067357098596;2749.42262124954;2834.4614523240516;377351;380993;382209.9999999972;382825;383474;36329.45505817415;36593.45109823355;36706.8164659175;37585.43621845674;38363;30485.84757076245;36930.63069369272;37012.259754805295;37123.62876371202;37196.442053369225;16118.435854745028;16345.346186152421;16364.509064728078;16365.099919504542;16390.508284751475;13645.317734113254;13693.109947853358;13767.931160344135;13769.380377883019;13773.38019789112;8401.705940292182;8444.61999210037;8592.140785921358;8600.096989816104;8643.783905402415;3542.946855797165;3588.8564457421935;3605.4231322988194;3614.1145419372424;3625.492431059654;1039.2828948025838;1089.7330154112294;1096.4901320885826;1115.827046807746;1126.8760436351995;31184.53223201654;31335.05994820159;31415.528767068514;31734.365312693615;31777.046688599377;1134.5348407153028;1179.9174057815871;1227.1900545640012;1261.1046157228286;1263.860975292717;13041.673958151123;13189.670258243621;15667.059976401453;15834.366625334858;16087.597810054842;488509;586804.0659796674;590114;591423;595320;63076.36923630705;63105.36894630995;64072.39819004469;64113.03830442547;64258.678706607105;1348.3527906604688;1551.1236151574324;1554.4870192836338;1561.820390655089;1564.6622138072012;30266;30579;30713.467951185004;30727.539086913268;30995.380092398478;53887.92224155573;54766.72616637051;55049;55230.44769552253;55330.72334638462;447637;450606;451383;451507;452121;26941.86529067342;27858.442831143668;28128.57807132854;28211.858940705166;28270.57594136131;46572.534274658174;47239.055218896116;47988;48110.27834582414;48355.758221210075;39378.60621393749;39620.603793961694;39736.403953940135;39749.403758944216;40567.59432405638;32493.35013299768;38648.33586080379;39342.2131557373;39360.40959385554;39421.60578394294;33424.49863252102;38887.222255555294;38930;39210;39384.80307598558;30805.537916931713;32190.35619287648;32492.837535813116;32616.34767304688;32955;23076.077066899004;23267.952942117307;24770.628440573044;25086.874565627055;25502.744972550037 13:19:11 INFO - PROCESS | 2227 | |2;jquery.html;411.7406034198456;413.72694021945523;414.5440015982419;420.8674267605704;424.08609446642475;20680.586388272226;21306.680399794015;21347.893260533674;21389.14443422263;22227.44431389216;12180.634580962564;12508.186967847083;16448.342066317364;21389.465263368424;21619.45951351217;4551.931721024187;5359.08895487768;5653.886922261552;5671.092625179972;6008.549358798085;6096.847578810521;6689.866202675944;6838.760643377483;6851.520393572452;6949.583025018515;6585.143931288926;6863.725450981955;6878.380945714885;6884.345987131214;6902.068220790179;5602.943970560283;6254.905391556459;6580.901286480706;6844.828879278033;6858.691358888837;5854.414558544154;6149.96925015372;6152.230971128609;6155.199824022893;6163.044728067157;20409.4897627559;24628.138015169563;25542.23373298804;26483.735162648318;26569.07008254702;2138.7968143026387;2188.2997440818945;2234;2486.1671340100906;2674.424998625305;10047.849282260771;10467.528961196764;10554.788904221949;10583.894161058368;10737.677869663923;1818.5544541587265;1854.5919897622503;1907.523119220195;1922.663533881579;1939.6508628446875;106076;114193.4290328543;115595;118250;118732;11386.772264554662;11615.883841161649;12037.638870833889;12074.87925120755;12153.331566763736;13646.317684115755;15216.01095928761;15417.460388886335;15474.839387046017;15609.141497217763;8714.912850871537;9152.267818574499;9187.127222913812;9218.032106628707;9251;9083;9174.449533028039;9181.219596334253;9242.399244049115;9248.491332976751;4773.594244489188;4823.614110871122;4887.511248875084;4888.460135057446;4915.508449155127;2035.6742921132548;2092.311379876851;2115.936521904345;2134.957300853974;2135.2915130619954;853.389826274217;900.7838118851429;943.2124176312718;992.1417973453056;1124.9212555121062;18166.818331816776;19080.04599770006;20756.58486830255;21056.26303079385;21086.578268434547;942.844430668932;970.5486948568949;986.5609803637312;1031.850381694665;1042.8227201375632;8846.778830529289;10940.4529773511;11069.446527673745;11203.99164075237;11248.550057997752;531606;543445.2827735835;546758;652091;664587;82500;109267;115701;141115;152234.23882880516;974.91713204377;1009.1220638044948;1009.4902074452501;1011.600417834951;1032.4012072997643;18315.479311808307;18548.721769173204;18783.34258300953;18811.811881881007;18852.622947540698;48713.75643121904;51235.74382128065;51483.48516514937;51511.48488515067;55433.44566554283;67344;69227;70879.29120708727;71515.28484715086;72913.27086729064;7051.330123638246;8069.878951815845;8173.959130204311;8367.539785311867;8460.534670593177;12256.87743122593;12921;13055.934720326337;13140.277284749049;13205.867941320465;11258.831117533407;11299.887001129884;11361.92061754132;11521.596744113916;11613.593524226611;10854.620088296871;11119.83320250213;11156.776864462827;11259.662210133709;11485.655430337103;11473.713157171138;11512.712182195512;11621.186516943733;11766.941165294118;11824.40877956116;7593.810154746176;8528.317734581095;8536.786580335542;8693.739187824376;8917.10828917103;9675.896712262043;10921.290116142425;10940.015398614163;11292.927171918654;11657.18399712012 13:19:11 INFO - PROCESS | 2227 | |3;mootools.html;1644.37513744777;1671.590460337217;1949.5223670200794;2007.2272175212547;2110.883901385423;8504.19210175034;9244.399114057598;9377.765555861108;9397.919239287485;9548.045195480448;9257.028012058738;9292.303077269215;9370.250379969602;9380.906190938089;9389.201917836992;2570.2546261584116;2579.342267721728;2594.688637363519;2601.4536947241104;2612.673415823022;2472.6167444046114;2489.153687746166;2561.5773397389503;2592.7277635848245;2604.882780274892;2391.6532102845076;2453.276283496364;2564.948701025978;2584.8449093054383;2637.367031912346;2598.376389666476;2600.5969074793343;2610.3604616868797;2615.594582839663;2628.4743051389605;2573.5882258838496;2606.9348266293496;2609.9478010439684;2624.711281759005;2627.395698989243;9438.669646562406;9499.382540134939;9561.808763824754;9565.330426870121;9581;5749.568782341299;5832.475077243069;5863.2670916135485;6002.069679199731;6004.219451471281;3706.4625629283873;3710.6289371062676;3732.6640602345647;3787.304364732197;3845.807709614536;1063.7074804428767;1075.333293358115;1078.5739632844982;1113.8663360396804;1129.170060005895;12351.938240308831;12366.381680916009;12388.75222495554;12457.875421245762;12487.562935297312;5081.390233172043;5088.389393272831;5181.326427564468;5207.062728708793;5214.895702085937;10724.624638137628;10742.838857417146;10917.672469825919;10938.671839844817;10945.343279403261;5650.63270887391;5806.071028635398;5891.941080589225;5911.231539899785;5926.703664816742;4690.085433340534;5123.077845987684;5212.817551385683;5217.087009773274;5255.13290307095;4319.287317592562;4330.17726631939;4384.69307148503;4386.298192289219;4404.097160082176;1428.1217051513452;1446.3708286895235;1450.891183161246;1454.3818876977455;1464.670449148933;865.7489328094908;938.3525367496405;959.947202903833;984.7193549838262;985.6500942165571;6165.916488468273;6181.721822517998;6227;6268.686565671789;6324.936750632435;490.18139706689914;492.65021834497907;493.612514176377;493.8123513065012;498.01641757529313;4026.617471340218;4089.2434899543678;4099.61053699898;4147.232761939051;4184;9337.533123343806;11145.275557088764;11209.775804483865;11371.54513819438;11571.537138514534;10074.093331600192;10388.272820902464;11191.496382662799;11290.153238507144;11303.434828258554;8424.957875210584;8732.257758090633;8774.166454186841;8779.561021948877;8829.381943264038;5959.76160953557;6033.3061697905305;6033.487153591994;6041.486473649613;6088.660494691161;9553.570089346134;9607.13535781783;9685.370450920667;9867.703968880945;9899.554520046471;9743.80512389734;9889.653862114792;9995.500224988868;10042.598296068076;10419.635312764018;7231.5299505531975;7984.56084915312;8073.677052918052;8409.705660301861;8638.26574741154;8744.519051452231;8758;8797.340199484936;8805.251553618014;8820.470771753458;7598.240175982358;7827.843443130992;7840.098388685375;7864.016997875266;7886.408519360956;6388;7611.581363024865;7646.617669116411;7783.221677832172;7829.6085195741125;7306.561606303639;7311.634418279171;7366.63166841645;7409.888851667337;7423.628818559158;5008.373953255843;5027.572656324253;5149.382074150976;5220.869478263074;5224.085784987536;4497.347884556655;5156.896862062813;5218.373795144607;5243.056249875059;5355.464453554613 13:19:11 INFO - PROCESS | 2227 | |4;prototype.html;313.6236516180583;320.36407730654645;341.7334479106297;345.0683155480204;345.21119242530824;6902.689378977945;7017.403520700746;7113;7168.820779480509;7176.784696459108;7129.821754456141;7153.713851445936;7182.96408517958;7194.784156475301;7212.819679508015;5249.107651699221;5289.629725919187;5303.178007408857;5322.0686379883555;5324.307839980797;5266.605004624649;5298.920516192241;5303.973480132594;5316.5215130638235;5319.813806516772;4664.323673067403;4852.393450818648;5255.211718242256;5258.44786297439;5276.050310944029;5087.338645976018;5250.92123618148;5266.762995665185;5286.656367336111;5305.973470132624;4491.528389519086;4501.7524036178;4504.8198072077075;4506.053728716974;4510.706804057726;6769.458443324522;6844.828879278058;6854.2117656469645;6872.587644741281;6882.174139103289;6090.878182436327;6096.1770161028135;6113.480354169901;6117.632942023492;6132.662703551303;6159.538034647419;7575.621218939086;7617.390608751287;7660.042494688164;7704.922950770477;4630.490646028934;4824.276358546246;4835.540623640749;4835.685680430761;4837.298591704219;6346.238451385817;6653.968634861556;6818.556793808387;7870.173631768639;7900.407469439758;4088.7137900347284;4894.608431325557;4897.632677549198;4906.94500682355;4908.410990681141;4983.227599721977;4986.626003049786;4988.326575912278;5002.924956125661;5004.2493625956395;5920.0231961726695;5933.931892259348;5945.583809133319;5993.640381577119;6020.187274717857;7352.889706654404;7582.696692132363;7588.544687318778;7612.543247405173;7614.505057171266;1713.6829686507785;1720.1829131162597;1735.670222657691;1735.7136072547887;1743.8517725993179;1019.0879163148941;1071.7213524483534;1075.301054314686;1077.8221593437152;1101.823708206683;7126.572405655574;7158.785236442915;7159.03353047332;7167.247439018932;7171.211166771651;7815.765527034198;7840.372770178372;7872.252136047066;7894.250046245597;7894.407919406068;7027.543209691354;7102.893456598155;7134.072570565793;7153.320434558708;7155.713771449188;4004.59954004603;4126.09225970286;4170.22850772608;4178.874633760992;4189.560096189917;8158.143394943446;8243.010838699274;8246.917530824734;8255.587220638945;8259.050209226016;6507.284198738135;8089.029316481942;8104.189581041848;8108.472949258279;8177.632006559719;6999.615021173884;8231.34149268057;8254.958725206336;8257.133001034925;8266;7679.923200768144;7867.527948323119;8059.91191189182;8060.677572897019;8066.354691624773;7852.568108754073;7880.684772609032;7895.407844411578;7901;7907.525548467111;8461.703840365557;8462.661493540436;8482.19419155204;8489.83020339602;8504;4890.021995600823;4921.63087768426;4929.383827021622;4937.827176048965;4939.629527785502;6393.424591786761;7684;8005.07941586725;8005.919940800517;8006.039275287003;6971;7168.709632266034;7675.313640225876;7760.3791696663;7811.4922530035365;6300.83434564607;7656.923430765621;7674.884876726966;7728.072631284282;7741.303282704584;7235.299704569527;7431.108267007994;7473.813154671177;7482.326590606872;7541.7360392386;6365.745370185141;6388.8083357499345;7321.377682897013;7708.113566939874;7713.305802477804;6426.068220108152;6907.412869905913;7350.595717235603;7562.054743157106;7564 13:19:11 INFO - PROCESS | 2227 | |5;yui.html;697.8953157026446;752.6424948149627;765.9808504787379;766.880354682164;772.7604442622787;14800.407983680654;15030.398784048652;15081.019733717301;15120.848791512082;15130.470433534829;13795.931020344884;13991.580252592414;13995.440182392718;14037.578872633812;14051.578452646438;784.6469088909985;947.2422062350126;949.1410273702293;970.6505657963163;970.7815741458186;953.1755031897428;956.0869369751905;961.6538046303325;969.1955676788249;974.4591751577872;930.9581068851918;1026.7535791410046;1037.1547189040946;1040.2302296300759;1043.7755882485264;1029.9948500257526;1031.561586325816;1034.1364960258193;1035.0787798858985;1037.4657051618422;742.7251916790822;754.1365136918198;764.457235362893;772.6368606754817;774.0479210570973;15288.388464461408;15424.228788560527;15444.613884652974;15478.767818482731;15663.060216387054;12987.935060324638;12989.350532473338;13040.673983150402;13074;13181.275029873354;8207;10437.20329083094;10473.371597704087;10475.371477711362;10619.203559732974;3586.372384832644;3593.3531964246426;3615.3188767223105;3682.9447558286647;3850.9229815403537;81639.18360816316;87593.56203218942;87870.56064719635;88904;89187.87842425484;9317.16145546904;9592.472414017297;9796.02039796029;9850.704478865646;10175;21171.78828211698;21194.94025298729;21979.890100549394;22006.669899951514;22047.66928496074;7458.328750412489;7473.140588832354;7498.775036748797;7533.171351151369;7574.053243344582;4145.357469592218;4148.668106551469;4190.790460476964;4214.367844823301;4256.255155347863;3357.6569372251297;3720.3675375186285;3778.1499162688174;3792.7534710243744;3795.2409518096492;665.6039656404431;686.375398387475;688.3357559954668;689.8827199376118;691.350130876974;577.1054864959381;587.0802475903771;596.0998891673604;601.8865099565855;602.813127930343;8071.354291656771;8086.474379165453;8202.630881610341;8212.137725538852;8236.888020117327;505.4010996968604;558.6787597131665;584.4652143288928;585.4584509328854;620.1782638004662;3233.692799184074;3301.5542901707963;3612.2956023575152;3730.7948062856804;3762.7177961652437;91487;92031;92830.53584732168;93901.5304923471;94967;58728;76273.6186319076;79390;80203;80835.5958220205;50476.747616262415;68833.31166688268;69935.25161870892;70137;70683.99999999897;7390.482666213528;7495;7575.772726818204;7645.044369453818;7848.529088254723;49757.50727478181;49853.75073124611;50186.24720629267;50399;51109.48890511196;62846.6857665727;67214.66392668005;68525;69181.3081869175;69229;10974;11166.218364714718;11248.212625116163;11395.772084558428;11644.41777911118;11871.228370155912;11900.285982841056;11932.403379831147;12211.084168687561;12570.87429125697;11487.138464615355;11578.673810047472;11686.94156529246;11699.415029248674;11794.587189448328;11228.776605552566;11491.712707182052;11534.134939879375;11553.13351498624;11618.767624647291;11460.82808757886;11473.196876218919;11519.596814111466;11573.132015098732;11751.529938802352;9617.759556011155;9845.45849978258;9873.605055797687;9913.107820296207;10210.846837297298;9635.793775168107;9801.264905132;9847.113759761656;9903.752406189902;9949.502524873582 13:19:11 INFO - PROCESS | 2227 | __end_tp_report 13:19:11 INFO - PROCESS | 2227 | __start_cc_report 13:19:11 INFO - PROCESS | 2227 | _x_x_mozilla_cycle_collect,399 13:19:11 INFO - PROCESS | 2227 | __end_cc_report 13:19:11 INFO - PROCESS | 2227 | __startTimestamp1468786751780__endTimestamp 13:19:11 INFO - PROCESS | 2227 | 13:19:11 INFO - PROCESS | 2227 | ------- Summary: start ------- 13:19:11 INFO - PROCESS | 2227 | Number of tests: 6 13:19:11 INFO - PROCESS | 2227 | 13:19:11 INFO - PROCESS | 2227 | [#0] dojo.html Cycles:165 Average:5952.19 Median:6178.78 stddev:658.79 (10.7%) stddev-sans-first:629.56 13:19:11 INFO - PROCESS | 2227 | Values: 3396.4 3677.5 3678.4 3721.6 3723.4 5725.5 5940.1 6012.4 6093.1 6099.0 6052.4 6081.3 6110.4 6110.8 6120.9 5457.3 5493.8 5504.5 5508.5 5588.3 4529.4 5433.0 5518.9 5587.6 5596.6 5008.6 5089.5 5536.9 5568.4 5575.0 5486.4 5491.1 5559.6 5561.6 5587.9 4536.4 5339.5 5349.1 5383.4 5459.0 5824.8 5913.4 5928.5 5930.8 5997.2 6255.0 6310.3 6339.5 6397.7 6400.9 5640.4 6178.8 6482.8 6483.8 6499.5 6106.6 6178.6 6182.7 6192.4 6202.5 6456.8 6509.2 6638.9 6653.7 6698.6 6241.7 6311.5 6328.2 6349.0 6359.2 6434.1 6474.7 6490.5 6507.2 6518.9 6206.4 6235.8 6299.8 6299.9 6389.0 6357.4 6366.9 6374.8 6383.6 6387.7 5041.1 5117.7 5119.7 5122.3 5179.4 4507.6 4581.0 4608.2 4614.6 4691.7 5954.0 6042.2 6079.5 6115.2 6148.1 5732.3 6392.9 6412.9 6445.3 6488.3 5963.9 6111.2 6130.7 6150.6 6170.4 5586.3 5595.6 5600.0 5611.4 5622.4 6688.6 6693.4 6707.8 6730.8 6746.8 6324.6 6363.1 6421.6 6457.0 6460.5 6726.1 6727.4 6731.7 6741.7 6759.8 4975.0 6383.4 6389.0 6393.6 6398.9 6229.4 6378.0 6421.4 6428.9 6461.1 6228.9 6244.6 6254.6 6257.5 6258.6 5264.6 6264.6 6266.8 6270.7 6279.0 6075.4 6093.3 6133.0 6188.2 6233.9 6232.6 6254.3 6287.6 6289.4 6289.7 6067.8 6112.9 6146.1 6196.9 6231.9 13:19:11 INFO - PROCESS | 2227 | 13:19:11 INFO - PROCESS | 2227 | [#1] ext.html Cycles:180 Average:60236.55 Median:383149.50 stddev:126478.84 (33.0%) stddev-sans-first:126754.16 13:19:11 INFO - PROCESS | 2227 | Values: 512.7 562.0 562.0 564.1 596.3 30432.4 39893.8 40278.4 40455.4 40520.4 41635.0 41715.0 42307.0 42525.1 42577.8 9539.2 9694.4 9771.6 9784.6 9798.8 9770.8 9888.1 9943.9 9954.6 9963.7 9847.1 9858.9 9892.6 9900.3 9918.8 9819.2 9863.0 9880.4 9906.3 9938.0 9714.8 9797.0 9845.8 9846.8 9863.5 34487.5 39634.2 40219.4 40645.4 40789.0 3068.2 3204.8 3389.8 3504.9 3896.0 27477.0 28320.6 28668.7 28720.4 29075.7 2675.8 2688.8 2743.1 2749.4 2834.5 377351.0 380993.0 382210.0 382825.0 383474.0 36329.5 36593.5 36706.8 37585.4 38363.0 30485.8 36930.6 37012.3 37123.6 37196.4 16118.4 16345.3 16364.5 16365.1 16390.5 13645.3 13693.1 13767.9 13769.4 13773.4 8401.7 8444.6 8592.1 8600.1 8643.8 3542.9 3588.9 3605.4 3614.1 3625.5 1039.3 1089.7 1096.5 1115.8 1126.9 31184.5 31335.1 31415.5 31734.4 31777.0 1134.5 1179.9 1227.2 1261.1 1263.9 13041.7 13189.7 15667.1 15834.4 16087.6 488509.0 586804.1 590114.0 591423.0 595320.0 63076.4 63105.4 64072.4 64113.0 64258.7 1348.4 1551.1 1554.5 1561.8 1564.7 30266.0 30579.0 30713.5 30727.5 30995.4 53887.9 54766.7 55049.0 55230.4 55330.7 447637.0 450606.0 451383.0 451507.0 452121.0 26941.9 27858.4 28128.6 28211.9 28270.6 46572.5 47239.1 47988.0 48110.3 48355.8 39378.6 39620.6 39736.4 39749.4 40567.6 32493.4 38648.3 39342.2 39360.4 39421.6 33424.5 38887.2 38930.0 39210.0 39384.8 30805.5 32190.4 32492.8 32616.3 32955.0 23076.1 23268.0 24770.6 25086.9 25502.7 13:19:11 INFO - PROCESS | 2227 | 13:19:11 INFO - PROCESS | 2227 | [#2] jquery.html Cycles:180 Average:34251.42 Median:12207.87 stddev:98350.03 (805.6%) stddev-sans-first:98593.10 13:19:11 INFO - PROCESS | 2227 | Values: 411.7 413.7 414.5 420.9 424.1 20680.6 21306.7 21347.9 21389.1 22227.4 12180.6 12508.2 16448.3 21389.5 21619.5 4551.9 5359.1 5653.9 5671.1 6008.5 6096.8 6689.9 6838.8 6851.5 6949.6 6585.1 6863.7 6878.4 6884.3 6902.1 5602.9 6254.9 6580.9 6844.8 6858.7 5854.4 6150.0 6152.2 6155.2 6163.0 20409.5 24628.1 25542.2 26483.7 26569.1 2138.8 2188.3 2234.0 2486.2 2674.4 10047.8 10467.5 10554.8 10583.9 10737.7 1818.6 1854.6 1907.5 1922.7 1939.7 106076.0 114193.4 115595.0 118250.0 118732.0 11386.8 11615.9 12037.6 12074.9 12153.3 13646.3 15216.0 15417.5 15474.8 15609.1 8714.9 9152.3 9187.1 9218.0 9251.0 9083.0 9174.4 9181.2 9242.4 9248.5 4773.6 4823.6 4887.5 4888.5 4915.5 2035.7 2092.3 2115.9 2135.0 2135.3 853.4 900.8 943.2 992.1 1124.9 18166.8 19080.0 20756.6 21056.3 21086.6 942.8 970.5 986.6 1031.9 1042.8 8846.8 10940.5 11069.4 11204.0 11248.6 531606.0 543445.3 546758.0 652091.0 664587.0 82500.0 109267.0 115701.0 141115.0 152234.2 974.9 1009.1 1009.5 1011.6 1032.4 18315.5 18548.7 18783.3 18811.8 18852.6 48713.8 51235.7 51483.5 51511.5 55433.4 67344.0 69227.0 70879.3 71515.3 72913.3 7051.3 8069.9 8174.0 8367.5 8460.5 12256.9 12921.0 13055.9 13140.3 13205.9 11258.8 11299.9 11361.9 11521.6 11613.6 10854.6 11119.8 11156.8 11259.7 11485.7 11473.7 11512.7 11621.2 11766.9 11824.4 7593.8 8528.3 8536.8 8693.7 8917.1 9675.9 10921.3 10940.0 11292.9 11657.2 13:19:11 INFO - PROCESS | 2227 | 13:19:11 INFO - PROCESS | 2227 | [#3] mootools.html Cycles:180 Average:6013.36 Median:5194.19 stddev:3324.38 (64.0%) stddev-sans-first:3317.49 13:19:11 INFO - PROCESS | 2227 | Values: 1644.4 1671.6 1949.5 2007.2 2110.9 8504.2 9244.4 9377.8 9397.9 9548.0 9257.0 9292.3 9370.3 9380.9 9389.2 2570.3 2579.3 2594.7 2601.5 2612.7 2472.6 2489.2 2561.6 2592.7 2604.9 2391.7 2453.3 2564.9 2584.8 2637.4 2598.4 2600.6 2610.4 2615.6 2628.5 2573.6 2606.9 2609.9 2624.7 2627.4 9438.7 9499.4 9561.8 9565.3 9581.0 5749.6 5832.5 5863.3 6002.1 6004.2 3706.5 3710.6 3732.7 3787.3 3845.8 1063.7 1075.3 1078.6 1113.9 1129.2 12351.9 12366.4 12388.8 12457.9 12487.6 5081.4 5088.4 5181.3 5207.1 5214.9 10724.6 10742.8 10917.7 10938.7 10945.3 5650.6 5806.1 5891.9 5911.2 5926.7 4690.1 5123.1 5212.8 5217.1 5255.1 4319.3 4330.2 4384.7 4386.3 4404.1 1428.1 1446.4 1450.9 1454.4 1464.7 865.7 938.4 959.9 984.7 985.7 6165.9 6181.7 6227.0 6268.7 6324.9 490.2 492.7 493.6 493.8 498.0 4026.6 4089.2 4099.6 4147.2 4184.0 9337.5 11145.3 11209.8 11371.5 11571.5 10074.1 10388.3 11191.5 11290.2 11303.4 8425.0 8732.3 8774.2 8779.6 8829.4 5959.8 6033.3 6033.5 6041.5 6088.7 9553.6 9607.1 9685.4 9867.7 9899.6 9743.8 9889.7 9995.5 10042.6 10419.6 7231.5 7984.6 8073.7 8409.7 8638.3 8744.5 8758.0 8797.3 8805.3 8820.5 7598.2 7827.8 7840.1 7864.0 7886.4 6388.0 7611.6 7646.6 7783.2 7829.6 7306.6 7311.6 7366.6 7409.9 7423.6 5008.4 5027.6 5149.4 5220.9 5224.1 4497.3 5156.9 5218.4 5243.1 5355.5 13:19:11 INFO - PROCESS | 2227 | 13:19:11 INFO - PROCESS | 2227 | [#4] prototype.html Cycles:180 Average:6166.36 Median:6905.05 stddev:1991.99 (28.8%) stddev-sans-first:1948.54 13:19:11 INFO - PROCESS | 2227 | Values: 313.6 320.4 341.7 345.1 345.2 6902.7 7017.4 7113.0 7168.8 7176.8 7129.8 7153.7 7183.0 7194.8 7212.8 5249.1 5289.6 5303.2 5322.1 5324.3 5266.6 5298.9 5304.0 5316.5 5319.8 4664.3 4852.4 5255.2 5258.4 5276.1 5087.3 5250.9 5266.8 5286.7 5306.0 4491.5 4501.8 4504.8 4506.1 4510.7 6769.5 6844.8 6854.2 6872.6 6882.2 6090.9 6096.2 6113.5 6117.6 6132.7 6159.5 7575.6 7617.4 7660.0 7704.9 4630.5 4824.3 4835.5 4835.7 4837.3 6346.2 6654.0 6818.6 7870.2 7900.4 4088.7 4894.6 4897.6 4906.9 4908.4 4983.2 4986.6 4988.3 5002.9 5004.2 5920.0 5933.9 5945.6 5993.6 6020.2 7352.9 7582.7 7588.5 7612.5 7614.5 1713.7 1720.2 1735.7 1735.7 1743.9 1019.1 1071.7 1075.3 1077.8 1101.8 7126.6 7158.8 7159.0 7167.2 7171.2 7815.8 7840.4 7872.3 7894.3 7894.4 7027.5 7102.9 7134.1 7153.3 7155.7 4004.6 4126.1 4170.2 4178.9 4189.6 8158.1 8243.0 8246.9 8255.6 8259.1 6507.3 8089.0 8104.2 8108.5 8177.6 6999.6 8231.3 8255.0 8257.1 8266.0 7679.9 7867.5 8059.9 8060.7 8066.4 7852.6 7880.7 7895.4 7901.0 7907.5 8461.7 8462.7 8482.2 8489.8 8504.0 4890.0 4921.6 4929.4 4937.8 4939.6 6393.4 7684.0 8005.1 8005.9 8006.0 6971.0 7168.7 7675.3 7760.4 7811.5 6300.8 7656.9 7674.9 7728.1 7741.3 7235.3 7431.1 7473.8 7482.3 7541.7 6365.7 6388.8 7321.4 7708.1 7713.3 6426.1 6907.4 7350.6 7562.1 7564.0 13:19:11 INFO - PROCESS | 2227 | 13:19:11 INFO - PROCESS | 2227 | [#5] yui.html Cycles:180 Average:18368.27 Median:25807.45 stddev:25842.04 (100.1%) stddev-sans-first:25880.48 13:19:11 INFO - PROCESS | 2227 | Values: 697.9 752.6 766.0 766.9 772.8 14800.4 15030.4 15081.0 15120.8 15130.5 13795.9 13991.6 13995.4 14037.6 14051.6 784.6 947.2 949.1 970.7 970.8 953.2 956.1 961.7 969.2 974.5 931.0 1026.8 1037.2 1040.2 1043.8 1030.0 1031.6 1034.1 1035.1 1037.5 742.7 754.1 764.5 772.6 774.0 15288.4 15424.2 15444.6 15478.8 15663.1 12987.9 12989.4 13040.7 13074.0 13181.3 8207.0 10437.2 10473.4 10475.4 10619.2 3586.4 3593.4 3615.3 3682.9 3850.9 81639.2 87593.6 87870.6 88904.0 89187.9 9317.2 9592.5 9796.0 9850.7 10175.0 21171.8 21194.9 21979.9 22006.7 22047.7 7458.3 7473.1 7498.8 7533.2 7574.1 4145.4 4148.7 4190.8 4214.4 4256.3 3357.7 3720.4 3778.1 3792.8 3795.2 665.6 686.4 688.3 689.9 691.4 577.1 587.1 596.1 601.9 602.8 8071.4 8086.5 8202.6 8212.1 8236.9 505.4 558.7 584.5 585.5 620.2 3233.7 3301.6 3612.3 3730.8 3762.7 91487.0 92031.0 92830.5 93901.5 94967.0 58728.0 76273.6 79390.0 80203.0 80835.6 50476.7 68833.3 69935.3 70137.0 70684.0 7390.5 7495.0 7575.8 7645.0 7848.5 49757.5 49853.8 50186.2 50399.0 51109.5 62846.7 67214.7 68525.0 69181.3 69229.0 10974.0 11166.2 11248.2 11395.8 11644.4 11871.2 11900.3 11932.4 12211.1 12570.9 11487.1 11578.7 11686.9 11699.4 11794.6 11228.8 11491.7 11534.1 11553.1 11618.8 11460.8 11473.2 11519.6 11573.1 11751.5 9617.8 9845.5 9873.6 9913.1 10210.8 9635.8 9801.3 9847.1 9903.8 9949.5 13:19:11 INFO - PROCESS | 2227 | -------- Summary: end -------- 13:19:11 INFO - PROCESS | 2227 | 13:19:12 INFO - TEST-INFO | 2227: exit 0 13:19:12 INFO - TEST-OK | dromaeo_css | took 1110147ms 13:19:12 INFO - TEST-START | kraken 13:19:12 INFO - operating with platform_type : mac_ 13:19:12 INFO - Initialising browser for kraken test... 13:19:12 INFO - TEST-INFO | started process 2232 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/tmp1Ru_cF/profile http://localhost:59765/getInfo.html) 13:19:14 INFO - PROCESS | 2232 | __metrics Screen width/height:1600/1200 13:19:14 INFO - PROCESS | 2232 | colorDepth:24 13:19:14 INFO - PROCESS | 2232 | Browser inner width/height: 1024/689 13:19:14 INFO - PROCESS | 2232 | __metrics 13:19:15 ERROR - PROCESS | 2232 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 13:19:15 INFO - TEST-INFO | 2232: exit 0 13:19:15 INFO - Browser initialized. 13:19:15 INFO - Running cycle 1/1 for kraken test... 13:19:15 INFO - TEST-INFO | started process 2236 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/T/tmp1Ru_cF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:27 INFO - PROCESS | 2236 | RSS: Main: 170536960 13:19:27 INFO - PROCESS | 2236 | 13:19:30 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59765/tests/kraken/driver.html?testName=audio-beat-detection) 13:19:30 INFO - PROCESS | 2236 | RSS: Main: 183394304 13:19:30 INFO - PROCESS | 2236 | 13:19:33 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59765/tests/kraken/driver.html?testName=audio-dft) 13:19:34 INFO - PROCESS | 2236 | RSS: Main: 192598016 13:19:34 INFO - PROCESS | 2236 | 13:19:37 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59765/tests/kraken/driver.html?testName=audio-fft) 13:19:38 INFO - PROCESS | 2236 | RSS: Main: 195538944 13:19:38 INFO - PROCESS | 2236 | 13:19:39 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59765/tests/kraken/driver.html?testName=audio-oscillator) 13:19:40 INFO - PROCESS | 2236 | RSS: Main: 197206016 13:19:40 INFO - PROCESS | 2236 | 13:19:42 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59765/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:19:43 INFO - PROCESS | 2236 | RSS: Main: 197844992 13:19:43 INFO - PROCESS | 2236 | 13:19:46 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59765/tests/kraken/driver.html?testName=imaging-darkroom) 13:19:46 INFO - PROCESS | 2236 | RSS: Main: 197844992 13:19:46 INFO - PROCESS | 2236 | 13:19:49 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59765/tests/kraken/driver.html?testName=imaging-desaturate) 13:19:50 INFO - PROCESS | 2236 | RSS: Main: 197566464 13:19:50 INFO - PROCESS | 2236 | 13:19:52 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59765/tests/kraken/driver.html?testName=json-parse-financial) 13:19:53 INFO - PROCESS | 2236 | RSS: Main: 197697536 13:19:53 INFO - PROCESS | 2236 | 13:19:55 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59765/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:19:55 INFO - PROCESS | 2236 | RSS: Main: 197382144 13:19:55 INFO - PROCESS | 2236 | 13:19:57 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59765/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:19:58 INFO - PROCESS | 2236 | RSS: Main: 197521408 13:19:58 INFO - PROCESS | 2236 | 13:20:00 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59765/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:20:01 INFO - PROCESS | 2236 | RSS: Main: 197390336 13:20:01 INFO - PROCESS | 2236 | 13:20:03 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:20:04 INFO - PROCESS | 2236 | RSS: Main: 197562368 13:20:04 INFO - PROCESS | 2236 | 13:20:07 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:20:08 INFO - PROCESS | 2236 | RSS: Main: 197517312 13:20:08 INFO - PROCESS | 2236 | 13:20:09 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:59765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59765/tests/kraken/driver.html?testName=ai-astar) 13:20:10 INFO - PROCESS | 2236 | RSS: Main: 199266304 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | __start_tp_report 13:20:10 INFO - PROCESS | 2236 | _x_x_mozilla_page_load 13:20:10 INFO - PROCESS | 2236 | _x_x_mozilla_page_load_details 13:20:10 INFO - PROCESS | 2236 | |i|pagename|runs| 13:20:10 INFO - PROCESS | 2236 | |0;ai-astar;112;117;109;116;119;117;106;118;119;116 13:20:10 INFO - PROCESS | 2236 | |1;audio-beat-detection;156;120;144;157;122;139;121;154;154;122 13:20:10 INFO - PROCESS | 2236 | |2;audio-dft;195;200;193;200;200;197;195;195;200;195 13:20:10 INFO - PROCESS | 2236 | |3;audio-fft;59;67;82;147;57;56;59;65;131;56 13:20:10 INFO - PROCESS | 2236 | |4;audio-oscillator;75;82;125;77;82;84;117;79;78;113 13:20:10 INFO - PROCESS | 2236 | |5;imaging-gaussian-blur;88;87;90;87;97;74;135;132;102;87 13:20:10 INFO - PROCESS | 2236 | |6;imaging-darkroom;95;95;95;94;95;95;96;95;95;104 13:20:10 INFO - PROCESS | 2236 | |7;imaging-desaturate;90;93;93;92;92;103;136;151;89;92 13:20:10 INFO - PROCESS | 2236 | |8;json-parse-financial;59;65;63;72;74;82;90;108;96;93 13:20:10 INFO - PROCESS | 2236 | |9;json-stringify-tinderbox;62;67;67;74;68;107;60;66;89;99 13:20:10 INFO - PROCESS | 2236 | |10;stanford-crypto-aes;82;79;80;82;80;80;82;81;96;104 13:20:10 INFO - PROCESS | 2236 | |11;stanford-crypto-ccm;119;142;148;144;144;124;125;126;146;141 13:20:10 INFO - PROCESS | 2236 | |12;stanford-crypto-pbkdf2;165;165;170;218;211;167;165;158;156;163 13:20:10 INFO - PROCESS | 2236 | |13;stanford-crypto-sha256-iterative;66;71;67;66;85;91;98;93;97;71 13:20:10 INFO - PROCESS | 2236 | __end_tp_report 13:20:10 INFO - PROCESS | 2236 | __start_cc_report 13:20:10 INFO - PROCESS | 2236 | _x_x_mozilla_cycle_collect,1042 13:20:10 INFO - PROCESS | 2236 | __end_cc_report 13:20:10 INFO - PROCESS | 2236 | __startTimestamp1468786810165__endTimestamp 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | ------- Summary: start ------- 13:20:10 INFO - PROCESS | 2236 | Number of tests: 14 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#0] ai-astar Cycles:10 Average:114.90 Median:117.00 stddev:4.43 (3.8%) stddev-sans-first:4.58 13:20:10 INFO - PROCESS | 2236 | Values: 112.0 117.0 109.0 116.0 119.0 117.0 106.0 118.0 119.0 116.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:149.00 stddev:16.16 (10.8%) stddev-sans-first:15.91 13:20:10 INFO - PROCESS | 2236 | Values: 156.0 120.0 144.0 157.0 122.0 139.0 121.0 154.0 154.0 122.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#2] audio-dft Cycles:10 Average:197.00 Median:198.50 stddev:2.75 (1.4%) stddev-sans-first:2.82 13:20:10 INFO - PROCESS | 2236 | Values: 195.0 200.0 193.0 200.0 200.0 197.0 195.0 195.0 200.0 195.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#3] audio-fft Cycles:10 Average:77.90 Median:59.00 stddev:33.34 (56.5%) stddev-sans-first:34.66 13:20:10 INFO - PROCESS | 2236 | Values: 59.0 67.0 82.0 147.0 57.0 56.0 59.0 65.0 131.0 56.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:78.50 stddev:19.12 (24.4%) stddev-sans-first:19.36 13:20:10 INFO - PROCESS | 2236 | Values: 75.0 82.0 125.0 77.0 82.0 84.0 117.0 79.0 78.0 113.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#5] imaging-gaussian-blur Cycles:10 Average:97.90 Median:87.00 stddev:20.12 (23.1%) stddev-sans-first:21.02 13:20:10 INFO - PROCESS | 2236 | Values: 88.0 87.0 90.0 87.0 97.0 74.0 135.0 132.0 102.0 87.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:95.00 stddev:2.88 (3.0%) stddev-sans-first:3.04 13:20:10 INFO - PROCESS | 2236 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 95.0 104.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#7] imaging-desaturate Cycles:10 Average:103.10 Median:92.00 stddev:21.91 (23.8%) stddev-sans-first:22.72 13:20:10 INFO - PROCESS | 2236 | Values: 90.0 93.0 93.0 92.0 92.0 103.0 136.0 151.0 89.0 92.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#8] json-parse-financial Cycles:10 Average:80.20 Median:78.00 stddev:16.22 (20.8%) stddev-sans-first:15.28 13:20:10 INFO - PROCESS | 2236 | Values: 59.0 65.0 63.0 72.0 74.0 82.0 90.0 108.0 96.0 93.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#9] json-stringify-tinderbox Cycles:10 Average:75.90 Median:67.50 stddev:16.47 (24.4%) stddev-sans-first:16.68 13:20:10 INFO - PROCESS | 2236 | Values: 62.0 67.0 67.0 74.0 68.0 107.0 60.0 66.0 89.0 99.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:81.50 stddev:8.40 (10.3%) stddev-sans-first:8.85 13:20:10 INFO - PROCESS | 2236 | Values: 82.0 79.0 80.0 82.0 80.0 80.0 82.0 81.0 96.0 104.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:143.00 stddev:10.99 (7.7%) stddev-sans-first:9.81 13:20:10 INFO - PROCESS | 2236 | Values: 119.0 142.0 148.0 144.0 144.0 124.0 125.0 126.0 146.0 141.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:166.00 stddev:21.89 (13.2%) stddev-sans-first:22.99 13:20:10 INFO - PROCESS | 2236 | Values: 165.0 165.0 170.0 218.0 211.0 167.0 165.0 158.0 156.0 163.0 13:20:10 INFO - PROCESS | 2236 | 13:20:10 INFO - PROCESS | 2236 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.50 Median:88.00 stddev:13.53 (15.4%) stddev-sans-first:13.30 13:20:10 INFO - PROCESS | 2236 | Values: 66.0 71.0 67.0 66.0 85.0 91.0 98.0 93.0 97.0 71.0 13:20:10 INFO - PROCESS | 2236 | -------- Summary: end -------- 13:20:10 INFO - PROCESS | 2236 | 13:20:11 INFO - TEST-INFO | 2236: exit 0 13:20:11 INFO - TEST-OK | kraken | took 58759ms 13:20:11 INFO - SUITE-END | took 1168s 13:20:11 INFO - Completed test suite (00:19:29) 13:20:11 INFO - javascript benchmark 13:20:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3396.354692608404, 3677.485152078711, 3678.411454167334, 3721.5534135903695, 3723.4042553191484, 5725.45608167224, 5940.138679891413, 6012.398760123985, 6093.086037094438, 6099.024156135019, 6052.42501962314, 6081.270247570298, 6110.388961103888, 6110.755569777215, 6120.867639486698, 5457.290552228214, 5493.807716729915, 5504.532114770229, 5508.476694713996, 5588.273524441837, 4529.365888775574, 5432.994895944244, 5518.91721624176, 5587.580931430159, 5596.552275817925, 5008.5993120550265, 5089.541941225289, 5536.861578460551, 5568.3596386415475, 5574.9721251393685, 5486.3690675572025, 5491.121420572729, 5559.580857772461, 5561.58288128392, 5587.8603034924245, 4536.432945881765, 5339.519443250126, 5349.063913815066, 5383.407825139271, 5459.0, 5824.767009319622, 5913.408659134096, 5928.49607783339, 5930.822075337704, 5997.190379298826, 6255.0, 6310.337414571496, 6339.492840572743, 6397.744090236385, 6400.9359906400805, 5640.351359593658, 6178.783742568989, 6482.837929051764, 6483.7730679425995, 6499.512536559777, 6106.572539922163, 6178.598391104564, 6182.6599537024995, 6192.442680158762, 6202.472789812871, 6456.806295811133, 6509.1863517060365, 6638.86722265552, 6653.667316634149, 6698.5980841149685, 6241.656708881055, 6311.495080393557, 6328.240611126695, 6348.984162534065, 6359.236891573041, 6434.099226108348, 6474.741010359533, 6490.513211509156, 6507.219133703986, 6518.934810651833, 6206.410391012847, 6235.812925612239, 6299.7795077173, 6299.874002519924, 6388.968055159788, 6357.396047375492, 6366.904496432558, 6374.84062898422, 6383.585066970632, 6387.680615969183, 5041.117804384291, 5117.718525481134, 5119.667221630582, 5122.308488354024, 5179.430262671103, 4507.616852567503, 4581.0, 4608.239640459354, 4614.607758340511, 4691.6863278282135, 5954.0, 6042.1540984261355, 6079.513638908877, 6115.181368569397, 6148.1085242639565, 5732.337622089547, 6392.904106438407, 6412.935870641327, 6445.291017988017, 6488.2538508072175, 5963.940360596425, 6111.205543279345, 6130.734471166763, 6150.600210986271, 6170.352113028068, 5586.301712285965, 5595.63628364155, 5600.0, 5611.410801865827, 5622.409646987007, 6688.565243259172, 6693.431058360094, 6707.798766037026, 6730.798076057824, 6746.807287631539, 6324.620522768649, 6363.109164717036, 6421.5825971311715, 6457.0, 6460.45086167681, 6726.125603671491, 6727.428168605723, 6731.697073631601, 6741.696623651849, 6759.831004224934, 4975.0, 6383.393577610305, 6389.0, 6393.6163830170335, 6398.904016439664, 6229.3770622937345, 6377.96811015942, 6421.389967953037, 6428.903566446601, 6461.0954466373805, 6228.906566401417, 6244.625322480666, 6254.562180647311, 6257.4994000480765, 6258.624482531062, 5264.578833693372, 6264.561480696308, 6266.843328916813, 6270.686465676789, 6279.0, 6075.422834830684, 6093.29927058394, 6132.967444181115, 6188.226471691039, 6233.937660623335, 6232.5948813328805, 6254.343293954252, 6287.591306565058, 6289.371062893857, 6289.7169627365965, 6067.848303792441, 6112.868254062901, 6146.108814221823, 6196.938030619636, 6231.906521402092], "value": 5913.031824878205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.743628185907, 561.9884208424836, 562.0279321647429, 564.0777329066976, 596.3261514488627, 30432.39135217297, 39893.8005309973, 40278.39582406262, 40455.393169102485, 40520.39219411704, 41634.959126021866, 41715.0, 42307.0, 42525.14949701004, 42577.787111064405, 9539.236861051098, 9694.36986595869, 9771.609135634566, 9784.608615655365, 9798.755031124243, 9770.804583908317, 9888.060634239735, 9943.850842237336, 9954.552045157949, 9963.651272205474, 9847.11375976162, 9858.90141098587, 9892.604295828194, 9900.25748068894, 9918.752031199241, 9819.165370943478, 9863.0, 9880.35777674456, 9906.257030722689, 9938.0, 9714.75713107178, 9797.0, 9845.753856153582, 9846.803063938682, 9863.50682465881, 34487.4826877597, 39634.20731585381, 40219.39670904939, 40645.390319145234, 40789.0, 3068.248279171617, 3204.788354151912, 3389.8305084745666, 3504.9474257886154, 3895.9870433687447, 27477.0, 28320.575191372147, 28668.713312866814, 28720.425591488263, 29075.709242907724, 2675.8260713053587, 2688.7714544263763, 2743.067357098596, 2749.42262124954, 2834.4614523240516, 377351.0, 380993.0, 382209.9999999972, 382825.0, 383474.0, 36329.45505817415, 36593.45109823355, 36706.8164659175, 37585.43621845674, 38363.0, 30485.84757076245, 36930.63069369272, 37012.259754805295, 37123.62876371202, 37196.442053369225, 16118.435854745028, 16345.346186152421, 16364.509064728078, 16365.099919504542, 16390.508284751475, 13645.317734113254, 13693.109947853358, 13767.931160344135, 13769.380377883019, 13773.38019789112, 8401.705940292182, 8444.61999210037, 8592.140785921358, 8600.096989816104, 8643.783905402415, 3542.946855797165, 3588.8564457421935, 3605.4231322988194, 3614.1145419372424, 3625.492431059654, 1039.2828948025838, 1089.7330154112294, 1096.4901320885826, 1115.827046807746, 1126.8760436351995, 31184.53223201654, 31335.05994820159, 31415.528767068514, 31734.365312693615, 31777.046688599377, 1134.5348407153028, 1179.9174057815871, 1227.1900545640012, 1261.1046157228286, 1263.860975292717, 13041.673958151123, 13189.670258243621, 15667.059976401453, 15834.366625334858, 16087.597810054842, 488509.0, 586804.0659796674, 590114.0, 591423.0, 595320.0, 63076.36923630705, 63105.36894630995, 64072.39819004469, 64113.03830442547, 64258.678706607105, 1348.3527906604688, 1551.1236151574324, 1554.4870192836338, 1561.820390655089, 1564.6622138072012, 30266.0, 30579.0, 30713.467951185004, 30727.539086913268, 30995.380092398478, 53887.92224155573, 54766.72616637051, 55049.0, 55230.44769552253, 55330.72334638462, 447637.0, 450606.0, 451383.0, 451507.0, 452121.0, 26941.86529067342, 27858.442831143668, 28128.57807132854, 28211.858940705166, 28270.57594136131, 46572.534274658174, 47239.055218896116, 47988.0, 48110.27834582414, 48355.758221210075, 39378.60621393749, 39620.603793961694, 39736.403953940135, 39749.403758944216, 40567.59432405638, 32493.35013299768, 38648.33586080379, 39342.2131557373, 39360.40959385554, 39421.60578394294, 33424.49863252102, 38887.222255555294, 38930.0, 39210.0, 39384.80307598558, 30805.537916931713, 32190.35619287648, 32492.837535813116, 32616.34767304688, 32955.0, 23076.077066899004, 23267.952942117307, 24770.628440573044, 25086.874565627055, 25502.744972550037], "value": 18559.198364876975, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.7406034198456, 413.72694021945523, 414.5440015982419, 420.8674267605704, 424.08609446642475, 20680.586388272226, 21306.680399794015, 21347.893260533674, 21389.14443422263, 22227.44431389216, 12180.634580962564, 12508.186967847083, 16448.342066317364, 21389.465263368424, 21619.45951351217, 4551.931721024187, 5359.08895487768, 5653.886922261552, 5671.092625179972, 6008.549358798085, 6096.847578810521, 6689.866202675944, 6838.760643377483, 6851.520393572452, 6949.583025018515, 6585.143931288926, 6863.725450981955, 6878.380945714885, 6884.345987131214, 6902.068220790179, 5602.943970560283, 6254.905391556459, 6580.901286480706, 6844.828879278033, 6858.691358888837, 5854.414558544154, 6149.96925015372, 6152.230971128609, 6155.199824022893, 6163.044728067157, 20409.4897627559, 24628.138015169563, 25542.23373298804, 26483.735162648318, 26569.07008254702, 2138.7968143026387, 2188.2997440818945, 2234.0, 2486.1671340100906, 2674.424998625305, 10047.849282260771, 10467.528961196764, 10554.788904221949, 10583.894161058368, 10737.677869663923, 1818.5544541587265, 1854.5919897622503, 1907.523119220195, 1922.663533881579, 1939.6508628446875, 106076.0, 114193.4290328543, 115595.0, 118250.0, 118732.0, 11386.772264554662, 11615.883841161649, 12037.638870833889, 12074.87925120755, 12153.331566763736, 13646.317684115755, 15216.01095928761, 15417.460388886335, 15474.839387046017, 15609.141497217763, 8714.912850871537, 9152.267818574499, 9187.127222913812, 9218.032106628707, 9251.0, 9083.0, 9174.449533028039, 9181.219596334253, 9242.399244049115, 9248.491332976751, 4773.594244489188, 4823.614110871122, 4887.511248875084, 4888.460135057446, 4915.508449155127, 2035.6742921132548, 2092.311379876851, 2115.936521904345, 2134.957300853974, 2135.2915130619954, 853.389826274217, 900.7838118851429, 943.2124176312718, 992.1417973453056, 1124.9212555121062, 18166.818331816776, 19080.04599770006, 20756.58486830255, 21056.26303079385, 21086.578268434547, 942.844430668932, 970.5486948568949, 986.5609803637312, 1031.850381694665, 1042.8227201375632, 8846.778830529289, 10940.4529773511, 11069.446527673745, 11203.99164075237, 11248.550057997752, 531606.0, 543445.2827735835, 546758.0, 652091.0, 664587.0, 82500.0, 109267.0, 115701.0, 141115.0, 152234.23882880516, 974.91713204377, 1009.1220638044948, 1009.4902074452501, 1011.600417834951, 1032.4012072997643, 18315.479311808307, 18548.721769173204, 18783.34258300953, 18811.811881881007, 18852.622947540698, 48713.75643121904, 51235.74382128065, 51483.48516514937, 51511.48488515067, 55433.44566554283, 67344.0, 69227.0, 70879.29120708727, 71515.28484715086, 72913.27086729064, 7051.330123638246, 8069.878951815845, 8173.959130204311, 8367.539785311867, 8460.534670593177, 12256.87743122593, 12921.0, 13055.934720326337, 13140.277284749049, 13205.867941320465, 11258.831117533407, 11299.887001129884, 11361.92061754132, 11521.596744113916, 11613.593524226611, 10854.620088296871, 11119.83320250213, 11156.776864462827, 11259.662210133709, 11485.655430337103, 11473.713157171138, 11512.712182195512, 11621.186516943733, 11766.941165294118, 11824.40877956116, 7593.810154746176, 8528.317734581095, 8536.786580335542, 8693.739187824376, 8917.10828917103, 9675.896712262043, 10921.290116142425, 10940.015398614163, 11292.927171918654, 11657.18399712012], "value": 9757.322393582122, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1644.37513744777, 1671.590460337217, 1949.5223670200794, 2007.2272175212547, 2110.883901385423, 8504.19210175034, 9244.399114057598, 9377.765555861108, 9397.919239287485, 9548.045195480448, 9257.028012058738, 9292.303077269215, 9370.250379969602, 9380.906190938089, 9389.201917836992, 2570.2546261584116, 2579.342267721728, 2594.688637363519, 2601.4536947241104, 2612.673415823022, 2472.6167444046114, 2489.153687746166, 2561.5773397389503, 2592.7277635848245, 2604.882780274892, 2391.6532102845076, 2453.276283496364, 2564.948701025978, 2584.8449093054383, 2637.367031912346, 2598.376389666476, 2600.5969074793343, 2610.3604616868797, 2615.594582839663, 2628.4743051389605, 2573.5882258838496, 2606.9348266293496, 2609.9478010439684, 2624.711281759005, 2627.395698989243, 9438.669646562406, 9499.382540134939, 9561.808763824754, 9565.330426870121, 9581.0, 5749.568782341299, 5832.475077243069, 5863.2670916135485, 6002.069679199731, 6004.219451471281, 3706.4625629283873, 3710.6289371062676, 3732.6640602345647, 3787.304364732197, 3845.807709614536, 1063.7074804428767, 1075.333293358115, 1078.5739632844982, 1113.8663360396804, 1129.170060005895, 12351.938240308831, 12366.381680916009, 12388.75222495554, 12457.875421245762, 12487.562935297312, 5081.390233172043, 5088.389393272831, 5181.326427564468, 5207.062728708793, 5214.895702085937, 10724.624638137628, 10742.838857417146, 10917.672469825919, 10938.671839844817, 10945.343279403261, 5650.63270887391, 5806.071028635398, 5891.941080589225, 5911.231539899785, 5926.703664816742, 4690.085433340534, 5123.077845987684, 5212.817551385683, 5217.087009773274, 5255.13290307095, 4319.287317592562, 4330.17726631939, 4384.69307148503, 4386.298192289219, 4404.097160082176, 1428.1217051513452, 1446.3708286895235, 1450.891183161246, 1454.3818876977455, 1464.670449148933, 865.7489328094908, 938.3525367496405, 959.947202903833, 984.7193549838262, 985.6500942165571, 6165.916488468273, 6181.721822517998, 6227.0, 6268.686565671789, 6324.936750632435, 490.18139706689914, 492.65021834497907, 493.612514176377, 493.8123513065012, 498.01641757529313, 4026.617471340218, 4089.2434899543678, 4099.61053699898, 4147.232761939051, 4184.0, 9337.533123343806, 11145.275557088764, 11209.775804483865, 11371.54513819438, 11571.537138514534, 10074.093331600192, 10388.272820902464, 11191.496382662799, 11290.153238507144, 11303.434828258554, 8424.957875210584, 8732.257758090633, 8774.166454186841, 8779.561021948877, 8829.381943264038, 5959.76160953557, 6033.3061697905305, 6033.487153591994, 6041.486473649613, 6088.660494691161, 9553.570089346134, 9607.13535781783, 9685.370450920667, 9867.703968880945, 9899.554520046471, 9743.80512389734, 9889.653862114792, 9995.500224988868, 10042.598296068076, 10419.635312764018, 7231.5299505531975, 7984.56084915312, 8073.677052918052, 8409.705660301861, 8638.26574741154, 8744.519051452231, 8758.0, 8797.340199484936, 8805.251553618014, 8820.470771753458, 7598.240175982358, 7827.843443130992, 7840.098388685375, 7864.016997875266, 7886.408519360956, 6388.0, 7611.581363024865, 7646.617669116411, 7783.221677832172, 7829.6085195741125, 7306.561606303639, 7311.634418279171, 7366.63166841645, 7409.888851667337, 7423.628818559158, 5008.373953255843, 5027.572656324253, 5149.382074150976, 5220.869478263074, 5224.085784987536, 4497.347884556655, 5156.896862062813, 5218.373795144607, 5243.056249875059, 5355.464453554613], "value": 4793.363356690824, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.6236516180583, 320.36407730654645, 341.7334479106297, 345.0683155480204, 345.21119242530824, 6902.689378977945, 7017.403520700746, 7113.0, 7168.820779480509, 7176.784696459108, 7129.821754456141, 7153.713851445936, 7182.96408517958, 7194.784156475301, 7212.819679508015, 5249.107651699221, 5289.629725919187, 5303.178007408857, 5322.0686379883555, 5324.307839980797, 5266.605004624649, 5298.920516192241, 5303.973480132594, 5316.5215130638235, 5319.813806516772, 4664.323673067403, 4852.393450818648, 5255.211718242256, 5258.44786297439, 5276.050310944029, 5087.338645976018, 5250.92123618148, 5266.762995665185, 5286.656367336111, 5305.973470132624, 4491.528389519086, 4501.7524036178, 4504.8198072077075, 4506.053728716974, 4510.706804057726, 6769.458443324522, 6844.828879278058, 6854.2117656469645, 6872.587644741281, 6882.174139103289, 6090.878182436327, 6096.1770161028135, 6113.480354169901, 6117.632942023492, 6132.662703551303, 6159.538034647419, 7575.621218939086, 7617.390608751287, 7660.042494688164, 7704.922950770477, 4630.490646028934, 4824.276358546246, 4835.540623640749, 4835.685680430761, 4837.298591704219, 6346.238451385817, 6653.968634861556, 6818.556793808387, 7870.173631768639, 7900.407469439758, 4088.7137900347284, 4894.608431325557, 4897.632677549198, 4906.94500682355, 4908.410990681141, 4983.227599721977, 4986.626003049786, 4988.326575912278, 5002.924956125661, 5004.2493625956395, 5920.0231961726695, 5933.931892259348, 5945.583809133319, 5993.640381577119, 6020.187274717857, 7352.889706654404, 7582.696692132363, 7588.544687318778, 7612.543247405173, 7614.505057171266, 1713.6829686507785, 1720.1829131162597, 1735.670222657691, 1735.7136072547887, 1743.8517725993179, 1019.0879163148941, 1071.7213524483534, 1075.301054314686, 1077.8221593437152, 1101.823708206683, 7126.572405655574, 7158.785236442915, 7159.03353047332, 7167.247439018932, 7171.211166771651, 7815.765527034198, 7840.372770178372, 7872.252136047066, 7894.250046245597, 7894.407919406068, 7027.543209691354, 7102.893456598155, 7134.072570565793, 7153.320434558708, 7155.713771449188, 4004.59954004603, 4126.09225970286, 4170.22850772608, 4178.874633760992, 4189.560096189917, 8158.143394943446, 8243.010838699274, 8246.917530824734, 8255.587220638945, 8259.050209226016, 6507.284198738135, 8089.029316481942, 8104.189581041848, 8108.472949258279, 8177.632006559719, 6999.615021173884, 8231.34149268057, 8254.958725206336, 8257.133001034925, 8266.0, 7679.923200768144, 7867.527948323119, 8059.91191189182, 8060.677572897019, 8066.354691624773, 7852.568108754073, 7880.684772609032, 7895.407844411578, 7901.0, 7907.525548467111, 8461.703840365557, 8462.661493540436, 8482.19419155204, 8489.83020339602, 8504.0, 4890.021995600823, 4921.63087768426, 4929.383827021622, 4937.827176048965, 4939.629527785502, 6393.424591786761, 7684.0, 8005.07941586725, 8005.919940800517, 8006.039275287003, 6971.0, 7168.709632266034, 7675.313640225876, 7760.3791696663, 7811.4922530035365, 6300.83434564607, 7656.923430765621, 7674.884876726966, 7728.072631284282, 7741.303282704584, 7235.299704569527, 7431.108267007994, 7473.813154671177, 7482.326590606872, 7541.7360392386, 6365.745370185141, 6388.8083357499345, 7321.377682897013, 7708.113566939874, 7713.305802477804, 6426.068220108152, 6907.412869905913, 7350.595717235603, 7562.054743157106, 7564.0], "value": 5488.636498241864, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.8953157026446, 752.6424948149627, 765.9808504787379, 766.880354682164, 772.7604442622787, 14800.407983680654, 15030.398784048652, 15081.019733717301, 15120.848791512082, 15130.470433534829, 13795.931020344884, 13991.580252592414, 13995.440182392718, 14037.578872633812, 14051.578452646438, 784.6469088909985, 947.2422062350126, 949.1410273702293, 970.6505657963163, 970.7815741458186, 953.1755031897428, 956.0869369751905, 961.6538046303325, 969.1955676788249, 974.4591751577872, 930.9581068851918, 1026.7535791410046, 1037.1547189040946, 1040.2302296300759, 1043.7755882485264, 1029.9948500257526, 1031.561586325816, 1034.1364960258193, 1035.0787798858985, 1037.4657051618422, 742.7251916790822, 754.1365136918198, 764.457235362893, 772.6368606754817, 774.0479210570973, 15288.388464461408, 15424.228788560527, 15444.613884652974, 15478.767818482731, 15663.060216387054, 12987.935060324638, 12989.350532473338, 13040.673983150402, 13074.0, 13181.275029873354, 8207.0, 10437.20329083094, 10473.371597704087, 10475.371477711362, 10619.203559732974, 3586.372384832644, 3593.3531964246426, 3615.3188767223105, 3682.9447558286647, 3850.9229815403537, 81639.18360816316, 87593.56203218942, 87870.56064719635, 88904.0, 89187.87842425484, 9317.16145546904, 9592.472414017297, 9796.02039796029, 9850.704478865646, 10175.0, 21171.78828211698, 21194.94025298729, 21979.890100549394, 22006.669899951514, 22047.66928496074, 7458.328750412489, 7473.140588832354, 7498.775036748797, 7533.171351151369, 7574.053243344582, 4145.357469592218, 4148.668106551469, 4190.790460476964, 4214.367844823301, 4256.255155347863, 3357.6569372251297, 3720.3675375186285, 3778.1499162688174, 3792.7534710243744, 3795.2409518096492, 665.6039656404431, 686.375398387475, 688.3357559954668, 689.8827199376118, 691.350130876974, 577.1054864959381, 587.0802475903771, 596.0998891673604, 601.8865099565855, 602.813127930343, 8071.354291656771, 8086.474379165453, 8202.630881610341, 8212.137725538852, 8236.888020117327, 505.4010996968604, 558.6787597131665, 584.4652143288928, 585.4584509328854, 620.1782638004662, 3233.692799184074, 3301.5542901707963, 3612.2956023575152, 3730.7948062856804, 3762.7177961652437, 91487.0, 92031.0, 92830.53584732168, 93901.5304923471, 94967.0, 58728.0, 76273.6186319076, 79390.0, 80203.0, 80835.5958220205, 50476.747616262415, 68833.31166688268, 69935.25161870892, 70137.0, 70683.99999999897, 7390.482666213528, 7495.0, 7575.772726818204, 7645.044369453818, 7848.529088254723, 49757.50727478181, 49853.75073124611, 50186.24720629267, 50399.0, 51109.48890511196, 62846.6857665727, 67214.66392668005, 68525.0, 69181.3081869175, 69229.0, 10974.0, 11166.218364714718, 11248.212625116163, 11395.772084558428, 11644.41777911118, 11871.228370155912, 11900.285982841056, 11932.403379831147, 12211.084168687561, 12570.87429125697, 11487.138464615355, 11578.673810047472, 11686.94156529246, 11699.415029248674, 11794.587189448328, 11228.776605552566, 11491.712707182052, 11534.134939879375, 11553.13351498624, 11618.767624647291, 11460.82808757886, 11473.196876218919, 11519.596814111466, 11573.132015098732, 11751.529938802352, 9617.759556011155, 9845.45849978258, 9873.605055797687, 9913.107820296207, 10210.846837297298, 9635.793775168107, 9801.264905132, 9847.113759761656, 9903.752406189902, 9949.502524873582], "value": 7018.694504608303, "unit": "score"}], "name": "dromaeo_css", "value": 7632.769278183921, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 109.0, 116.0, 119.0, 117.0, 106.0, 118.0, 119.0, 116.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 120.0, 144.0, 157.0, 122.0, 139.0, 121.0, 154.0, 154.0, 122.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 200.0, 193.0, 200.0, 200.0, 197.0, 195.0, 195.0, 200.0, 195.0], "value": 197.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 67.0, 82.0, 147.0, 57.0, 56.0, 59.0, 65.0, 131.0, 56.0], "value": 77.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 125.0, 77.0, 82.0, 84.0, 117.0, 79.0, 78.0, 113.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 90.0, 87.0, 97.0, 74.0, 135.0, 132.0, 102.0, 87.0], "value": 97.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 104.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 93.0, 92.0, 92.0, 103.0, 136.0, 151.0, 89.0, 92.0], "value": 103.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 65.0, 63.0, 72.0, 74.0, 82.0, 90.0, 108.0, 96.0, 93.0], "value": 80.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 67.0, 74.0, 68.0, 107.0, 60.0, 66.0, 89.0, 99.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 80.0, 82.0, 80.0, 80.0, 82.0, 81.0, 96.0, 104.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 142.0, 148.0, 144.0, 144.0, 124.0, 125.0, 126.0, 146.0, 141.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 170.0, 218.0, 211.0, 167.0, 165.0, 158.0, 156.0, 163.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 67.0, 66.0, 85.0, 91.0, 98.0, 93.0, 97.0, 71.0], "value": 80.5, "unit": "score"}], "name": "kraken", "value": 1547.7, "alertThreshold": 2.0}]} 13:20:11 INFO - Return code: 0 13:20:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:20:11 ERROR - # TBPL SUCCESS # 13:20:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:20:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:20:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:20:11 INFO - 2016-07-17 13:20:11.498 screenresolution[2241:32669] starting screenresolution argv=screenresolution get 13:20:11 INFO - 2016-07-17 13:20:11.500 screenresolution[2241:32669] Display 0: 1600x1200x32@60 13:20:11 INFO - 2016-07-17 13:20:11.507 screenresolution[2242:32672] starting screenresolution argv=screenresolution list 13:20:11 INFO - Available Modes on Display 0 13:20:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:20:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:20:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:20:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:20:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:20:11 INFO - Intel Iris: 13:20:11 INFO - Chipset Model: Intel Iris 13:20:11 INFO - Type: GPU 13:20:11 INFO - Bus: Built-In 13:20:11 INFO - VRAM (Dynamic, Max): 1536 MB 13:20:11 INFO - Vendor: Intel (0x8086) 13:20:11 INFO - Device ID: 0x0a2e 13:20:11 INFO - Revision ID: 0x0009 13:20:11 INFO - Displays: 13:20:11 INFO - Display: 13:20:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:20:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:20:11 INFO - Display Serial Number: 1600x1200 60 13:20:11 INFO - Main Display: Yes 13:20:11 INFO - Mirror: Off 13:20:11 INFO - Online: Yes 13:20:11 INFO - Rotation: Supported 13:20:11 INFO - Return code: 0 13:20:11 INFO - Running post-action listener: _resource_record_post_action 13:20:11 INFO - Running post-run listener: _resource_record_post_run 13:20:12 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 249856; Write bytes: 496517632; Read time: 2; Write time: 1600 13:20:12 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194667008; Write bytes: 197609472; Read time: 17675; Write time: 456 13:20:12 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 249856; Write bytes: 298060288; Read time: 2; Write time: 1139 13:20:12 INFO - Running post-run listener: _upload_blobber_files 13:20:12 INFO - Blob upload gear active. 13:20:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:20:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:20:13 INFO - (blobuploader) - INFO - Open directory for files ... 13:20:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:20:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:20:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:14 INFO - (blobuploader) - INFO - Done attempting. 13:20:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:20:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:20:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:15 INFO - (blobuploader) - INFO - Done attempting. 13:20:15 INFO - (blobuploader) - INFO - Iteration through files over. 13:20:15 INFO - Return code: 0 13:20:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:20:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:20:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f6b5eca529d26d44a673f1e4a151878ccdc9b078ac67ea3cdee1b95ee9a8f06fb77e37743347ecedbd14e98f70172d0091de00bfe768426911ffc9b42cbd679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a70dab8c8caf43021a96e91a486124305feaa0f95960a4bbaeed8defe5baf5963ba820ecf43ae5c689b4352f9604cc476585d728c8df379b4aafcb943494043a"} 13:20:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:20:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:20:15 INFO - Contents: 13:20:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f6b5eca529d26d44a673f1e4a151878ccdc9b078ac67ea3cdee1b95ee9a8f06fb77e37743347ecedbd14e98f70172d0091de00bfe768426911ffc9b42cbd679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a70dab8c8caf43021a96e91a486124305feaa0f95960a4bbaeed8defe5baf5963ba820ecf43ae5c689b4352f9604cc476585d728c8df379b4aafcb943494043a"} 13:20:15 INFO - Running post-run listener: copy_logs_to_upload_dir 13:20:15 INFO - Copying logs to upload dir... 13:20:15 INFO - mkdir: /builds/slave/test/build/upload/logs 13:20:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.876945 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-17 13:20:15.338995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 13:20:15.342714) ========= 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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners TMPDIR=/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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/4f6b5eca529d26d44a673f1e4a151878ccdc9b078ac67ea3cdee1b95ee9a8f06fb77e37743347ecedbd14e98f70172d0091de00bfe768426911ffc9b42cbd679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a70dab8c8caf43021a96e91a486124305feaa0f95960a4bbaeed8defe5baf5963ba820ecf43ae5c689b4352f9604cc476585d728c8df379b4aafcb943494043a"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011121 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468602118/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f6b5eca529d26d44a673f1e4a151878ccdc9b078ac67ea3cdee1b95ee9a8f06fb77e37743347ecedbd14e98f70172d0091de00bfe768426911ffc9b42cbd679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a70dab8c8caf43021a96e91a486124305feaa0f95960a4bbaeed8defe5baf5963ba820ecf43ae5c689b4352f9604cc476585d728c8df379b4aafcb943494043a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 13:20:15.379774) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 13:20:15.380561) ========= 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.5Xg3pzhfdx/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.GYaSGfY8y1/Listeners TMPDIR=/var/folders/jq/hg7w4nn92rb7mz49hy3qd8vw00000w/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.005329 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 13:20:15.432000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 13:20:15.432840) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 13:20:15.433566) ========= ========= Total master_lag: 0.28 =========