builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0384 starttime: 1488111367.61 results: success (0) buildid: 20170226041552 builduid: c157c7d1d2864e61b640849e3d46bf03 revision: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:07.605685) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:07.606093) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:07.606372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:07.656772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:07.657051) ========= 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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners TMPDIR=/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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-02-26 04:16:07-- 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% 8.21M=0.001s 2017-02-26 04:16:07 (8.21 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124426 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:07.808859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:07.809224) ========= 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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners TMPDIR=/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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.019894 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:07.858341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-26 04:16:07.861998) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8GXs3ayNFy/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.Lim5bgn7xS/Listeners TMPDIR=/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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-02-26 04:16:07,958 truncating revision to first 12 chars 2017-02-26 04:16:07,959 Setting DEBUG logging. 2017-02-26 04:16:07,959 attempt 1/10 2017-02-26 04:16:07,959 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fc9f6f7e8e86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-26 04:16:09,737 unpacking tar archive at: mozilla-central-fc9f6f7e8e86/testing/mozharness/ program finished with exit code 0 elapsedTime=2.032694 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-26 04:16:09.920735) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:09.921034) ========= script_repo_revision: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:09.921421) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:09.921680) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-26 04:16:09.979933) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-26 04:16:09.980491) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8GXs3ayNFy/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.Lim5bgn7xS/Listeners TMPDIR=/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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 04:16:10 INFO - MultiFileLogger online at 20170226 04:16:10 in /builds/slave/test 04:16:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:16:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:10 INFO - {'append_to_log': False, 04:16:10 INFO - 'base_work_dir': '/builds/slave/test', 04:16:10 INFO - 'blob_upload_branch': 'Firefox', 04:16:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:10 INFO - 'branch': 'Firefox', 04:16:10 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:10 INFO - 'config_files': ('talos/mac_config.py',), 04:16:10 INFO - 'default_actions': ('clobber', 04:16:10 INFO - 'read-buildbot-config', 04:16:10 INFO - 'download-and-extract', 04:16:10 INFO - 'populate-webroot', 04:16:10 INFO - 'create-virtualenv', 04:16:10 INFO - 'install', 04:16:10 INFO - 'run-tests'), 04:16:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:10 INFO - 'download_minidump_stackwalk': True, 04:16:10 INFO - 'download_symbols': 'ondemand', 04:16:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:10 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:10 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:10 INFO - 'installer_path': 'installer.exe', 04:16:10 INFO - 'log_level': 'info', 04:16:10 INFO - 'log_name': 'talos', 04:16:10 INFO - 'log_to_console': True, 04:16:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:16:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:16:10 INFO - 'opt_config_files': (), 04:16:10 INFO - 'pip_index': False, 04:16:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:16:10 INFO - 'cmd': ('bash', 04:16:10 INFO - '-c', 04:16:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:16:10 INFO - 'enabled': True, 04:16:10 INFO - 'halt_on_failure': False, 04:16:10 INFO - 'name': 'check_screen_resolution'},), 04:16:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:16:10 INFO - 'cmd': ('bash', 04:16:10 INFO - '-c', 04:16:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:16:10 INFO - 'enabled': True, 04:16:10 INFO - 'halt_on_failure': False, 04:16:10 INFO - 'name': 'check_screen_resolution'},), 04:16:10 INFO - 'run_cmd_checks_enabled': True, 04:16:10 INFO - 'sps_profile': False, 04:16:10 INFO - 'sps_profile_interval': 0, 04:16:10 INFO - 'suite': 'dromaeojs-e10s', 04:16:10 INFO - 'system_bits': '32', 04:16:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:10 INFO - 'title': 't-yosemite-r7-0384', 04:16:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:10 INFO - 'use_talos_json': True, 04:16:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:10 INFO - 'work_dir': 'build'} 04:16:10 INFO - [mozharness: 2017-02-26 12:16:10.228587Z] Running clobber step. 04:16:10 INFO - Running pre-action listener: _resource_record_pre_action 04:16:10 INFO - Running main action method: clobber 04:16:10 INFO - rmtree: /builds/slave/test/build 04:16:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:11 INFO - Running post-action listener: _resource_record_post_action 04:16:11 INFO - [mozharness: 2017-02-26 12:16:11.159202Z] Finished clobber step (success) 04:16:11 INFO - [mozharness: 2017-02-26 12:16:11.159378Z] Running read-buildbot-config step. 04:16:11 INFO - Running pre-action listener: _resource_record_pre_action 04:16:11 INFO - Running main action method: read_buildbot_config 04:16:11 INFO - Using buildbot properties: 04:16:11 INFO - { 04:16:11 INFO - "project": "", 04:16:11 INFO - "product": "firefox", 04:16:11 INFO - "script_repo_revision": "production", 04:16:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:16:11 INFO - "repository": "", 04:16:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:16:11 INFO - "buildid": "20170226041552", 04:16:11 INFO - "stage_platform": "macosx64", 04:16:11 INFO - "basedir": "/builds/slave/test", 04:16:11 INFO - "buildnumber": 98, 04:16:11 INFO - "platform": "yosemite_r7", 04:16:11 INFO - "mozci_request": { 04:16:11 INFO - "priority": -1, 04:16:11 INFO - "type": "trigger_all_talos_jobs", 04:16:11 INFO - "times": 1 04:16:11 INFO - }, 04:16:11 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:16:11 INFO - "slavebuilddir": "test", 04:16:11 INFO - "branch": "mozilla-central", 04:16:11 INFO - "revision": "fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd", 04:16:11 INFO - "slavename": "t-yosemite-r7-0384", 04:16:11 INFO - "builduid": "c157c7d1d2864e61b640849e3d46bf03", 04:16:11 INFO - "repo_path": "mozilla-central" 04:16:11 INFO - } 04:16:11 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg. 04:16:11 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json. 04:16:11 INFO - Running post-action listener: _resource_record_post_action 04:16:11 INFO - [mozharness: 2017-02-26 12:16:11.163142Z] Finished read-buildbot-config step (success) 04:16:11 INFO - [mozharness: 2017-02-26 12:16:11.163251Z] Running download-and-extract step. 04:16:11 INFO - Running pre-action listener: _resource_record_pre_action 04:16:11 INFO - Running main action method: download_and_extract 04:16:11 INFO - mkdir: /builds/slave/test/build/tests 04:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:11 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json 04:16:11 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:16:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:16:11 INFO - Downloaded 1199 bytes. 04:16:11 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:16:11 INFO - Using the following test package requirements: 04:16:11 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:16:11 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:11 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:16:11 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:11 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:16:11 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:11 INFO - u'jsshell-mac.zip'], 04:16:11 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:11 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:16:11 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:16:11 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:11 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:16:11 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:11 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:16:11 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:11 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:16:11 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:16:11 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:16:11 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:16:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip 04:16:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:16:11 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:16:14 INFO - Expected file size: 51504348 04:16:14 INFO - Obtained file size: 51504348 04:16:29 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:16:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip 04:16:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:16:29 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:16:30 INFO - Expected file size: 51504348 04:16:30 INFO - Obtained file size: 51504348 04:16:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.talos.tests.zip 04:16:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:16:45 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:16:49 INFO - Expected file size: 14403647 04:16:49 INFO - Obtained file size: 14403647 04:16: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')]} 04:16:49 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 04:16:49 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:16:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:16:53 INFO - Downloaded 70417704 bytes. 04:16:53 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 04:16:53 INFO - mkdir: /builds/slave/test/properties 04:16:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:53 INFO - Contents: 04:16:53 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 04:16:54 INFO - Running post-action listener: _resource_record_post_action 04:16:54 INFO - Running post-action listener: set_extra_try_arguments 04:16:54 INFO - [mozharness: 2017-02-26 12:16:54.411292Z] Finished download-and-extract step (success) 04:16:54 INFO - [mozharness: 2017-02-26 12:16:54.411447Z] Running populate-webroot step. 04:16:54 INFO - Running pre-action listener: _resource_record_pre_action 04:16:54 INFO - Running main action method: populate_webroot 04:16:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:54 INFO - '--tppagecycles', 04:16:54 INFO - '7'], 04:16:54 INFO - 'tests': ['tsvgm']}}, 04:16:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:16:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:16:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:16:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:16:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:16:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:16:54 INFO - 'talos_options': ['--disable-e10s'], 04:16:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:16:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:16:54 INFO - 'talos_options': ['--disable-e10s'], 04:16:54 INFO - 'tests': ['damp', 'tps']}, 04:16:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:16:54 INFO - 'tests': ['damp', 'tps']}, 04:16:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:16:54 INFO - 'tests': ['dromaeo_dom']}, 04:16:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:16:54 INFO - 'tests': ['basic_compositor_video']}, 04:16:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:16:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:16:54 INFO - 'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore', 04:16:54 INFO - 'tabpaint']}, 04:16:54 INFO - 'other-e10s': {'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore', 04:16:54 INFO - 'tabpaint']}, 04:16:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore', 04:16:54 INFO - 'tabpaint']}, 04:16:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore', 04:16:54 INFO - 'tabpaint']}, 04:16:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:16:54 INFO - 'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore', 04:16:54 INFO - 'tabpaint']}, 04:16:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:16:54 INFO - 'tests': ['a11yr', 04:16:54 INFO - 'ts_paint', 04:16:54 INFO - 'tpaint', 04:16:54 INFO - 'sessionrestore', 04:16:54 INFO - 'sessionrestore_no_auto_restore', 04:16:54 INFO - 'tabpaint']}, 04:16:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:16:54 INFO - 'tests': ['tsvgx', 04:16:54 INFO - 'tsvgr_opacity', 04:16:54 INFO - 'tart', 04:16:54 INFO - 'tscrollx', 04:16:54 INFO - 'cart', 04:16:54 INFO - 'tsvg_static']}, 04:16:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:16:54 INFO - 'tsvgr_opacity', 04:16:54 INFO - 'tart', 04:16:54 INFO - 'tscrollx', 04:16:54 INFO - 'cart', 04:16:54 INFO - 'tsvg_static']}, 04:16:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:16:54 INFO - 'talos_options': ['--disable-e10s'], 04:16:54 INFO - 'tests': ['tp5o']}, 04:16:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:16:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:16:54 INFO - 'talos_options': ['--disable-e10s', 04:16:54 INFO - '--xperf_path', 04:16:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:54 INFO - 'tests': ['tp5n']}, 04:16:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:16:54 INFO - 'talos_options': ['--xperf_path', 04:16:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:54 INFO - 'tests': ['tp5n']}}, 04:16:54 INFO - 'talos.zip': {'path': '', 04:16:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:54 INFO - Running post-action listener: _resource_record_post_action 04:16:54 INFO - [mozharness: 2017-02-26 12:16:54.429615Z] Finished populate-webroot step (success) 04:16:54 INFO - [mozharness: 2017-02-26 12:16:54.429744Z] Running create-virtualenv step. 04:16:54 INFO - Running pre-action listener: _resource_record_pre_action 04:16:54 INFO - Running main action method: create_virtualenv 04:16:54 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:54 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 04:16:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:54 INFO - Using real prefix '/tools/python27' 04:16:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:55 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:58 INFO - Installing pip.................done. 04:16:58 INFO - Return code: 0 04:16:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:16:58 INFO - Reading from file tmpfile_stdout 04:16:58 INFO - Output received: 04:16:58 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) 04:16:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:58 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 0x10df46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bead80aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd24d30>, '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 0x10dc4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd19be8>, '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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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 04:16:58 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 04:16:58 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 04:16:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GXs3ayNFy/Render', 04:16:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:58 INFO - 'HOME': '/Users/cltbld', 04:16:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:58 INFO - 'LOGNAME': 'cltbld', 04:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:58 INFO - 'MOZ_NO_REMOTE': '1', 04:16:58 INFO - 'NO_EM_RESTART': '1', 04:16:58 INFO - 'PAGER': '/bin/cat', 04:16:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:58 INFO - 'PWD': '/builds/slave/test', 04:16:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:58 INFO - 'SHELL': '/bin/bash', 04:16:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lim5bgn7xS/Listeners', 04:16:58 INFO - 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/', 04:16:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:58 INFO - 'USER': 'cltbld', 04:16:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:58 INFO - 'XPC_FLAGS': '0x0', 04:16:58 INFO - 'XPC_SERVICE_NAME': '0', 04:16:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:58 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 04:16:58 INFO - Cleaning up... 04:16:58 INFO - Return code: 0 04:16:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:58 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 0x10df46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bead80aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd24d30>, '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 0x10dc4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd19be8>, '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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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 04:16:58 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 04:16:58 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 04:16:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GXs3ayNFy/Render', 04:16:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:58 INFO - 'HOME': '/Users/cltbld', 04:16:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:58 INFO - 'LOGNAME': 'cltbld', 04:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:58 INFO - 'MOZ_NO_REMOTE': '1', 04:16:58 INFO - 'NO_EM_RESTART': '1', 04:16:58 INFO - 'PAGER': '/bin/cat', 04:16:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:58 INFO - 'PWD': '/builds/slave/test', 04:16:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:58 INFO - 'SHELL': '/bin/bash', 04:16:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lim5bgn7xS/Listeners', 04:16:58 INFO - 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/', 04:16:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:58 INFO - 'USER': 'cltbld', 04:16:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:58 INFO - 'XPC_FLAGS': '0x0', 04:16:58 INFO - 'XPC_SERVICE_NAME': '0', 04:16:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:58 INFO - Downloading/unpacking psutil>=3.1.1 04:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:17:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:02 INFO - Installing collected packages: psutil 04:17:02 INFO - Running setup.py install for psutil 04:17:02 INFO - building 'psutil._psutil_osx' extension 04:17:02 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 04:17:02 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 04:17:02 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 04:17:02 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 04:17:03 INFO - building 'psutil._psutil_posix' extension 04:17:03 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 04:17:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:17:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:17:03 INFO - ^ 04:17:03 INFO - 1 warning generated. 04:17:03 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 04:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:03 INFO - Successfully installed psutil 04:17:03 INFO - Cleaning up... 04:17:03 INFO - Return code: 0 04:17:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bead80aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd24d30>, '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 0x10dc4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd19be8>, '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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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 04:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:17:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GXs3ayNFy/Render', 04:17:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:03 INFO - 'HOME': '/Users/cltbld', 04:17:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:03 INFO - 'LOGNAME': 'cltbld', 04:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:03 INFO - 'MOZ_NO_REMOTE': '1', 04:17:03 INFO - 'NO_EM_RESTART': '1', 04:17:03 INFO - 'PAGER': '/bin/cat', 04:17:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:03 INFO - 'PWD': '/builds/slave/test', 04:17:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:03 INFO - 'SHELL': '/bin/bash', 04:17:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lim5bgn7xS/Listeners', 04:17:03 INFO - 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/', 04:17:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:03 INFO - 'USER': 'cltbld', 04:17:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:03 INFO - 'XPC_FLAGS': '0x0', 04:17:03 INFO - 'XPC_SERVICE_NAME': '0', 04:17:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:17:06 INFO - Installing collected packages: mozsystemmonitor 04:17:06 INFO - Running setup.py install for mozsystemmonitor 04:17:06 INFO - Successfully installed mozsystemmonitor 04:17:06 INFO - Cleaning up... 04:17:07 INFO - Return code: 0 04:17:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:17:07 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')]} 04:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:07 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')]} 04:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:07 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 0x10df46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bead80aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd24d30>, '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 0x10dc4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd19be8>, '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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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 04:17:07 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 04:17:07 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 04:17:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GXs3ayNFy/Render', 04:17:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:07 INFO - 'HOME': '/Users/cltbld', 04:17:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:07 INFO - 'LOGNAME': 'cltbld', 04:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:07 INFO - 'MOZ_NO_REMOTE': '1', 04:17:07 INFO - 'NO_EM_RESTART': '1', 04:17:07 INFO - 'PAGER': '/bin/cat', 04:17:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:07 INFO - 'PWD': '/builds/slave/test', 04:17:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:07 INFO - 'SHELL': '/bin/bash', 04:17:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lim5bgn7xS/Listeners', 04:17:07 INFO - 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/', 04:17:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:07 INFO - 'USER': 'cltbld', 04:17:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:07 INFO - 'XPC_FLAGS': '0x0', 04:17:07 INFO - 'XPC_SERVICE_NAME': '0', 04:17:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:07 INFO - Downloading/unpacking jsonschema==2.5.1 04:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:17:09 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 04:17:09 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 04:17:09 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 04:17:09 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 04:17:09 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 04:17:09 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 04:17:10 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:10 INFO - warning: no files found matching '*.txt' 04:17:10 INFO - no previously-included directories found matching 'build' 04:17:10 INFO - no previously-included directories found matching 'dist' 04:17:10 INFO - no previously-included directories found matching '.git*' 04:17:10 INFO - Installing collected packages: jsonschema, functools32 04:17:10 INFO - Running setup.py install for functools32 04:17:10 INFO - warning: no files found matching '*.txt' 04:17:10 INFO - no previously-included directories found matching 'build' 04:17:10 INFO - no previously-included directories found matching 'dist' 04:17:10 INFO - no previously-included directories found matching '.git*' 04:17:10 INFO - Successfully installed jsonschema functools32 04:17:10 INFO - Cleaning up... 04:17:10 INFO - Return code: 0 04:17:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10df46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bead80aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd24d30>, '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 0x10dc4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd19be8>, '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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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 04:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:17:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GXs3ayNFy/Render', 04:17:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:10 INFO - 'HOME': '/Users/cltbld', 04:17:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:10 INFO - 'LOGNAME': 'cltbld', 04:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:10 INFO - 'MOZ_NO_REMOTE': '1', 04:17:10 INFO - 'NO_EM_RESTART': '1', 04:17:10 INFO - 'PAGER': '/bin/cat', 04:17:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:10 INFO - 'PWD': '/builds/slave/test', 04:17:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:10 INFO - 'SHELL': '/bin/bash', 04:17:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lim5bgn7xS/Listeners', 04:17:10 INFO - 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/', 04:17:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:10 INFO - 'USER': 'cltbld', 04:17:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:10 INFO - 'XPC_FLAGS': '0x0', 04:17:10 INFO - 'XPC_SERVICE_NAME': '0', 04:17:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:17:10 INFO - Cleaning up... 04:17:10 INFO - Return code: 0 04:17:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10df46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bead80aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd24d30>, '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 0x10dc4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd19be8>, '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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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 04:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:17:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GXs3ayNFy/Render', 04:17:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:10 INFO - 'HOME': '/Users/cltbld', 04:17:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:10 INFO - 'LOGNAME': 'cltbld', 04:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:10 INFO - 'MOZ_NO_REMOTE': '1', 04:17:10 INFO - 'NO_EM_RESTART': '1', 04:17:10 INFO - 'PAGER': '/bin/cat', 04:17:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:10 INFO - 'PWD': '/builds/slave/test', 04:17:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:10 INFO - 'SHELL': '/bin/bash', 04:17:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lim5bgn7xS/Listeners', 04:17:10 INFO - 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/', 04:17:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:10 INFO - 'USER': 'cltbld', 04:17:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:10 INFO - 'XPC_FLAGS': '0x0', 04:17:10 INFO - 'XPC_SERVICE_NAME': '0', 04:17:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:11 INFO - Downloading/unpacking blobuploader==1.2.4 04:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:13 INFO - Downloading blobuploader-1.2.4.tar.gz 04:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:17:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:17:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:15 INFO - Downloading docopt-0.6.1.tar.gz 04:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:17:15 INFO - Installing collected packages: blobuploader, requests, docopt 04:17:15 INFO - Running setup.py install for blobuploader 04:17:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:17:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:17:15 INFO - Running setup.py install for requests 04:17:15 INFO - Running setup.py install for docopt 04:17:16 INFO - Successfully installed blobuploader requests docopt 04:17:16 INFO - Cleaning up... 04:17:16 INFO - Return code: 0 04:17:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:16 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 0x10df46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bead80aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd24d30>, '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 0x10dc4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd19be8>, '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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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 04:17:16 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 04:17:16 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 04:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GXs3ayNFy/Render', 04:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:16 INFO - 'HOME': '/Users/cltbld', 04:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:16 INFO - 'LOGNAME': 'cltbld', 04:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:16 INFO - 'MOZ_NO_REMOTE': '1', 04:17:16 INFO - 'NO_EM_RESTART': '1', 04:17:16 INFO - 'PAGER': '/bin/cat', 04:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:16 INFO - 'PWD': '/builds/slave/test', 04:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:16 INFO - 'SHELL': '/bin/bash', 04:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lim5bgn7xS/Listeners', 04:17:16 INFO - 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/', 04:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:16 INFO - 'USER': 'cltbld', 04:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:16 INFO - 'XPC_FLAGS': '0x0', 04:17:16 INFO - 'XPC_SERVICE_NAME': '0', 04:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:16 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-voUtE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:16 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-oNy2IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:16 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-s7USev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:16 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-n81flO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:16 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-0JDdv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:16 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-fkKPf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:17 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-GjzGqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:17 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-hLGH7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:17 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-kVX9A0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:17 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-OEQUxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:17 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-O3GalS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:17 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-WMcEr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:17 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-KPLP8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:17 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-gsjvb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:17 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-QzPfYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:17 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-0WlD_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:18 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-zLoI34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:17:18 INFO - Running setup.py install for manifestparser 04:17:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:17:18 INFO - Running setup.py install for mozcrash 04:17:18 INFO - Running setup.py install for mozdebug 04:17:18 INFO - Running setup.py install for mozdevice 04:17:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:17:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:17:18 INFO - Running setup.py install for mozfile 04:17:18 INFO - Running setup.py install for mozhttpd 04:17:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:17:19 INFO - Running setup.py install for mozinfo 04:17:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:17:19 INFO - Running setup.py install for mozInstall 04:17:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:17:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:17:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:17:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:17:19 INFO - Running setup.py install for mozleak 04:17:19 INFO - Running setup.py install for mozlog 04:17:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:17:19 INFO - Running setup.py install for moznetwork 04:17:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:17:19 INFO - Running setup.py install for mozprocess 04:17:20 INFO - Running setup.py install for mozprofile 04:17:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:17:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:17:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:17:20 INFO - Running setup.py install for mozrunner 04:17:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:17:20 INFO - Running setup.py install for mozscreenshot 04:17:20 INFO - Running setup.py install for moztest 04:17:20 INFO - Running setup.py install for mozversion 04:17:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:17:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:17:20 INFO - Cleaning up... 04:17:20 INFO - Return code: 0 04:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:20 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 0x10df46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bead80aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd24d30>, '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 0x10dc4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd19be8>, '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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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 04:17:20 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 04:17:20 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 04:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GXs3ayNFy/Render', 04:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:20 INFO - 'HOME': '/Users/cltbld', 04:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:20 INFO - 'LOGNAME': 'cltbld', 04:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:20 INFO - 'MOZ_NO_REMOTE': '1', 04:17:20 INFO - 'NO_EM_RESTART': '1', 04:17:20 INFO - 'PAGER': '/bin/cat', 04:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:20 INFO - 'PWD': '/builds/slave/test', 04:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:20 INFO - 'SHELL': '/bin/bash', 04:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lim5bgn7xS/Listeners', 04:17:20 INFO - 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/', 04:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:20 INFO - 'USER': 'cltbld', 04:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:20 INFO - 'XPC_FLAGS': '0x0', 04:17:20 INFO - 'XPC_SERVICE_NAME': '0', 04:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:21 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-X2kSwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:21 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)) 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:21 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-oCD1is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:21 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)) 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:21 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-WgaLJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:21 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)) 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:21 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-yPLurf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:21 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-CmeN_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:21 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)) 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:21 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-L1Zpcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:21 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)) 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:21 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-JQS4Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:21 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)) 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:21 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-IrFtFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:21 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)) 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:21 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-kYW1Zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:22 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)) 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:22 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-qercbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:22 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)) 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:22 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-87VYyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:22 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)) 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:22 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-7HTHMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:22 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-_LUu1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:22 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)) 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:22 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-ltxnvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:22 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)) 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:22 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-Y78Q2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:22 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)) 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:22 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-zS19cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:22 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)) 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:22 INFO - Running setup.py (path:/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/pip-BkEfeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:22 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)) 04:17:22 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)) 04:17:22 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)) 04:17:22 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)) 04:17:22 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:22 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:25 INFO - Downloading blessings-1.6.tar.gz 04:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:17:25 INFO - Installing collected packages: blessings 04:17:25 INFO - Running setup.py install for blessings 04:17:25 INFO - Successfully installed blessings 04:17:25 INFO - Cleaning up... 04:17:25 INFO - Return code: 0 04:17:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:17:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:26 INFO - Reading from file tmpfile_stdout 04:17:26 INFO - Current package versions: 04:17:26 INFO - blessings == 1.6 04:17:26 INFO - blobuploader == 1.2.4 04:17:26 INFO - docopt == 0.6.1 04:17:26 INFO - functools32 == 3.2.3-2 04:17:26 INFO - jsonschema == 2.5.1 04:17:26 INFO - manifestparser == 1.1 04:17:26 INFO - mozInstall == 1.12 04:17:26 INFO - mozcrash == 1.0 04:17:26 INFO - mozdebug == 0.1 04:17:26 INFO - mozdevice == 0.49 04:17:26 INFO - mozfile == 1.2 04:17:26 INFO - mozhttpd == 0.7 04:17:26 INFO - mozinfo == 0.9 04:17:26 INFO - mozleak == 0.1 04:17:26 INFO - mozlog == 3.4 04:17:26 INFO - moznetwork == 0.27 04:17:26 INFO - mozprocess == 0.24 04:17:26 INFO - mozprofile == 0.28 04:17:26 INFO - mozrunner == 6.13 04:17:26 INFO - mozscreenshot == 0.1 04:17:26 INFO - mozsystemmonitor == 0.3 04:17:26 INFO - moztest == 0.8 04:17:26 INFO - mozversion == 1.4 04:17:26 INFO - psutil == 3.1.1 04:17:26 INFO - requests == 1.2.3 04:17:26 INFO - wsgiref == 0.1.2 04:17:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:26 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 0x10df46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bead80aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd24d30>, '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 0x10dc4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd19be8>, '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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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 04:17:26 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 04:17:26 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 04:17:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GXs3ayNFy/Render', 04:17:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:26 INFO - 'HOME': '/Users/cltbld', 04:17:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:26 INFO - 'LOGNAME': 'cltbld', 04:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:26 INFO - 'MOZ_NO_REMOTE': '1', 04:17:26 INFO - 'NO_EM_RESTART': '1', 04:17:26 INFO - 'PAGER': '/bin/cat', 04:17:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:26 INFO - 'PWD': '/builds/slave/test', 04:17:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:26 INFO - 'SHELL': '/bin/bash', 04:17:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lim5bgn7xS/Listeners', 04:17:26 INFO - 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/', 04:17:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:26 INFO - 'USER': 'cltbld', 04:17:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:26 INFO - 'XPC_FLAGS': '0x0', 04:17:26 INFO - 'XPC_SERVICE_NAME': '0', 04:17:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:26 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)) 04:17:26 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)) 04:17:26 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)) 04:17:26 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)) 04:17:26 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)) 04:17:26 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)) 04:17:26 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)) 04:17:26 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)) 04:17:26 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)) 04:17:26 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)) 04:17:26 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)) 04:17:26 INFO - Cleaning up... 04:17:26 INFO - Return code: 0 04:17:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bead80aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd24d30>, '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 0x10dc4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd19be8>, '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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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 04:17:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:17:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GXs3ayNFy/Render', 04:17:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:26 INFO - 'HOME': '/Users/cltbld', 04:17:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:26 INFO - 'LOGNAME': 'cltbld', 04:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:26 INFO - 'MOZ_NO_REMOTE': '1', 04:17:26 INFO - 'NO_EM_RESTART': '1', 04:17:26 INFO - 'PAGER': '/bin/cat', 04:17:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:26 INFO - 'PWD': '/builds/slave/test', 04:17:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:26 INFO - 'SHELL': '/bin/bash', 04:17:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lim5bgn7xS/Listeners', 04:17:26 INFO - 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/', 04:17:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:26 INFO - 'USER': 'cltbld', 04:17:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:26 INFO - 'XPC_FLAGS': '0x0', 04:17:26 INFO - 'XPC_SERVICE_NAME': '0', 04:17:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:17:26 INFO - Cleaning up... 04:17:26 INFO - Return code: 0 04:17:26 INFO - Running post-action listener: _resource_record_post_action 04:17:26 INFO - Running post-action listener: _start_resource_monitoring 04:17:26 INFO - Starting resource monitoring. 04:17:26 INFO - [mozharness: 2017-02-26 12:17:26.791488Z] Finished create-virtualenv step (success) 04:17:26 INFO - [mozharness: 2017-02-26 12:17:26.792446Z] Running install step. 04:17:26 INFO - Running pre-action listener: _resource_record_pre_action 04:17:26 INFO - Running main action method: install 04:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:27 INFO - Reading from file tmpfile_stdout 04:17:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:17:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:17:27 INFO - Reading from file tmpfile_stdout 04:17:27 INFO - Output received: 04:17:27 INFO - Usage: mozinstall [options] installer 04:17:27 INFO - Options: 04:17:27 INFO - -h, --help show this help message and exit 04:17:27 INFO - -d DEST, --destination=DEST 04:17:27 INFO - Directory to install application into. [default: 04:17:27 INFO - "/builds/slave/test"] 04:17:27 INFO - --app=APP Application being installed. [default: firefox] 04:17:27 INFO - mkdir: /builds/slave/test/build/application 04:17:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:17:49 INFO - Reading from file tmpfile_stdout 04:17:49 INFO - Output received: 04:17:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:17:49 INFO - Running post-action listener: _resource_record_post_action 04:17:49 INFO - [mozharness: 2017-02-26 12:17:49.309133Z] Finished install step (success) 04:17:49 INFO - [mozharness: 2017-02-26 12:17:49.309267Z] Running run-tests step. 04:17:49 INFO - Running pre-action listener: _resource_record_pre_action 04:17:49 INFO - Running main action method: run_tests 04:17:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:17:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:17:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:17:49 INFO - 2017-02-26 04:17:49.323 screenresolution[2195:27034] starting screenresolution argv=screenresolution get 04:17:49 INFO - 2017-02-26 04:17:49.326 screenresolution[2195:27034] Display 0: 1600x1200x32@60 04:17:49 INFO - 2017-02-26 04:17:49.332 screenresolution[2196:27037] starting screenresolution argv=screenresolution list 04:17:49 INFO - Available Modes on Display 0 04:17:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:17:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:17:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:17:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:17:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:17:49 INFO - Intel Iris: 04:17:49 INFO - Chipset Model: Intel Iris 04:17:49 INFO - Type: GPU 04:17:49 INFO - Bus: Built-In 04:17:49 INFO - VRAM (Dynamic, Max): 1536 MB 04:17:49 INFO - Vendor: Intel (0x8086) 04:17:49 INFO - Device ID: 0x0a2e 04:17:49 INFO - Revision ID: 0x0009 04:17:49 INFO - Displays: 04:17:49 INFO - Display: 04:17:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:17:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:17:49 INFO - Display Serial Number: 1600x1200 60 04:17:49 INFO - Main Display: Yes 04:17:49 INFO - Mirror: Off 04:17:49 INFO - Online: Yes 04:17:49 INFO - Rotation: Supported 04:17:49 INFO - Return code: 0 04:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:17:49 INFO - Python 2.7.3 04:17:49 INFO - Return code: 0 04:17:49 INFO - grabbing minidump binary from tooltool 04:17: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')]} 04:17:49 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 0x10dd24d30>, '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 0x10dc4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd19be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:17:49 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 04:17:49 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 04:17:49 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 04:17:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:49 INFO - Return code: 0 04:17:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:17:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:17:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:17:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:17:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0384', '--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 04:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0384 --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 04:17:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GXs3ayNFy/Render', 04:17:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:49 INFO - 'HOME': '/Users/cltbld', 04:17:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:49 INFO - 'LOGNAME': 'cltbld', 04:17:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:49 INFO - 'MOZ_NO_REMOTE': '1', 04:17:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:49 INFO - 'NO_EM_RESTART': '1', 04:17:49 INFO - 'PAGER': '/bin/cat', 04:17:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:49 INFO - 'PWD': '/builds/slave/test', 04:17:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:49 INFO - 'SHELL': '/bin/bash', 04:17:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lim5bgn7xS/Listeners', 04:17:49 INFO - 'TMPDIR': '/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/', 04:17:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:49 INFO - 'USER': 'cltbld', 04:17:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:49 INFO - 'XPC_FLAGS': '0x0', 04:17:49 INFO - 'XPC_SERVICE_NAME': '0', 04:17:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0384', '--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 04:17:49 INFO - mozversion application_buildid: 20170214071445 04:17:49 INFO - mozversion application_changeset: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd 04:17:49 INFO - mozversion application_display_name: Nightly 04:17:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:49 INFO - mozversion application_name: Firefox 04:17:49 INFO - mozversion application_remotingname: firefox 04:17:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:17:49 INFO - mozversion application_vendor: Mozilla 04:17:49 INFO - mozversion application_version: 54.0a1 04:17:49 INFO - mozversion platform_buildid: 20170214071445 04:17:49 INFO - mozversion platform_changeset: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd 04:17:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:17:49 INFO - mozversion platform_version: 54.0a1 04:17:49 INFO - using testdate: 1488111469 04:17:49 INFO - actual date: 1488111469 04:17:49 INFO - starting webserver on 'localhost:49478' 04:17:49 INFO - SUITE-START | Running 2 tests 04:17:49 INFO - TEST-START | dromaeo_css 04:17:49 INFO - operating with platform_type : mac_ 04:17:49 INFO - Initialising browser for dromaeo_css test... 04:17:49 INFO - TEST-INFO | started process 2206 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/tmpjeC9X5/profile http://localhost:49478/getInfo.html) 04:17:52 INFO - PROCESS | 2206 | 2017-02-26 04:17:52.735 plugin-container[2208:27201] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e2f, name = 'com.apple.tsm.portname' 04:17:52 INFO - PROCESS | 2206 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:17:52 INFO - PROCESS | 2206 | 2017-02-26 04:17:52.738 plugin-container[2208:27201] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 04:17:52 INFO - PROCESS | 2206 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:17:52 INFO - PROCESS | 2206 | 2017-02-26 04:17:52.738 plugin-container[2208:27201] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:17:52 INFO - PROCESS | 2206 | __metrics Screen width/height:1600/1200 04:17:52 INFO - PROCESS | 2206 | colorDepth:24 04:17:52 INFO - PROCESS | 2206 | Browser inner width/height: 1024/689 04:17:52 INFO - PROCESS | 2206 | __metrics 04:17:52 ERROR - PROCESS | 2206 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:17:53 INFO - TEST-INFO | 2206: exit 0 04:17:53 INFO - Browser initialized. 04:17:53 INFO - Running cycle 1/1 for dromaeo_css test... 04:17:53 INFO - TEST-INFO | started process 2209 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/tmpjeC9X5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:56 INFO - PROCESS | 2209 | 2017-02-26 04:17:56.001 plugin-container[2210:27326] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x463b, name = 'com.apple.tsm.portname' 04:17:56 INFO - PROCESS | 2209 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:17:56 INFO - PROCESS | 2209 | 2017-02-26 04:17:56.002 plugin-container[2210:27326] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x450b, name = 'com.apple.CFPasteboardClient' 04:17:56 INFO - PROCESS | 2209 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:17:56 INFO - PROCESS | 2209 | 2017-02-26 04:17:56.002 plugin-container[2210:27326] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:18:05 INFO - PROCESS | 2209 | RSS: Main: 234364928 04:18:05 INFO - PROCESS | 2209 | 04:21:08 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49478/tests/dromaeo/cssquery-ext.html) 04:21:10 INFO - PROCESS | 2209 | RSS: Main: 255451136 04:21:10 INFO - PROCESS | 2209 | 04:22:54 INFO - PROCESS | 2209 | ************************* 04:22:54 INFO - PROCESS | 2209 | A coding exception was thrown and uncaught in a Task. 04:22:54 INFO - PROCESS | 2209 | 04:22:54 ERROR - PROCESS | 2209 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:22:54 INFO - PROCESS | 2209 | Full stack: 04:22:54 INFO - PROCESS | 2209 | ************************* 04:24:12 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-ext.html (next: http://localhost:49478/tests/dromaeo/cssquery-jquery.html) 04:24:13 INFO - PROCESS | 2209 | RSS: Main: 260710400 04:24:13 INFO - PROCESS | 2209 | 04:27:15 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49478/tests/dromaeo/cssquery-mootools.html) 04:27:16 INFO - PROCESS | 2209 | RSS: Main: 272506880 04:27:16 INFO - PROCESS | 2209 | 04:30:18 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49478/tests/dromaeo/cssquery-prototype.html) 04:30:18 INFO - PROCESS | 2209 | RSS: Main: 265388032 04:30:18 INFO - PROCESS | 2209 | 04:33:21 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49478/tests/dromaeo/cssquery-yui.html) 04:33:22 INFO - PROCESS | 2209 | RSS: Main: 269287424 04:33:22 INFO - PROCESS | 2209 | 04:36:25 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:49478/tests/dromaeo/cssquery-yui.html (next: http://localhost:49478/tests/dromaeo/cssquery-dojo.html) 04:36:25 INFO - PROCESS | 2209 | RSS: Main: 271728640 04:36:25 INFO - PROCESS | 2209 | 04:36:25 INFO - PROCESS | 2209 | __start_tp_report 04:36:25 INFO - PROCESS | 2209 | _x_x_mozilla_page_load 04:36:25 INFO - PROCESS | 2209 | _x_x_mozilla_page_load_details 04:36:25 INFO - PROCESS | 2209 | |i|pagename|runs| 04:36:25 INFO - PROCESS | 2209 | |0;dojo.html;2924.795264331497;3202.135423435671;3232.418164730349;3276.50852372144;3296.719778818801;5281.075811732941;5383.192521121834;5416.268803711503;5420.322459692538;5489.368722596902;5325.147976323789;5480.6437581557275;5540.085885828834;5583.888322233553;5637.267155269809;4951.405831300249;4997.900041999158;5084.415292241384;5111.258867464216;5148.433672296063;4941.629377796662;5108.64239503235;5175.146100893348;5191.143461328877;5241;4871.732054736988;4919.778609962525;5097.49025097491;5109.284700141983;5137.717425541612;4266;4824.179889418807;4954.380702412199;4976.800927962877;5061.316722242487;3992.241474119937;4965.106280869442;5028.321176641143;5056.216286475602;5112.974435127838;5266.131088370453;5478.616496845222;5516.834494965157;5518.061929471959;5565.359983601857;4398.318260669601;5781.88436231273;5878.853028674274;6088.299845517734;6143.232095988002;6041.697915104227;6049.092636104576;6049.304330002062;6050.576459647827;6069.575129740876;5619.381867994517;5666.320041595035;5706.600537962303;5745.425457454263;5746.080627099685;6095;6133.264008318941;6189.783357582463;6222.533310001768;6224.937750622526;5739.081746920473;5837.503812176013;6021.397860214031;6022.759089636365;6048;4868.707877527359;5085.804835863569;5097.362829646294;5626.071698169756;5670.914936275959;4838.830640927551;5878.000739874232;5997.400259973968;6008.369121242294;6052.364501727343;5156.329677142023;6116.8836339025665;6135.753292002367;6146.108814221912;6154.046122850965;4558.772061396917;4886.21820508724;4887.0714564232685;4900.191468407673;4953.207486802166;4253.936190957138;4264.232438161099;4281.250781113355;4292.742435453821;4373.453318335208;5715.228444159985;5735.1970724098655;5771.134329850556;5792.971035144881;5808.041673123887;6068.089786532056;6070.726817293233;6076.908846367308;6077.848053798691;6117.3270940197435;5390.4879036491475;5406.405295417501;5694.629849059798;5704.657720536781;5725.742341594639;5209.843704688866;5221.530062294411;5283.418823929364;5287.576993840484;5326.041312563776;6101.943964575756;6138.081874382086;6141.332587233735;6142.98993493194;6145.125736650364;6058.878822423615;6083.543734219863;6092.116643086639;6117.816465506042;6140.9078863816185;6041.214642096499;6043.456088952015;6074.301455332693;6076.574639775174;6104.328523862283;5986.371430999682;6021.2473440819895;6021.7591296347655;6030.7286172121485;6058.7273572688455;6038.698065096815;6087.756489740361;6115.453310713017;6139.293981192041;6140.385961403824;5821.126830975388;5956.076808094752;5976.282846058501;5983.790567330123;5985.910211346746;5621.5221706155435;5675;5678.0915053591225;5746.195532625352;5999.010163323002;5546.03287241324;5614.803481878114;5617.185508101385;5655.604107712421;5751.252337196305;5814.186013957965;5848.883022339614;5863.1791549184;5864.853378665397;5868.119782032559;5705.343885453226;5706.201131841629;5709.914351284817;5723.828285151452;5727.226824378656 04:36:25 INFO - PROCESS | 2209 | |1;ext.html;439.7471453913999;451.34554895401675;458.008411788478;471.4366332232981;520.240448944541;29362.119136425914;40811.59188408119;41620.16759664808;42839.143217135635;42908.35637465433;40676.593234067725;41162.38256426148;41274.793626031904;41327.58672413275;41363.17273654525;9049.502277374759;9304.25565954722;9341.673041443517;10749.247552671317;11130.165237607212;9300.534973251344;10907.236493445462;11001.284916480443;11006.889931100706;11024.44877756113;10969.725756856064;11026.834597481004;11054;11116.722081947935;11117.27737697051;10947.452627368639;11018.889811101906;11024.228304018721;11024.669259922215;11037.724056898562;9352.906470935271;10902.563897444094;10961.890381096246;10995.835062474069;11000.889991100066;29861.701382986328;35567;35804.82097589495;35857.46213806795;35946.820265898765;3422.57217847769;3496.0735405117666;3656.433252845813;3676.871309504181;3802.0874990002476;26744;26956;26971.325716857038;27008.594871076948;27965;3027.42302742301;3038.8784448622027;3044.2237229506554;3079.707427794356;3117.485614873543;429336;433133;434930;434975.6502434967;437985;42850;43689.78155109204;49608.75195624071;50030.499085027506;53554;48051.75974120177;53775.65560860932;53784.19323710148;53839.19331696882;53910;13920;14061.578152655436;14091.71816563663;14099.929500352433;14168.079074860101;10729.356238625707;10749;10811.027007569199;10819.621313254156;10830.837537436944;16175.110368929822;16304.51086467408;16430.260638271306;16467.423640172536;16487.917560412123;7143.749843777422;7341;7745.186755390716;7797.727079552188;7868.213178682086;806.962419889783;810;816.7590560784582;842.2251528593708;850.6597361055503;27924.44151117007;28049.859750701115;28083;28391.29021774472;28711;884.1247165306429;933.272047802715;942.3968660057569;976.5263847034183;1177.7055736065984;12092.75814483723;12274.754504909852;12353.567625133257;12705.809412858815;14606.780898286534;590120;593261;594444;595029;596381;50382.244266336034;50975.72560686013;51041.48958510441;51347.22979155316;51563.74218128961;1317.9934100329629;1329.0630105775406;1343.2813444806982;1349.1298112717438;1353.6683512539491;22186.1125554976;22994.310170694906;23613;23696;23887.044518219078;41022.58977410307;42468.1506369877;43236;43398;43435;477383;517235;521240;521480;522365;23194.65208021847;25323.62014569746;25890.22329330123;25907;25931;39554.60445395509;39850.68773981531;40420;40770.592294076676;41065.97335066647;32777.85277515276;33202.833985829915;33495;34288.828555857064;34482.310353793284;31626.209344766565;33718.325633486704;33761.324773504886;34358;34459.31081378408;31093.844530778108;31112;31599.36801263916;31826.84086579645;31908;27065.323366915985;28081.57877631796;28627.713722862503;28634.14097577076;28833;19147;20044.6970946888;21482.78517214808;21678.45803854916;21703.45741356479 04:36:25 INFO - PROCESS | 2209 | |2;jquery.html;377.778999285418;380.33881202336374;389.629851640941;393.590665707664;412.3587820938441;13012.869871301284;16081.678366432665;19281.325153619626;20535.28126515572;20584;21054;21068;21202.92860891076;21489.67765483519;21614.89192554039;5596.944030559704;5708.486236238738;5735.311762588495;5856.736446859902;5885.7939972100985;5673.631213971099;5830;5868.325142608612;5883.646981181121;5923.496502797268;5394;5709.457601527848;5790.36306006339;5790.942090579104;5807.854803629901;5524.806631767909;5724.542036637059;5760.711964401784;5789.102689083199;5793;5116.897662046738;5124.02643497738;5124.15451450514;5149.536541711264;5184.274201611777;22272.66591001136;22374.440638983993;23647.645285320734;23850.522989540113;24961.375965601004;2685;2764.4290314590044;2823.799885048846;2859.127965970378;2901.970980290191;8099.757007289791;9259.351845370828;9938.055884690943;12551.748965020739;14372.137671739729;1750.62361592257;1770.663573920951;1770.849477794389;1775.8934463932205;1797.3619365125323;116076;127954.08068878975;128012.35993820065;129250;130462;9394.295427842939;9791.216702663769;11163.330200188015;11496.436104807537;11589.478473468715;12774.425150868048;14868.851311486964;14897.925510372379;14936.626584335478;15017.924910375597;5793.159991801165;7733.458657893893;7995.160508146677;8069.717559885493;8131.14622964592;6331.303556608769;7692.538447693157;7762.805929851799;7871.622466068415;7872.094709108412;3965.9291991162227;4358.411614432074;4563.863084107482;4639.420072490939;4698.154332220165;1741.9113054341037;1974.9703754443694;2021.737174167349;2034.4812072921607;2036.7657719362167;818.8894499242646;842.3219308456751;863.0463338011532;885.526243459746;975.302658599105;20191.59616807685;20728.48178795512;20766.1693532257;20918.746972549354;21067.8946605266;996.1831298335295;996.2428554298785;1025.733309339577;1026.4559783314855;1040.7190058684264;9753.561089750978;10562.894346235356;10575.36547807134;10583.31208471447;10728.73178170552;629816;649031;657339;662095;673756;106308;135867;139897;142226;142418.87905604678;964.7298756348234;981.293468702533;1007.6825799873017;1044.8767574857059;1049.071571659087;17036.65926681484;18165;18973;19092;19122.235110595422;57374;57849.421505784405;57984.13023804562;58514;58675.70662146662;64709.67645161932;85657;86284.70572941285;86741.56629216814;88686;6738.820706376463;7745.612719364122;7806.297433231037;8224.342052635655;8250.917490825015;11492.540298388305;12129.393530323625;12468.688282793002;12483.31341776211;12564.308963006757;9444.763880902758;10113.797724045626;10284.434356110485;10726.785464290515;11097.833532497181;8380.664773408995;9024.59389327495;10494.895051049392;10894.455277236266;10951.014408703255;9578.185854202471;10267.383956962607;10620.946895265473;10800.675979720621;11075.335479871233;7873.921260787548;7891.802704932423;8139.226773456512;8327.6668933242;8344.332453403591;9817.410955342702;10791.6222932197;11059.336439813636;11060.17048721333;11124.721881952692 04:36:25 INFO - PROCESS | 2209 | |3;mootools.html;1436.3895344478594;1442.6393401649589;1446.435890002899;1458.8468210837864;1478.8595083467071;7336.633168341575;7580.5072670276395;8170.142135075813;8637.611307491154;8686.869696954544;8104.878426823588;8378.581070946459;8401.83196336073;8468.576571171432;8515.063343032278;2246.9887650561764;2285.2915596165244;2291.324059402472;2294.3461113582634;2301.2866011536476;2245.618244898363;2268.727752669682;2284.6116160252795;2292.6790249365104;2295.644175152854;2252.3468194223738;2256.638937769957;2275.7610450902666;2280.2019293247395;2281.9201327953524;2240.350298413458;2247.932562023142;2275.97724022761;2278.4303924019077;2279.179495381661;2193.3748881568677;2236.888155592214;2240.9103635854544;2251.448395143184;2257.24382331919;8410.243078122938;8449.915500845036;8461.830763384698;8484.236418722283;8518.148185181495;5022.045811295842;5142.897142057175;5166.302549155854;5201.531862132426;5209.296744939423;3215.8713651453913;3265.0857759827286;3426.297608990176;3484.3031393721103;3488.197714525648;1223.614561413152;1234.0806099455874;1651.1909164509304;1701.6341486580445;1785.1966615023161;9843.901560984441;10830.458477076194;10933.125349972062;10959.945200273947;10962.890371096266;4460.620847227957;4535.455745310584;4685.648576356787;4697.882552936136;4710.633916164343;8829.911700883038;8833;8858.15847494487;8922.643094276285;8945.01604823469;5129.256257842592;5142.460041695643;5146.742662866842;5151.459096794858;5156.278121063054;3948.407738839197;4705.858824235278;4758.476567577563;4784.091022705675;4796.592289655348;3623.873164439232;3661.707063434919;3739.3456145174487;3774.641409066134;3784.0918179636687;1003.2926786615419;1150.5685367987005;1156.1791128298835;1159.0611604600301;1174.4069245031205;839.3956351426963;870.4907629037084;873.8820259264918;915.33638112368;930.5096948782325;4512.774361281923;4978.427480839678;5492.642978206404;5579.637323573955;5809.535237181015;506.4656787089582;552.9447055294438;559.4629156010194;564.2605151987126;571.928508936383;3685.4754493172263;3702.9074273142846;3838.865639702597;3869.2068126034096;3921.568627450978;9501.334906556613;9776;9827.75430614226;9895.406275623485;9906.51402289648;9862.309638325249;9875.456849873326;9884.703458896245;9885.209183265322;9887.406755594688;7594.734184303523;7649.502782319131;7812.492188007761;7862.685492580347;7880.487768295043;5356.196570514454;5489.258950041693;5517.531009864207;5567.137093750475;5633.324001119892;9099.36304458708;9173.678921237724;9201.539923003957;9210.539473026189;9211.21704655085;8920;9291.442513449214;9323.347365684336;9333.673321433716;9336.906630933603;5549.528290095387;6050.6369617823075;6231.40801623845;6539.673016349258;6700.93299067003;7848.686052557834;7929.167437418988;8065.669164588012;8075.313598344206;8107.473014254055;6990.440764738911;7112.537685050455;7152.284771523015;7155.892661610184;7300.926990730025;6824.829379265558;7029.05107810439;7063.505554611128;7077.363037326665;7108.680109395193;6321.8735625288155;6360.840978975378;6421.229452465734;6426.871462570816;6450.903236451363;4942.851714448572;4946.752662366939;5011.7494125294315;5033.245013248042;5090.389153301628;4422.314541246112;4448.888777780581;4827.758612069452;5010;5111.488851114858 04:36:25 INFO - PROCESS | 2209 | |4;prototype.html;311.29646997785005;354.4364460507792;360.27225005488896;369.50301844019793;373.46034979454697;4469.4636643602735;4785.665003449752;5302.522772950434;5363.436839131893;5409.8106566270135;5241.5020573045595;5309.522143007129;5319.88786559862;5348.277982472365;5360.195970604412;3528.259065596228;3531.7880927144324;4101.974506373406;4167.478870212381;4235.216484950294;3655.524781778365;3693.279810436966;3765.5523909458934;4193.35003074524;4243.936340954888;4061.939070913939;4172.624463798257;4172.812223449937;4175.745097647266;4178.853740119096;3814.1036856338737;4024.082540158391;4189.539150693421;4196.706230563862;4200.600942910419;3724.8696295629793;3727.2545490901657;3728.3475391806596;3730.3658378075793;3758.849646014156;4890.774697512623;4899.89752305732;5098.980203959186;5156.977557505114;5244.213367994793;3971.2724964640183;4149.170165966789;4889.037626808792;4904.141775189328;4921.311016457699;5678.217673340075;5686.289213848269;5728.112142617859;5736.483716465538;5858.209141765849;3059.5410688396696;3988.7862236458755;4110.547839737626;4139.730917490384;4172.624463798273;5147.845564633104;5617.707927176732;5623.734659701576;5954.940450595525;5961.452935503368;3695.152423788106;3917.4123881417445;4218.557051509609;4230.746155230696;4239.364095385655;3539.911502212414;3837.4435706822355;3917.745346552465;3947.585503522089;4285.357196420562;3907.628775266345;4479.395281637003;4508.864734057984;4549.3176023596725;4814;4619.884502887455;4780.641451891052;4951.282064100757;5728.481952282648;5770.798022069207;1204.8313236146946;1378.3521744779937;1393.7421577008083;1399.8320201575875;1401.9695523790006;907.26964793342;916.9403988740711;923.7228831350702;949.9715008549755;996.097453863118;4308.332208507686;4455.349067304948;4865.5864251538305;4931.852044438672;5066.847994560169;5082.908258851586;5094.949050509447;5341.599380046512;5348.1175606025345;5590.608657393944;4463.5313292103865;4516;4850.975745121252;5092.541671249532;5125.718085505258;2617.241000109947;2890.9710902891125;2908.476474234658;2916.314666053476;2962.7333539981505;5153.5361817436615;5392.784288628411;5593.496585307342;5696.322728317684;5741.483266506035;4794.039152466599;5028.84913452597;5344.060766578366;5504.91742623861;5652.18043383707;4670.991473666289;4702.553257440606;4754.0491901619125;5132.897342053213;5541.639793413496;5209.791608335776;5281.656692314988;5622.718864056699;5625.662460252398;5695.977927835559;4521.727002849085;4708.835190768444;5438.918416223839;5462.481064298885;5515.200295956984;4485.170243504832;4592.897704550817;5278.498542638443;5656.010198215378;5844.444777746107;3650.3429382711365;3668.6881615063016;4091;4134.669226461936;4149.792510374409;5158.329417175743;5592.608517403905;5858.209141765978;5860.2967643883;5902.498287645598;4657.835541114721;5052.568488874548;5304.787808487617;5631.070873306023;5661.858453538694;4971.502849715144;5550.000999820071;5593.440655934374;5598.888022239451;5709.885802284014;4309.956900431081;4747.335373047707;5444.564434845123;5486.807961721321;5535.557155427476;5058.229619633246;5085.415177254515;5517;5565.554755619622;5589.80435684749;4603.286490593963;4770.546798054179;5503.807366742145;5514.28314319152;5548.9722551386985 04:36:25 INFO - PROCESS | 2209 | |5;yui.html;636.430394796657;701.0570782297808;752.3341842469415;758.3175142371869;816.1593558634605;13643.249621270827;14639.41442342305;14823.332950017248;14832.480863169778;14854.702905941887;13723.31383430827;13790.517331893385;13847.030707850454;13867.167969921786;13946.511872084453;897.5915958239018;909.077286554148;909.9772505687345;910.8314961732101;912.406935491929;890.8975467821218;909.9499527525984;915.7802127489422;933.3886304470583;936.5083331251079;961.9951900240524;967.8451447768358;972.1299437003877;972.5623469438781;973.5813600151968;962.4946902875976;962.7978124593843;966.8066386722649;967.9884520675911;971.0823272007955;719.5143278287135;720.9531380460253;720.9942130727658;721.6536062689886;724.026184781468;14886.851131488764;15191.316390762331;15220.771688424682;15318.923405383013;15686.607834804106;13778.09500516603;13824.654383640389;13887.513937012156;13927.651808704763;13945.58163255104;11378.487968041376;11396.943015284953;11550.884491155064;11611;11877.881221187765;3565.286942611488;3618.6019537850816;3623.184783423735;3633.5458067741533;3764.7552909060823;83278.58360708218;83837;101852.3972346317;104103.47948260287;104434.43348349705;10489;10507.684769456928;10728.927107289208;10761.623343182951;10797.13622910181;21305.893470532857;21516;21545.67681484779;21632.35102946914;21967.780322196573;7020.719171233196;7353.926460735431;7442.479026468203;7587;7601.201873803282;4002.6197511236387;4129.710920235615;4130.173965206971;4133.400656904792;4136.524299705512;3402.0474267205223;3435.7423193260606;3475.721942244614;3514.279572687593;3522.6653467920505;590.2562770908686;625.5371025441141;633.4394061255822;635.9077933699588;648.335456157433;597.7877853361994;614.9354317796657;637.2639601260552;647.5078940005535;663.3366633366634;7680.3471704905705;8065.596720164086;9010.729678109667;9044.095590441035;9462.763430914145;606.154414591651;637.9885995505332;649.6524359467662;663.8970959501188;666.3702800853147;4374.606285434263;4512.72923624577;4536.909261814745;4538.795754191069;4550.49944506104;73352.63323683347;96882;97986.02013979769;98103;98893;84233;85218;85683.57158214293;86013;86285.56857215674;45330;62512.43718907155;65239.673801630684;66207.66896165488;75297.62351188209;7863.174366691644;8088.595570221348;9289.576858832474;10311.278210525192;10554.89260143192;38295.6170438292;42202;46404;47566.28650570175;48039.799005025154;58163.79293200465;62271;63228;63363.683181583794;63853.36146638474;9945.900540994497;12448.439820207932;12514.68539788135;12622.684432889251;12714.11001229942;13668.043236973317;13714.588562343146;13740.175589464265;13814.723705526034;13893.305334733424;12749.745005100032;12775.680607984874;12789.296588687339;13028.068684545902;13266.204027758366;12703.110782245154;12826.358682066046;12888.613341599766;12997.217220494158;13239.669008274484;12539.686507837378;12707;12963.546275880299;13160.802587960996;13257.933710331386;9239.676611318571;10589.417582033062;10713.571457141627;10729.248952573556;10867.862789990086;7586.582737949466;9511.15064235504;9776.1690256329;10311.639092631722;10508.842367364343 04:36:25 INFO - PROCESS | 2209 | __end_tp_report 04:36:25 INFO - PROCESS | 2209 | __start_cc_report 04:36:25 INFO - PROCESS | 2209 | _x_x_mozilla_cycle_collect,432 04:36:25 INFO - PROCESS | 2209 | __end_cc_report 04:36:25 INFO - PROCESS | 2209 | __startTimestamp1488112585453__endTimestamp 04:36:25 INFO - PROCESS | 2209 | 04:36:25 INFO - PROCESS | 2209 | ------- Summary: start ------- 04:36:25 INFO - PROCESS | 2209 | Number of tests: 6 04:36:25 INFO - PROCESS | 2209 | 04:36:25 INFO - PROCESS | 2209 | [#0] dojo.html Cycles:165 Average:5516.96 Median:5706.20 stddev:653.26 (11.4%) stddev-sans-first:622.81 04:36:25 INFO - PROCESS | 2209 | Values: 2924.8 3202.1 3232.4 3276.5 3296.7 5281.1 5383.2 5416.3 5420.3 5489.4 5325.1 5480.6 5540.1 5583.9 5637.3 4951.4 4997.9 5084.4 5111.3 5148.4 4941.6 5108.6 5175.1 5191.1 5241.0 4871.7 4919.8 5097.5 5109.3 5137.7 4266.0 4824.2 4954.4 4976.8 5061.3 3992.2 4965.1 5028.3 5056.2 5113.0 5266.1 5478.6 5516.8 5518.1 5565.4 4398.3 5781.9 5878.9 6088.3 6143.2 6041.7 6049.1 6049.3 6050.6 6069.6 5619.4 5666.3 5706.6 5745.4 5746.1 6095.0 6133.3 6189.8 6222.5 6224.9 5739.1 5837.5 6021.4 6022.8 6048.0 4868.7 5085.8 5097.4 5626.1 5670.9 4838.8 5878.0 5997.4 6008.4 6052.4 5156.3 6116.9 6135.8 6146.1 6154.0 4558.8 4886.2 4887.1 4900.2 4953.2 4253.9 4264.2 4281.3 4292.7 4373.5 5715.2 5735.2 5771.1 5793.0 5808.0 6068.1 6070.7 6076.9 6077.8 6117.3 5390.5 5406.4 5694.6 5704.7 5725.7 5209.8 5221.5 5283.4 5287.6 5326.0 6101.9 6138.1 6141.3 6143.0 6145.1 6058.9 6083.5 6092.1 6117.8 6140.9 6041.2 6043.5 6074.3 6076.6 6104.3 5986.4 6021.2 6021.8 6030.7 6058.7 6038.7 6087.8 6115.5 6139.3 6140.4 5821.1 5956.1 5976.3 5983.8 5985.9 5621.5 5675.0 5678.1 5746.2 5999.0 5546.0 5614.8 5617.2 5655.6 5751.3 5814.2 5848.9 5863.2 5864.9 5868.1 5705.3 5706.2 5709.9 5723.8 5727.2 04:36:25 INFO - PROCESS | 2209 | 04:36:25 INFO - PROCESS | 2209 | [#1] ext.html Cycles:180 Average:62964.57 Median:33348.92 stddev:138324.82 (414.8%) stddev-sans-first:138633.20 04:36:25 INFO - PROCESS | 2209 | Values: 439.7 451.3 458.0 471.4 520.2 29362.1 40811.6 41620.2 42839.1 42908.4 40676.6 41162.4 41274.8 41327.6 41363.2 9049.5 9304.3 9341.7 10749.2 11130.2 9300.5 10907.2 11001.3 11006.9 11024.4 10969.7 11026.8 11054.0 11116.7 11117.3 10947.5 11018.9 11024.2 11024.7 11037.7 9352.9 10902.6 10961.9 10995.8 11000.9 29861.7 35567.0 35804.8 35857.5 35946.8 3422.6 3496.1 3656.4 3676.9 3802.1 26744.0 26956.0 26971.3 27008.6 27965.0 3027.4 3038.9 3044.2 3079.7 3117.5 429336.0 433133.0 434930.0 434975.7 437985.0 42850.0 43689.8 49608.8 50030.5 53554.0 48051.8 53775.7 53784.2 53839.2 53910.0 13920.0 14061.6 14091.7 14099.9 14168.1 10729.4 10749.0 10811.0 10819.6 10830.8 16175.1 16304.5 16430.3 16467.4 16487.9 7143.7 7341.0 7745.2 7797.7 7868.2 807.0 810.0 816.8 842.2 850.7 27924.4 28049.9 28083.0 28391.3 28711.0 884.1 933.3 942.4 976.5 1177.7 12092.8 12274.8 12353.6 12705.8 14606.8 590120.0 593261.0 594444.0 595029.0 596381.0 50382.2 50975.7 51041.5 51347.2 51563.7 1318.0 1329.1 1343.3 1349.1 1353.7 22186.1 22994.3 23613.0 23696.0 23887.0 41022.6 42468.2 43236.0 43398.0 43435.0 477383.0 517235.0 521240.0 521480.0 522365.0 23194.7 25323.6 25890.2 25907.0 25931.0 39554.6 39850.7 40420.0 40770.6 41066.0 32777.9 33202.8 33495.0 34288.8 34482.3 31626.2 33718.3 33761.3 34358.0 34459.3 31093.8 31112.0 31599.4 31826.8 31908.0 27065.3 28081.6 28627.7 28634.1 28833.0 19147.0 20044.7 21482.8 21678.5 21703.5 04:36:25 INFO - PROCESS | 2209 | 04:36:25 INFO - PROCESS | 2209 | [#2] jquery.html Cycles:180 Average:36944.05 Median:379.06 stddev:109240.25 (28818.8%) stddev-sans-first:109512.19 04:36:25 INFO - PROCESS | 2209 | Values: 377.8 380.3 389.6 393.6 412.4 13012.9 16081.7 19281.3 20535.3 20584.0 21054.0 21068.0 21202.9 21489.7 21614.9 5596.9 5708.5 5735.3 5856.7 5885.8 5673.6 5830.0 5868.3 5883.6 5923.5 5394.0 5709.5 5790.4 5790.9 5807.9 5524.8 5724.5 5760.7 5789.1 5793.0 5116.9 5124.0 5124.2 5149.5 5184.3 22272.7 22374.4 23647.6 23850.5 24961.4 2685.0 2764.4 2823.8 2859.1 2902.0 8099.8 9259.4 9938.1 12551.7 14372.1 1750.6 1770.7 1770.8 1775.9 1797.4 116076.0 127954.1 128012.4 129250.0 130462.0 9394.3 9791.2 11163.3 11496.4 11589.5 12774.4 14868.9 14897.9 14936.6 15017.9 5793.2 7733.5 7995.2 8069.7 8131.1 6331.3 7692.5 7762.8 7871.6 7872.1 3965.9 4358.4 4563.9 4639.4 4698.2 1741.9 1975.0 2021.7 2034.5 2036.8 818.9 842.3 863.0 885.5 975.3 20191.6 20728.5 20766.2 20918.7 21067.9 996.2 996.2 1025.7 1026.5 1040.7 9753.6 10562.9 10575.4 10583.3 10728.7 629816.0 649031.0 657339.0 662095.0 673756.0 106308.0 135867.0 139897.0 142226.0 142418.9 964.7 981.3 1007.7 1044.9 1049.1 17036.7 18165.0 18973.0 19092.0 19122.2 57374.0 57849.4 57984.1 58514.0 58675.7 64709.7 85657.0 86284.7 86741.6 88686.0 6738.8 7745.6 7806.3 8224.3 8250.9 11492.5 12129.4 12468.7 12483.3 12564.3 9444.8 10113.8 10284.4 10726.8 11097.8 8380.7 9024.6 10494.9 10894.5 10951.0 9578.2 10267.4 10620.9 10800.7 11075.3 7873.9 7891.8 8139.2 8327.7 8344.3 9817.4 10791.6 11059.3 11060.2 11124.7 04:36:25 INFO - PROCESS | 2209 | 04:36:25 INFO - PROCESS | 2209 | [#3] mootools.html Cycles:180 Average:5359.89 Median:5205.41 stddev:2934.17 (56.4%) stddev-sans-first:2927.59 04:36:25 INFO - PROCESS | 2209 | Values: 1436.4 1442.6 1446.4 1458.8 1478.9 7336.6 7580.5 8170.1 8637.6 8686.9 8104.9 8378.6 8401.8 8468.6 8515.1 2247.0 2285.3 2291.3 2294.3 2301.3 2245.6 2268.7 2284.6 2292.7 2295.6 2252.3 2256.6 2275.8 2280.2 2281.9 2240.4 2247.9 2276.0 2278.4 2279.2 2193.4 2236.9 2240.9 2251.4 2257.2 8410.2 8449.9 8461.8 8484.2 8518.1 5022.0 5142.9 5166.3 5201.5 5209.3 3215.9 3265.1 3426.3 3484.3 3488.2 1223.6 1234.1 1651.2 1701.6 1785.2 9843.9 10830.5 10933.1 10959.9 10962.9 4460.6 4535.5 4685.6 4697.9 4710.6 8829.9 8833.0 8858.2 8922.6 8945.0 5129.3 5142.5 5146.7 5151.5 5156.3 3948.4 4705.9 4758.5 4784.1 4796.6 3623.9 3661.7 3739.3 3774.6 3784.1 1003.3 1150.6 1156.2 1159.1 1174.4 839.4 870.5 873.9 915.3 930.5 4512.8 4978.4 5492.6 5579.6 5809.5 506.5 552.9 559.5 564.3 571.9 3685.5 3702.9 3838.9 3869.2 3921.6 9501.3 9776.0 9827.8 9895.4 9906.5 9862.3 9875.5 9884.7 9885.2 9887.4 7594.7 7649.5 7812.5 7862.7 7880.5 5356.2 5489.3 5517.5 5567.1 5633.3 9099.4 9173.7 9201.5 9210.5 9211.2 8920.0 9291.4 9323.3 9333.7 9336.9 5549.5 6050.6 6231.4 6539.7 6700.9 7848.7 7929.2 8065.7 8075.3 8107.5 6990.4 7112.5 7152.3 7155.9 7300.9 6824.8 7029.1 7063.5 7077.4 7108.7 6321.9 6360.8 6421.2 6426.9 6450.9 4942.9 4946.8 5011.7 5033.2 5090.4 4422.3 4448.9 4827.8 5010.0 5111.5 04:36:25 INFO - PROCESS | 2209 | 04:36:25 INFO - PROCESS | 2209 | [#4] prototype.html Cycles:180 Average:4460.05 Median:4889.91 stddev:1313.86 (26.9%) stddev-sans-first:1280.11 04:36:25 INFO - PROCESS | 2209 | Values: 311.3 354.4 360.3 369.5 373.5 4469.5 4785.7 5302.5 5363.4 5409.8 5241.5 5309.5 5319.9 5348.3 5360.2 3528.3 3531.8 4102.0 4167.5 4235.2 3655.5 3693.3 3765.6 4193.4 4243.9 4061.9 4172.6 4172.8 4175.7 4178.9 3814.1 4024.1 4189.5 4196.7 4200.6 3724.9 3727.3 3728.3 3730.4 3758.8 4890.8 4899.9 5099.0 5157.0 5244.2 3971.3 4149.2 4889.0 4904.1 4921.3 5678.2 5686.3 5728.1 5736.5 5858.2 3059.5 3988.8 4110.5 4139.7 4172.6 5147.8 5617.7 5623.7 5954.9 5961.5 3695.2 3917.4 4218.6 4230.7 4239.4 3539.9 3837.4 3917.7 3947.6 4285.4 3907.6 4479.4 4508.9 4549.3 4814.0 4619.9 4780.6 4951.3 5728.5 5770.8 1204.8 1378.4 1393.7 1399.8 1402.0 907.3 916.9 923.7 950.0 996.1 4308.3 4455.3 4865.6 4931.9 5066.8 5082.9 5094.9 5341.6 5348.1 5590.6 4463.5 4516.0 4851.0 5092.5 5125.7 2617.2 2891.0 2908.5 2916.3 2962.7 5153.5 5392.8 5593.5 5696.3 5741.5 4794.0 5028.8 5344.1 5504.9 5652.2 4671.0 4702.6 4754.0 5132.9 5541.6 5209.8 5281.7 5622.7 5625.7 5696.0 4521.7 4708.8 5438.9 5462.5 5515.2 4485.2 4592.9 5278.5 5656.0 5844.4 3650.3 3668.7 4091.0 4134.7 4149.8 5158.3 5592.6 5858.2 5860.3 5902.5 4657.8 5052.6 5304.8 5631.1 5661.9 4971.5 5550.0 5593.4 5598.9 5709.9 4310.0 4747.3 5444.6 5486.8 5535.6 5058.2 5085.4 5517.0 5565.6 5589.8 4603.3 4770.5 5503.8 5514.3 5549.0 04:36:25 INFO - PROCESS | 2209 | 04:36:25 INFO - PROCESS | 2209 | [#5] yui.html Cycles:180 Average:18823.39 Median:4537.85 stddev:26588.23 (585.9%) stddev-sans-first:26627.75 04:36:25 INFO - PROCESS | 2209 | Values: 636.4 701.1 752.3 758.3 816.2 13643.2 14639.4 14823.3 14832.5 14854.7 13723.3 13790.5 13847.0 13867.2 13946.5 897.6 909.1 910.0 910.8 912.4 890.9 909.9 915.8 933.4 936.5 962.0 967.8 972.1 972.6 973.6 962.5 962.8 966.8 968.0 971.1 719.5 721.0 721.0 721.7 724.0 14886.9 15191.3 15220.8 15318.9 15686.6 13778.1 13824.7 13887.5 13927.7 13945.6 11378.5 11396.9 11550.9 11611.0 11877.9 3565.3 3618.6 3623.2 3633.5 3764.8 83278.6 83837.0 101852.4 104103.5 104434.4 10489.0 10507.7 10728.9 10761.6 10797.1 21305.9 21516.0 21545.7 21632.4 21967.8 7020.7 7353.9 7442.5 7587.0 7601.2 4002.6 4129.7 4130.2 4133.4 4136.5 3402.0 3435.7 3475.7 3514.3 3522.7 590.3 625.5 633.4 635.9 648.3 597.8 614.9 637.3 647.5 663.3 7680.3 8065.6 9010.7 9044.1 9462.8 606.2 638.0 649.7 663.9 666.4 4374.6 4512.7 4536.9 4538.8 4550.5 73352.6 96882.0 97986.0 98103.0 98893.0 84233.0 85218.0 85683.6 86013.0 86285.6 45330.0 62512.4 65239.7 66207.7 75297.6 7863.2 8088.6 9289.6 10311.3 10554.9 38295.6 42202.0 46404.0 47566.3 48039.8 58163.8 62271.0 63228.0 63363.7 63853.4 9945.9 12448.4 12514.7 12622.7 12714.1 13668.0 13714.6 13740.2 13814.7 13893.3 12749.7 12775.7 12789.3 13028.1 13266.2 12703.1 12826.4 12888.6 12997.2 13239.7 12539.7 12707.0 12963.5 13160.8 13257.9 9239.7 10589.4 10713.6 10729.2 10867.9 7586.6 9511.2 9776.2 10311.6 10508.8 04:36:25 INFO - PROCESS | 2209 | -------- Summary: end -------- 04:36:25 INFO - PROCESS | 2209 | 04:36:26 INFO - TEST-INFO | 2209: exit 0 04:36:26 INFO - TEST-OK | dromaeo_css | took 1116231ms 04:36:26 INFO - TEST-START | kraken 04:36:26 INFO - operating with platform_type : mac_ 04:36:26 INFO - Initialising browser for kraken test... 04:36:26 INFO - TEST-INFO | started process 2216 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/tmpReyeu6/profile http://localhost:49478/getInfo.html) 04:36:28 INFO - PROCESS | 2216 | 2017-02-26 04:36:28.963 plugin-container[2217:29522] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 04:36:28 INFO - PROCESS | 2216 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:28 INFO - PROCESS | 2216 | 2017-02-26 04:36:28.965 plugin-container[2217:29522] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 04:36:28 INFO - PROCESS | 2216 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:28 INFO - PROCESS | 2216 | 2017-02-26 04:36:28.966 plugin-container[2217:29522] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:36:29 INFO - PROCESS | 2216 | __metrics Screen width/height:1600/1200 04:36:29 INFO - PROCESS | 2216 | colorDepth:24 04:36:29 INFO - PROCESS | 2216 | Browser inner width/height: 1024/689 04:36:29 INFO - PROCESS | 2216 | __metrics 04:36:29 ERROR - PROCESS | 2216 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:36:29 INFO - TEST-INFO | 2216: exit 0 04:36:29 INFO - Browser initialized. 04:36:29 INFO - Running cycle 1/1 for kraken test... 04:36:29 INFO - TEST-INFO | started process 2218 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/T/tmpReyeu6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:32 INFO - PROCESS | 2218 | 2017-02-26 04:36:32.279 plugin-container[2219:29642] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 04:36:32 INFO - PROCESS | 2218 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:32 INFO - PROCESS | 2218 | 2017-02-26 04:36:32.279 plugin-container[2219:29642] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 04:36:32 INFO - PROCESS | 2218 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:32 INFO - PROCESS | 2218 | 2017-02-26 04:36:32.279 plugin-container[2219:29642] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:36:42 INFO - PROCESS | 2218 | RSS: Main: 232878080 04:36:42 INFO - PROCESS | 2218 | 04:36:45 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49478/tests/kraken/driver.html?testName=audio-beat-detection) 04:36:46 INFO - PROCESS | 2218 | RSS: Main: 247623680 04:36:46 INFO - PROCESS | 2218 | 04:36:48 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49478/tests/kraken/driver.html?testName=audio-dft) 04:36:49 INFO - PROCESS | 2218 | RSS: Main: 255508480 04:36:49 INFO - PROCESS | 2218 | 04:36:52 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49478/tests/kraken/driver.html?testName=audio-fft) 04:36:53 INFO - PROCESS | 2218 | RSS: Main: 258285568 04:36:53 INFO - PROCESS | 2218 | 04:36:55 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49478/tests/kraken/driver.html?testName=audio-oscillator) 04:36:55 INFO - PROCESS | 2218 | RSS: Main: 259526656 04:36:55 INFO - PROCESS | 2218 | 04:36:57 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49478/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:58 INFO - PROCESS | 2218 | RSS: Main: 259891200 04:36:58 INFO - PROCESS | 2218 | 04:37:01 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49478/tests/kraken/driver.html?testName=imaging-darkroom) 04:37:02 INFO - PROCESS | 2218 | RSS: Main: 265678848 04:37:02 INFO - PROCESS | 2218 | 04:37:05 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49478/tests/kraken/driver.html?testName=imaging-desaturate) 04:37:05 INFO - PROCESS | 2218 | RSS: Main: 264863744 04:37:05 INFO - PROCESS | 2218 | 04:37:08 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49478/tests/kraken/driver.html?testName=json-parse-financial) 04:37:09 INFO - PROCESS | 2218 | RSS: Main: 265003008 04:37:09 INFO - PROCESS | 2218 | 04:37:11 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49478/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:37:11 INFO - PROCESS | 2218 | RSS: Main: 265527296 04:37:11 INFO - PROCESS | 2218 | 04:37:13 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:37:14 INFO - PROCESS | 2218 | RSS: Main: 265506816 04:37:14 INFO - PROCESS | 2218 | 04:37:16 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:37:17 INFO - PROCESS | 2218 | RSS: Main: 265613312 04:37:17 INFO - PROCESS | 2218 | 04:37:20 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:37:21 INFO - PROCESS | 2218 | RSS: Main: 265908224 04:37:21 INFO - PROCESS | 2218 | 04:37:24 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:37:25 INFO - PROCESS | 2218 | RSS: Main: 265707520 04:37:25 INFO - PROCESS | 2218 | 04:37:26 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:49478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49478/tests/kraken/driver.html?testName=ai-astar) 04:37:27 INFO - PROCESS | 2218 | RSS: Main: 267771904 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | __start_tp_report 04:37:27 INFO - PROCESS | 2218 | _x_x_mozilla_page_load 04:37:27 INFO - PROCESS | 2218 | _x_x_mozilla_page_load_details 04:37:27 INFO - PROCESS | 2218 | |i|pagename|runs| 04:37:27 INFO - PROCESS | 2218 | |0;ai-astar;109;118;118;117;116;118;121;136;177;118 04:37:27 INFO - PROCESS | 2218 | |1;audio-beat-detection;141;115;114;152;118;120;116;134;139;117 04:37:27 INFO - PROCESS | 2218 | |2;audio-dft;206;207;206;208;225;198;199;198;198;197 04:37:27 INFO - PROCESS | 2218 | |3;audio-fft;88;62;63;84;60;53;72;85;93;82 04:37:27 INFO - PROCESS | 2218 | |4;audio-oscillator;91;73;86;73;72;72;88;103;99;99 04:37:27 INFO - PROCESS | 2218 | |5;imaging-gaussian-blur;90;90;94;90;100;88;132;136;90;90 04:37:27 INFO - PROCESS | 2218 | |6;imaging-darkroom;98;97;119;104;117;96;100;94;116;97 04:37:27 INFO - PROCESS | 2218 | |7;imaging-desaturate;91;94;93;119;95;90;93;95;94;95 04:37:27 INFO - PROCESS | 2218 | |8;json-parse-financial;66;65;63;64;66;66;64;67;67;84 04:37:27 INFO - PROCESS | 2218 | |9;json-stringify-tinderbox;86;108;68;76;102;109;104;81;69;73 04:37:27 INFO - PROCESS | 2218 | |10;stanford-crypto-aes;87;87;108;109;81;110;109;110;90;90 04:37:27 INFO - PROCESS | 2218 | |11;stanford-crypto-ccm;153;151;161;146;152;159;147;145;207;163 04:37:27 INFO - PROCESS | 2218 | |12;stanford-crypto-pbkdf2;180;213;256;182;179;177;179;178;218;236 04:37:27 INFO - PROCESS | 2218 | |13;stanford-crypto-sha256-iterative;71;68;70;67;73;70;68;67;69;68 04:37:27 INFO - PROCESS | 2218 | __end_tp_report 04:37:27 INFO - PROCESS | 2218 | __start_cc_report 04:37:27 INFO - PROCESS | 2218 | _x_x_mozilla_cycle_collect,1007 04:37:27 INFO - PROCESS | 2218 | __end_cc_report 04:37:27 INFO - PROCESS | 2218 | __startTimestamp1488112647189__endTimestamp 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | ------- Summary: start ------- 04:37:27 INFO - PROCESS | 2218 | Number of tests: 14 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#0] ai-astar Cycles:10 Average:124.80 Median:118.00 stddev:19.54 (16.6%) stddev-sans-first:19.88 04:37:27 INFO - PROCESS | 2218 | Values: 109.0 118.0 118.0 117.0 116.0 118.0 121.0 136.0 177.0 118.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:127.00 stddev:13.65 (10.7%) stddev-sans-first:13.44 04:37:27 INFO - PROCESS | 2218 | Values: 141.0 115.0 114.0 152.0 118.0 120.0 116.0 134.0 139.0 117.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#2] audio-dft Cycles:10 Average:204.20 Median:206.00 stddev:8.53 (4.1%) stddev-sans-first:9.03 04:37:27 INFO - PROCESS | 2218 | Values: 206.0 207.0 206.0 208.0 225.0 198.0 199.0 198.0 198.0 197.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#3] audio-fft Cycles:10 Average:74.20 Median:83.00 stddev:13.93 (16.8%) stddev-sans-first:13.86 04:37:27 INFO - PROCESS | 2218 | Values: 88.0 62.0 63.0 84.0 60.0 53.0 72.0 85.0 93.0 82.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:87.00 stddev:12.40 (14.3%) stddev-sans-first:13.00 04:37:27 INFO - PROCESS | 2218 | Values: 91.0 73.0 86.0 73.0 72.0 72.0 88.0 103.0 99.0 99.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#5] imaging-gaussian-blur Cycles:10 Average:100.00 Median:90.00 stddev:18.26 (20.3%) stddev-sans-first:19.00 04:37:27 INFO - PROCESS | 2218 | Values: 90.0 90.0 94.0 90.0 100.0 88.0 132.0 136.0 90.0 90.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#6] imaging-darkroom Cycles:10 Average:103.80 Median:95.00 stddev:9.73 (10.2%) stddev-sans-first:10.09 04:37:27 INFO - PROCESS | 2218 | Values: 98.0 97.0 119.0 104.0 117.0 96.0 100.0 94.0 116.0 97.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:94.00 stddev:8.29 (8.8%) stddev-sans-first:8.60 04:37:27 INFO - PROCESS | 2218 | Values: 91.0 94.0 93.0 119.0 95.0 90.0 93.0 95.0 94.0 95.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:66.00 stddev:6.05 (9.2%) stddev-sans-first:6.40 04:37:27 INFO - PROCESS | 2218 | Values: 66.0 65.0 63.0 64.0 66.0 66.0 64.0 67.0 67.0 84.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#9] json-stringify-tinderbox Cycles:10 Average:87.60 Median:71.00 stddev:16.58 (23.4%) stddev-sans-first:17.58 04:37:27 INFO - PROCESS | 2218 | Values: 86.0 108.0 68.0 76.0 102.0 109.0 104.0 81.0 69.0 73.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#10] stanford-crypto-aes Cycles:10 Average:98.10 Median:84.00 stddev:11.97 (14.2%) stddev-sans-first:12.00 04:37:27 INFO - PROCESS | 2218 | Values: 87.0 87.0 108.0 109.0 81.0 110.0 109.0 110.0 90.0 90.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#11] stanford-crypto-ccm Cycles:10 Average:158.40 Median:156.00 stddev:18.19 (11.7%) stddev-sans-first:19.19 04:37:27 INFO - PROCESS | 2218 | Values: 153.0 151.0 161.0 146.0 152.0 159.0 147.0 145.0 207.0 163.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.80 Median:197.50 stddev:28.95 (14.7%) stddev-sans-first:29.81 04:37:27 INFO - PROCESS | 2218 | Values: 180.0 213.0 256.0 182.0 179.0 177.0 179.0 178.0 218.0 236.0 04:37:27 INFO - PROCESS | 2218 | 04:37:27 INFO - PROCESS | 2218 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.91 (2.8%) stddev-sans-first:1.90 04:37:27 INFO - PROCESS | 2218 | Values: 71.0 68.0 70.0 67.0 73.0 70.0 68.0 67.0 69.0 68.0 04:37:27 INFO - PROCESS | 2218 | -------- Summary: end -------- 04:37:27 INFO - PROCESS | 2218 | 04:37:28 INFO - TEST-INFO | 2218: exit 0 04:37:28 INFO - TEST-OK | kraken | took 61975ms 04:37:28 INFO - SUITE-END | took 1178s 04:37:28 INFO - Completed test suite (00:19:38) 04:37:28 INFO - javascript benchmark 04:37:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7025.051789696611, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2924.795264331497, 3202.135423435671, 3232.418164730349, 3276.50852372144, 3296.719778818801, 5281.075811732941, 5383.192521121834, 5416.268803711503, 5420.322459692538, 5489.368722596902, 5325.147976323789, 5480.6437581557275, 5540.085885828834, 5583.888322233553, 5637.267155269809, 4951.405831300249, 4997.900041999158, 5084.415292241384, 5111.258867464216, 5148.433672296063, 4941.629377796662, 5108.64239503235, 5175.146100893348, 5191.143461328877, 5241.0, 4871.732054736988, 4919.778609962525, 5097.49025097491, 5109.284700141983, 5137.717425541612, 4266.0, 4824.179889418807, 4954.380702412199, 4976.800927962877, 5061.316722242487, 3992.241474119937, 4965.106280869442, 5028.321176641143, 5056.216286475602, 5112.974435127838, 5266.131088370453, 5478.616496845222, 5516.834494965157, 5518.061929471959, 5565.359983601857, 4398.318260669601, 5781.88436231273, 5878.853028674274, 6088.299845517734, 6143.232095988002, 6041.697915104227, 6049.092636104576, 6049.304330002062, 6050.576459647827, 6069.575129740876, 5619.381867994517, 5666.320041595035, 5706.600537962303, 5745.425457454263, 5746.080627099685, 6095.0, 6133.264008318941, 6189.783357582463, 6222.533310001768, 6224.937750622526, 5739.081746920473, 5837.503812176013, 6021.397860214031, 6022.759089636365, 6048.0, 4868.707877527359, 5085.804835863569, 5097.362829646294, 5626.071698169756, 5670.914936275959, 4838.830640927551, 5878.000739874232, 5997.400259973968, 6008.369121242294, 6052.364501727343, 5156.329677142023, 6116.8836339025665, 6135.753292002367, 6146.108814221912, 6154.046122850965, 4558.772061396917, 4886.21820508724, 4887.0714564232685, 4900.191468407673, 4953.207486802166, 4253.936190957138, 4264.232438161099, 4281.250781113355, 4292.742435453821, 4373.453318335208, 5715.228444159985, 5735.1970724098655, 5771.134329850556, 5792.971035144881, 5808.041673123887, 6068.089786532056, 6070.726817293233, 6076.908846367308, 6077.848053798691, 6117.3270940197435, 5390.4879036491475, 5406.405295417501, 5694.629849059798, 5704.657720536781, 5725.742341594639, 5209.843704688866, 5221.530062294411, 5283.418823929364, 5287.576993840484, 5326.041312563776, 6101.943964575756, 6138.081874382086, 6141.332587233735, 6142.98993493194, 6145.125736650364, 6058.878822423615, 6083.543734219863, 6092.116643086639, 6117.816465506042, 6140.9078863816185, 6041.214642096499, 6043.456088952015, 6074.301455332693, 6076.574639775174, 6104.328523862283, 5986.371430999682, 6021.2473440819895, 6021.7591296347655, 6030.7286172121485, 6058.7273572688455, 6038.698065096815, 6087.756489740361, 6115.453310713017, 6139.293981192041, 6140.385961403824, 5821.126830975388, 5956.076808094752, 5976.282846058501, 5983.790567330123, 5985.910211346746, 5621.5221706155435, 5675.0, 5678.0915053591225, 5746.195532625352, 5999.010163323002, 5546.03287241324, 5614.803481878114, 5617.185508101385, 5655.604107712421, 5751.252337196305, 5814.186013957965, 5848.883022339614, 5863.1791549184, 5864.853378665397, 5868.119782032559, 5705.343885453226, 5706.201131841629, 5709.914351284817, 5723.828285151452, 5727.226824378656], "value": 5475.4516608923495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.7471453913999, 451.34554895401675, 458.008411788478, 471.4366332232981, 520.240448944541, 29362.119136425914, 40811.59188408119, 41620.16759664808, 42839.143217135635, 42908.35637465433, 40676.593234067725, 41162.38256426148, 41274.793626031904, 41327.58672413275, 41363.17273654525, 9049.502277374759, 9304.25565954722, 9341.673041443517, 10749.247552671317, 11130.165237607212, 9300.534973251344, 10907.236493445462, 11001.284916480443, 11006.889931100706, 11024.44877756113, 10969.725756856064, 11026.834597481004, 11054.0, 11116.722081947935, 11117.27737697051, 10947.452627368639, 11018.889811101906, 11024.228304018721, 11024.669259922215, 11037.724056898562, 9352.906470935271, 10902.563897444094, 10961.890381096246, 10995.835062474069, 11000.889991100066, 29861.701382986328, 35567.0, 35804.82097589495, 35857.46213806795, 35946.820265898765, 3422.57217847769, 3496.0735405117666, 3656.433252845813, 3676.871309504181, 3802.0874990002476, 26744.0, 26956.0, 26971.325716857038, 27008.594871076948, 27965.0, 3027.42302742301, 3038.8784448622027, 3044.2237229506554, 3079.707427794356, 3117.485614873543, 429336.0, 433133.0, 434930.0, 434975.6502434967, 437985.0, 42850.0, 43689.78155109204, 49608.75195624071, 50030.499085027506, 53554.0, 48051.75974120177, 53775.65560860932, 53784.19323710148, 53839.19331696882, 53910.0, 13920.0, 14061.578152655436, 14091.71816563663, 14099.929500352433, 14168.079074860101, 10729.356238625707, 10749.0, 10811.027007569199, 10819.621313254156, 10830.837537436944, 16175.110368929822, 16304.51086467408, 16430.260638271306, 16467.423640172536, 16487.917560412123, 7143.749843777422, 7341.0, 7745.186755390716, 7797.727079552188, 7868.213178682086, 806.962419889783, 810.0, 816.7590560784582, 842.2251528593708, 850.6597361055503, 27924.44151117007, 28049.859750701115, 28083.0, 28391.29021774472, 28711.0, 884.1247165306429, 933.272047802715, 942.3968660057569, 976.5263847034183, 1177.7055736065984, 12092.75814483723, 12274.754504909852, 12353.567625133257, 12705.809412858815, 14606.780898286534, 590120.0, 593261.0, 594444.0, 595029.0, 596381.0, 50382.244266336034, 50975.72560686013, 51041.48958510441, 51347.22979155316, 51563.74218128961, 1317.9934100329629, 1329.0630105775406, 1343.2813444806982, 1349.1298112717438, 1353.6683512539491, 22186.1125554976, 22994.310170694906, 23613.0, 23696.0, 23887.044518219078, 41022.58977410307, 42468.1506369877, 43236.0, 43398.0, 43435.0, 477383.0, 517235.0, 521240.0, 521480.0, 522365.0, 23194.65208021847, 25323.62014569746, 25890.22329330123, 25907.0, 25931.0, 39554.60445395509, 39850.68773981531, 40420.0, 40770.592294076676, 41065.97335066647, 32777.85277515276, 33202.833985829915, 33495.0, 34288.828555857064, 34482.310353793284, 31626.209344766565, 33718.325633486704, 33761.324773504886, 34358.0, 34459.31081378408, 31093.844530778108, 31112.0, 31599.36801263916, 31826.84086579645, 31908.0, 27065.323366915985, 28081.57877631796, 28627.713722862503, 28634.14097577076, 28833.0, 19147.0, 20044.6970946888, 21482.78517214808, 21678.45803854916, 21703.45741356479], "value": 18316.0606998223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.778999285418, 380.33881202336374, 389.629851640941, 393.590665707664, 412.3587820938441, 13012.869871301284, 16081.678366432665, 19281.325153619626, 20535.28126515572, 20584.0, 21054.0, 21068.0, 21202.92860891076, 21489.67765483519, 21614.89192554039, 5596.944030559704, 5708.486236238738, 5735.311762588495, 5856.736446859902, 5885.7939972100985, 5673.631213971099, 5830.0, 5868.325142608612, 5883.646981181121, 5923.496502797268, 5394.0, 5709.457601527848, 5790.36306006339, 5790.942090579104, 5807.854803629901, 5524.806631767909, 5724.542036637059, 5760.711964401784, 5789.102689083199, 5793.0, 5116.897662046738, 5124.02643497738, 5124.15451450514, 5149.536541711264, 5184.274201611777, 22272.66591001136, 22374.440638983993, 23647.645285320734, 23850.522989540113, 24961.375965601004, 2685.0, 2764.4290314590044, 2823.799885048846, 2859.127965970378, 2901.970980290191, 8099.757007289791, 9259.351845370828, 9938.055884690943, 12551.748965020739, 14372.137671739729, 1750.62361592257, 1770.663573920951, 1770.849477794389, 1775.8934463932205, 1797.3619365125323, 116076.0, 127954.08068878975, 128012.35993820065, 129250.0, 130462.0, 9394.295427842939, 9791.216702663769, 11163.330200188015, 11496.436104807537, 11589.478473468715, 12774.425150868048, 14868.851311486964, 14897.925510372379, 14936.626584335478, 15017.924910375597, 5793.159991801165, 7733.458657893893, 7995.160508146677, 8069.717559885493, 8131.14622964592, 6331.303556608769, 7692.538447693157, 7762.805929851799, 7871.622466068415, 7872.094709108412, 3965.9291991162227, 4358.411614432074, 4563.863084107482, 4639.420072490939, 4698.154332220165, 1741.9113054341037, 1974.9703754443694, 2021.737174167349, 2034.4812072921607, 2036.7657719362167, 818.8894499242646, 842.3219308456751, 863.0463338011532, 885.526243459746, 975.302658599105, 20191.59616807685, 20728.48178795512, 20766.1693532257, 20918.746972549354, 21067.8946605266, 996.1831298335295, 996.2428554298785, 1025.733309339577, 1026.4559783314855, 1040.7190058684264, 9753.561089750978, 10562.894346235356, 10575.36547807134, 10583.31208471447, 10728.73178170552, 629816.0, 649031.0, 657339.0, 662095.0, 673756.0, 106308.0, 135867.0, 139897.0, 142226.0, 142418.87905604678, 964.7298756348234, 981.293468702533, 1007.6825799873017, 1044.8767574857059, 1049.071571659087, 17036.65926681484, 18165.0, 18973.0, 19092.0, 19122.235110595422, 57374.0, 57849.421505784405, 57984.13023804562, 58514.0, 58675.70662146662, 64709.67645161932, 85657.0, 86284.70572941285, 86741.56629216814, 88686.0, 6738.820706376463, 7745.612719364122, 7806.297433231037, 8224.342052635655, 8250.917490825015, 11492.540298388305, 12129.393530323625, 12468.688282793002, 12483.31341776211, 12564.308963006757, 9444.763880902758, 10113.797724045626, 10284.434356110485, 10726.785464290515, 11097.833532497181, 8380.664773408995, 9024.59389327495, 10494.895051049392, 10894.455277236266, 10951.014408703255, 9578.185854202471, 10267.383956962607, 10620.946895265473, 10800.675979720621, 11075.335479871233, 7873.921260787548, 7891.802704932423, 8139.226773456512, 8327.6668933242, 8344.332453403591, 9817.410955342702, 10791.6222932197, 11059.336439813636, 11060.17048721333, 11124.721881952692], "value": 9465.123853438972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.3895344478594, 1442.6393401649589, 1446.435890002899, 1458.8468210837864, 1478.8595083467071, 7336.633168341575, 7580.5072670276395, 8170.142135075813, 8637.611307491154, 8686.869696954544, 8104.878426823588, 8378.581070946459, 8401.83196336073, 8468.576571171432, 8515.063343032278, 2246.9887650561764, 2285.2915596165244, 2291.324059402472, 2294.3461113582634, 2301.2866011536476, 2245.618244898363, 2268.727752669682, 2284.6116160252795, 2292.6790249365104, 2295.644175152854, 2252.3468194223738, 2256.638937769957, 2275.7610450902666, 2280.2019293247395, 2281.9201327953524, 2240.350298413458, 2247.932562023142, 2275.97724022761, 2278.4303924019077, 2279.179495381661, 2193.3748881568677, 2236.888155592214, 2240.9103635854544, 2251.448395143184, 2257.24382331919, 8410.243078122938, 8449.915500845036, 8461.830763384698, 8484.236418722283, 8518.148185181495, 5022.045811295842, 5142.897142057175, 5166.302549155854, 5201.531862132426, 5209.296744939423, 3215.8713651453913, 3265.0857759827286, 3426.297608990176, 3484.3031393721103, 3488.197714525648, 1223.614561413152, 1234.0806099455874, 1651.1909164509304, 1701.6341486580445, 1785.1966615023161, 9843.901560984441, 10830.458477076194, 10933.125349972062, 10959.945200273947, 10962.890371096266, 4460.620847227957, 4535.455745310584, 4685.648576356787, 4697.882552936136, 4710.633916164343, 8829.911700883038, 8833.0, 8858.15847494487, 8922.643094276285, 8945.01604823469, 5129.256257842592, 5142.460041695643, 5146.742662866842, 5151.459096794858, 5156.278121063054, 3948.407738839197, 4705.858824235278, 4758.476567577563, 4784.091022705675, 4796.592289655348, 3623.873164439232, 3661.707063434919, 3739.3456145174487, 3774.641409066134, 3784.0918179636687, 1003.2926786615419, 1150.5685367987005, 1156.1791128298835, 1159.0611604600301, 1174.4069245031205, 839.3956351426963, 870.4907629037084, 873.8820259264918, 915.33638112368, 930.5096948782325, 4512.774361281923, 4978.427480839678, 5492.642978206404, 5579.637323573955, 5809.535237181015, 506.4656787089582, 552.9447055294438, 559.4629156010194, 564.2605151987126, 571.928508936383, 3685.4754493172263, 3702.9074273142846, 3838.865639702597, 3869.2068126034096, 3921.568627450978, 9501.334906556613, 9776.0, 9827.75430614226, 9895.406275623485, 9906.51402289648, 9862.309638325249, 9875.456849873326, 9884.703458896245, 9885.209183265322, 9887.406755594688, 7594.734184303523, 7649.502782319131, 7812.492188007761, 7862.685492580347, 7880.487768295043, 5356.196570514454, 5489.258950041693, 5517.531009864207, 5567.137093750475, 5633.324001119892, 9099.36304458708, 9173.678921237724, 9201.539923003957, 9210.539473026189, 9211.21704655085, 8920.0, 9291.442513449214, 9323.347365684336, 9333.673321433716, 9336.906630933603, 5549.528290095387, 6050.6369617823075, 6231.40801623845, 6539.673016349258, 6700.93299067003, 7848.686052557834, 7929.167437418988, 8065.669164588012, 8075.313598344206, 8107.473014254055, 6990.440764738911, 7112.537685050455, 7152.284771523015, 7155.892661610184, 7300.926990730025, 6824.829379265558, 7029.05107810439, 7063.505554611128, 7077.363037326665, 7108.680109395193, 6321.8735625288155, 6360.840978975378, 6421.229452465734, 6426.871462570816, 6450.903236451363, 4942.851714448572, 4946.752662366939, 5011.7494125294315, 5033.245013248042, 5090.389153301628, 4422.314541246112, 4448.888777780581, 4827.758612069452, 5010.0, 5111.488851114858], "value": 4319.356032316437, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.29646997785005, 354.4364460507792, 360.27225005488896, 369.50301844019793, 373.46034979454697, 4469.4636643602735, 4785.665003449752, 5302.522772950434, 5363.436839131893, 5409.8106566270135, 5241.5020573045595, 5309.522143007129, 5319.88786559862, 5348.277982472365, 5360.195970604412, 3528.259065596228, 3531.7880927144324, 4101.974506373406, 4167.478870212381, 4235.216484950294, 3655.524781778365, 3693.279810436966, 3765.5523909458934, 4193.35003074524, 4243.936340954888, 4061.939070913939, 4172.624463798257, 4172.812223449937, 4175.745097647266, 4178.853740119096, 3814.1036856338737, 4024.082540158391, 4189.539150693421, 4196.706230563862, 4200.600942910419, 3724.8696295629793, 3727.2545490901657, 3728.3475391806596, 3730.3658378075793, 3758.849646014156, 4890.774697512623, 4899.89752305732, 5098.980203959186, 5156.977557505114, 5244.213367994793, 3971.2724964640183, 4149.170165966789, 4889.037626808792, 4904.141775189328, 4921.311016457699, 5678.217673340075, 5686.289213848269, 5728.112142617859, 5736.483716465538, 5858.209141765849, 3059.5410688396696, 3988.7862236458755, 4110.547839737626, 4139.730917490384, 4172.624463798273, 5147.845564633104, 5617.707927176732, 5623.734659701576, 5954.940450595525, 5961.452935503368, 3695.152423788106, 3917.4123881417445, 4218.557051509609, 4230.746155230696, 4239.364095385655, 3539.911502212414, 3837.4435706822355, 3917.745346552465, 3947.585503522089, 4285.357196420562, 3907.628775266345, 4479.395281637003, 4508.864734057984, 4549.3176023596725, 4814.0, 4619.884502887455, 4780.641451891052, 4951.282064100757, 5728.481952282648, 5770.798022069207, 1204.8313236146946, 1378.3521744779937, 1393.7421577008083, 1399.8320201575875, 1401.9695523790006, 907.26964793342, 916.9403988740711, 923.7228831350702, 949.9715008549755, 996.097453863118, 4308.332208507686, 4455.349067304948, 4865.5864251538305, 4931.852044438672, 5066.847994560169, 5082.908258851586, 5094.949050509447, 5341.599380046512, 5348.1175606025345, 5590.608657393944, 4463.5313292103865, 4516.0, 4850.975745121252, 5092.541671249532, 5125.718085505258, 2617.241000109947, 2890.9710902891125, 2908.476474234658, 2916.314666053476, 2962.7333539981505, 5153.5361817436615, 5392.784288628411, 5593.496585307342, 5696.322728317684, 5741.483266506035, 4794.039152466599, 5028.84913452597, 5344.060766578366, 5504.91742623861, 5652.18043383707, 4670.991473666289, 4702.553257440606, 4754.0491901619125, 5132.897342053213, 5541.639793413496, 5209.791608335776, 5281.656692314988, 5622.718864056699, 5625.662460252398, 5695.977927835559, 4521.727002849085, 4708.835190768444, 5438.918416223839, 5462.481064298885, 5515.200295956984, 4485.170243504832, 4592.897704550817, 5278.498542638443, 5656.010198215378, 5844.444777746107, 3650.3429382711365, 3668.6881615063016, 4091.0, 4134.669226461936, 4149.792510374409, 5158.329417175743, 5592.608517403905, 5858.209141765978, 5860.2967643883, 5902.498287645598, 4657.835541114721, 5052.568488874548, 5304.787808487617, 5631.070873306023, 5661.858453538694, 4971.502849715144, 5550.000999820071, 5593.440655934374, 5598.888022239451, 5709.885802284014, 4309.956900431081, 4747.335373047707, 5444.564434845123, 5486.807961721321, 5535.557155427476, 5058.229619633246, 5085.415177254515, 5517.0, 5565.554755619622, 5589.80435684749, 4603.286490593963, 4770.546798054179, 5503.807366742145, 5514.28314319152, 5548.9722551386985], "value": 4063.195032734332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.430394796657, 701.0570782297808, 752.3341842469415, 758.3175142371869, 816.1593558634605, 13643.249621270827, 14639.41442342305, 14823.332950017248, 14832.480863169778, 14854.702905941887, 13723.31383430827, 13790.517331893385, 13847.030707850454, 13867.167969921786, 13946.511872084453, 897.5915958239018, 909.077286554148, 909.9772505687345, 910.8314961732101, 912.406935491929, 890.8975467821218, 909.9499527525984, 915.7802127489422, 933.3886304470583, 936.5083331251079, 961.9951900240524, 967.8451447768358, 972.1299437003877, 972.5623469438781, 973.5813600151968, 962.4946902875976, 962.7978124593843, 966.8066386722649, 967.9884520675911, 971.0823272007955, 719.5143278287135, 720.9531380460253, 720.9942130727658, 721.6536062689886, 724.026184781468, 14886.851131488764, 15191.316390762331, 15220.771688424682, 15318.923405383013, 15686.607834804106, 13778.09500516603, 13824.654383640389, 13887.513937012156, 13927.651808704763, 13945.58163255104, 11378.487968041376, 11396.943015284953, 11550.884491155064, 11611.0, 11877.881221187765, 3565.286942611488, 3618.6019537850816, 3623.184783423735, 3633.5458067741533, 3764.7552909060823, 83278.58360708218, 83837.0, 101852.3972346317, 104103.47948260287, 104434.43348349705, 10489.0, 10507.684769456928, 10728.927107289208, 10761.623343182951, 10797.13622910181, 21305.893470532857, 21516.0, 21545.67681484779, 21632.35102946914, 21967.780322196573, 7020.719171233196, 7353.926460735431, 7442.479026468203, 7587.0, 7601.201873803282, 4002.6197511236387, 4129.710920235615, 4130.173965206971, 4133.400656904792, 4136.524299705512, 3402.0474267205223, 3435.7423193260606, 3475.721942244614, 3514.279572687593, 3522.6653467920505, 590.2562770908686, 625.5371025441141, 633.4394061255822, 635.9077933699588, 648.335456157433, 597.7877853361994, 614.9354317796657, 637.2639601260552, 647.5078940005535, 663.3366633366634, 7680.3471704905705, 8065.596720164086, 9010.729678109667, 9044.095590441035, 9462.763430914145, 606.154414591651, 637.9885995505332, 649.6524359467662, 663.8970959501188, 666.3702800853147, 4374.606285434263, 4512.72923624577, 4536.909261814745, 4538.795754191069, 4550.49944506104, 73352.63323683347, 96882.0, 97986.02013979769, 98103.0, 98893.0, 84233.0, 85218.0, 85683.57158214293, 86013.0, 86285.56857215674, 45330.0, 62512.43718907155, 65239.673801630684, 66207.66896165488, 75297.62351188209, 7863.174366691644, 8088.595570221348, 9289.576858832474, 10311.278210525192, 10554.89260143192, 38295.6170438292, 42202.0, 46404.0, 47566.28650570175, 48039.799005025154, 58163.79293200465, 62271.0, 63228.0, 63363.683181583794, 63853.36146638474, 9945.900540994497, 12448.439820207932, 12514.68539788135, 12622.684432889251, 12714.11001229942, 13668.043236973317, 13714.588562343146, 13740.175589464265, 13814.723705526034, 13893.305334733424, 12749.745005100032, 12775.680607984874, 12789.296588687339, 13028.068684545902, 13266.204027758366, 12703.110782245154, 12826.358682066046, 12888.613341599766, 12997.217220494158, 13239.669008274484, 12539.686507837378, 12707.0, 12963.546275880299, 13160.802587960996, 13257.933710331386, 9239.676611318571, 10589.417582033062, 10713.571457141627, 10729.248952573556, 10867.862789990086, 7586.582737949466, 9511.15064235504, 9776.1690256329, 10311.639092631722, 10508.842367364343], "value": 7214.173455050032, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 118.0, 117.0, 116.0, 118.0, 121.0, 136.0, 177.0, 118.0], "value": 124.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 115.0, 114.0, 152.0, 118.0, 120.0, 116.0, 134.0, 139.0, 117.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 207.0, 206.0, 208.0, 225.0, 198.0, 199.0, 198.0, 198.0, 197.0], "value": 204.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 62.0, 63.0, 84.0, 60.0, 53.0, 72.0, 85.0, 93.0, 82.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 73.0, 86.0, 73.0, 72.0, 72.0, 88.0, 103.0, 99.0, 99.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 94.0, 90.0, 100.0, 88.0, 132.0, 136.0, 90.0, 90.0], "value": 100.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 119.0, 104.0, 117.0, 96.0, 100.0, 94.0, 116.0, 97.0], "value": 103.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 93.0, 119.0, 95.0, 90.0, 93.0, 95.0, 94.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 63.0, 64.0, 66.0, 66.0, 64.0, 67.0, 67.0, 84.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 108.0, 68.0, 76.0, 102.0, 109.0, 104.0, 81.0, 69.0, 73.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 108.0, 109.0, 81.0, 110.0, 109.0, 110.0, 90.0, 90.0], "value": 98.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 161.0, 146.0, 152.0, 159.0, 147.0, 145.0, 207.0, 163.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 213.0, 256.0, 182.0, 179.0, 177.0, 179.0, 178.0, 218.0, 236.0], "value": 199.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 67.0, 73.0, 70.0, 68.0, 67.0, 69.0, 68.0], "value": 69.1, "unit": "score"}]}]} 04:37:28 INFO - Return code: 0 04:37:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:37:28 ERROR - # TBPL SUCCESS # 04:37:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:37:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:37:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:37:28 INFO - 2017-02-26 04:37:28.546 screenresolution[2223:30034] starting screenresolution argv=screenresolution get 04:37:28 INFO - 2017-02-26 04:37:28.549 screenresolution[2223:30034] Display 0: 1600x1200x32@60 04:37:28 INFO - 2017-02-26 04:37:28.555 screenresolution[2224:30037] starting screenresolution argv=screenresolution list 04:37:28 INFO - Available Modes on Display 0 04:37:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:37:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:37:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:37:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:37:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:37:28 INFO - Intel Iris: 04:37:28 INFO - Chipset Model: Intel Iris 04:37:28 INFO - Type: GPU 04:37:28 INFO - Bus: Built-In 04:37:28 INFO - VRAM (Dynamic, Max): 1536 MB 04:37:28 INFO - Vendor: Intel (0x8086) 04:37:28 INFO - Device ID: 0x0a2e 04:37:28 INFO - Revision ID: 0x0009 04:37:28 INFO - Displays: 04:37:28 INFO - Display: 04:37:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:37:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:37:28 INFO - Display Serial Number: 1600x1200 60 04:37:28 INFO - Main Display: Yes 04:37:28 INFO - Mirror: Off 04:37:28 INFO - Online: Yes 04:37:28 INFO - Rotation: Supported 04:37:28 INFO - Return code: 0 04:37:28 INFO - Running post-action listener: _resource_record_post_action 04:37:28 INFO - [mozharness: 2017-02-26 12:37:28.791355Z] Finished run-tests step (success) 04:37:28 INFO - Running post-run listener: _resource_record_post_run 04:37:28 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 1873408; Write bytes: 556943872; Read time: 13; Write time: 1700 04:37:28 INFO - TinderboxPrint: CPU usage
54.7% 04:37:28 INFO - TinderboxPrint: I/O read bytes / time
1,873,408 / 13 04:37:28 INFO - TinderboxPrint: I/O write bytes / time
556,943,872 / 1,700 04:37:28 INFO - TinderboxPrint: CPU idle
2,174.7 (45.3%) 04:37:28 INFO - TinderboxPrint: CPU system
969.6 (20.2%) 04:37:28 INFO - TinderboxPrint: CPU user
1,661.5 (34.6%) 04:37:28 INFO - TinderboxPrint: Swap in / out
254,849,024 / 0 04:37:28 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 244599296; Write bytes: 235012096; Read time: 17872; Write time: 488 04:37:28 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 1873408; Write bytes: 302549504; Read time: 13; Write time: 1158 04:37:29 INFO - Running post-run listener: _upload_blobber_files 04:37:29 INFO - Blob upload gear active. 04:37:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:37:29 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 04:37:29 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:37:29 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:37:29 INFO - (blobuploader) - INFO - Open directory for files ... 04:37:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:37:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:37:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:30 INFO - (blobuploader) - INFO - Done attempting. 04:37:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:37:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:37:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:31 INFO - (blobuploader) - INFO - Done attempting. 04:37:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:37:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:32 INFO - (blobuploader) - INFO - Done attempting. 04:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:37:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:35 INFO - (blobuploader) - INFO - Done attempting. 04:37:35 INFO - (blobuploader) - INFO - Iteration through files over. 04:37:35 INFO - Return code: 0 04:37:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:37:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:37:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1f70a3e7f8a209b96b64436ed1a9121d8c8464d1b510f2e3eddfad92d6ffe48ca96e9222cf96e4f306f845904bcb3b75f478e0b11e86a3913f2175a69b394ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f979c0a716b2470d63c8b89c538c018cf6c687001460d735d61c476707a0eec83f305adeca7dddee69112e007f93bd35dc4ba2f6a8b07e5057fe9658c771a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79bdff7fcbf31a55187d16386cc22aa891cd5026230a8e9ca329c287ea14ccb0886f82ea353278aba97fb6a2a5f98c7a3dd9e2c2b184ef711c688203e9ed91bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fb38b96429242e9b3ce13151d8af8b01bbbb2b57f1ed752e6a5322ad656ae994fd3b6c3b4f7b72215d324aead6dce8929af777630edbbd40757271d0c977519"} 04:37:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:37:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:37:35 INFO - Contents: 04:37:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1f70a3e7f8a209b96b64436ed1a9121d8c8464d1b510f2e3eddfad92d6ffe48ca96e9222cf96e4f306f845904bcb3b75f478e0b11e86a3913f2175a69b394ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f979c0a716b2470d63c8b89c538c018cf6c687001460d735d61c476707a0eec83f305adeca7dddee69112e007f93bd35dc4ba2f6a8b07e5057fe9658c771a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79bdff7fcbf31a55187d16386cc22aa891cd5026230a8e9ca329c287ea14ccb0886f82ea353278aba97fb6a2a5f98c7a3dd9e2c2b184ef711c688203e9ed91bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fb38b96429242e9b3ce13151d8af8b01bbbb2b57f1ed752e6a5322ad656ae994fd3b6c3b4f7b72215d324aead6dce8929af777630edbbd40757271d0c977519"} 04:37:35 INFO - Running post-run listener: copy_logs_to_upload_dir 04:37:35 INFO - Copying logs to upload dir... 04:37:35 INFO - mkdir: /builds/slave/test/build/upload/logs 04:37:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.214302 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-26 04:37:35.277935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-26 04:37:35.282138) ========= 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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners TMPDIR=/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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/Firefox/sha512/c1f70a3e7f8a209b96b64436ed1a9121d8c8464d1b510f2e3eddfad92d6ffe48ca96e9222cf96e4f306f845904bcb3b75f478e0b11e86a3913f2175a69b394ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f979c0a716b2470d63c8b89c538c018cf6c687001460d735d61c476707a0eec83f305adeca7dddee69112e007f93bd35dc4ba2f6a8b07e5057fe9658c771a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79bdff7fcbf31a55187d16386cc22aa891cd5026230a8e9ca329c287ea14ccb0886f82ea353278aba97fb6a2a5f98c7a3dd9e2c2b184ef711c688203e9ed91bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fb38b96429242e9b3ce13151d8af8b01bbbb2b57f1ed752e6a5322ad656ae994fd3b6c3b4f7b72215d324aead6dce8929af777630edbbd40757271d0c977519"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1f70a3e7f8a209b96b64436ed1a9121d8c8464d1b510f2e3eddfad92d6ffe48ca96e9222cf96e4f306f845904bcb3b75f478e0b11e86a3913f2175a69b394ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f979c0a716b2470d63c8b89c538c018cf6c687001460d735d61c476707a0eec83f305adeca7dddee69112e007f93bd35dc4ba2f6a8b07e5057fe9658c771a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79bdff7fcbf31a55187d16386cc22aa891cd5026230a8e9ca329c287ea14ccb0886f82ea353278aba97fb6a2a5f98c7a3dd9e2c2b184ef711c688203e9ed91bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fb38b96429242e9b3ce13151d8af8b01bbbb2b57f1ed752e6a5322ad656ae994fd3b6c3b4f7b72215d324aead6dce8929af777630edbbd40757271d0c977519"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-26 04:37:35.321609) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 04:37:35.321929) ========= 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.8GXs3ayNFy/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.Lim5bgn7xS/Listeners TMPDIR=/var/folders/g3/9s44hl6d1bl5lknrx5vblzqc00000w/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.005090 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 04:37:35.370292) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-26 04:37:35.370606) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-26 04:37:35.370948) ========= ========= Total master_lag: 0.24 =========