builder: pine_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0228 starttime: 1492713871.75 results: success (0) buildid: 20170420093432 builduid: fca03e3c36e944d3a7e629f5a0a8583b revision: 3026cea8748e3d8ae3128fe0da6dc35070726ac2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:31.749277) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:31.749998) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:31.750287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:32.089219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:32.089476) ========= 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.HoZcXubeJg/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.fplvsWnEYr/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 --2017-04-20 11:44:32-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 76.4M=0s 2017-04-20 11:44:32 (76.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173976 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:32.312163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:32.312440) ========= 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.HoZcXubeJg/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.fplvsWnEYr/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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.021807 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:32.360237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 11:44:32.360577) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 3026cea8748e3d8ae3128fe0da6dc35070726ac2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev 3026cea8748e3d8ae3128fe0da6dc35070726ac2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HoZcXubeJg/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.fplvsWnEYr/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 2017-04-20 11:44:32,460 truncating revision to first 12 chars 2017-04-20 11:44:32,460 Setting DEBUG logging. 2017-04-20 11:44:32,460 attempt 1/10 2017-04-20 11:44:32,460 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/3026cea8748e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-20 11:44:33,226 unpacking tar archive at: pine-3026cea8748e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.025880 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 11:44:33.410452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:33.410770) ========= script_repo_revision: 3026cea8748e3d8ae3128fe0da6dc35070726ac2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:33.411163) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:33.411440) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 11:44:33.431615) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-20 11:44:33.431933) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HoZcXubeJg/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.fplvsWnEYr/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 11:44:33 INFO - MultiFileLogger online at 20170420 11:44:33 in /builds/slave/test 11:44:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 11:44:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:44:33 INFO - {'append_to_log': False, 11:44:33 INFO - 'base_work_dir': '/builds/slave/test', 11:44:33 INFO - 'blob_upload_branch': 'Pine', 11:44:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:44:33 INFO - 'branch': 'Pine', 11:44:33 INFO - 'buildbot_json_path': 'buildprops.json', 11:44:33 INFO - 'config_files': ('talos/mac_config.py',), 11:44:33 INFO - 'default_actions': ('clobber', 11:44:33 INFO - 'read-buildbot-config', 11:44:33 INFO - 'download-and-extract', 11:44:33 INFO - 'populate-webroot', 11:44:33 INFO - 'create-virtualenv', 11:44:33 INFO - 'install', 11:44:33 INFO - 'run-tests'), 11:44:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:44:33 INFO - 'download_minidump_stackwalk': True, 11:44:33 INFO - 'download_symbols': 'ondemand', 11:44:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:44:33 INFO - 'tooltool.py': '/tools/tooltool.py', 11:44:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:44:33 INFO - '/tools/misc-python/virtualenv.py')}, 11:44:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:44:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:44:33 INFO - 'gecko_profile': False, 11:44:33 INFO - 'gecko_profile_interval': 0, 11:44:33 INFO - 'installer_path': 'installer.exe', 11:44:33 INFO - 'log_level': 'info', 11:44:33 INFO - 'log_name': 'talos', 11:44:33 INFO - 'log_to_console': True, 11:44:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:44:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:44:33 INFO - 'opt_config_files': (), 11:44:33 INFO - 'pip_index': False, 11:44:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:44:33 INFO - 'cmd': ('bash', 11:44:33 INFO - '-c', 11:44:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:44:33 INFO - 'enabled': True, 11:44:33 INFO - 'halt_on_failure': False, 11:44:33 INFO - 'name': 'check_screen_resolution'},), 11:44:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:44:33 INFO - 'cmd': ('bash', 11:44:33 INFO - '-c', 11:44:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:44:33 INFO - 'enabled': True, 11:44:33 INFO - 'halt_on_failure': False, 11:44:33 INFO - 'name': 'check_screen_resolution'},), 11:44:33 INFO - 'run_cmd_checks_enabled': True, 11:44:33 INFO - 'suite': 'dromaeojs-e10s', 11:44:33 INFO - 'system_bits': '32', 11:44:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:44:33 INFO - 'title': 't-yosemite-r7-0228', 11:44:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:44:33 INFO - 'use_talos_json': True, 11:44:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:44:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:44:33 INFO - 'work_dir': 'build'} 11:44:33 INFO - [mozharness: 2017-04-20 18:44:33.645256Z] Running clobber step. 11:44:33 INFO - Running pre-action listener: _resource_record_pre_action 11:44:33 INFO - Running main action method: clobber 11:44:33 INFO - rmtree: /builds/slave/test/build 11:44:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:44:35 INFO - Running post-action listener: _resource_record_post_action 11:44:35 INFO - [mozharness: 2017-04-20 18:44:35.881347Z] Finished clobber step (success) 11:44:35 INFO - [mozharness: 2017-04-20 18:44:35.881473Z] Running read-buildbot-config step. 11:44:35 INFO - Running pre-action listener: _resource_record_pre_action 11:44:35 INFO - Running main action method: read_buildbot_config 11:44:35 INFO - Using buildbot properties: 11:44:35 INFO - { 11:44:35 INFO - "project": "", 11:44:35 INFO - "product": "firefox", 11:44:35 INFO - "script_repo_revision": "default", 11:44:35 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs-e10s", 11:44:35 INFO - "repository": "", 11:44:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs-e10s", 11:44:35 INFO - "buildid": "20170420093432", 11:44:35 INFO - "pgo_build": "False", 11:44:35 INFO - "basedir": "/builds/slave/test", 11:44:35 INFO - "buildnumber": 13, 11:44:35 INFO - "slavename": "t-yosemite-r7-0228", 11:44:35 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:44:35 INFO - "platform": "yosemite_r7", 11:44:35 INFO - "scheduler": "tests-pine-macosx64-talos", 11:44:35 INFO - "branch": "pine", 11:44:35 INFO - "repo_path": "projects/pine", 11:44:35 INFO - "revision": "3026cea8748e3d8ae3128fe0da6dc35070726ac2", 11:44:35 INFO - "stage_platform": "macosx64", 11:44:35 INFO - "builduid": "fca03e3c36e944d3a7e629f5a0a8583b", 11:44:35 INFO - "slavebuilddir": "test" 11:44:35 INFO - } 11:44:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 11:44:35 INFO - Running post-action listener: _resource_record_post_action 11:44:35 INFO - [mozharness: 2017-04-20 18:44:35.884866Z] Finished read-buildbot-config step (success) 11:44:35 INFO - [mozharness: 2017-04-20 18:44:35.884980Z] Running download-and-extract step. 11:44:35 INFO - Running pre-action listener: _resource_record_pre_action 11:44:35 INFO - Running main action method: download_and_extract 11:44:35 INFO - mkdir: /builds/slave/test/build/tests 11:44:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:35 INFO - trying https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 11:44:35 INFO - Downloading https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 11:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 11:44:37 INFO - Downloaded 1325 bytes. 11:44:37 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 11:44:37 INFO - Using the following test package requirements: 11:44:37 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:44:37 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 11:44:37 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 11:44:37 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:44:37 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 11:44:37 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:44:37 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 11:44:37 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:44:37 INFO - u'jsshell-mac.zip'], 11:44:37 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:44:37 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 11:44:37 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 11:44:37 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:44:37 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 11:44:37 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:44:37 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 11:44:37 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:44:37 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 11:44:37 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:44:37 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 11:44:37 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:44:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 11:44:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:44:37 INFO - Fetch https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 11:44:44 INFO - Expected file size: 52522788 11:44:44 INFO - Obtained file size: 52522788 11:45:00 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:45:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 11:45:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:45:00 INFO - Fetch https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 11:45:02 INFO - Expected file size: 52522788 11:45:02 INFO - Obtained file size: 52522788 11:45:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 11:45:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:45:18 INFO - Fetch https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 11:45:19 INFO - Expected file size: 14408811 11:45:19 INFO - Obtained file size: 14408811 11:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:20 INFO - trying https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:45:20 INFO - Downloading https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 11:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 11:45:23 INFO - Downloaded 71216153 bytes. 11:45:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:45:23 INFO - mkdir: /builds/slave/test/properties 11:45:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:45:23 INFO - Writing to file /builds/slave/test/properties/build_url 11:45:23 INFO - Contents: 11:45:23 INFO - build_url:https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:45:24 INFO - Running post-action listener: _resource_record_post_action 11:45:24 INFO - Running post-action listener: set_extra_try_arguments 11:45:24 INFO - [mozharness: 2017-04-20 18:45:24.037521Z] Finished download-and-extract step (success) 11:45:24 INFO - [mozharness: 2017-04-20 18:45:24.037647Z] Running populate-webroot step. 11:45:24 INFO - Running pre-action listener: _resource_record_pre_action 11:45:24 INFO - Running main action method: populate_webroot 11:45:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:45:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:45:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:45:24 INFO - '--tppagecycles', 11:45:24 INFO - '7'], 11:45:24 INFO - 'tests': ['tsvgm']}}, 11:45:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:45:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:45:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:45:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:45:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:45:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:45:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:45:24 INFO - 'talos_options': ['--disable-e10s'], 11:45:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:45:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:45:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:45:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:45:24 INFO - 'talos_options': ['--disable-e10s'], 11:45:24 INFO - 'tests': ['damp', 'tps']}, 11:45:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:45:24 INFO - 'tests': ['damp', 'tps']}, 11:45:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:45:24 INFO - 'tests': ['dromaeo_dom']}, 11:45:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:45:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:45:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:45:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:45:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:45:24 INFO - 'tests': ['a11yr', 11:45:24 INFO - 'ts_paint', 11:45:24 INFO - 'tpaint', 11:45:24 INFO - 'sessionrestore', 11:45:24 INFO - 'sessionrestore_no_auto_restore', 11:45:24 INFO - 'tabpaint']}, 11:45:24 INFO - 'other-e10s': {'tests': ['a11yr', 11:45:24 INFO - 'ts_paint', 11:45:24 INFO - 'tpaint', 11:45:24 INFO - 'sessionrestore', 11:45:24 INFO - 'sessionrestore_no_auto_restore', 11:45:24 INFO - 'tabpaint']}, 11:45:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:45:24 INFO - 'ts_paint', 11:45:24 INFO - 'tpaint', 11:45:24 INFO - 'sessionrestore', 11:45:24 INFO - 'sessionrestore_no_auto_restore', 11:45:24 INFO - 'tabpaint']}, 11:45:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:45:24 INFO - 'ts_paint', 11:45:24 INFO - 'tpaint', 11:45:24 INFO - 'sessionrestore', 11:45:24 INFO - 'sessionrestore_no_auto_restore', 11:45:24 INFO - 'tabpaint']}, 11:45:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:45:24 INFO - 'tests': ['a11yr', 11:45:24 INFO - 'ts_paint', 11:45:24 INFO - 'tpaint', 11:45:24 INFO - 'sessionrestore', 11:45:24 INFO - 'sessionrestore_no_auto_restore', 11:45:24 INFO - 'tabpaint']}, 11:45:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:45:24 INFO - 'tests': ['a11yr', 11:45:24 INFO - 'ts_paint', 11:45:24 INFO - 'tpaint', 11:45:24 INFO - 'sessionrestore', 11:45:24 INFO - 'sessionrestore_no_auto_restore', 11:45:24 INFO - 'tabpaint']}, 11:45:24 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 11:45:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 11:45:24 INFO - 'bloom_basic_ref']}, 11:45:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:45:24 INFO - 'tests': ['tsvgx', 11:45:24 INFO - 'tsvgr_opacity', 11:45:24 INFO - 'tart', 11:45:24 INFO - 'tscrollx', 11:45:24 INFO - 'cart', 11:45:24 INFO - 'tsvg_static']}, 11:45:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:45:24 INFO - 'tsvgr_opacity', 11:45:24 INFO - 'tart', 11:45:24 INFO - 'tscrollx', 11:45:24 INFO - 'cart', 11:45:24 INFO - 'tsvg_static']}, 11:45:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:45:24 INFO - 'talos_options': ['--disable-e10s'], 11:45:24 INFO - 'tests': ['tp5o']}, 11:45:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:45:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:45:24 INFO - 'talos_options': ['--disable-e10s', 11:45:24 INFO - '--xperf_path', 11:45:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:45:24 INFO - 'tests': ['tp5n']}, 11:45:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:45:24 INFO - 'talos_options': ['--xperf_path', 11:45:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:45:24 INFO - 'tests': ['tp5n']}}, 11:45:24 INFO - 'talos.zip': {'path': '', 11:45:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:45:24 INFO - Running post-action listener: _resource_record_post_action 11:45:24 INFO - [mozharness: 2017-04-20 18:45:24.056448Z] Finished populate-webroot step (success) 11:45:24 INFO - [mozharness: 2017-04-20 18:45:24.056582Z] Running create-virtualenv step. 11:45:24 INFO - Running pre-action listener: _resource_record_pre_action 11:45:24 INFO - Running main action method: create_virtualenv 11:45:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:45:24 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 11:45:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:45:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:45:24 INFO - Using real prefix '/tools/python27' 11:45:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:45:24 INFO - Installing distribute.............................................................................................................................................................................................done. 11:45:27 INFO - Installing pip.................done. 11:45:27 INFO - Return code: 0 11:45:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:45:28 INFO - Reading from file tmpfile_stdout 11:45:28 INFO - Output received: 11:45:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:45:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:45:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:28 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 0x10df5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95abc85830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39d30>, '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 0x10dc5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ebe8>, '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.HoZcXubeJg/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.fplvsWnEYr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 11:45:28 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 11:45:28 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 11:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoZcXubeJg/Render', 11:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:28 INFO - 'HOME': '/Users/cltbld', 11:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:28 INFO - 'LOGNAME': 'cltbld', 11:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:28 INFO - 'MOZ_NO_REMOTE': '1', 11:45:28 INFO - 'NO_EM_RESTART': '1', 11:45:28 INFO - 'PAGER': '/bin/cat', 11:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:28 INFO - 'PWD': '/builds/slave/test', 11:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:28 INFO - 'SHELL': '/bin/bash', 11:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fplvsWnEYr/Listeners', 11:45:28 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 11:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:28 INFO - 'USER': 'cltbld', 11:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:28 INFO - 'XPC_FLAGS': '0x0', 11:45:28 INFO - 'XPC_SERVICE_NAME': '0', 11:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:28 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 11:45:28 INFO - Cleaning up... 11:45:28 INFO - Return code: 0 11:45:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:45:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:28 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95abc85830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39d30>, '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 0x10dc5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ebe8>, '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.HoZcXubeJg/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.fplvsWnEYr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 11:45:28 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>=3.1.1'] in /builds/slave/test/build 11:45:28 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>=3.1.1 11:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoZcXubeJg/Render', 11:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:28 INFO - 'HOME': '/Users/cltbld', 11:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:28 INFO - 'LOGNAME': 'cltbld', 11:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:28 INFO - 'MOZ_NO_REMOTE': '1', 11:45:28 INFO - 'NO_EM_RESTART': '1', 11:45:28 INFO - 'PAGER': '/bin/cat', 11:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:28 INFO - 'PWD': '/builds/slave/test', 11:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:28 INFO - 'SHELL': '/bin/bash', 11:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fplvsWnEYr/Listeners', 11:45:28 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 11:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:28 INFO - 'USER': 'cltbld', 11:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:28 INFO - 'XPC_FLAGS': '0x0', 11:45:28 INFO - 'XPC_SERVICE_NAME': '0', 11:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:28 INFO - Downloading/unpacking psutil>=3.1.1 11:45:28 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 11:45:28 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 11:45:28 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 11:45:28 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 11:45:28 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 11:45:28 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 11:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:45:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:45:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:45:32 INFO - Installing collected packages: psutil 11:45:32 INFO - Running setup.py install for psutil 11:45:32 INFO - building 'psutil._psutil_osx' extension 11:45:32 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 11:45:32 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 11:45:32 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 11:45:32 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 11:45:32 INFO - building 'psutil._psutil_posix' extension 11:45:32 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 11:45:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:45:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:45:32 INFO - ^ 11:45:32 INFO - 1 warning generated. 11:45:32 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 11:45:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:45:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:45:33 INFO - Successfully installed psutil 11:45:33 INFO - Cleaning up... 11:45:33 INFO - Return code: 0 11:45:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:33 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95abc85830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39d30>, '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 0x10dc5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ebe8>, '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.HoZcXubeJg/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.fplvsWnEYr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 11:45:33 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.3'] in /builds/slave/test/build 11:45:33 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.3 11:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoZcXubeJg/Render', 11:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:33 INFO - 'HOME': '/Users/cltbld', 11:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:33 INFO - 'LOGNAME': 'cltbld', 11:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:33 INFO - 'MOZ_NO_REMOTE': '1', 11:45:33 INFO - 'NO_EM_RESTART': '1', 11:45:33 INFO - 'PAGER': '/bin/cat', 11:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:33 INFO - 'PWD': '/builds/slave/test', 11:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:33 INFO - 'SHELL': '/bin/bash', 11:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fplvsWnEYr/Listeners', 11:45:33 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 11:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:33 INFO - 'USER': 'cltbld', 11:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:33 INFO - 'XPC_FLAGS': '0x0', 11:45:33 INFO - 'XPC_SERVICE_NAME': '0', 11:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:45:36 INFO - Installing collected packages: mozsystemmonitor 11:45:36 INFO - Running setup.py install for mozsystemmonitor 11:45:36 INFO - Successfully installed mozsystemmonitor 11:45:36 INFO - Cleaning up... 11:45:36 INFO - Return code: 0 11:45:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:36 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95abc85830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39d30>, '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 0x10dc5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ebe8>, '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.HoZcXubeJg/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.fplvsWnEYr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 11:45:36 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==2.5.1'] in /builds/slave/test/build 11:45:36 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==2.5.1 11:45:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoZcXubeJg/Render', 11:45:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:36 INFO - 'HOME': '/Users/cltbld', 11:45:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:36 INFO - 'LOGNAME': 'cltbld', 11:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:36 INFO - 'MOZ_NO_REMOTE': '1', 11:45:36 INFO - 'NO_EM_RESTART': '1', 11:45:36 INFO - 'PAGER': '/bin/cat', 11:45:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:36 INFO - 'PWD': '/builds/slave/test', 11:45:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:36 INFO - 'SHELL': '/bin/bash', 11:45:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fplvsWnEYr/Listeners', 11:45:36 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 11:45:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:36 INFO - 'USER': 'cltbld', 11:45:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:36 INFO - 'XPC_FLAGS': '0x0', 11:45:36 INFO - 'XPC_SERVICE_NAME': '0', 11:45:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:36 INFO - Downloading/unpacking jsonschema==2.5.1 11:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:45:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:45:39 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 11:45:39 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 11:45:39 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 11:45:39 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 11:45:39 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 11:45:39 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 11:45:39 INFO - Downloading functools32-3.2.3-2.tar.gz 11:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:45:39 INFO - warning: no files found matching '*.txt' 11:45:39 INFO - no previously-included directories found matching 'build' 11:45:39 INFO - no previously-included directories found matching 'dist' 11:45:39 INFO - no previously-included directories found matching '.git*' 11:45:39 INFO - Installing collected packages: jsonschema, functools32 11:45:39 INFO - Running setup.py install for functools32 11:45:39 INFO - warning: no files found matching '*.txt' 11:45:39 INFO - no previously-included directories found matching 'build' 11:45:39 INFO - no previously-included directories found matching 'dist' 11:45:39 INFO - no previously-included directories found matching '.git*' 11:45:39 INFO - Successfully installed jsonschema functools32 11:45:39 INFO - Cleaning up... 11:45:40 INFO - Return code: 0 11:45:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:40 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95abc85830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39d30>, '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 0x10dc5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ebe8>, '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.HoZcXubeJg/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.fplvsWnEYr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 11:45:40 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:45:40 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 functools32==3.2.3-2 11:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoZcXubeJg/Render', 11:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:40 INFO - 'HOME': '/Users/cltbld', 11:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:40 INFO - 'LOGNAME': 'cltbld', 11:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:40 INFO - 'MOZ_NO_REMOTE': '1', 11:45:40 INFO - 'NO_EM_RESTART': '1', 11:45:40 INFO - 'PAGER': '/bin/cat', 11:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:40 INFO - 'PWD': '/builds/slave/test', 11:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:40 INFO - 'SHELL': '/bin/bash', 11:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fplvsWnEYr/Listeners', 11:45:40 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 11:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:40 INFO - 'USER': 'cltbld', 11:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:40 INFO - 'XPC_FLAGS': '0x0', 11:45:40 INFO - 'XPC_SERVICE_NAME': '0', 11:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:45:40 INFO - Cleaning up... 11:45:40 INFO - Return code: 0 11:45:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:40 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 0x10df5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95abc85830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39d30>, '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 0x10dc5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ebe8>, '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.HoZcXubeJg/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.fplvsWnEYr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 11:45:40 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 11:45:40 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 11:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoZcXubeJg/Render', 11:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:40 INFO - 'HOME': '/Users/cltbld', 11:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:40 INFO - 'LOGNAME': 'cltbld', 11:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:40 INFO - 'MOZ_NO_REMOTE': '1', 11:45:40 INFO - 'NO_EM_RESTART': '1', 11:45:40 INFO - 'PAGER': '/bin/cat', 11:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:40 INFO - 'PWD': '/builds/slave/test', 11:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:40 INFO - 'SHELL': '/bin/bash', 11:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fplvsWnEYr/Listeners', 11:45:40 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 11:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:40 INFO - 'USER': 'cltbld', 11:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:40 INFO - 'XPC_FLAGS': '0x0', 11:45:40 INFO - 'XPC_SERVICE_NAME': '0', 11:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:40 INFO - Downloading/unpacking blobuploader==1.2.4 11:45:40 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 11:45:40 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 11:45:40 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 11:45:40 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 11:45:40 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 11:45:40 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 11:45:43 INFO - Downloading blobuploader-1.2.4.tar.gz 11:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:45:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:45:43 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 11:45:43 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 11:45:43 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 11:45:43 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 11:45:43 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 11:45:43 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 11:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:45:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:45:43 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 11:45:43 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 11:45:43 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 11:45:43 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 11:45:43 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 11:45:43 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 11:45:44 INFO - Downloading docopt-0.6.1.tar.gz 11:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:45:44 INFO - Installing collected packages: blobuploader, requests, docopt 11:45:44 INFO - Running setup.py install for blobuploader 11:45:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:45:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:45:44 INFO - Running setup.py install for requests 11:45:45 INFO - Running setup.py install for docopt 11:45:45 INFO - Successfully installed blobuploader requests docopt 11:45:45 INFO - Cleaning up... 11:45:45 INFO - Return code: 0 11:45:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:45 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 0x10df5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95abc85830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39d30>, '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 0x10dc5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ebe8>, '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.HoZcXubeJg/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.fplvsWnEYr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 11:45:45 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 11:45:45 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 11:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoZcXubeJg/Render', 11:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:45 INFO - 'HOME': '/Users/cltbld', 11:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:45 INFO - 'LOGNAME': 'cltbld', 11:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:45 INFO - 'MOZ_NO_REMOTE': '1', 11:45:45 INFO - 'NO_EM_RESTART': '1', 11:45:45 INFO - 'PAGER': '/bin/cat', 11:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:45 INFO - 'PWD': '/builds/slave/test', 11:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:45 INFO - 'SHELL': '/bin/bash', 11:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fplvsWnEYr/Listeners', 11:45:45 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 11:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:45 INFO - 'USER': 'cltbld', 11:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:45 INFO - 'XPC_FLAGS': '0x0', 11:45:45 INFO - 'XPC_SERVICE_NAME': '0', 11:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:45:45 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-waP7ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:45:45 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-KPfu0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:45:45 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-STkdiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:45:45 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-y6ejmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:45:46 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-wo5emz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:45:46 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-2dJW5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:45:46 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-JRHdcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:45:46 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-0HP25F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:45:46 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-7icAQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:45:46 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-Ds8_jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:45:46 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-DGEVOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:45:46 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-kaepmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:45:46 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-TVt28b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:45:47 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-DhnSpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:47 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-oeDZQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:45:47 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-ZCBix3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:45:47 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-id0Nlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:45:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:45:47 INFO - Running setup.py install for manifestparser 11:45:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:45:47 INFO - Running setup.py install for mozcrash 11:45:47 INFO - Running setup.py install for mozdebug 11:45:47 INFO - Running setup.py install for mozdevice 11:45:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:45:47 INFO - Running setup.py install for mozfile 11:45:48 INFO - Running setup.py install for mozhttpd 11:45:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:45:48 INFO - Running setup.py install for mozinfo 11:45:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:45:48 INFO - Running setup.py install for mozInstall 11:45:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:45:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:45:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:45:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:45:48 INFO - Running setup.py install for mozleak 11:45:48 INFO - Running setup.py install for mozlog 11:45:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:45:48 INFO - Running setup.py install for moznetwork 11:45:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:45:49 INFO - Running setup.py install for mozprocess 11:45:49 INFO - Running setup.py install for mozprofile 11:45:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:45:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:45:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:45:49 INFO - Running setup.py install for mozrunner 11:45:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:45:49 INFO - Running setup.py install for mozscreenshot 11:45:49 INFO - Running setup.py install for moztest 11:45:49 INFO - Running setup.py install for mozversion 11:45:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:45:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:45:49 INFO - Cleaning up... 11:45:49 INFO - Return code: 0 11:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:49 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 0x10df5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95abc85830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39d30>, '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 0x10dc5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ebe8>, '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.HoZcXubeJg/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.fplvsWnEYr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 11:45:49 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 11:45:49 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 11:45:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoZcXubeJg/Render', 11:45:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:49 INFO - 'HOME': '/Users/cltbld', 11:45:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:49 INFO - 'LOGNAME': 'cltbld', 11:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:49 INFO - 'MOZ_NO_REMOTE': '1', 11:45:49 INFO - 'NO_EM_RESTART': '1', 11:45:49 INFO - 'PAGER': '/bin/cat', 11:45:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:49 INFO - 'PWD': '/builds/slave/test', 11:45:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:49 INFO - 'SHELL': '/bin/bash', 11:45:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fplvsWnEYr/Listeners', 11:45:49 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 11:45:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:49 INFO - 'USER': 'cltbld', 11:45:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:49 INFO - 'XPC_FLAGS': '0x0', 11:45:49 INFO - 'XPC_SERVICE_NAME': '0', 11:45:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:45:50 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-H0CIsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:45:50 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)) 11:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:45:50 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-tFLeRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 11:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:45:50 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-9BDVjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:45:50 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)) 11:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:45:50 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-e2XdcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 11:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:45:50 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-Be54q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:45:50 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)) 11:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:45:50 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-YZnfso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:45:50 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)) 11:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:45:50 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-RsZ5Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:45:50 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)) 11:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:45:50 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-8QaJuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:45:51 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)) 11:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:45:51 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-goGkcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:45:51 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)) 11:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:45:51 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-v6cT1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 11:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:45:51 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-D7uoMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:45:51 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)) 11:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:45:51 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-uRYHEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 11:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:45:51 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-k9YU6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:45:51 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)) 11:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:45:51 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-TEhCgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 11:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:51 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-c1c_Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:51 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)) 11:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:45:51 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-LCBv_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 11:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:45:51 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-sUONeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:45:52 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)) 11:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:45:52 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)) 11:45:52 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:45:52 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:45:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45:54 INFO - Downloading blessings-1.6.tar.gz 11:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:45:54 INFO - Installing collected packages: blessings 11:45:54 INFO - Running setup.py install for blessings 11:45:54 INFO - Successfully installed blessings 11:45:54 INFO - Cleaning up... 11:45:55 INFO - Return code: 0 11:45:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:45:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:55 INFO - Reading from file tmpfile_stdout 11:45:55 INFO - Current package versions: 11:45:55 INFO - blessings == 1.6 11:45:55 INFO - blobuploader == 1.2.4 11:45:55 INFO - docopt == 0.6.1 11:45:55 INFO - functools32 == 3.2.3-2 11:45:55 INFO - jsonschema == 2.5.1 11:45:55 INFO - manifestparser == 1.1 11:45:55 INFO - mozInstall == 1.12 11:45:55 INFO - mozcrash == 1.0 11:45:55 INFO - mozdebug == 0.1 11:45:55 INFO - mozdevice == 0.50 11:45:55 INFO - mozfile == 1.2 11:45:55 INFO - mozhttpd == 0.7 11:45:55 INFO - mozinfo == 0.9 11:45:55 INFO - mozleak == 0.1 11:45:55 INFO - mozlog == 3.4 11:45:55 INFO - moznetwork == 0.27 11:45:55 INFO - mozprocess == 0.25 11:45:55 INFO - mozprofile == 0.28 11:45:55 INFO - mozrunner == 6.13 11:45:55 INFO - mozscreenshot == 0.1 11:45:55 INFO - mozsystemmonitor == 0.3 11:45:55 INFO - moztest == 0.8 11:45:55 INFO - mozversion == 1.4 11:45:55 INFO - psutil == 3.1.1 11:45:55 INFO - requests == 1.2.3 11:45:55 INFO - wsgiref == 0.1.2 11:45:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:55 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 0x10df5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95abc85830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39d30>, '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 0x10dc5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ebe8>, '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.HoZcXubeJg/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.fplvsWnEYr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 11:45:55 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 11:45:55 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 11:45:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoZcXubeJg/Render', 11:45:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:55 INFO - 'HOME': '/Users/cltbld', 11:45:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:55 INFO - 'LOGNAME': 'cltbld', 11:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:55 INFO - 'MOZ_NO_REMOTE': '1', 11:45:55 INFO - 'NO_EM_RESTART': '1', 11:45:55 INFO - 'PAGER': '/bin/cat', 11:45:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:55 INFO - 'PWD': '/builds/slave/test', 11:45:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:55 INFO - 'SHELL': '/bin/bash', 11:45:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fplvsWnEYr/Listeners', 11:45:55 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 11:45:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:55 INFO - 'USER': 'cltbld', 11:45:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:55 INFO - 'XPC_FLAGS': '0x0', 11:45:55 INFO - 'XPC_SERVICE_NAME': '0', 11:45:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:55 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)) 11:45:55 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)) 11:45:55 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)) 11:45:55 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)) 11:45:55 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)) 11:45:55 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)) 11:45:55 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)) 11:45:55 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)) 11:45:55 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)) 11:45:55 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)) 11:45:55 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)) 11:45:55 INFO - Cleaning up... 11:45:55 INFO - Return code: 0 11:45:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95abc85830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39d30>, '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 0x10dc5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ebe8>, '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.HoZcXubeJg/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.fplvsWnEYr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 11:45: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', 'jsonschema'] in /builds/slave/test/build 11:45: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 jsonschema 11:45:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoZcXubeJg/Render', 11:45:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:55 INFO - 'HOME': '/Users/cltbld', 11:45:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:55 INFO - 'LOGNAME': 'cltbld', 11:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:55 INFO - 'MOZ_NO_REMOTE': '1', 11:45:55 INFO - 'NO_EM_RESTART': '1', 11:45:55 INFO - 'PAGER': '/bin/cat', 11:45:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:55 INFO - 'PWD': '/builds/slave/test', 11:45:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:55 INFO - 'SHELL': '/bin/bash', 11:45:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fplvsWnEYr/Listeners', 11:45:55 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 11:45:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:55 INFO - 'USER': 'cltbld', 11:45:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:55 INFO - 'XPC_FLAGS': '0x0', 11:45:55 INFO - 'XPC_SERVICE_NAME': '0', 11:45:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:45:55 INFO - Cleaning up... 11:45:55 INFO - Return code: 0 11:45:55 INFO - Running post-action listener: _resource_record_post_action 11:45:55 INFO - Running post-action listener: _start_resource_monitoring 11:45:55 INFO - Starting resource monitoring. 11:45:55 INFO - [mozharness: 2017-04-20 18:45:55.895626Z] Finished create-virtualenv step (success) 11:45:55 INFO - [mozharness: 2017-04-20 18:45:55.896583Z] Running install step. 11:45:55 INFO - Running pre-action listener: _resource_record_pre_action 11:45:55 INFO - Running main action method: install 11:45:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:56 INFO - Reading from file tmpfile_stdout 11:45:56 INFO - Detecting whether we're running mozinstall >=1.0... 11:45:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:45:56 INFO - Reading from file tmpfile_stdout 11:45:56 INFO - Output received: 11:45:56 INFO - Usage: mozinstall [options] installer 11:45:56 INFO - Options: 11:45:56 INFO - -h, --help show this help message and exit 11:45:56 INFO - -d DEST, --destination=DEST 11:45:56 INFO - Directory to install application into. [default: 11:45:56 INFO - "/builds/slave/test"] 11:45:56 INFO - --app=APP Application being installed. [default: firefox] 11:45:56 INFO - mkdir: /builds/slave/test/build/application 11:45:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:46:15 INFO - Reading from file tmpfile_stdout 11:46:15 INFO - Output received: 11:46:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:46:15 INFO - Running post-action listener: _resource_record_post_action 11:46:15 INFO - [mozharness: 2017-04-20 18:46:15.896445Z] Finished install step (success) 11:46:15 INFO - [mozharness: 2017-04-20 18:46:15.896586Z] Running run-tests step. 11:46:15 INFO - Running pre-action listener: _resource_record_pre_action 11:46:15 INFO - Running main action method: run_tests 11:46:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:46:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:46:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:46:15 INFO - 2017-04-20 11:46:15.910 screenresolution[1909:15995] starting screenresolution argv=screenresolution get 11:46:15 INFO - 2017-04-20 11:46:15.912 screenresolution[1909:15995] Display 0: 1600x1200x32@60 11:46:15 INFO - 2017-04-20 11:46:15.918 screenresolution[1910:15997] starting screenresolution argv=screenresolution list 11:46:15 INFO - Available Modes on Display 0 11:46:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:46:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:46:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:46:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:46:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:46:16 INFO - Intel Iris: 11:46:16 INFO - Chipset Model: Intel Iris 11:46:16 INFO - Type: GPU 11:46:16 INFO - Bus: Built-In 11:46:16 INFO - VRAM (Dynamic, Max): 1536 MB 11:46:16 INFO - Vendor: Intel (0x8086) 11:46:16 INFO - Device ID: 0x0a2e 11:46:16 INFO - Revision ID: 0x0009 11:46:16 INFO - Displays: 11:46:16 INFO - Display: 11:46:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:46:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:46:16 INFO - Display Serial Number: 1600x1200 60 11:46:16 INFO - Main Display: Yes 11:46:16 INFO - Mirror: Off 11:46:16 INFO - Online: Yes 11:46:16 INFO - Rotation: Supported 11:46:16 INFO - Return code: 0 11:46:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:46:16 INFO - Python 2.7.3 11:46:16 INFO - Return code: 0 11:46:16 INFO - grabbing minidump binary from tooltool 11:46:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:16 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39d30>, '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 0x10dc5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:46:16 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 11:46:16 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 11:46:16 INFO - Calling ['/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'] with output_timeout 600 11:46:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:46:16 INFO - Return code: 0 11:46:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:46:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:46:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:46:16 INFO - ENV: RUST_BACKTRACE is now 1 11:46:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:46:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:46:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0228', '--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 11:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0228 --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 11:46:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HoZcXubeJg/Render', 11:46:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:16 INFO - 'HOME': '/Users/cltbld', 11:46:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:16 INFO - 'LOGNAME': 'cltbld', 11:46:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:46:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:16 INFO - 'MOZ_NO_REMOTE': '1', 11:46:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:46:16 INFO - 'NO_EM_RESTART': '1', 11:46:16 INFO - 'PAGER': '/bin/cat', 11:46:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:16 INFO - 'PWD': '/builds/slave/test', 11:46:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:46:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:16 INFO - 'RUST_BACKTRACE': '1', 11:46:16 INFO - 'SHELL': '/bin/bash', 11:46:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fplvsWnEYr/Listeners', 11:46:16 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 11:46:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:16 INFO - 'USER': 'cltbld', 11:46:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:16 INFO - 'XPC_FLAGS': '0x0', 11:46:16 INFO - 'XPC_SERVICE_NAME': '0', 11:46:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0228', '--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 11:46:16 INFO - mozversion application_buildid: 20170420093432 11:46:16 INFO - mozversion application_changeset: 3026cea8748e3d8ae3128fe0da6dc35070726ac2 11:46:16 INFO - mozversion application_display_name: Nightly 11:46:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:46:16 INFO - mozversion application_name: Firefox 11:46:16 INFO - mozversion application_remotingname: firefox 11:46:16 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 11:46:16 INFO - mozversion application_vendor: Mozilla 11:46:16 INFO - mozversion application_version: 55.0a1 11:46:16 INFO - mozversion platform_buildid: 20170420093432 11:46:16 INFO - mozversion platform_changeset: 3026cea8748e3d8ae3128fe0da6dc35070726ac2 11:46:16 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 11:46:16 INFO - mozversion platform_version: 55.0a1 11:46:16 INFO - using testdate: 1492713976 11:46:16 INFO - actual date: 1492713976 11:46:16 INFO - starting webserver on 'localhost:49379' 11:46:16 INFO - SUITE-START | Running 2 tests 11:46:16 INFO - TEST-START | dromaeo_css 11:46:16 INFO - operating with platform_type : mac_ 11:46:16 INFO - Initialising browser for dromaeo_css test... 11:46:16 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpAigSKr/profile http://localhost:49379/getInfo.html) 11:46:19 INFO - PID 1920 | 2017-04-20 11:46:19.315 plugin-container[1922:16162] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e43, name = 'com.apple.tsm.portname' 11:46:19 INFO - PID 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:46:19 INFO - PID 1920 | 2017-04-20 11:46:19.318 plugin-container[1922:16162] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 11:46:19 INFO - PID 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:46:19 INFO - PID 1920 | 2017-04-20 11:46:19.318 plugin-container[1922:16162] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:46:19 INFO - PID 1920 | __metrics Screen width/height:1600/1200 11:46:19 INFO - PID 1920 | colorDepth:24 11:46:19 INFO - PID 1920 | Browser inner width/height: 1024/689 11:46:19 INFO - PID 1920 | __metrics 11:46:19 ERROR - PID 1920 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 11:46:20 INFO - TEST-INFO | 1920: exit 0 11:46:20 INFO - Browser initialized. 11:46:20 INFO - Running cycle 1/1 for dromaeo_css test... 11:46:20 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpAigSKr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:46:22 INFO - PID 1923 | 2017-04-20 11:46:22.955 plugin-container[1924:16294] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 11:46:22 INFO - PID 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:46:22 INFO - PID 1923 | 2017-04-20 11:46:22.955 plugin-container[1924:16294] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 11:46:22 INFO - PID 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:46:22 INFO - PID 1923 | 2017-04-20 11:46:22.955 plugin-container[1924:16294] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:46:32 INFO - PID 1923 | RSS: Main: 236957696 11:46:32 INFO - PID 1923 | 11:49:36 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49379/tests/dromaeo/cssquery-ext.html) 11:49:38 INFO - PID 1923 | RSS: Main: 252162048 11:49:38 INFO - PID 1923 | 11:51:21 INFO - PID 1923 | ************************* 11:51:21 INFO - PID 1923 | A coding exception was thrown and uncaught in a Task. 11:51:21 INFO - PID 1923 | 11:51:21 ERROR - PID 1923 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:51:21 INFO - PID 1923 | Full stack: 11:51:21 INFO - PID 1923 | ************************* 11:51:21 INFO - PID 1923 | ************************* 11:51:21 INFO - PID 1923 | A coding exception was thrown and uncaught in a Task. 11:51:21 INFO - PID 1923 | 11:51:21 ERROR - PID 1923 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:51:21 INFO - PID 1923 | Full stack: 11:51:21 INFO - PID 1923 | ************************* 11:51:21 INFO - PID 1923 | ************************* 11:51:21 INFO - PID 1923 | A coding exception was thrown and uncaught in a Task. 11:51:21 INFO - PID 1923 | 11:51:21 ERROR - PID 1923 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:51:21 INFO - PID 1923 | Full stack: 11:51:21 INFO - PID 1923 | ************************* 11:51:21 INFO - PID 1923 | ************************* 11:51:21 INFO - PID 1923 | A coding exception was thrown and uncaught in a Task. 11:51:21 INFO - PID 1923 | 11:51:21 ERROR - PID 1923 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:51:21 INFO - PID 1923 | Full stack: 11:51:21 INFO - PID 1923 | ************************* 11:52:40 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-ext.html (next: http://localhost:49379/tests/dromaeo/cssquery-jquery.html) 11:52:40 INFO - PID 1923 | RSS: Main: 258326528 11:52:40 INFO - PID 1923 | 11:55:42 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49379/tests/dromaeo/cssquery-mootools.html) 11:55:43 INFO - PID 1923 | RSS: Main: 267096064 11:55:43 INFO - PID 1923 | 11:58:44 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49379/tests/dromaeo/cssquery-prototype.html) 11:58:45 INFO - PID 1923 | RSS: Main: 260591616 11:58:45 INFO - PID 1923 | 12:01:48 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49379/tests/dromaeo/cssquery-yui.html) 12:01:49 INFO - PID 1923 | RSS: Main: 269729792 12:01:49 INFO - PID 1923 | 12:04:50 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-yui.html (next: http://localhost:49379/tests/dromaeo/cssquery-dojo.html) 12:04:51 INFO - PID 1923 | RSS: Main: 264392704 12:04:51 INFO - PID 1923 | 12:04:51 INFO - PID 1923 | __start_tp_report 12:04:51 INFO - PID 1923 | _x_x_mozilla_page_load 12:04:51 INFO - PID 1923 | _x_x_mozilla_page_load_details 12:04:51 INFO - PID 1923 | |i|pagename|runs| 12:04:51 INFO - PID 1923 | |0;dojo.html;2866.41238546098;3581.2300355423577;3594.209273959728;3609.404448266036;3626.854925802968;6021.608595441304;6102.115193296975;6143.81568552943;6167.321594624594;6214.471769899564;6032.788852390167;6098.06917627449;6116.82275545647;6130.570860039799;6209.192804935352;5222.660527065728;5395.649282796606;5423.29497165369;5425.403205647375;5508.669479831203;5352.2506849041165;5418.647787893794;5484.451554844523;5492.972535137319;5510.641808282448;5432.864178395532;5460.180972854064;5486;5493.533049690781;5496.642718223303;5259.474052594748;5297.576193904517;5326.334208223972;5329.8934021319355;5332.3867755207875;4551.203539380595;5289.523942845162;5297.947020529784;5358.598105142091;5363.275957745694;4674.462436819776;6018.608790428652;6121.204243448367;6176.6911654417545;6193.87612247757;5838;6375.776847810304;6718.462522998148;6747.696353664097;6762.120924279861;6579.572327798678;6716.529842910949;6807.149106361705;6817.727290908358;6834.6582670866255;6118.969405152946;6340.270868850095;6354.142190804275;6360.872782544323;6374.171357723466;6084.178635884187;6880.105586273752;6893.20728116263;6970.895436568456;6985;6333.96833015832;6380.0748891410485;6491.578047426902;6515.771947981798;6567.474602031826;6725.831854203586;6771.559848609824;6783.626900520519;6792.150981127359;6804.489663275274;6642.202935647753;6695.665216739144;6696.995450682339;6717.227518835299;6718.630475323806;6402.455791257702;6463.612183269019;6611.404973552307;6631.436327912085;6704.899426508607;5400.324959380077;5405.054115529767;5418.485243901823;5420.403755586883;5432.29380180574;4792.568668819823;4812.302216178635;4832.130216561053;4842.15262329098;4851.490593487703;5979.312379076375;6168.907466388007;6215.782447614402;6223.533235007392;6315.55791094619;6793.66031698423;6827.590344579341;6843.828904277433;6846.828829279209;6847.246802851682;6232.844178895564;6266.122742816009;6283.246010478681;6288.182536270256;6332.968335158294;5701.743421546041;5824.213731146241;5842.970785146047;6019.939800602026;6030.698465076729;6746.730130794811;6893.20728116273;6926.619035953071;6956.339147780953;6985.336393042653;6764.458843292623;6775.593464392152;6781.559198652072;6793.4565234782085;6801.795946121624;6542.476601871744;6653.467722582085;6712.664366781739;6874.828129296608;6958.130233720785;6663.13379260693;6667.566608170453;6667.566608170453;6672.165979252593;6691.5315927884585;6501.2198536175965;6587.176602924635;6657.933420665925;6701.698423571049;6728.562643428161;6588.308227636029;6596.340365963365;6600.174978127734;6629.535932484872;6634.170728658918;6508.837279067871;6572.112764776694;6599.934000659932;6604.537682362381;6618.966905165444;5391.7059905623155;6110.236220472441;6243.937560624336;6252.249730032425;6336.904946425715;6495.220573531206;6524;6546.476281897532;6551.082848401133;6555.082288479712;6365.90451143224;6384.297727250092;6416.197975253093;6425.1968503937005;6444.420002199825 12:04:51 INFO - PID 1923 | |1;ext.html;713.7002458967233;754.7810286387486;827.0117209934127;1257.7798885195089;1264.1277518512231;35613.46579801305;37044.88865334038;37048.814755926214;37117.886463406074;37138.44292335617;37304.62695373052;37425.81287093561;37476.250474990484;37503.62496375036;40325.59674403255;7123.608201548913;7874.960625196881;8031.518108913484;8483.872741908875;8694.17405346491;8618.78453038676;8678.913210867906;8682.782930426727;8682.86975695365;8714.25928796053;8656.61045252962;8712.869306960401;8727.301815854747;8728.083551227124;8757.868631970525;8628.180322869317;8652.653893844239;8700.738977830611;8710.346723995726;8711.477311361306;8482.66069357225;8570.614322355508;8576.44253123545;8576.485410875304;8596.527191004492;37252.81373593142;37274;37376.878693639235;37412;37502.24995500102;3482.077249528877;3489.354469423165;3529.6117427083;3529.876454324112;3534.0634731796094;30397.392052158833;30607.846960765277;30716;30758;30773.84583079185;3119.4385010698293;3199.2001999500126;3205.85573649184;3212.8554215060144;3213;227722;234214;240306;244846;259574.9999999981;47879.5212047882;47991.04017919622;48061.759691202016;48228.5177148224;48278;39206.41190382146;46733.06533869372;49091.50908490869;49678;49719.50280497221;12122.696932576757;13191.240496458464;13747.450101996008;13854.376553054935;13869.167849929037;11144.88551144879;11291.54833806655;11312.151588630886;11337.716557086138;11338.319700817978;13464.93267533656;13530;13641.317934103256;13645.863541364459;13674;5035.345405097387;6080.787172448943;6081.756729730761;6108.877822443526;6158.7228574714245;905.6241659711278;981.5351808117357;1009.5658866687395;1036.461040259076;1101.3612104979093;23641.0485109756;24591.63112553313;24596.315106873964;24647.5070498589;24676.13633522854;1141.366541569437;1145.6162185667895;1150.4822829726656;1167.5855071449682;1195.1633856300625;12453.315067671183;12615.747685046248;12660.303683297323;12672.429740661692;12688.555900543437;256575;307500;307636;308363;310848;53650.46349536533;53882.92234155295;53924;54248.45751542513;54364.18453723197;1359.558143603313;1495.9476418325523;1512.9621759455881;1556.9922150389175;1569.3487202810707;22984.655230171225;24084.879575602008;24395.878020609784;24402.75597244005;24706.25881223566;38057.80971095237;38129;38203.85388438351;38208.80895595504;38346;286225;286452.56773715996;287458;288035;289052;34657.826710866284;34948.65051349556;34986;35317.64682353144;35424.46863297001;33880.66119338775;35672.464913025804;44022.89942751457;44628;46050.53949460462;29017.854910725313;30566.93015744438;30818.84590577033;30900.519424682847;31357.491400687435;30396.696033039385;30570;31104;31123.68876311208;31472.055838324886;35940;36670.8166459166;36726;36763.26473470569;36937.07657308589;30571.694283056884;30820.22949426282;31249.062528124192;31317.217069573442;31787.046388608378;23498.942547585742;24371.878140609184;24443.633345499475;25022;25281 12:04:51 INFO - PID 1923 | |2;jquery.html;374.3150035435154;434.42221844946204;437.6717461903572;445.888527868033;462.1381124203362;19269.518262043457;21007.68488472672;21450.463738406546;21482.140714371406;21796.78203217967;21506.677399839016;22151.889240553814;22607.321780346574;22701.65947510789;22830.08679652816;6130.233720784902;6270;6273.027680709497;6280.403361680633;6289.591176573531;6088.299845517756;6288;6314.431701146896;6315.305316415191;6317.905231421532;5894.381089985554;6202.503799696014;6231.750729970796;6277.403646653584;6277.968610156966;5988.940110598904;6044.395560443964;6063.514918806529;6076.4834989025985;6077.392260773931;4552.8861778455475;5420.403755586922;5428.728563571805;5452.345718513764;5513.448655134494;26791.196264111913;26813.46373072547;27167.320816979536;27684.169474915783;27725.168244952685;2156.277646988261;2209.4034610655194;2218.0684112672716;2225.0988349718227;2227.1982086448866;16471.34114635413;17143.914280428642;17523;17641.294348226056;18264.90867545667;2113.9788602113936;2140.8073273405466;2163.0482587661377;2167.6856855755987;2168.9566208675897;150790;154089;155057.22471387684;156073;158428.20785896113;12162.209456385306;12748.61754147377;12805.359732013361;12998.285094319714;13049.478020879249;13444.462221511225;16653.666926661397;16734.665306693798;16783.748243776354;16788.908720933345;7538.906858505486;8722.476651400937;8958.328125390623;9052.773680657905;9087;8340.499570025819;8431.704890328809;8445.493270403795;8483.915160848312;8666.480011199348;6898.482613803984;7399.408047356199;8260.380471464545;8268.545230012287;8283.50298982063;2200.7799220078186;2225.121077174507;2226.4545186429427;2227.96141530501;2383.5590415773136;957.899420560845;958.4249450329886;968.9563969621383;991.1228562722043;1018.6994836523244;20301.49246268855;20623.896880515502;20627.4843128923;20749.858757768165;21176.576468470543;984.4200058905496;986.753311672082;1008.1027885182194;1021.2544842265188;1035.233926894093;9455.763605909908;10358.482075896174;10487.056164945192;10705.46472676363;10767.19246056549;514107;527480;532067;545353;548732;99968;127355;130079;134449.32775336257;134956;1193.7493126443544;1221.1146918484028;1236.6413740015296;1237.560665963588;1240.6960294727849;19098.7135192975;21878;22248.443788905406;22263.554728905656;22290.77709222887;56375.154372683624;56425;57364.13953790613;57400.56498587569;58361.70819145877;78300;79006.6049669748;79030.6048469754;79298;79673.60163199146;8748.300135989233;8825.117488251124;8882.200601945857;8935.910640893508;9038.231750301298;13699.657508561966;13756.449742010607;13829.377678004314;14009.579712608638;14025.649358765704;11683.065354771768;11774.470148843495;11802.52789888395;11897.702557436134;11952.462139203582;10596.947015264874;10916.508757106109;10950.507227174956;10951.233413660968;11045.889541104487;11114.832942540917;11432.828507572227;11753.941230293794;12062.638120856389;12116.878831211576;8712.912870871463;8771.517566533646;8876.556172191495;8886;8989.685361012333;11634.6509604712;11730.706732331419;11827.763444730885;11839.348835814113;11874.287542747463 12:04:51 INFO - PID 1923 | |3;mootools.html;1169.380228478906;1399.8460169381372;1418;1440.5462279381993;1446.2551785830299;11511.884881151185;11804.468798904049;12007.819882701766;12022.278663280198;12188.024958003361;11802.704932376695;11830.23103498272;12030.639080827566;12049.337286449241;12050.93974530126;2533.7466253374605;2568.268043607572;2579.7162312145647;2584.2247325802277;2584.8449093054383;2497.051120574188;2530.6204069389646;2541.097910241865;2558.961615575768;2562.026429956614;2477.5044991001782;2535.657686212356;2553.5786595211766;2556.2586849813624;2567;2118.925837595677;2447.5227330670527;2497.1384872219055;2522.8738563071865;2540.847549147057;2073.8133567978803;2442.9877850610633;2504.261242933321;2562.641230227751;2567.1785028790796;9029.277657787427;11874.643760687193;11910;12043.759124817454;12047.759044819142;6495.675216239217;6650.301718319555;6764.3573860483175;6768.729250829961;6777.695003724844;3942.960570394288;4160.54234034256;4205.768682722449;4384.780760961971;4485;1148.7128217945515;1234.4692581199338;1263.570386068741;1324.2120938041849;1326.7213885084143;16271.267792949227;16835.242414091274;16877.91561042187;16996.980181189167;17010.40463583781;5256.08018596744;5302.534321540502;5739.971300143473;5925.377835327315;5954.047352423591;11709.355985420712;12360.75278494443;12458.563950261698;12465.626031219077;12490.313032783284;6710.664466776641;6710.899336509956;6722.126123603998;6723.22682891464;6753.797386078426;5877.970610146922;6132.448079672851;6142.477889379453;6212.161358216673;6223.751049958041;4414.933775993362;4485.506594274627;4532.252178390595;4537.546245375436;4551.3173024046655;1328.2893651896188;1354.7967804829354;1355.2207480698637;1371.6228037289825;1376.3324787478066;698.434268242725;787.4015748031537;791.1732239809298;830.2693629605908;830.4311546590604;6725.932740672531;6960.37356637905;7026.683799229047;7036.331548502884;7036.824079398056;896.8117244650864;930.3812964378748;932.6316105138433;934.6261495401893;936.6721647423348;3384;4279.465066866642;4314.69797114199;4316.395704601296;4413.933790993137;14846.925765371105;15322.770158447633;15379.923100384427;15392.30734616945;15442.305096270695;13394;13838.031337806256;13841.792373114411;13851.653708657162;13888.305584720723;7541.5098018629715;8521.531315777567;8649.437786543855;8741.082186370466;8754.343424243207;5208.895822083613;6883.483738719716;6962.1993470749485;7159.964200178966;7257.455690823315;10161.542730576994;11377.54489820398;12844.743105138032;12915.935420322838;13100.934495327463;13039.087263891437;13132.27772472485;13199.34003299812;13261.66845828862;13326.466941322238;9585.376950498196;9793.216542676426;9801.460919649488;9823.901760982299;9828.557714902989;10893.128549716163;11055.502502387573;11148.108151348035;11153.888461115284;11169.776604468028;9233.353665243369;9364.110409511086;9373.531323433937;9472.763180920532;9493.193078588121;9080;9099.727008189764;9215.2627789778;9288.767780805534;9299.209567186594;8252.504849709037;8399.454035487674;8403.747887563382;8498.61756220984;8524.786880328042;4755.690880092783;6084.84387966285;6166.4758495526585;6248.375162483715;6272.717727702173;5509.650135716775;5522.2544956430365;6166.260048794174;6203.534734894991;6263.27972283175 12:04:51 INFO - PID 1923 | |4;prototype.html;410.5094412177447;413.64426593129906;416.9971219217779;420.5605142625956;425.9552746961567;6025.487833534149;6234.438900498954;6356.396142366473;6393.442622950822;6530.673466326689;5369.463053694629;5684.488396044366;5732.684702341369;6121.938780612192;6290.654014029226;4591.357209990604;4696.671233013691;4794.113089078514;4817.710937343753;4826.251930950708;4129.9174016519655;4762.309465127554;4798.712077275357;4829.710217386951;4835.371401717772;4762.452317983441;4793.472718001017;4802.735849528274;4808.278758186265;4823.53999460276;4153.1486045360625;4598.873276047357;4678.111158879819;4805.3753012108555;4806.158922188621;4234.788260586958;4262.744235345889;4262.808173632194;4279.443672322609;4306.160298741746;6239.688015599202;6246.531510136712;6249.312575616678;6253.37466253371;6266.373362663743;5516.503514683657;5705.686187259699;5730.083186690152;5752.165935939307;5781.9763082920645;6807.761728339485;6817.761378351734;6819.693113809891;6820.590764554143;6834.521583489158;4225.72532785368;4619.960508885508;4800.519948005206;4806.53880423909;4874.2444921037295;6147.323794382614;6889.379955804002;7116.822079448003;7237.819054523679;7264.418846492268;4014.815629389337;4436.0906014267;4567.885802854888;4772.618190544748;4797.304390863305;3686.760360576554;3690.372636651776;4643.721376717408;4855.757212139379;4857.611391088704;5203.855151866584;5358.732063396893;5500.28496295479;5501.862453438696;5550.27846379968;5376.381716102698;6234.407731265614;6262.903991801417;6656.633885136267;6775.322467753185;1530.5102367242598;1674.3386362387032;1732.7834020747407;1749.0380290839987;1750.3436211420717;1051.9007637019333;1157.7915975124558;1169.3334799164395;1199.3103965220034;1208.8005479096028;6262.279837818709;6287.245530536365;6295.464885484694;6304.495640348761;6311.33730958252;6640.576189690728;6937;6962.199347075049;6981.581105133709;6986.231514533397;6255.937440625627;6261.373862613702;6316.778912738124;6320.968395158086;6336.619802811846;2873.726995935383;3649.8540058397366;3660.524131862841;3668.926621467556;3682.392405253157;6800.319968003259;7148.678309476086;7234.819129521804;7245.000949344935;7245.384142347854;7178.641067946582;7205.675744591506;7247.383972362408;7274.945132955691;7299.927000729925;6950.733155416946;7148.035015272975;7199.424046076301;7219.530730502501;7249.383802376751;6795.45636349081;6903.0680858083515;7037.944308353788;7040.3663670269925;7051.964740176471;5524.281843360337;6848.760293389708;6908.5509441886115;6920.858058420506;6940.6529673515115;5806.970965145148;6576.605403675795;6999;7245.818854528679;7271.781846544613;4566.45202575693;4588.2429399150105;4588.609968152745;4589.485469794893;4603.884902877455;6019.849503762266;6686.498512611671;7026.0678313464205;7057.4473615804445;7058.11773528309;5533.3083364579425;5834.94165058344;6020.367861374492;6644.601323920387;6755;5547.945890280834;6462.4183823456115;6733.858676913761;6802.523823332517;6819.659017049028;6318.968405157945;6514.185726784152;6548.377904099103;6639.40245377899;6659.167604049494;6483.481321494175;6760.9520524318805;6788.253292137762;6798.422134118655;6810.9318906810295;5195.402528709247;6566.540342176193;6589.374009469093;6592.802490792058;6630.30381809903 12:04:51 INFO - PID 1923 | |5;yui.html;827.4042689263728;835.5905606252934;858.502068800096;858.7380848841103;873.3144481581959;16412;16767.161641917915;16772.1613919304;18054.097295135256;18698.345557905475;17545.649087018253;17845.7323140153;17964.730529042074;17969.73045404317;18008.279668813266;951.1914872358509;958.2860768727273;971.0920289529278;976.3946353260989;977.4917043137564;886.5035580075146;919.5172534419416;957.248559880494;991.7223177510309;997.7755005123826;981.0826876870113;1003.4781913405025;1020.7142000239945;1023.4575674892282;1025.7897131088146;981.3130808434089;1006.4062203300051;1026.112412762962;1026.7741096958657;1027.1679939249232;725.5392825555757;727.9126504819402;748.928851759082;753.5365750063726;762.9008228930259;16134.435294764744;16306.429274975319;16407.753883691756;16411.261493232832;16425.09661968591;16634.6673066538;17086.48740537786;17356;17546.736798948026;17568.824311756845;13671.992161724405;13712;13819.378127984264;13883.930580347134;14009.439622415091;3484.0418884806627;3541.061618671054;3567.6253993330847;3573.76770509916;3573.928521429583;133866.33066834701;134040;135238.97141542885;137263.31368343194;137785;13161.407736651874;13177.077604567588;13219.603411897659;13302.866971330162;13351.332433378293;25079.62380564293;25205.369865753135;25355.746442535707;25516.744832551438;25591.744082559308;7575.621218939031;7634.4655874088285;7655.923440765521;7732.188120247293;7776.961115194388;3813.828377723009;3873.0898238913833;3888.766673999569;3888.805559722059;3904;4324.286492728727;4347.630451411602;4379.978100109479;4405.867823965286;4435.733855968652;896.5382827843666;905.7282815155427;913.6391125505388;918.9632414703337;919.7792529792802;548.9039418101896;613.6655522740117;650.2424675253371;677.11298199359;691.6921969723526;10190.592376305012;10739.785204295871;11833.585824496102;11864.76270474603;11894.226875253082;567.29088639201;656.6224420957968;671.6238906212536;675.1594265139834;690.0925283252507;4177.56135605757;5000.524950129732;5303.761330740126;5330.227117068003;5487.067198576252;64020.67989660115;97542;100073.49963250138;100111.49944250377;102821;71605.64197179084;78555;87062;87241.12758872457;90208;81865.77201341985;82398.58800706078;82914.17085829185;83616.58191709002;84920;11000.944995274973;11278.323300601991;12750.808737868754;12930.806037909628;12947.482100716243;33156.1710957228;39361.40957885577;40804.79597601993;41547.16905661809;42390.78804605957;52743.73628131835;52979;53302.73348633232;53481.465185347646;54229;16082.954607950445;16154.192290385668;16298.26657800378;16382.918085409498;16412.343506259615;17728.822711773235;18142.5464363392;18173.273069077088;18373.448796536126;18578.81421185771;16354.754678679592;16383.59041023984;16909.577260568585;16975.915120424812;17094.743578846577;16709.479759058537;16728.33086676568;16740.581485462473;17135.971841689538;17141.48575542736;16088.27602757902;16259.430919917746;16463.012219266882;16546.83453165501;16664.83335166633;11549.48027338755;11792.174547781573;11815.822762658396;11871.465784039567;11961.521539138337;12937.353132343533;13495.392707327997;13824.559309219818;13925.23411212393;13932.721345573234 12:04:51 INFO - PID 1923 | __end_tp_report 12:04:51 INFO - PID 1923 | __start_cc_report 12:04:51 INFO - PID 1923 | _x_x_mozilla_cycle_collect,437 12:04:51 INFO - PID 1923 | __end_cc_report 12:04:51 INFO - PID 1923 | __startTimestamp1492715091092__endTimestamp 12:04:51 INFO - PID 1923 | 12:04:51 INFO - PID 1923 | ------- Summary: start ------- 12:04:51 INFO - PID 1923 | Number of tests: 6 12:04:51 INFO - PID 1923 | 12:04:51 INFO - PID 1923 | [#0] dojo.html Cycles:165 Average:6136.45 Median:6365.90 stddev:754.57 (11.9%) stddev-sans-first:711.95 12:04:51 INFO - PID 1923 | Values: 2866.4 3581.2 3594.2 3609.4 3626.9 6021.6 6102.1 6143.8 6167.3 6214.5 6032.8 6098.1 6116.8 6130.6 6209.2 5222.7 5395.6 5423.3 5425.4 5508.7 5352.3 5418.6 5484.5 5493.0 5510.6 5432.9 5460.2 5486.0 5493.5 5496.6 5259.5 5297.6 5326.3 5329.9 5332.4 4551.2 5289.5 5297.9 5358.6 5363.3 4674.5 6018.6 6121.2 6176.7 6193.9 5838.0 6375.8 6718.5 6747.7 6762.1 6579.6 6716.5 6807.1 6817.7 6834.7 6119.0 6340.3 6354.1 6360.9 6374.2 6084.2 6880.1 6893.2 6970.9 6985.0 6334.0 6380.1 6491.6 6515.8 6567.5 6725.8 6771.6 6783.6 6792.2 6804.5 6642.2 6695.7 6697.0 6717.2 6718.6 6402.5 6463.6 6611.4 6631.4 6704.9 5400.3 5405.1 5418.5 5420.4 5432.3 4792.6 4812.3 4832.1 4842.2 4851.5 5979.3 6168.9 6215.8 6223.5 6315.6 6793.7 6827.6 6843.8 6846.8 6847.2 6232.8 6266.1 6283.2 6288.2 6333.0 5701.7 5824.2 5843.0 6019.9 6030.7 6746.7 6893.2 6926.6 6956.3 6985.3 6764.5 6775.6 6781.6 6793.5 6801.8 6542.5 6653.5 6712.7 6874.8 6958.1 6663.1 6667.6 6667.6 6672.2 6691.5 6501.2 6587.2 6657.9 6701.7 6728.6 6588.3 6596.3 6600.2 6629.5 6634.2 6508.8 6572.1 6599.9 6604.5 6619.0 5391.7 6110.2 6243.9 6252.2 6336.9 6495.2 6524.0 6546.5 6551.1 6555.1 6365.9 6384.3 6416.2 6425.2 6444.4 12:04:51 INFO - PID 1923 | 12:04:51 INFO - PID 1923 | [#1] ext.html Cycles:180 Average:42942.02 Median:34269.24 stddev:72460.39 (211.4%) stddev-sans-first:72594.29 12:04:51 INFO - PID 1923 | Values: 713.7 754.8 827.0 1257.8 1264.1 35613.5 37044.9 37048.8 37117.9 37138.4 37304.6 37425.8 37476.3 37503.6 40325.6 7123.6 7875.0 8031.5 8483.9 8694.2 8618.8 8678.9 8682.8 8682.9 8714.3 8656.6 8712.9 8727.3 8728.1 8757.9 8628.2 8652.7 8700.7 8710.3 8711.5 8482.7 8570.6 8576.4 8576.5 8596.5 37252.8 37274.0 37376.9 37412.0 37502.2 3482.1 3489.4 3529.6 3529.9 3534.1 30397.4 30607.8 30716.0 30758.0 30773.8 3119.4 3199.2 3205.9 3212.9 3213.0 227722.0 234214.0 240306.0 244846.0 259575.0 47879.5 47991.0 48061.8 48228.5 48278.0 39206.4 46733.1 49091.5 49678.0 49719.5 12122.7 13191.2 13747.5 13854.4 13869.2 11144.9 11291.5 11312.2 11337.7 11338.3 13464.9 13530.0 13641.3 13645.9 13674.0 5035.3 6080.8 6081.8 6108.9 6158.7 905.6 981.5 1009.6 1036.5 1101.4 23641.0 24591.6 24596.3 24647.5 24676.1 1141.4 1145.6 1150.5 1167.6 1195.2 12453.3 12615.7 12660.3 12672.4 12688.6 256575.0 307500.0 307636.0 308363.0 310848.0 53650.5 53882.9 53924.0 54248.5 54364.2 1359.6 1495.9 1513.0 1557.0 1569.3 22984.7 24084.9 24395.9 24402.8 24706.3 38057.8 38129.0 38203.9 38208.8 38346.0 286225.0 286452.6 287458.0 288035.0 289052.0 34657.8 34948.7 34986.0 35317.6 35424.5 33880.7 35672.5 44022.9 44628.0 46050.5 29017.9 30566.9 30818.8 30900.5 31357.5 30396.7 30570.0 31104.0 31123.7 31472.1 35940.0 36670.8 36726.0 36763.3 36937.1 30571.7 30820.2 31249.1 31317.2 31787.0 23498.9 24371.9 24443.6 25022.0 25281.0 12:04:51 INFO - PID 1923 | 12:04:51 INFO - PID 1923 | [#2] jquery.html Cycles:180 Average:35069.86 Median:2227.58 stddev:90723.58 (4072.7%) stddev-sans-first:90940.68 12:04:51 INFO - PID 1923 | Values: 374.3 434.4 437.7 445.9 462.1 19269.5 21007.7 21450.5 21482.1 21796.8 21506.7 22151.9 22607.3 22701.7 22830.1 6130.2 6270.0 6273.0 6280.4 6289.6 6088.3 6288.0 6314.4 6315.3 6317.9 5894.4 6202.5 6231.8 6277.4 6278.0 5988.9 6044.4 6063.5 6076.5 6077.4 4552.9 5420.4 5428.7 5452.3 5513.4 26791.2 26813.5 27167.3 27684.2 27725.2 2156.3 2209.4 2218.1 2225.1 2227.2 16471.3 17143.9 17523.0 17641.3 18264.9 2114.0 2140.8 2163.0 2167.7 2169.0 150790.0 154089.0 155057.2 156073.0 158428.2 12162.2 12748.6 12805.4 12998.3 13049.5 13444.5 16653.7 16734.7 16783.7 16788.9 7538.9 8722.5 8958.3 9052.8 9087.0 8340.5 8431.7 8445.5 8483.9 8666.5 6898.5 7399.4 8260.4 8268.5 8283.5 2200.8 2225.1 2226.5 2228.0 2383.6 957.9 958.4 969.0 991.1 1018.7 20301.5 20623.9 20627.5 20749.9 21176.6 984.4 986.8 1008.1 1021.3 1035.2 9455.8 10358.5 10487.1 10705.5 10767.2 514107.0 527480.0 532067.0 545353.0 548732.0 99968.0 127355.0 130079.0 134449.3 134956.0 1193.7 1221.1 1236.6 1237.6 1240.7 19098.7 21878.0 22248.4 22263.6 22290.8 56375.2 56425.0 57364.1 57400.6 58361.7 78300.0 79006.6 79030.6 79298.0 79673.6 8748.3 8825.1 8882.2 8935.9 9038.2 13699.7 13756.4 13829.4 14009.6 14025.6 11683.1 11774.5 11802.5 11897.7 11952.5 10596.9 10916.5 10950.5 10951.2 11045.9 11114.8 11432.8 11753.9 12062.6 12116.9 8712.9 8771.5 8876.6 8886.0 8989.7 11634.7 11730.7 11827.8 11839.3 11874.3 12:04:51 INFO - PID 1923 | 12:04:51 INFO - PID 1923 | [#3] mootools.html Cycles:180 Average:7130.21 Median:4051.75 stddev:4465.00 (110.2%) stddev-sans-first:4455.06 12:04:51 INFO - PID 1923 | Values: 1169.4 1399.8 1418.0 1440.5 1446.3 11511.9 11804.5 12007.8 12022.3 12188.0 11802.7 11830.2 12030.6 12049.3 12050.9 2533.7 2568.3 2579.7 2584.2 2584.8 2497.1 2530.6 2541.1 2559.0 2562.0 2477.5 2535.7 2553.6 2556.3 2567.0 2118.9 2447.5 2497.1 2522.9 2540.8 2073.8 2443.0 2504.3 2562.6 2567.2 9029.3 11874.6 11910.0 12043.8 12047.8 6495.7 6650.3 6764.4 6768.7 6777.7 3943.0 4160.5 4205.8 4384.8 4485.0 1148.7 1234.5 1263.6 1324.2 1326.7 16271.3 16835.2 16877.9 16997.0 17010.4 5256.1 5302.5 5740.0 5925.4 5954.0 11709.4 12360.8 12458.6 12465.6 12490.3 6710.7 6710.9 6722.1 6723.2 6753.8 5878.0 6132.4 6142.5 6212.2 6223.8 4414.9 4485.5 4532.3 4537.5 4551.3 1328.3 1354.8 1355.2 1371.6 1376.3 698.4 787.4 791.2 830.3 830.4 6725.9 6960.4 7026.7 7036.3 7036.8 896.8 930.4 932.6 934.6 936.7 3384.0 4279.5 4314.7 4316.4 4413.9 14846.9 15322.8 15379.9 15392.3 15442.3 13394.0 13838.0 13841.8 13851.7 13888.3 7541.5 8521.5 8649.4 8741.1 8754.3 5208.9 6883.5 6962.2 7160.0 7257.5 10161.5 11377.5 12844.7 12915.9 13100.9 13039.1 13132.3 13199.3 13261.7 13326.5 9585.4 9793.2 9801.5 9823.9 9828.6 10893.1 11055.5 11148.1 11153.9 11169.8 9233.4 9364.1 9373.5 9472.8 9493.2 9080.0 9099.7 9215.3 9288.8 9299.2 8252.5 8399.5 8403.7 8498.6 8524.8 4755.7 6084.8 6166.5 6248.4 6272.7 5509.7 5522.3 6166.3 6203.5 6263.3 12:04:51 INFO - PID 1923 | 12:04:51 INFO - PID 1923 | [#4] prototype.html Cycles:180 Average:5496.84 Median:6234.42 stddev:1693.59 (27.2%) stddev-sans-first:1654.75 12:04:51 INFO - PID 1923 | Values: 410.5 413.6 417.0 420.6 426.0 6025.5 6234.4 6356.4 6393.4 6530.7 5369.5 5684.5 5732.7 6121.9 6290.7 4591.4 4696.7 4794.1 4817.7 4826.3 4129.9 4762.3 4798.7 4829.7 4835.4 4762.5 4793.5 4802.7 4808.3 4823.5 4153.1 4598.9 4678.1 4805.4 4806.2 4234.8 4262.7 4262.8 4279.4 4306.2 6239.7 6246.5 6249.3 6253.4 6266.4 5516.5 5705.7 5730.1 5752.2 5782.0 6807.8 6817.8 6819.7 6820.6 6834.5 4225.7 4620.0 4800.5 4806.5 4874.2 6147.3 6889.4 7116.8 7237.8 7264.4 4014.8 4436.1 4567.9 4772.6 4797.3 3686.8 3690.4 4643.7 4855.8 4857.6 5203.9 5358.7 5500.3 5501.9 5550.3 5376.4 6234.4 6262.9 6656.6 6775.3 1530.5 1674.3 1732.8 1749.0 1750.3 1051.9 1157.8 1169.3 1199.3 1208.8 6262.3 6287.2 6295.5 6304.5 6311.3 6640.6 6937.0 6962.2 6981.6 6986.2 6255.9 6261.4 6316.8 6321.0 6336.6 2873.7 3649.9 3660.5 3668.9 3682.4 6800.3 7148.7 7234.8 7245.0 7245.4 7178.6 7205.7 7247.4 7274.9 7299.9 6950.7 7148.0 7199.4 7219.5 7249.4 6795.5 6903.1 7037.9 7040.4 7052.0 5524.3 6848.8 6908.6 6920.9 6940.7 5807.0 6576.6 6999.0 7245.8 7271.8 4566.5 4588.2 4588.6 4589.5 4603.9 6019.8 6686.5 7026.1 7057.4 7058.1 5533.3 5834.9 6020.4 6644.6 6755.0 5547.9 6462.4 6733.9 6802.5 6819.7 6319.0 6514.2 6548.4 6639.4 6659.2 6483.5 6761.0 6788.3 6798.4 6810.9 5195.4 6566.5 6589.4 6592.8 6630.3 12:04:51 INFO - PID 1923 | 12:04:51 INFO - PID 1923 | [#5] yui.html Cycles:180 Average:21508.54 Median:21888.98 stddev:30456.93 (139.1%) stddev-sans-first:30502.78 12:04:51 INFO - PID 1923 | Values: 827.4 835.6 858.5 858.7 873.3 16412.0 16767.2 16772.2 18054.1 18698.3 17545.6 17845.7 17964.7 17969.7 18008.3 951.2 958.3 971.1 976.4 977.5 886.5 919.5 957.2 991.7 997.8 981.1 1003.5 1020.7 1023.5 1025.8 981.3 1006.4 1026.1 1026.8 1027.2 725.5 727.9 748.9 753.5 762.9 16134.4 16306.4 16407.8 16411.3 16425.1 16634.7 17086.5 17356.0 17546.7 17568.8 13672.0 13712.0 13819.4 13883.9 14009.4 3484.0 3541.1 3567.6 3573.8 3573.9 133866.3 134040.0 135239.0 137263.3 137785.0 13161.4 13177.1 13219.6 13302.9 13351.3 25079.6 25205.4 25355.7 25516.7 25591.7 7575.6 7634.5 7655.9 7732.2 7777.0 3813.8 3873.1 3888.8 3888.8 3904.0 4324.3 4347.6 4380.0 4405.9 4435.7 896.5 905.7 913.6 919.0 919.8 548.9 613.7 650.2 677.1 691.7 10190.6 10739.8 11833.6 11864.8 11894.2 567.3 656.6 671.6 675.2 690.1 4177.6 5000.5 5303.8 5330.2 5487.1 64020.7 97542.0 100073.5 100111.5 102821.0 71605.6 78555.0 87062.0 87241.1 90208.0 81865.8 82398.6 82914.2 83616.6 84920.0 11000.9 11278.3 12750.8 12930.8 12947.5 33156.2 39361.4 40804.8 41547.2 42390.8 52743.7 52979.0 53302.7 53481.5 54229.0 16083.0 16154.2 16298.3 16382.9 16412.3 17728.8 18142.5 18173.3 18373.4 18578.8 16354.8 16383.6 16909.6 16975.9 17094.7 16709.5 16728.3 16740.6 17136.0 17141.5 16088.3 16259.4 16463.0 16546.8 16664.8 11549.5 11792.2 11815.8 11871.5 11961.5 12937.4 13495.4 13824.6 13925.2 13932.7 12:04:51 INFO - PID 1923 | -------- Summary: end -------- 12:04:51 INFO - PID 1923 | 12:04:51 INFO - TEST-INFO | 1923: exit 0 12:04:51 INFO - TEST-OK | dromaeo_css | took 1115254ms 12:04:51 INFO - TEST-START | kraken 12:04:51 INFO - operating with platform_type : mac_ 12:04:51 INFO - Initialising browser for kraken test... 12:04:51 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpIzuDwF/profile http://localhost:49379/getInfo.html) 12:04:54 INFO - PID 1929 | 2017-04-20 12:04:54.454 plugin-container[1930:18404] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 12:04:54 INFO - PID 1929 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:04:54 INFO - PID 1929 | 2017-04-20 12:04:54.456 plugin-container[1930:18404] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 12:04:54 INFO - PID 1929 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:04:54 INFO - PID 1929 | 2017-04-20 12:04:54.456 plugin-container[1930:18404] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:04:54 INFO - PID 1929 | __metrics Screen width/height:1600/1200 12:04:54 INFO - PID 1929 | colorDepth:24 12:04:54 INFO - PID 1929 | Browser inner width/height: 1024/689 12:04:54 INFO - PID 1929 | __metrics 12:04:54 ERROR - PID 1929 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 12:04:55 INFO - TEST-INFO | 1929: exit 0 12:04:55 INFO - Browser initialized. 12:04:55 INFO - Running cycle 1/1 for kraken test... 12:04:55 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpIzuDwF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:04:58 INFO - PID 1931 | 2017-04-20 12:04:58.415 plugin-container[1932:18527] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 12:04:58 INFO - PID 1931 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:04:58 INFO - PID 1931 | 2017-04-20 12:04:58.416 plugin-container[1932:18527] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 12:04:58 INFO - PID 1931 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:04:58 INFO - PID 1931 | 2017-04-20 12:04:58.416 plugin-container[1932:18527] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:05:08 INFO - PID 1931 | RSS: Main: 236445696 12:05:08 INFO - PID 1931 | 12:05:11 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-beat-detection) 12:05:12 INFO - PID 1931 | RSS: Main: 249667584 12:05:12 INFO - PID 1931 | 12:05:14 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-dft) 12:05:15 INFO - PID 1931 | RSS: Main: 257966080 12:05:15 INFO - PID 1931 | 12:05:18 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-fft) 12:05:19 INFO - PID 1931 | RSS: Main: 260411392 12:05:19 INFO - PID 1931 | 12:05:21 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-oscillator) 12:05:21 INFO - PID 1931 | RSS: Main: 262455296 12:05:21 INFO - PID 1931 | 12:05:23 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:05:24 INFO - PID 1931 | RSS: Main: 263086080 12:05:24 INFO - PID 1931 | 12:05:27 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49379/tests/kraken/driver.html?testName=imaging-darkroom) 12:05:27 INFO - PID 1931 | RSS: Main: 268173312 12:05:27 INFO - PID 1931 | 12:05:31 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49379/tests/kraken/driver.html?testName=imaging-desaturate) 12:05:31 INFO - PID 1931 | RSS: Main: 269557760 12:05:31 INFO - PID 1931 | 12:05:35 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49379/tests/kraken/driver.html?testName=json-parse-financial) 12:05:35 INFO - PID 1931 | RSS: Main: 270004224 12:05:35 INFO - PID 1931 | 12:05:37 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:05:37 INFO - PID 1931 | RSS: Main: 268931072 12:05:37 INFO - PID 1931 | 12:05:39 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:05:40 INFO - PID 1931 | RSS: Main: 268996608 12:05:40 INFO - PID 1931 | 12:05:42 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:05:43 INFO - PID 1931 | RSS: Main: 268853248 12:05:43 INFO - PID 1931 | 12:05:46 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:05:47 INFO - PID 1931 | RSS: Main: 269201408 12:05:47 INFO - PID 1931 | 12:05:50 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:05:50 INFO - PID 1931 | RSS: Main: 266358784 12:05:50 INFO - PID 1931 | 12:05:52 INFO - PID 1931 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49379/tests/kraken/driver.html?testName=ai-astar) 12:05:53 INFO - PID 1931 | RSS: Main: 268255232 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | __start_tp_report 12:05:53 INFO - PID 1931 | _x_x_mozilla_page_load 12:05:53 INFO - PID 1931 | _x_x_mozilla_page_load_details 12:05:53 INFO - PID 1931 | |i|pagename|runs| 12:05:53 INFO - PID 1931 | |0;ai-astar;104;115;114;123;174;165;113;116;114;114 12:05:53 INFO - PID 1931 | |1;audio-beat-detection;145;111;111;147;113;109;109;112;156;115 12:05:53 INFO - PID 1931 | |2;audio-dft;195;199;204;226;211;275;282;199;199;194 12:05:53 INFO - PID 1931 | |3;audio-fft;85;64;93;73;81;50;60;70;90;85 12:05:53 INFO - PID 1931 | |4;audio-oscillator;84;72;108;109;105;81;90;70;72;92 12:05:53 INFO - PID 1931 | |5;imaging-gaussian-blur;88;88;87;88;89;102;87;89;88;88 12:05:53 INFO - PID 1931 | |6;imaging-darkroom;95;104;119;157;95;97;98;97;121;133 12:05:53 INFO - PID 1931 | |7;imaging-desaturate;124;90;141;77;140;146;94;138;88;138 12:05:53 INFO - PID 1931 | |8;json-parse-financial;50;49;49;50;51;51;50;49;51;50 12:05:53 INFO - PID 1931 | |9;json-stringify-tinderbox;61;72;84;99;58;72;85;83;85;56 12:05:53 INFO - PID 1931 | |10;stanford-crypto-aes;82;84;84;85;85;83;84;85;83;83 12:05:53 INFO - PID 1931 | |11;stanford-crypto-ccm;140;144;148;125;146;150;159;164;214;139 12:05:53 INFO - PID 1931 | |12;stanford-crypto-pbkdf2;173;177;235;234;183;223;203;241;204;237 12:05:53 INFO - PID 1931 | |13;stanford-crypto-sha256-iterative;70;69;59;61;71;61;86;99;99;102 12:05:53 INFO - PID 1931 | __end_tp_report 12:05:53 INFO - PID 1931 | __start_cc_report 12:05:53 INFO - PID 1931 | _x_x_mozilla_cycle_collect,1008 12:05:53 INFO - PID 1931 | __end_cc_report 12:05:53 INFO - PID 1931 | __startTimestamp1492715153002__endTimestamp 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | ------- Summary: start ------- 12:05:53 INFO - PID 1931 | Number of tests: 14 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#0] ai-astar Cycles:10 Average:125.20 Median:115.50 stddev:23.88 (20.7%) stddev-sans-first:24.07 12:05:53 INFO - PID 1931 | Values: 104.0 115.0 114.0 123.0 174.0 165.0 113.0 116.0 114.0 114.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:114.00 stddev:18.60 (16.3%) stddev-sans-first:17.91 12:05:53 INFO - PID 1931 | Values: 145.0 111.0 111.0 147.0 113.0 109.0 109.0 112.0 156.0 115.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#2] audio-dft Cycles:10 Average:218.40 Median:207.50 stddev:33.07 (15.9%) stddev-sans-first:33.97 12:05:53 INFO - PID 1931 | Values: 195.0 199.0 204.0 226.0 211.0 275.0 282.0 199.0 199.0 194.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#3] audio-fft Cycles:10 Average:75.10 Median:83.00 stddev:14.08 (17.0%) stddev-sans-first:14.47 12:05:53 INFO - PID 1931 | Values: 85.0 64.0 93.0 73.0 81.0 50.0 60.0 70.0 90.0 85.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:76.50 stddev:15.09 (19.7%) stddev-sans-first:15.93 12:05:53 INFO - PID 1931 | Values: 84.0 72.0 108.0 109.0 105.0 81.0 90.0 70.0 72.0 92.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:88.00 stddev:4.48 (5.1%) stddev-sans-first:4.72 12:05:53 INFO - PID 1931 | Values: 88.0 88.0 87.0 88.0 89.0 102.0 87.0 89.0 88.0 88.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#6] imaging-darkroom Cycles:10 Average:111.60 Median:95.00 stddev:20.77 (21.9%) stddev-sans-first:21.14 12:05:53 INFO - PID 1931 | Values: 95.0 104.0 119.0 157.0 95.0 97.0 98.0 97.0 121.0 133.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#7] imaging-desaturate Cycles:10 Average:117.60 Median:111.50 stddev:27.02 (24.2%) stddev-sans-first:28.56 12:05:53 INFO - PID 1931 | Values: 124.0 90.0 141.0 77.0 140.0 146.0 94.0 138.0 88.0 138.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 12:05:53 INFO - PID 1931 | Values: 50.0 49.0 49.0 50.0 51.0 51.0 50.0 49.0 51.0 50.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#9] json-stringify-tinderbox Cycles:10 Average:75.50 Median:83.50 stddev:14.07 (16.9%) stddev-sans-first:13.91 12:05:53 INFO - PID 1931 | Values: 61.0 72.0 84.0 99.0 58.0 72.0 85.0 83.0 85.0 56.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:0.87 12:05:53 INFO - PID 1931 | Values: 82.0 84.0 84.0 85.0 85.0 83.0 84.0 85.0 83.0 83.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#11] stanford-crypto-ccm Cycles:10 Average:152.90 Median:149.00 stddev:24.02 (16.1%) stddev-sans-first:25.01 12:05:53 INFO - PID 1931 | Values: 140.0 144.0 148.0 125.0 146.0 150.0 159.0 164.0 214.0 139.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:211.00 Median:228.50 stddev:26.50 (11.6%) stddev-sans-first:24.28 12:05:53 INFO - PID 1931 | Values: 173.0 177.0 235.0 234.0 183.0 223.0 203.0 241.0 204.0 237.0 12:05:53 INFO - PID 1931 | 12:05:53 INFO - PID 1931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.70 Median:70.50 stddev:17.17 (24.4%) stddev-sans-first:17.99 12:05:53 INFO - PID 1931 | Values: 70.0 69.0 59.0 61.0 71.0 61.0 86.0 99.0 99.0 102.0 12:05:53 INFO - PID 1931 | -------- Summary: end -------- 12:05:53 INFO - PID 1931 | 12:05:54 INFO - TEST-INFO | 1931: exit 0 12:05:54 INFO - TEST-OK | kraken | took 62481ms 12:05:54 INFO - SUITE-END | took 1177s 12:05:54 INFO - Completed test suite (00:19:38) 12:05:54 INFO - javascript benchmark 12:05:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7920.975806542458, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2866.41238546098, 3581.2300355423577, 3594.209273959728, 3609.404448266036, 3626.854925802968, 6021.608595441304, 6102.115193296975, 6143.81568552943, 6167.321594624594, 6214.471769899564, 6032.788852390167, 6098.06917627449, 6116.82275545647, 6130.570860039799, 6209.192804935352, 5222.660527065728, 5395.649282796606, 5423.29497165369, 5425.403205647375, 5508.669479831203, 5352.2506849041165, 5418.647787893794, 5484.451554844523, 5492.972535137319, 5510.641808282448, 5432.864178395532, 5460.180972854064, 5486.0, 5493.533049690781, 5496.642718223303, 5259.474052594748, 5297.576193904517, 5326.334208223972, 5329.8934021319355, 5332.3867755207875, 4551.203539380595, 5289.523942845162, 5297.947020529784, 5358.598105142091, 5363.275957745694, 4674.462436819776, 6018.608790428652, 6121.204243448367, 6176.6911654417545, 6193.87612247757, 5838.0, 6375.776847810304, 6718.462522998148, 6747.696353664097, 6762.120924279861, 6579.572327798678, 6716.529842910949, 6807.149106361705, 6817.727290908358, 6834.6582670866255, 6118.969405152946, 6340.270868850095, 6354.142190804275, 6360.872782544323, 6374.171357723466, 6084.178635884187, 6880.105586273752, 6893.20728116263, 6970.895436568456, 6985.0, 6333.96833015832, 6380.0748891410485, 6491.578047426902, 6515.771947981798, 6567.474602031826, 6725.831854203586, 6771.559848609824, 6783.626900520519, 6792.150981127359, 6804.489663275274, 6642.202935647753, 6695.665216739144, 6696.995450682339, 6717.227518835299, 6718.630475323806, 6402.455791257702, 6463.612183269019, 6611.404973552307, 6631.436327912085, 6704.899426508607, 5400.324959380077, 5405.054115529767, 5418.485243901823, 5420.403755586883, 5432.29380180574, 4792.568668819823, 4812.302216178635, 4832.130216561053, 4842.15262329098, 4851.490593487703, 5979.312379076375, 6168.907466388007, 6215.782447614402, 6223.533235007392, 6315.55791094619, 6793.66031698423, 6827.590344579341, 6843.828904277433, 6846.828829279209, 6847.246802851682, 6232.844178895564, 6266.122742816009, 6283.246010478681, 6288.182536270256, 6332.968335158294, 5701.743421546041, 5824.213731146241, 5842.970785146047, 6019.939800602026, 6030.698465076729, 6746.730130794811, 6893.20728116273, 6926.619035953071, 6956.339147780953, 6985.336393042653, 6764.458843292623, 6775.593464392152, 6781.559198652072, 6793.4565234782085, 6801.795946121624, 6542.476601871744, 6653.467722582085, 6712.664366781739, 6874.828129296608, 6958.130233720785, 6663.13379260693, 6667.566608170453, 6667.566608170453, 6672.165979252593, 6691.5315927884585, 6501.2198536175965, 6587.176602924635, 6657.933420665925, 6701.698423571049, 6728.562643428161, 6588.308227636029, 6596.340365963365, 6600.174978127734, 6629.535932484872, 6634.170728658918, 6508.837279067871, 6572.112764776694, 6599.934000659932, 6604.537682362381, 6618.966905165444, 5391.7059905623155, 6110.236220472441, 6243.937560624336, 6252.249730032425, 6336.904946425715, 6495.220573531206, 6524.0, 6546.476281897532, 6551.082848401133, 6555.082288479712, 6365.90451143224, 6384.297727250092, 6416.197975253093, 6425.1968503937005, 6444.420002199825], "value": 6084.427503293652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.7002458967233, 754.7810286387486, 827.0117209934127, 1257.7798885195089, 1264.1277518512231, 35613.46579801305, 37044.88865334038, 37048.814755926214, 37117.886463406074, 37138.44292335617, 37304.62695373052, 37425.81287093561, 37476.250474990484, 37503.62496375036, 40325.59674403255, 7123.608201548913, 7874.960625196881, 8031.518108913484, 8483.872741908875, 8694.17405346491, 8618.78453038676, 8678.913210867906, 8682.782930426727, 8682.86975695365, 8714.25928796053, 8656.61045252962, 8712.869306960401, 8727.301815854747, 8728.083551227124, 8757.868631970525, 8628.180322869317, 8652.653893844239, 8700.738977830611, 8710.346723995726, 8711.477311361306, 8482.66069357225, 8570.614322355508, 8576.44253123545, 8576.485410875304, 8596.527191004492, 37252.81373593142, 37274.0, 37376.878693639235, 37412.0, 37502.24995500102, 3482.077249528877, 3489.354469423165, 3529.6117427083, 3529.876454324112, 3534.0634731796094, 30397.392052158833, 30607.846960765277, 30716.0, 30758.0, 30773.84583079185, 3119.4385010698293, 3199.2001999500126, 3205.85573649184, 3212.8554215060144, 3213.0, 227722.0, 234214.0, 240306.0, 244846.0, 259574.9999999981, 47879.5212047882, 47991.04017919622, 48061.759691202016, 48228.5177148224, 48278.0, 39206.41190382146, 46733.06533869372, 49091.50908490869, 49678.0, 49719.50280497221, 12122.696932576757, 13191.240496458464, 13747.450101996008, 13854.376553054935, 13869.167849929037, 11144.88551144879, 11291.54833806655, 11312.151588630886, 11337.716557086138, 11338.319700817978, 13464.93267533656, 13530.0, 13641.317934103256, 13645.863541364459, 13674.0, 5035.345405097387, 6080.787172448943, 6081.756729730761, 6108.877822443526, 6158.7228574714245, 905.6241659711278, 981.5351808117357, 1009.5658866687395, 1036.461040259076, 1101.3612104979093, 23641.0485109756, 24591.63112553313, 24596.315106873964, 24647.5070498589, 24676.13633522854, 1141.366541569437, 1145.6162185667895, 1150.4822829726656, 1167.5855071449682, 1195.1633856300625, 12453.315067671183, 12615.747685046248, 12660.303683297323, 12672.429740661692, 12688.555900543437, 256575.0, 307500.0, 307636.0, 308363.0, 310848.0, 53650.46349536533, 53882.92234155295, 53924.0, 54248.45751542513, 54364.18453723197, 1359.558143603313, 1495.9476418325523, 1512.9621759455881, 1556.9922150389175, 1569.3487202810707, 22984.655230171225, 24084.879575602008, 24395.878020609784, 24402.75597244005, 24706.25881223566, 38057.80971095237, 38129.0, 38203.85388438351, 38208.80895595504, 38346.0, 286225.0, 286452.56773715996, 287458.0, 288035.0, 289052.0, 34657.826710866284, 34948.65051349556, 34986.0, 35317.64682353144, 35424.46863297001, 33880.66119338775, 35672.464913025804, 44022.89942751457, 44628.0, 46050.53949460462, 29017.854910725313, 30566.93015744438, 30818.84590577033, 30900.519424682847, 31357.491400687435, 30396.696033039385, 30570.0, 31104.0, 31123.68876311208, 31472.055838324886, 35940.0, 36670.8166459166, 36726.0, 36763.26473470569, 36937.07657308589, 30571.694283056884, 30820.22949426282, 31249.062528124192, 31317.217069573442, 31787.046388608378, 23498.942547585742, 24371.878140609184, 24443.633345499475, 25022.0, 25281.0], "value": 17391.131009225704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.3150035435154, 434.42221844946204, 437.6717461903572, 445.888527868033, 462.1381124203362, 19269.518262043457, 21007.68488472672, 21450.463738406546, 21482.140714371406, 21796.78203217967, 21506.677399839016, 22151.889240553814, 22607.321780346574, 22701.65947510789, 22830.08679652816, 6130.233720784902, 6270.0, 6273.027680709497, 6280.403361680633, 6289.591176573531, 6088.299845517756, 6288.0, 6314.431701146896, 6315.305316415191, 6317.905231421532, 5894.381089985554, 6202.503799696014, 6231.750729970796, 6277.403646653584, 6277.968610156966, 5988.940110598904, 6044.395560443964, 6063.514918806529, 6076.4834989025985, 6077.392260773931, 4552.8861778455475, 5420.403755586922, 5428.728563571805, 5452.345718513764, 5513.448655134494, 26791.196264111913, 26813.46373072547, 27167.320816979536, 27684.169474915783, 27725.168244952685, 2156.277646988261, 2209.4034610655194, 2218.0684112672716, 2225.0988349718227, 2227.1982086448866, 16471.34114635413, 17143.914280428642, 17523.0, 17641.294348226056, 18264.90867545667, 2113.9788602113936, 2140.8073273405466, 2163.0482587661377, 2167.6856855755987, 2168.9566208675897, 150790.0, 154089.0, 155057.22471387684, 156073.0, 158428.20785896113, 12162.209456385306, 12748.61754147377, 12805.359732013361, 12998.285094319714, 13049.478020879249, 13444.462221511225, 16653.666926661397, 16734.665306693798, 16783.748243776354, 16788.908720933345, 7538.906858505486, 8722.476651400937, 8958.328125390623, 9052.773680657905, 9087.0, 8340.499570025819, 8431.704890328809, 8445.493270403795, 8483.915160848312, 8666.480011199348, 6898.482613803984, 7399.408047356199, 8260.380471464545, 8268.545230012287, 8283.50298982063, 2200.7799220078186, 2225.121077174507, 2226.4545186429427, 2227.96141530501, 2383.5590415773136, 957.899420560845, 958.4249450329886, 968.9563969621383, 991.1228562722043, 1018.6994836523244, 20301.49246268855, 20623.896880515502, 20627.4843128923, 20749.858757768165, 21176.576468470543, 984.4200058905496, 986.753311672082, 1008.1027885182194, 1021.2544842265188, 1035.233926894093, 9455.763605909908, 10358.482075896174, 10487.056164945192, 10705.46472676363, 10767.19246056549, 514107.0, 527480.0, 532067.0, 545353.0, 548732.0, 99968.0, 127355.0, 130079.0, 134449.32775336257, 134956.0, 1193.7493126443544, 1221.1146918484028, 1236.6413740015296, 1237.560665963588, 1240.6960294727849, 19098.7135192975, 21878.0, 22248.443788905406, 22263.554728905656, 22290.77709222887, 56375.154372683624, 56425.0, 57364.13953790613, 57400.56498587569, 58361.70819145877, 78300.0, 79006.6049669748, 79030.6048469754, 79298.0, 79673.60163199146, 8748.300135989233, 8825.117488251124, 8882.200601945857, 8935.910640893508, 9038.231750301298, 13699.657508561966, 13756.449742010607, 13829.377678004314, 14009.579712608638, 14025.649358765704, 11683.065354771768, 11774.470148843495, 11802.52789888395, 11897.702557436134, 11952.462139203582, 10596.947015264874, 10916.508757106109, 10950.507227174956, 10951.233413660968, 11045.889541104487, 11114.832942540917, 11432.828507572227, 11753.941230293794, 12062.638120856389, 12116.878831211576, 8712.912870871463, 8771.517566533646, 8876.556172191495, 8886.0, 8989.685361012333, 11634.6509604712, 11730.706732331419, 11827.763444730885, 11839.348835814113, 11874.287542747463], "value": 10442.067349138393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1169.380228478906, 1399.8460169381372, 1418.0, 1440.5462279381993, 1446.2551785830299, 11511.884881151185, 11804.468798904049, 12007.819882701766, 12022.278663280198, 12188.024958003361, 11802.704932376695, 11830.23103498272, 12030.639080827566, 12049.337286449241, 12050.93974530126, 2533.7466253374605, 2568.268043607572, 2579.7162312145647, 2584.2247325802277, 2584.8449093054383, 2497.051120574188, 2530.6204069389646, 2541.097910241865, 2558.961615575768, 2562.026429956614, 2477.5044991001782, 2535.657686212356, 2553.5786595211766, 2556.2586849813624, 2567.0, 2118.925837595677, 2447.5227330670527, 2497.1384872219055, 2522.8738563071865, 2540.847549147057, 2073.8133567978803, 2442.9877850610633, 2504.261242933321, 2562.641230227751, 2567.1785028790796, 9029.277657787427, 11874.643760687193, 11910.0, 12043.759124817454, 12047.759044819142, 6495.675216239217, 6650.301718319555, 6764.3573860483175, 6768.729250829961, 6777.695003724844, 3942.960570394288, 4160.54234034256, 4205.768682722449, 4384.780760961971, 4485.0, 1148.7128217945515, 1234.4692581199338, 1263.570386068741, 1324.2120938041849, 1326.7213885084143, 16271.267792949227, 16835.242414091274, 16877.91561042187, 16996.980181189167, 17010.40463583781, 5256.08018596744, 5302.534321540502, 5739.971300143473, 5925.377835327315, 5954.047352423591, 11709.355985420712, 12360.75278494443, 12458.563950261698, 12465.626031219077, 12490.313032783284, 6710.664466776641, 6710.899336509956, 6722.126123603998, 6723.22682891464, 6753.797386078426, 5877.970610146922, 6132.448079672851, 6142.477889379453, 6212.161358216673, 6223.751049958041, 4414.933775993362, 4485.506594274627, 4532.252178390595, 4537.546245375436, 4551.3173024046655, 1328.2893651896188, 1354.7967804829354, 1355.2207480698637, 1371.6228037289825, 1376.3324787478066, 698.434268242725, 787.4015748031537, 791.1732239809298, 830.2693629605908, 830.4311546590604, 6725.932740672531, 6960.37356637905, 7026.683799229047, 7036.331548502884, 7036.824079398056, 896.8117244650864, 930.3812964378748, 932.6316105138433, 934.6261495401893, 936.6721647423348, 3384.0, 4279.465066866642, 4314.69797114199, 4316.395704601296, 4413.933790993137, 14846.925765371105, 15322.770158447633, 15379.923100384427, 15392.30734616945, 15442.305096270695, 13394.0, 13838.031337806256, 13841.792373114411, 13851.653708657162, 13888.305584720723, 7541.5098018629715, 8521.531315777567, 8649.437786543855, 8741.082186370466, 8754.343424243207, 5208.895822083613, 6883.483738719716, 6962.1993470749485, 7159.964200178966, 7257.455690823315, 10161.542730576994, 11377.54489820398, 12844.743105138032, 12915.935420322838, 13100.934495327463, 13039.087263891437, 13132.27772472485, 13199.34003299812, 13261.66845828862, 13326.466941322238, 9585.376950498196, 9793.216542676426, 9801.460919649488, 9823.901760982299, 9828.557714902989, 10893.128549716163, 11055.502502387573, 11148.108151348035, 11153.888461115284, 11169.776604468028, 9233.353665243369, 9364.110409511086, 9373.531323433937, 9472.763180920532, 9493.193078588121, 9080.0, 9099.727008189764, 9215.2627789778, 9288.767780805534, 9299.209567186594, 8252.504849709037, 8399.454035487674, 8403.747887563382, 8498.61756220984, 8524.786880328042, 4755.690880092783, 6084.84387966285, 6166.4758495526585, 6248.375162483715, 6272.717727702173, 5509.650135716775, 5522.2544956430365, 6166.260048794174, 6203.534734894991, 6263.27972283175], "value": 5410.920080498067, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.5094412177447, 413.64426593129906, 416.9971219217779, 420.5605142625956, 425.9552746961567, 6025.487833534149, 6234.438900498954, 6356.396142366473, 6393.442622950822, 6530.673466326689, 5369.463053694629, 5684.488396044366, 5732.684702341369, 6121.938780612192, 6290.654014029226, 4591.357209990604, 4696.671233013691, 4794.113089078514, 4817.710937343753, 4826.251930950708, 4129.9174016519655, 4762.309465127554, 4798.712077275357, 4829.710217386951, 4835.371401717772, 4762.452317983441, 4793.472718001017, 4802.735849528274, 4808.278758186265, 4823.53999460276, 4153.1486045360625, 4598.873276047357, 4678.111158879819, 4805.3753012108555, 4806.158922188621, 4234.788260586958, 4262.744235345889, 4262.808173632194, 4279.443672322609, 4306.160298741746, 6239.688015599202, 6246.531510136712, 6249.312575616678, 6253.37466253371, 6266.373362663743, 5516.503514683657, 5705.686187259699, 5730.083186690152, 5752.165935939307, 5781.9763082920645, 6807.761728339485, 6817.761378351734, 6819.693113809891, 6820.590764554143, 6834.521583489158, 4225.72532785368, 4619.960508885508, 4800.519948005206, 4806.53880423909, 4874.2444921037295, 6147.323794382614, 6889.379955804002, 7116.822079448003, 7237.819054523679, 7264.418846492268, 4014.815629389337, 4436.0906014267, 4567.885802854888, 4772.618190544748, 4797.304390863305, 3686.760360576554, 3690.372636651776, 4643.721376717408, 4855.757212139379, 4857.611391088704, 5203.855151866584, 5358.732063396893, 5500.28496295479, 5501.862453438696, 5550.27846379968, 5376.381716102698, 6234.407731265614, 6262.903991801417, 6656.633885136267, 6775.322467753185, 1530.5102367242598, 1674.3386362387032, 1732.7834020747407, 1749.0380290839987, 1750.3436211420717, 1051.9007637019333, 1157.7915975124558, 1169.3334799164395, 1199.3103965220034, 1208.8005479096028, 6262.279837818709, 6287.245530536365, 6295.464885484694, 6304.495640348761, 6311.33730958252, 6640.576189690728, 6937.0, 6962.199347075049, 6981.581105133709, 6986.231514533397, 6255.937440625627, 6261.373862613702, 6316.778912738124, 6320.968395158086, 6336.619802811846, 2873.726995935383, 3649.8540058397366, 3660.524131862841, 3668.926621467556, 3682.392405253157, 6800.319968003259, 7148.678309476086, 7234.819129521804, 7245.000949344935, 7245.384142347854, 7178.641067946582, 7205.675744591506, 7247.383972362408, 7274.945132955691, 7299.927000729925, 6950.733155416946, 7148.035015272975, 7199.424046076301, 7219.530730502501, 7249.383802376751, 6795.45636349081, 6903.0680858083515, 7037.944308353788, 7040.3663670269925, 7051.964740176471, 5524.281843360337, 6848.760293389708, 6908.5509441886115, 6920.858058420506, 6940.6529673515115, 5806.970965145148, 6576.605403675795, 6999.0, 7245.818854528679, 7271.781846544613, 4566.45202575693, 4588.2429399150105, 4588.609968152745, 4589.485469794893, 4603.884902877455, 6019.849503762266, 6686.498512611671, 7026.0678313464205, 7057.4473615804445, 7058.11773528309, 5533.3083364579425, 5834.94165058344, 6020.367861374492, 6644.601323920387, 6755.0, 5547.945890280834, 6462.4183823456115, 6733.858676913761, 6802.523823332517, 6819.659017049028, 6318.968405157945, 6514.185726784152, 6548.377904099103, 6639.40245377899, 6659.167604049494, 6483.481321494175, 6760.9520524318805, 6788.253292137762, 6798.422134118655, 6810.9318906810295, 5195.402528709247, 6566.540342176193, 6589.374009469093, 6592.802490792058, 6630.30381809903], "value": 4979.917915619823, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.4042689263728, 835.5905606252934, 858.502068800096, 858.7380848841103, 873.3144481581959, 16412.0, 16767.161641917915, 16772.1613919304, 18054.097295135256, 18698.345557905475, 17545.649087018253, 17845.7323140153, 17964.730529042074, 17969.73045404317, 18008.279668813266, 951.1914872358509, 958.2860768727273, 971.0920289529278, 976.3946353260989, 977.4917043137564, 886.5035580075146, 919.5172534419416, 957.248559880494, 991.7223177510309, 997.7755005123826, 981.0826876870113, 1003.4781913405025, 1020.7142000239945, 1023.4575674892282, 1025.7897131088146, 981.3130808434089, 1006.4062203300051, 1026.112412762962, 1026.7741096958657, 1027.1679939249232, 725.5392825555757, 727.9126504819402, 748.928851759082, 753.5365750063726, 762.9008228930259, 16134.435294764744, 16306.429274975319, 16407.753883691756, 16411.261493232832, 16425.09661968591, 16634.6673066538, 17086.48740537786, 17356.0, 17546.736798948026, 17568.824311756845, 13671.992161724405, 13712.0, 13819.378127984264, 13883.930580347134, 14009.439622415091, 3484.0418884806627, 3541.061618671054, 3567.6253993330847, 3573.76770509916, 3573.928521429583, 133866.33066834701, 134040.0, 135238.97141542885, 137263.31368343194, 137785.0, 13161.407736651874, 13177.077604567588, 13219.603411897659, 13302.866971330162, 13351.332433378293, 25079.62380564293, 25205.369865753135, 25355.746442535707, 25516.744832551438, 25591.744082559308, 7575.621218939031, 7634.4655874088285, 7655.923440765521, 7732.188120247293, 7776.961115194388, 3813.828377723009, 3873.0898238913833, 3888.766673999569, 3888.805559722059, 3904.0, 4324.286492728727, 4347.630451411602, 4379.978100109479, 4405.867823965286, 4435.733855968652, 896.5382827843666, 905.7282815155427, 913.6391125505388, 918.9632414703337, 919.7792529792802, 548.9039418101896, 613.6655522740117, 650.2424675253371, 677.11298199359, 691.6921969723526, 10190.592376305012, 10739.785204295871, 11833.585824496102, 11864.76270474603, 11894.226875253082, 567.29088639201, 656.6224420957968, 671.6238906212536, 675.1594265139834, 690.0925283252507, 4177.56135605757, 5000.524950129732, 5303.761330740126, 5330.227117068003, 5487.067198576252, 64020.67989660115, 97542.0, 100073.49963250138, 100111.49944250377, 102821.0, 71605.64197179084, 78555.0, 87062.0, 87241.12758872457, 90208.0, 81865.77201341985, 82398.58800706078, 82914.17085829185, 83616.58191709002, 84920.0, 11000.944995274973, 11278.323300601991, 12750.808737868754, 12930.806037909628, 12947.482100716243, 33156.1710957228, 39361.40957885577, 40804.79597601993, 41547.16905661809, 42390.78804605957, 52743.73628131835, 52979.0, 53302.73348633232, 53481.465185347646, 54229.0, 16082.954607950445, 16154.192290385668, 16298.26657800378, 16382.918085409498, 16412.343506259615, 17728.822711773235, 18142.5464363392, 18173.273069077088, 18373.448796536126, 18578.81421185771, 16354.754678679592, 16383.59041023984, 16909.577260568585, 16975.915120424812, 17094.743578846577, 16709.479759058537, 16728.33086676568, 16740.581485462473, 17135.971841689538, 17141.48575542736, 16088.27602757902, 16259.430919917746, 16463.012219266882, 16546.83453165501, 16664.83335166633, 11549.48027338755, 11792.174547781573, 11815.822762658396, 11871.465784039567, 11961.521539138337, 12937.353132343533, 13495.392707327997, 13824.559309219818, 13925.23411212393, 13932.721345573234], "value": 8294.992317252545, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1599.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 123.0, 174.0, 165.0, 113.0, 116.0, 114.0, 114.0], "value": 125.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 111.0, 111.0, 147.0, 113.0, 109.0, 109.0, 112.0, 156.0, 115.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 199.0, 204.0, 226.0, 211.0, 275.0, 282.0, 199.0, 199.0, 194.0], "value": 218.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 64.0, 93.0, 73.0, 81.0, 50.0, 60.0, 70.0, 90.0, 85.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 108.0, 109.0, 105.0, 81.0, 90.0, 70.0, 72.0, 92.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 88.0, 89.0, 102.0, 87.0, 89.0, 88.0, 88.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 104.0, 119.0, 157.0, 95.0, 97.0, 98.0, 97.0, 121.0, 133.0], "value": 111.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 90.0, 141.0, 77.0, 140.0, 146.0, 94.0, 138.0, 88.0, 138.0], "value": 117.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 50.0, 51.0, 51.0, 50.0, 49.0, 51.0, 50.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 72.0, 84.0, 99.0, 58.0, 72.0, 85.0, 83.0, 85.0, 56.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 84.0, 85.0, 85.0, 83.0, 84.0, 85.0, 83.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 144.0, 148.0, 125.0, 146.0, 150.0, 159.0, 164.0, 214.0, 139.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 177.0, 235.0, 234.0, 183.0, 223.0, 203.0, 241.0, 204.0, 237.0], "value": 211.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 59.0, 61.0, 71.0, 61.0, 86.0, 99.0, 99.0, 102.0], "value": 77.7, "unit": "score"}]}]} 12:05:54 INFO - Return code: 0 12:05:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:05:54 ERROR - # TBPL SUCCESS # 12:05:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:05:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:05:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:05:54 INFO - 2017-04-20 12:05:54.771 screenresolution[1936:18924] starting screenresolution argv=screenresolution get 12:05:54 INFO - 2017-04-20 12:05:54.773 screenresolution[1936:18924] Display 0: 1600x1200x32@60 12:05:54 INFO - 2017-04-20 12:05:54.779 screenresolution[1937:18927] starting screenresolution argv=screenresolution list 12:05:54 INFO - Available Modes on Display 0 12:05:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:05:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:05:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:05:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:05:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:05:55 INFO - Intel Iris: 12:05:55 INFO - Chipset Model: Intel Iris 12:05:55 INFO - Type: GPU 12:05:55 INFO - Bus: Built-In 12:05:55 INFO - VRAM (Dynamic, Max): 1536 MB 12:05:55 INFO - Vendor: Intel (0x8086) 12:05:55 INFO - Device ID: 0x0a2e 12:05:55 INFO - Revision ID: 0x0009 12:05:55 INFO - Displays: 12:05:55 INFO - Display: 12:05:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:05:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:05:55 INFO - Display Serial Number: 1600x1200 60 12:05:55 INFO - Main Display: Yes 12:05:55 INFO - Mirror: Off 12:05:55 INFO - Online: Yes 12:05:55 INFO - Rotation: Supported 12:05:55 INFO - Return code: 0 12:05:55 INFO - Running post-action listener: _resource_record_post_action 12:05:55 INFO - [mozharness: 2017-04-20 19:05:55.014558Z] Finished run-tests step (success) 12:05:55 INFO - Running post-run listener: _resource_record_post_run 12:05:55 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 950272; Write bytes: 519758848; Read time: 8; Write time: 1659 12:05:55 INFO - TinderboxPrint: CPU usage
54.2% 12:05:55 INFO - TinderboxPrint: I/O read bytes / time
950,272 / 8 12:05:55 INFO - TinderboxPrint: I/O write bytes / time
519,758,848 / 1,659 12:05:55 INFO - TinderboxPrint: CPU idle
2,197.5 (45.8%) 12:05:55 INFO - TinderboxPrint: CPU system
965.7 (20.1%) 12:05:55 INFO - TinderboxPrint: CPU user
1,630.4 (34.0%) 12:05:55 INFO - TinderboxPrint: Swap in / out
209,309,696 / 0 12:05:55 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 193698304; Write bytes: 195180032; Read time: 14963; Write time: 443 12:05:55 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 950272; Write bytes: 307752448; Read time: 8; Write time: 1163 12:05:55 INFO - Running post-run listener: _upload_blobber_files 12:05:55 INFO - Blob upload gear active. 12:05:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:05:55 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 12:05:55 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:05:55 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:05:55 INFO - (blobuploader) - INFO - Open directory for files ... 12:05:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:05:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:05:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:57 INFO - (blobuploader) - INFO - Done attempting. 12:05:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:05:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:05:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:58 INFO - (blobuploader) - INFO - Done attempting. 12:05:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:05:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:05:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:59 INFO - (blobuploader) - INFO - Done attempting. 12:05:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:05:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:06:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:02 INFO - (blobuploader) - INFO - Done attempting. 12:06:02 INFO - (blobuploader) - INFO - Iteration through files over. 12:06:02 INFO - Return code: 0 12:06:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:06:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:06:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9752a4f734c1ba0830bf14d0994a0d317970e5460ee68b0e7232ed2f1292babc511106ee3f1b30b0d630dabaf796270285e538fce621fec381715fc24ea1c02a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b606eb8d06f86783d277b502805709ce4ad611d3243e6c3d8421aeae297bfa68614778cd3c01dd76678a438b6ea2fbda941d513e7fef6bceab2ec47bbd6d5d6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c12f97bb2155585c0e3da6222791d928e0e32620e41ea5768812723cdab4b3c0fb3957505e7930715700e135bd6fa6b7606d18b90c83a5d60f1ead7c4c60622e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c70ce3a562bb5df54a7339fd9a55a52b5c5d5285dc703047979375712a662a7294ffc3ef3d178ce1c15bdea6fd8be9ec7e706f6723491973c4ea495d50918538"} 12:06:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:06:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:06:02 INFO - Contents: 12:06:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9752a4f734c1ba0830bf14d0994a0d317970e5460ee68b0e7232ed2f1292babc511106ee3f1b30b0d630dabaf796270285e538fce621fec381715fc24ea1c02a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b606eb8d06f86783d277b502805709ce4ad611d3243e6c3d8421aeae297bfa68614778cd3c01dd76678a438b6ea2fbda941d513e7fef6bceab2ec47bbd6d5d6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c12f97bb2155585c0e3da6222791d928e0e32620e41ea5768812723cdab4b3c0fb3957505e7930715700e135bd6fa6b7606d18b90c83a5d60f1ead7c4c60622e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c70ce3a562bb5df54a7339fd9a55a52b5c5d5285dc703047979375712a662a7294ffc3ef3d178ce1c15bdea6fd8be9ec7e706f6723491973c4ea495d50918538"} 12:06:02 INFO - Running post-run listener: copy_logs_to_upload_dir 12:06:02 INFO - Copying logs to upload dir... 12:06:02 INFO - mkdir: /builds/slave/test/build/upload/logs 12:06:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.419068 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-20 12:06:02.885233) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 12:06:02.889160) ========= 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.HoZcXubeJg/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.fplvsWnEYr/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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/Pine/sha512/9752a4f734c1ba0830bf14d0994a0d317970e5460ee68b0e7232ed2f1292babc511106ee3f1b30b0d630dabaf796270285e538fce621fec381715fc24ea1c02a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b606eb8d06f86783d277b502805709ce4ad611d3243e6c3d8421aeae297bfa68614778cd3c01dd76678a438b6ea2fbda941d513e7fef6bceab2ec47bbd6d5d6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c12f97bb2155585c0e3da6222791d928e0e32620e41ea5768812723cdab4b3c0fb3957505e7930715700e135bd6fa6b7606d18b90c83a5d60f1ead7c4c60622e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c70ce3a562bb5df54a7339fd9a55a52b5c5d5285dc703047979375712a662a7294ffc3ef3d178ce1c15bdea6fd8be9ec7e706f6723491973c4ea495d50918538"} build_url:https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/as2WP9X-TmKRGPggNVHlsg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9752a4f734c1ba0830bf14d0994a0d317970e5460ee68b0e7232ed2f1292babc511106ee3f1b30b0d630dabaf796270285e538fce621fec381715fc24ea1c02a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b606eb8d06f86783d277b502805709ce4ad611d3243e6c3d8421aeae297bfa68614778cd3c01dd76678a438b6ea2fbda941d513e7fef6bceab2ec47bbd6d5d6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c12f97bb2155585c0e3da6222791d928e0e32620e41ea5768812723cdab4b3c0fb3957505e7930715700e135bd6fa6b7606d18b90c83a5d60f1ead7c4c60622e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c70ce3a562bb5df54a7339fd9a55a52b5c5d5285dc703047979375712a662a7294ffc3ef3d178ce1c15bdea6fd8be9ec7e706f6723491973c4ea495d50918538"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 12:06:02.924154) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 12:06:02.924479) ========= 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.HoZcXubeJg/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.fplvsWnEYr/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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.005187 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 12:06:02.973670) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 12:06:02.973997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 12:06:02.974323) ========= ========= Total master_lag: 0.20 =========