builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0273 starttime: 1489187181.48 results: success (0) buildid: 20170310150612 builduid: 396ea4a64a334f6db68cdf31f01de9c4 revision: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:21.482505) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:21.482931) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:21.483206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:21.511340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:21.512058) ========= 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.xfPsJCexSn/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.JPrXbsOmLM/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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-03-10 15:06:21-- 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% 64.5M=0s 2017-03-10 15:06:21 (64.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151885 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:21.691129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:21.691869) ========= 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.xfPsJCexSn/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.JPrXbsOmLM/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.026054 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:21.744229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-10 15:06:21.745032) ========= 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.xfPsJCexSn/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.JPrXbsOmLM/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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-03-10 15:06:21,856 truncating revision to first 12 chars 2017-03-10 15:06:21,857 Setting DEBUG logging. 2017-03-10 15:06:21,857 attempt 1/10 2017-03-10 15:06:21,857 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-03-10 15:06:24,003 unpacking tar archive at: mozilla-central-fc9f6f7e8e86/testing/mozharness/ program finished with exit code 0 elapsedTime=2.421950 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-10 15:06:24.192388) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:24.192714) ========= script_repo_revision: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:24.193108) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:24.193372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 15:06:24.213244) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-10 15:06:24.213526) ========= /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.xfPsJCexSn/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.JPrXbsOmLM/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 15:06:24 INFO - MultiFileLogger online at 20170310 15:06:24 in /builds/slave/test 15:06:24 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 15:06:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:06:24 INFO - {'append_to_log': False, 15:06:24 INFO - 'base_work_dir': '/builds/slave/test', 15:06:24 INFO - 'blob_upload_branch': 'Firefox', 15:06:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:06:24 INFO - 'branch': 'Firefox', 15:06:24 INFO - 'buildbot_json_path': 'buildprops.json', 15:06:24 INFO - 'config_files': ('talos/mac_config.py',), 15:06:24 INFO - 'default_actions': ('clobber', 15:06:24 INFO - 'read-buildbot-config', 15:06:24 INFO - 'download-and-extract', 15:06:24 INFO - 'populate-webroot', 15:06:24 INFO - 'create-virtualenv', 15:06:24 INFO - 'install', 15:06:24 INFO - 'run-tests'), 15:06:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:06:24 INFO - 'download_minidump_stackwalk': True, 15:06:24 INFO - 'download_symbols': 'ondemand', 15:06:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:06:24 INFO - 'tooltool.py': '/tools/tooltool.py', 15:06:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:06:24 INFO - '/tools/misc-python/virtualenv.py')}, 15:06:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:06:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:06:24 INFO - 'installer_path': 'installer.exe', 15:06:24 INFO - 'log_level': 'info', 15:06:24 INFO - 'log_name': 'talos', 15:06:24 INFO - 'log_to_console': True, 15:06:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:06:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:06:24 INFO - 'opt_config_files': (), 15:06:24 INFO - 'pip_index': False, 15:06:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:06:24 INFO - 'cmd': ('bash', 15:06:24 INFO - '-c', 15:06:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:06:24 INFO - 'enabled': True, 15:06:24 INFO - 'halt_on_failure': False, 15:06:24 INFO - 'name': 'check_screen_resolution'},), 15:06:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:06:24 INFO - 'cmd': ('bash', 15:06:24 INFO - '-c', 15:06:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:06:24 INFO - 'enabled': True, 15:06:24 INFO - 'halt_on_failure': False, 15:06:24 INFO - 'name': 'check_screen_resolution'},), 15:06:24 INFO - 'run_cmd_checks_enabled': True, 15:06:24 INFO - 'sps_profile': False, 15:06:24 INFO - 'sps_profile_interval': 0, 15:06:24 INFO - 'suite': 'dromaeojs-e10s', 15:06:24 INFO - 'system_bits': '32', 15:06:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:06:24 INFO - 'title': 't-yosemite-r7-0273', 15:06:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:06:24 INFO - 'use_talos_json': True, 15:06:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:06:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:06:24 INFO - 'work_dir': 'build'} 15:06:24 INFO - [mozharness: 2017-03-10 23:06:24.432784Z] Running clobber step. 15:06:24 INFO - Running pre-action listener: _resource_record_pre_action 15:06:24 INFO - Running main action method: clobber 15:06:24 INFO - rmtree: /builds/slave/test/build 15:06:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:06:26 INFO - Running post-action listener: _resource_record_post_action 15:06:26 INFO - [mozharness: 2017-03-10 23:06:26.976912Z] Finished clobber step (success) 15:06:26 INFO - [mozharness: 2017-03-10 23:06:26.977116Z] Running read-buildbot-config step. 15:06:26 INFO - Running pre-action listener: _resource_record_pre_action 15:06:26 INFO - Running main action method: read_buildbot_config 15:06:26 INFO - Using buildbot properties: 15:06:26 INFO - { 15:06:26 INFO - "project": "", 15:06:26 INFO - "product": "firefox", 15:06:26 INFO - "script_repo_revision": "production", 15:06:26 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:06:26 INFO - "repository": "", 15:06:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:06:26 INFO - "buildid": "20170310150612", 15:06:26 INFO - "stage_platform": "macosx64", 15:06:26 INFO - "basedir": "/builds/slave/test", 15:06:26 INFO - "buildnumber": 98, 15:06:26 INFO - "platform": "yosemite_r7", 15:06:26 INFO - "mozci_request": { 15:06:26 INFO - "priority": -1, 15:06:26 INFO - "type": "trigger_all_talos_jobs", 15:06:26 INFO - "times": 1 15:06:26 INFO - }, 15:06:26 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 15:06:26 INFO - "slavebuilddir": "test", 15:06:26 INFO - "branch": "mozilla-central", 15:06:26 INFO - "revision": "fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd", 15:06:26 INFO - "slavename": "t-yosemite-r7-0273", 15:06:26 INFO - "builduid": "396ea4a64a334f6db68cdf31f01de9c4", 15:06:26 INFO - "repo_path": "mozilla-central" 15:06:26 INFO - } 15:06:26 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg. 15:06:26 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. 15:06:26 INFO - Running post-action listener: _resource_record_post_action 15:06:26 INFO - [mozharness: 2017-03-10 23:06:26.981863Z] Finished read-buildbot-config step (success) 15:06:26 INFO - [mozharness: 2017-03-10 23:06:26.982013Z] Running download-and-extract step. 15:06:26 INFO - Running pre-action listener: _resource_record_pre_action 15:06:26 INFO - Running main action method: download_and_extract 15:06:26 INFO - mkdir: /builds/slave/test/build/tests 15:06: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')]} 15:06:26 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json 15:06:26 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 15:06:26 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 15:06:27 INFO - Downloaded 1199 bytes. 15:06:27 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 15:06:27 INFO - Using the following test package requirements: 15:06:27 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 15:06:27 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 15:06:27 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 15:06:27 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 15:06:27 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 15:06:27 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 15:06:27 INFO - u'jsshell-mac.zip'], 15:06:27 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 15:06:27 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 15:06:27 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 15:06:27 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 15:06:27 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 15:06:27 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 15:06:27 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 15:06:27 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 15:06:27 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 15:06:27 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 15:06:27 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 15:06:27 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:06:27 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 15:06:27 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 15:06:27 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 15:06:28 INFO - Expected file size: 51504348 15:06:28 INFO - Obtained file size: 51504348 15:06:44 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 15:06:44 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 15:06:44 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 15:06:44 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 15:06:45 INFO - Expected file size: 51504348 15:06:45 INFO - Obtained file size: 51504348 15:07:00 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 15:07:00 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 15:07:00 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 15:07:00 INFO - Expected file size: 14403647 15:07:00 INFO - Obtained file size: 14403647 15:07:01 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')]} 15:07:01 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 15:07:01 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 15:07:01 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 15:07:02 INFO - Downloaded 70417704 bytes. 15:07:02 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 15:07:02 INFO - mkdir: /builds/slave/test/properties 15:07:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:07:02 INFO - Writing to file /builds/slave/test/properties/build_url 15:07:02 INFO - Contents: 15:07:02 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 15:07:03 INFO - Running post-action listener: _resource_record_post_action 15:07:03 INFO - Running post-action listener: set_extra_try_arguments 15:07:03 INFO - [mozharness: 2017-03-10 23:07:03.346391Z] Finished download-and-extract step (success) 15:07:03 INFO - [mozharness: 2017-03-10 23:07:03.346510Z] Running populate-webroot step. 15:07:03 INFO - Running pre-action listener: _resource_record_pre_action 15:07:03 INFO - Running main action method: populate_webroot 15:07:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:07:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:07:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:07:03 INFO - '--tppagecycles', 15:07:03 INFO - '7'], 15:07:03 INFO - 'tests': ['tsvgm']}}, 15:07:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:07:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:07:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:07:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:07:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:07:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:07:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:07:03 INFO - 'talos_options': ['--disable-e10s'], 15:07:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:07:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:07:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:07:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:07:03 INFO - 'talos_options': ['--disable-e10s'], 15:07:03 INFO - 'tests': ['damp', 'tps']}, 15:07:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:07:03 INFO - 'tests': ['damp', 'tps']}, 15:07:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:07:03 INFO - 'tests': ['dromaeo_dom']}, 15:07:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:07:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:07:03 INFO - 'tests': ['basic_compositor_video']}, 15:07:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:07:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:07:03 INFO - 'tests': ['a11yr', 15:07:03 INFO - 'ts_paint', 15:07:03 INFO - 'tpaint', 15:07:03 INFO - 'sessionrestore', 15:07:03 INFO - 'sessionrestore_no_auto_restore', 15:07:03 INFO - 'tabpaint']}, 15:07:03 INFO - 'other-e10s': {'tests': ['a11yr', 15:07:03 INFO - 'ts_paint', 15:07:03 INFO - 'tpaint', 15:07:03 INFO - 'sessionrestore', 15:07:03 INFO - 'sessionrestore_no_auto_restore', 15:07:03 INFO - 'tabpaint']}, 15:07:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:07:03 INFO - 'ts_paint', 15:07:03 INFO - 'tpaint', 15:07:03 INFO - 'sessionrestore', 15:07:03 INFO - 'sessionrestore_no_auto_restore', 15:07:03 INFO - 'tabpaint']}, 15:07:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:07:03 INFO - 'ts_paint', 15:07:03 INFO - 'tpaint', 15:07:03 INFO - 'sessionrestore', 15:07:03 INFO - 'sessionrestore_no_auto_restore', 15:07:03 INFO - 'tabpaint']}, 15:07:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:07:03 INFO - 'tests': ['a11yr', 15:07:03 INFO - 'ts_paint', 15:07:03 INFO - 'tpaint', 15:07:03 INFO - 'sessionrestore', 15:07:03 INFO - 'sessionrestore_no_auto_restore', 15:07:03 INFO - 'tabpaint']}, 15:07:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:07:03 INFO - 'tests': ['a11yr', 15:07:03 INFO - 'ts_paint', 15:07:03 INFO - 'tpaint', 15:07:03 INFO - 'sessionrestore', 15:07:03 INFO - 'sessionrestore_no_auto_restore', 15:07:03 INFO - 'tabpaint']}, 15:07:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:07:03 INFO - 'tests': ['tsvgx', 15:07:03 INFO - 'tsvgr_opacity', 15:07:03 INFO - 'tart', 15:07:03 INFO - 'tscrollx', 15:07:03 INFO - 'cart', 15:07:03 INFO - 'tsvg_static']}, 15:07:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:07:03 INFO - 'tsvgr_opacity', 15:07:03 INFO - 'tart', 15:07:03 INFO - 'tscrollx', 15:07:03 INFO - 'cart', 15:07:03 INFO - 'tsvg_static']}, 15:07:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:07:03 INFO - 'talos_options': ['--disable-e10s'], 15:07:03 INFO - 'tests': ['tp5o']}, 15:07:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:07:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:07:03 INFO - 'talos_options': ['--disable-e10s', 15:07:03 INFO - '--xperf_path', 15:07:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:07:03 INFO - 'tests': ['tp5n']}, 15:07:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:07:03 INFO - 'talos_options': ['--xperf_path', 15:07:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:07:03 INFO - 'tests': ['tp5n']}}, 15:07:03 INFO - 'talos.zip': {'path': '', 15:07:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:07:03 INFO - Running post-action listener: _resource_record_post_action 15:07:03 INFO - [mozharness: 2017-03-10 23:07:03.364929Z] Finished populate-webroot step (success) 15:07:03 INFO - [mozharness: 2017-03-10 23:07:03.365066Z] Running create-virtualenv step. 15:07:03 INFO - Running pre-action listener: _resource_record_pre_action 15:07:03 INFO - Running main action method: create_virtualenv 15:07:03 INFO - Creating virtualenv /builds/slave/test/build/venv 15:07:03 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 15:07:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:07:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:07:03 INFO - Using real prefix '/tools/python27' 15:07:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:07:04 INFO - Installing distribute.............................................................................................................................................................................................done. 15:07:07 INFO - Installing pip.................done. 15:07:07 INFO - Return code: 0 15:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:07:07 INFO - Reading from file tmpfile_stdout 15:07:07 INFO - Output received: 15:07:07 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) 15:07:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:07: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')]} 15:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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')]} 15:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd61d757d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e969d30>, '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 0x10e890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e95ebe8>, '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.xfPsJCexSn/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.JPrXbsOmLM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 15:07: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', 'pip>=1.5'] in /builds/slave/test/build 15:07: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 pip>=1.5 15:07:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfPsJCexSn/Render', 15:07:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:07 INFO - 'HOME': '/Users/cltbld', 15:07:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:07 INFO - 'LOGNAME': 'cltbld', 15:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:07 INFO - 'MOZ_NO_REMOTE': '1', 15:07:07 INFO - 'NO_EM_RESTART': '1', 15:07:07 INFO - 'PAGER': '/bin/cat', 15:07:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:07 INFO - 'PWD': '/builds/slave/test', 15:07:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:07 INFO - 'SHELL': '/bin/bash', 15:07:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPrXbsOmLM/Listeners', 15:07:07 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 15:07:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:07 INFO - 'USER': 'cltbld', 15:07:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:07 INFO - 'XPC_FLAGS': '0x0', 15:07:07 INFO - 'XPC_SERVICE_NAME': '0', 15:07:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:07 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 15:07:07 INFO - Cleaning up... 15:07:07 INFO - Return code: 0 15:07:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:07: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')]} 15:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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')]} 15:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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', '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 0x10eb8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd61d757d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e969d30>, '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 0x10e890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e95ebe8>, '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.xfPsJCexSn/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.JPrXbsOmLM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 15:07: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:07: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 psutil>=3.1.1 15:07:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfPsJCexSn/Render', 15:07:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:07 INFO - 'HOME': '/Users/cltbld', 15:07:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:07 INFO - 'LOGNAME': 'cltbld', 15:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:07 INFO - 'MOZ_NO_REMOTE': '1', 15:07:07 INFO - 'NO_EM_RESTART': '1', 15:07:07 INFO - 'PAGER': '/bin/cat', 15:07:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:07 INFO - 'PWD': '/builds/slave/test', 15:07:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:07 INFO - 'SHELL': '/bin/bash', 15:07:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPrXbsOmLM/Listeners', 15:07:07 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 15:07:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:07 INFO - 'USER': 'cltbld', 15:07:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:07 INFO - 'XPC_FLAGS': '0x0', 15:07:07 INFO - 'XPC_SERVICE_NAME': '0', 15:07:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:07 INFO - Downloading/unpacking psutil>=3.1.1 15:07: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 15:07: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 15:07: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 15:07: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 15:07: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 15:07: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 15:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:07:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:07:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:07:11 INFO - Installing collected packages: psutil 15:07:11 INFO - Running setup.py install for psutil 15:07:11 INFO - building 'psutil._psutil_osx' extension 15:07:11 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 15:07:12 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 15:07:12 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 15:07:12 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 15:07:12 INFO - building 'psutil._psutil_posix' extension 15:07:12 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 15:07:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:07:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:07:12 INFO - ^ 15:07:12 INFO - 1 warning generated. 15:07:12 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 15:07:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:07:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:07:12 INFO - Successfully installed psutil 15:07:12 INFO - Cleaning up... 15:07:12 INFO - Return code: 0 15:07:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:07:12 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')]} 15:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:12 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')]} 15:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:12 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 0x10eb8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd61d757d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e969d30>, '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 0x10e890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e95ebe8>, '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.xfPsJCexSn/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.JPrXbsOmLM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 15:07:12 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 15:07:12 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 15:07:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfPsJCexSn/Render', 15:07:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:12 INFO - 'HOME': '/Users/cltbld', 15:07:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:12 INFO - 'LOGNAME': 'cltbld', 15:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:12 INFO - 'MOZ_NO_REMOTE': '1', 15:07:12 INFO - 'NO_EM_RESTART': '1', 15:07:12 INFO - 'PAGER': '/bin/cat', 15:07:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:12 INFO - 'PWD': '/builds/slave/test', 15:07:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:12 INFO - 'SHELL': '/bin/bash', 15:07:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPrXbsOmLM/Listeners', 15:07:12 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 15:07:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:12 INFO - 'USER': 'cltbld', 15:07:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:12 INFO - 'XPC_FLAGS': '0x0', 15:07:12 INFO - 'XPC_SERVICE_NAME': '0', 15:07:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:07:15 INFO - Installing collected packages: mozsystemmonitor 15:07:15 INFO - Running setup.py install for mozsystemmonitor 15:07:15 INFO - Successfully installed mozsystemmonitor 15:07:15 INFO - Cleaning up... 15:07:15 INFO - Return code: 0 15:07:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:07:15 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')]} 15:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:15 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')]} 15:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:15 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 0x10eb8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd61d757d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e969d30>, '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 0x10e890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e95ebe8>, '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.xfPsJCexSn/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.JPrXbsOmLM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 15:07:15 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 15:07:15 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 15:07:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfPsJCexSn/Render', 15:07:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:15 INFO - 'HOME': '/Users/cltbld', 15:07:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:15 INFO - 'LOGNAME': 'cltbld', 15:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:15 INFO - 'MOZ_NO_REMOTE': '1', 15:07:15 INFO - 'NO_EM_RESTART': '1', 15:07:15 INFO - 'PAGER': '/bin/cat', 15:07:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:15 INFO - 'PWD': '/builds/slave/test', 15:07:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:15 INFO - 'SHELL': '/bin/bash', 15:07:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPrXbsOmLM/Listeners', 15:07:15 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 15:07:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:15 INFO - 'USER': 'cltbld', 15:07:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:15 INFO - 'XPC_FLAGS': '0x0', 15:07:15 INFO - 'XPC_SERVICE_NAME': '0', 15:07:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:16 INFO - Downloading/unpacking jsonschema==2.5.1 15:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:07:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:07:18 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 15:07:18 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 15:07:18 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 15:07:18 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 15:07:18 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 15:07:18 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 15:07:19 INFO - Downloading functools32-3.2.3-2.tar.gz 15:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:07:19 INFO - warning: no files found matching '*.txt' 15:07:19 INFO - no previously-included directories found matching 'build' 15:07:19 INFO - no previously-included directories found matching 'dist' 15:07:19 INFO - no previously-included directories found matching '.git*' 15:07:19 INFO - Installing collected packages: jsonschema, functools32 15:07:19 INFO - Running setup.py install for functools32 15:07:19 INFO - warning: no files found matching '*.txt' 15:07:19 INFO - no previously-included directories found matching 'build' 15:07:19 INFO - no previously-included directories found matching 'dist' 15:07:19 INFO - no previously-included directories found matching '.git*' 15:07:19 INFO - Successfully installed jsonschema functools32 15:07:19 INFO - Cleaning up... 15:07:19 INFO - Return code: 0 15:07:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:20 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 0x10eb8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd61d757d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e969d30>, '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 0x10e890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e95ebe8>, '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.xfPsJCexSn/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.JPrXbsOmLM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 15:07:20 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 15:07:20 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 15:07:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfPsJCexSn/Render', 15:07:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:20 INFO - 'HOME': '/Users/cltbld', 15:07:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:20 INFO - 'LOGNAME': 'cltbld', 15:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:20 INFO - 'MOZ_NO_REMOTE': '1', 15:07:20 INFO - 'NO_EM_RESTART': '1', 15:07:20 INFO - 'PAGER': '/bin/cat', 15:07:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:20 INFO - 'PWD': '/builds/slave/test', 15:07:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:20 INFO - 'SHELL': '/bin/bash', 15:07:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPrXbsOmLM/Listeners', 15:07:20 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 15:07:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:20 INFO - 'USER': 'cltbld', 15:07:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:20 INFO - 'XPC_FLAGS': '0x0', 15:07:20 INFO - 'XPC_SERVICE_NAME': '0', 15:07:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:07:20 INFO - Cleaning up... 15:07:20 INFO - Return code: 0 15:07:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:07: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')]} 15:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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')]} 15:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:21 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 0x10eb8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd61d757d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e969d30>, '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 0x10e890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e95ebe8>, '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.xfPsJCexSn/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.JPrXbsOmLM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 15:07:21 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 15:07:21 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 15:07:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfPsJCexSn/Render', 15:07:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:21 INFO - 'HOME': '/Users/cltbld', 15:07:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:21 INFO - 'LOGNAME': 'cltbld', 15:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:21 INFO - 'MOZ_NO_REMOTE': '1', 15:07:21 INFO - 'NO_EM_RESTART': '1', 15:07:21 INFO - 'PAGER': '/bin/cat', 15:07:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:21 INFO - 'PWD': '/builds/slave/test', 15:07:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:21 INFO - 'SHELL': '/bin/bash', 15:07:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPrXbsOmLM/Listeners', 15:07:21 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 15:07:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:21 INFO - 'USER': 'cltbld', 15:07:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:21 INFO - 'XPC_FLAGS': '0x0', 15:07:21 INFO - 'XPC_SERVICE_NAME': '0', 15:07:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:21 INFO - Downloading/unpacking blobuploader==1.2.4 15:07:21 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 15:07:21 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 15:07:21 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 15:07:21 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 15:07:21 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 15:07:21 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 15:07:24 INFO - Downloading blobuploader-1.2.4.tar.gz 15:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:07:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:07:24 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 15:07:24 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 15:07:24 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 15:07:24 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 15:07:24 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 15:07:24 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 15:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:07:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:07:25 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 15:07:25 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 15:07:25 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 15:07:25 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 15:07:25 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 15:07:25 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 15:07:25 INFO - Downloading docopt-0.6.1.tar.gz 15:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:07:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:07:25 INFO - Running setup.py install for blobuploader 15:07:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:07:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:07:25 INFO - Running setup.py install for requests 15:07:26 INFO - Running setup.py install for docopt 15:07:26 INFO - Successfully installed blobuploader requests docopt 15:07:26 INFO - Cleaning up... 15:07:26 INFO - Return code: 0 15:07:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:07: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')]} 15:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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')]} 15:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:26 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 0x10eb8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd61d757d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e969d30>, '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 0x10e890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e95ebe8>, '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.xfPsJCexSn/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.JPrXbsOmLM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 15:07:26 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 15:07:26 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 15:07:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfPsJCexSn/Render', 15:07:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:26 INFO - 'HOME': '/Users/cltbld', 15:07:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:26 INFO - 'LOGNAME': 'cltbld', 15:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:26 INFO - 'MOZ_NO_REMOTE': '1', 15:07:26 INFO - 'NO_EM_RESTART': '1', 15:07:26 INFO - 'PAGER': '/bin/cat', 15:07:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:26 INFO - 'PWD': '/builds/slave/test', 15:07:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:26 INFO - 'SHELL': '/bin/bash', 15:07:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPrXbsOmLM/Listeners', 15:07:26 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 15:07:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:26 INFO - 'USER': 'cltbld', 15:07:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:26 INFO - 'XPC_FLAGS': '0x0', 15:07:26 INFO - 'XPC_SERVICE_NAME': '0', 15:07:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:07:26 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-aB_Z82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:07:26 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-OefHpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:07:26 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-tQfUJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:07:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-BJWoJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:07:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-0SsCS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:07:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-WI4_RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:07:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-6nA1lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:07:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-8oSpOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:07:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-1Ohan4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:07:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-jtO7Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:07:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-TG3ofe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:07:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-7AkTmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:07:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-l9dLUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:07:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ec7Zab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:07:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-rpSh8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:07:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-wUEsFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:07:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-aqUUU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:07:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:07:28 INFO - Running setup.py install for manifestparser 15:07:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:07:28 INFO - Running setup.py install for mozcrash 15:07:28 INFO - Running setup.py install for mozdebug 15:07:28 INFO - Running setup.py install for mozdevice 15:07:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:07:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:07:29 INFO - Running setup.py install for mozfile 15:07:29 INFO - Running setup.py install for mozhttpd 15:07:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:07:29 INFO - Running setup.py install for mozinfo 15:07:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:07:29 INFO - Running setup.py install for mozInstall 15:07:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:07:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:07:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:07:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:07:29 INFO - Running setup.py install for mozleak 15:07:29 INFO - Running setup.py install for mozlog 15:07:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:07:30 INFO - Running setup.py install for moznetwork 15:07:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:07:30 INFO - Running setup.py install for mozprocess 15:07:30 INFO - Running setup.py install for mozprofile 15:07:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:07:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:07:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:07:30 INFO - Running setup.py install for mozrunner 15:07:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:07:30 INFO - Running setup.py install for mozscreenshot 15:07:30 INFO - Running setup.py install for moztest 15:07:30 INFO - Running setup.py install for mozversion 15:07:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:07:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:07:31 INFO - Cleaning up... 15:07:31 INFO - Return code: 0 15:07:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:31 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 0x10eb8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd61d757d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e969d30>, '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 0x10e890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e95ebe8>, '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.xfPsJCexSn/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.JPrXbsOmLM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 15:07:31 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 15:07:31 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 15:07:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfPsJCexSn/Render', 15:07:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:31 INFO - 'HOME': '/Users/cltbld', 15:07:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:31 INFO - 'LOGNAME': 'cltbld', 15:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:31 INFO - 'MOZ_NO_REMOTE': '1', 15:07:31 INFO - 'NO_EM_RESTART': '1', 15:07:31 INFO - 'PAGER': '/bin/cat', 15:07:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:31 INFO - 'PWD': '/builds/slave/test', 15:07:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:31 INFO - 'SHELL': '/bin/bash', 15:07:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPrXbsOmLM/Listeners', 15:07:31 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 15:07:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:31 INFO - 'USER': 'cltbld', 15:07:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:31 INFO - 'XPC_FLAGS': '0x0', 15:07:31 INFO - 'XPC_SERVICE_NAME': '0', 15:07:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:07:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-1iNe8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:07:31 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)) 15:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:07:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-MhMxU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:07:31 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)) 15:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:07:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-a6VyDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:07:31 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)) 15:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:07:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-re_JQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:07:31 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)) 15:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:07:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-T0pM6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:07:31 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)) 15:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:07:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-_nrxTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:07:31 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)) 15:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:07:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-aB2ejB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:07:32 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)) 15:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:07:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-XRUT2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:07:32 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)) 15:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:07:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-f656vX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:07:32 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)) 15:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:07:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-UVIb10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:07:32 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)) 15:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:07:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-l18wTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:07:32 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)) 15:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:07:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-GezQQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:07:32 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)) 15:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:07:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ZJf79Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:07:32 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)) 15:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:07:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-uvR_Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:07:32 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)) 15:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:07:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-USVm6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:07:32 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)) 15:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:07:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-9Fs3I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:07:33 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)) 15:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:07:33 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-omo0dL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:07:33 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)) 15:07:33 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)) 15:07:33 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)) 15:07:33 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)) 15:07:33 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)) 15:07:33 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)) 15:07:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:35 INFO - Downloading blessings-1.6.tar.gz 15:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:07:35 INFO - Installing collected packages: blessings 15:07:35 INFO - Running setup.py install for blessings 15:07:36 INFO - Successfully installed blessings 15:07:36 INFO - Cleaning up... 15:07:36 INFO - Return code: 0 15:07:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:07:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:07:36 INFO - Reading from file tmpfile_stdout 15:07:36 INFO - Current package versions: 15:07:36 INFO - blessings == 1.6 15:07:36 INFO - blobuploader == 1.2.4 15:07:36 INFO - docopt == 0.6.1 15:07:36 INFO - functools32 == 3.2.3-2 15:07:36 INFO - jsonschema == 2.5.1 15:07:36 INFO - manifestparser == 1.1 15:07:36 INFO - mozInstall == 1.12 15:07:36 INFO - mozcrash == 1.0 15:07:36 INFO - mozdebug == 0.1 15:07:36 INFO - mozdevice == 0.49 15:07:36 INFO - mozfile == 1.2 15:07:36 INFO - mozhttpd == 0.7 15:07:36 INFO - mozinfo == 0.9 15:07:36 INFO - mozleak == 0.1 15:07:36 INFO - mozlog == 3.4 15:07:36 INFO - moznetwork == 0.27 15:07:36 INFO - mozprocess == 0.24 15:07:36 INFO - mozprofile == 0.28 15:07:36 INFO - mozrunner == 6.13 15:07:36 INFO - mozscreenshot == 0.1 15:07:36 INFO - mozsystemmonitor == 0.3 15:07:36 INFO - moztest == 0.8 15:07:36 INFO - mozversion == 1.4 15:07:36 INFO - psutil == 3.1.1 15:07:36 INFO - requests == 1.2.3 15:07:36 INFO - wsgiref == 0.1.2 15:07:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:36 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 0x10eb8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd61d757d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e969d30>, '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 0x10e890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e95ebe8>, '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.xfPsJCexSn/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.JPrXbsOmLM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 15:07:36 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 15:07:36 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 15:07:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfPsJCexSn/Render', 15:07:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:36 INFO - 'HOME': '/Users/cltbld', 15:07:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:36 INFO - 'LOGNAME': 'cltbld', 15:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:36 INFO - 'MOZ_NO_REMOTE': '1', 15:07:36 INFO - 'NO_EM_RESTART': '1', 15:07:36 INFO - 'PAGER': '/bin/cat', 15:07:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:36 INFO - 'PWD': '/builds/slave/test', 15:07:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:36 INFO - 'SHELL': '/bin/bash', 15:07:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPrXbsOmLM/Listeners', 15:07:36 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 15:07:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:36 INFO - 'USER': 'cltbld', 15:07:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:36 INFO - 'XPC_FLAGS': '0x0', 15:07:36 INFO - 'XPC_SERVICE_NAME': '0', 15:07:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:36 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)) 15:07:36 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)) 15:07:36 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)) 15:07:36 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)) 15:07:36 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)) 15:07:36 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)) 15:07:36 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)) 15:07:36 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)) 15:07:36 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)) 15:07:36 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)) 15:07:36 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)) 15:07:36 INFO - Cleaning up... 15:07:36 INFO - Return code: 0 15:07:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd61d757d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e969d30>, '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 0x10e890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e95ebe8>, '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.xfPsJCexSn/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.JPrXbsOmLM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 15:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:07:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfPsJCexSn/Render', 15:07:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:36 INFO - 'HOME': '/Users/cltbld', 15:07:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:36 INFO - 'LOGNAME': 'cltbld', 15:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:36 INFO - 'MOZ_NO_REMOTE': '1', 15:07:36 INFO - 'NO_EM_RESTART': '1', 15:07:36 INFO - 'PAGER': '/bin/cat', 15:07:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:36 INFO - 'PWD': '/builds/slave/test', 15:07:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:36 INFO - 'SHELL': '/bin/bash', 15:07:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPrXbsOmLM/Listeners', 15:07:36 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 15:07:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:36 INFO - 'USER': 'cltbld', 15:07:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:36 INFO - 'XPC_FLAGS': '0x0', 15:07:36 INFO - 'XPC_SERVICE_NAME': '0', 15:07:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:07:36 INFO - Cleaning up... 15:07:37 INFO - Return code: 0 15:07:37 INFO - Running post-action listener: _resource_record_post_action 15:07:37 INFO - Running post-action listener: _start_resource_monitoring 15:07:37 INFO - Starting resource monitoring. 15:07:37 INFO - [mozharness: 2017-03-10 23:07:37.028923Z] Finished create-virtualenv step (success) 15:07:37 INFO - [mozharness: 2017-03-10 23:07:37.029868Z] Running install step. 15:07:37 INFO - Running pre-action listener: _resource_record_pre_action 15:07:37 INFO - Running main action method: install 15:07:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:07:37 INFO - Reading from file tmpfile_stdout 15:07:37 INFO - Detecting whether we're running mozinstall >=1.0... 15:07:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:07:37 INFO - Reading from file tmpfile_stdout 15:07:37 INFO - Output received: 15:07:37 INFO - Usage: mozinstall [options] installer 15:07:37 INFO - Options: 15:07:37 INFO - -h, --help show this help message and exit 15:07:37 INFO - -d DEST, --destination=DEST 15:07:37 INFO - Directory to install application into. [default: 15:07:37 INFO - "/builds/slave/test"] 15:07:37 INFO - --app=APP Application being installed. [default: firefox] 15:07:37 INFO - mkdir: /builds/slave/test/build/application 15:07:37 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'] 15:07:37 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 15:07:59 INFO - Reading from file tmpfile_stdout 15:07:59 INFO - Output received: 15:07:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:07:59 INFO - Running post-action listener: _resource_record_post_action 15:07:59 INFO - [mozharness: 2017-03-10 23:07:59.439709Z] Finished install step (success) 15:07:59 INFO - [mozharness: 2017-03-10 23:07:59.439812Z] Running run-tests step. 15:07:59 INFO - Running pre-action listener: _resource_record_pre_action 15:07:59 INFO - Running main action method: run_tests 15:07:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:07:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:07:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:07:59 INFO - 2017-03-10 15:07:59.453 screenresolution[1626:7372] starting screenresolution argv=screenresolution get 15:07:59 INFO - 2017-03-10 15:07:59.455 screenresolution[1626:7372] Display 0: 1600x1200x32@60 15:07:59 INFO - 2017-03-10 15:07:59.460 screenresolution[1627:7375] starting screenresolution argv=screenresolution list 15:07:59 INFO - Available Modes on Display 0 15:07:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:07:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:07:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:07:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:07:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:07:59 INFO - Intel Iris: 15:07:59 INFO - Chipset Model: Intel Iris 15:07:59 INFO - Type: GPU 15:07:59 INFO - Bus: Built-In 15:07:59 INFO - VRAM (Dynamic, Max): 1536 MB 15:07:59 INFO - Vendor: Intel (0x8086) 15:07:59 INFO - Device ID: 0x0a2e 15:07:59 INFO - Revision ID: 0x0009 15:07:59 INFO - Displays: 15:07:59 INFO - Display: 15:07:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:07:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:07:59 INFO - Display Serial Number: 1600x1200 60 15:07:59 INFO - Main Display: Yes 15:07:59 INFO - Mirror: Off 15:07:59 INFO - Online: Yes 15:07:59 INFO - Rotation: Supported 15:07:59 INFO - Return code: 0 15:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:07:59 INFO - Python 2.7.3 15:07:59 INFO - Return code: 0 15:07:59 INFO - grabbing minidump binary from tooltool 15:07:59 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')]} 15:07:59 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 0x10e969d30>, '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 0x10e890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e95ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:07:59 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 15:07:59 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 15:07:59 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 15:07:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:07:59 INFO - Return code: 0 15:07:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:07:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:07:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:07:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:07:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:07:59 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-0273', '--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 15:07:59 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-0273 --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 15:07:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfPsJCexSn/Render', 15:07:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:59 INFO - 'HOME': '/Users/cltbld', 15:07:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:59 INFO - 'LOGNAME': 'cltbld', 15:07:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:07:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:59 INFO - 'MOZ_NO_REMOTE': '1', 15:07:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:07:59 INFO - 'NO_EM_RESTART': '1', 15:07:59 INFO - 'PAGER': '/bin/cat', 15:07:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:59 INFO - 'PWD': '/builds/slave/test', 15:07:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:07:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:59 INFO - 'SHELL': '/bin/bash', 15:07:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPrXbsOmLM/Listeners', 15:07:59 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 15:07:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:59 INFO - 'USER': 'cltbld', 15:07:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:59 INFO - 'XPC_FLAGS': '0x0', 15:07:59 INFO - 'XPC_SERVICE_NAME': '0', 15:07:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:59 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-0273', '--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 15:08:00 INFO - mozversion application_buildid: 20170214071445 15:08:00 INFO - mozversion application_changeset: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd 15:08:00 INFO - mozversion application_display_name: Nightly 15:08:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:08:00 INFO - mozversion application_name: Firefox 15:08:00 INFO - mozversion application_remotingname: firefox 15:08:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:08:00 INFO - mozversion application_vendor: Mozilla 15:08:00 INFO - mozversion application_version: 54.0a1 15:08:00 INFO - mozversion platform_buildid: 20170214071445 15:08:00 INFO - mozversion platform_changeset: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd 15:08:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:08:00 INFO - mozversion platform_version: 54.0a1 15:08:00 INFO - using testdate: 1489187280 15:08:00 INFO - actual date: 1489187280 15:08:00 INFO - starting webserver on 'localhost:49241' 15:08:00 INFO - SUITE-START | Running 2 tests 15:08:00 INFO - TEST-START | dromaeo_css 15:08:00 INFO - operating with platform_type : mac_ 15:08:00 INFO - Initialising browser for dromaeo_css test... 15:08:00 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmplxY70y/profile http://localhost:49241/getInfo.html) 15:08:03 INFO - PROCESS | 1637 | 2017-03-10 15:08:03.028 plugin-container[1639:7547] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 15:08:03 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:08:03 INFO - PROCESS | 1637 | 2017-03-10 15:08:03.032 plugin-container[1639:7547] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9327, name = 'com.apple.CFPasteboardClient' 15:08:03 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:08:03 INFO - PROCESS | 1637 | 2017-03-10 15:08:03.032 plugin-container[1639:7547] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:08:03 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 15:08:03 INFO - PROCESS | 1637 | colorDepth:24 15:08:03 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 15:08:03 INFO - PROCESS | 1637 | __metrics 15:08:03 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 15:08:03 INFO - TEST-INFO | 1637: exit 0 15:08:03 INFO - Browser initialized. 15:08:03 INFO - Running cycle 1/1 for dromaeo_css test... 15:08:04 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmplxY70y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:08:06 INFO - PROCESS | 1640 | 2017-03-10 15:08:06.422 plugin-container[1641:7671] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 15:08:06 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:08:06 INFO - PROCESS | 1640 | 2017-03-10 15:08:06.423 plugin-container[1641:7671] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 15:08:06 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:08:06 INFO - PROCESS | 1640 | 2017-03-10 15:08:06.423 plugin-container[1641:7671] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:08:16 INFO - PROCESS | 1640 | RSS: Main: 234147840 15:08:16 INFO - PROCESS | 1640 | 15:11:19 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 15:11:21 INFO - PROCESS | 1640 | RSS: Main: 255291392 15:11:21 INFO - PROCESS | 1640 | 15:13:04 INFO - PROCESS | 1640 | ************************* 15:13:04 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 15:13:04 INFO - PROCESS | 1640 | 15:13:04 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:13:04 INFO - PROCESS | 1640 | Full stack: 15:13:04 INFO - PROCESS | 1640 | ************************* 15:14:23 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 15:14:24 INFO - PROCESS | 1640 | RSS: Main: 260939776 15:14:24 INFO - PROCESS | 1640 | 15:17:26 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 15:17:26 INFO - PROCESS | 1640 | RSS: Main: 273080320 15:17:26 INFO - PROCESS | 1640 | 15:20:28 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 15:20:29 INFO - PROCESS | 1640 | RSS: Main: 264970240 15:20:29 INFO - PROCESS | 1640 | 15:23:32 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 15:23:33 INFO - PROCESS | 1640 | RSS: Main: 268386304 15:23:33 INFO - PROCESS | 1640 | 15:26:36 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 15:26:36 INFO - PROCESS | 1640 | RSS: Main: 269557760 15:26:36 INFO - PROCESS | 1640 | 15:26:36 INFO - PROCESS | 1640 | __start_tp_report 15:26:36 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 15:26:36 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 15:26:36 INFO - PROCESS | 1640 | |i|pagename|runs| 15:26:36 INFO - PROCESS | 1640 | |0;dojo.html;3337.949930751039;3340.89977300681;3347.0962840033208;3359.8320083995795;3381.357542067007;5400.648957817739;5494.313210848644;5540.307461567304;5540.616969131699;5552.278203833506;5393.973030134854;5549.445055494449;5567.081431563797;5576.219329293892;5654.151877218409;5051.292819005343;5070.695758254507;5103.770330335125;5172.612054095939;5174.793008279665;4376.97811510942;4913.950860491385;5136.614753893455;5210.19242017486;5217.921731174036;5029.3964724232965;5089.618278629081;5090.9236361454605;5148.35645544305;5160.432352441228;5088.592912567023;5097.158968770148;5108.106081435771;5113.846584602431;5155.871103222412;5088.287639730441;5098.668586541863;5115.87210319745;5118.283440318359;5122.33409656746;5318.760655770499;5409;5440.7551660174995;5472.91790623141;5557.194206840026;6112.685862051835;6185.381461853824;6187.350328215518;6191.81424557264;6193.256809182882;6234.87530249397;6241;6245.937540624581;6259.561830671855;6292.937070629281;4861.6353773467135;5586.860328491739;5755.194272801811;5771.134329850556;5823.068309070571;6135.202044401884;6234.37656234382;6271.122042913996;6275.341089185661;6288.434040936338;5016.046951079356;5419.485148910847;5568.582356323292;5683.26117604717;6015.428534289235;4909.410870695468;6017.789377371771;6064.727087281083;6075.1191077294425;6080.604760690541;6081.665508397081;6121.54443000217;6137.22377000893;6142.201513803267;6200.100985357098;5134.409542902614;5846.503047241032;6188.9690551546955;6240;6247.875042499216;4475.552444755498;4575.656825738083;4780.139574876555;4909.754512274372;4911.533404326583;3731.6828069614385;4355.303151495809;4384.079343337871;4392.077663690597;4419.049904270597;5734.942650573525;5744.540436765049;5751.597388182787;5755.3381361143165;5755.395683453261;6025.969870150709;6033.155358249848;6069.544784141207;6107.826086956522;6234.314225435199;5685.459881311269;5724.971375143181;5750.108733146369;5780.277465316835;5817.970910145422;5372.140457526777;5390.757415916293;5396.325459317585;5399.811006614749;5431.37539182999;6118.223266370627;6143.846403839761;6246.46905013079;6262.2172228471445;6291.685415729286;6167.259928808572;6168.9691551541955;6195.2875419325555;6223.595466294676;6228;5581.9162712560155;6132.17215675878;6252.280987686292;6258.311585725475;6262.843428914313;5890.617109887844;6008.429199226067;6076.817695469143;6101.450869421596;6116.113163591165;5992.191054207626;6031.306399764083;6078.817635470943;6095.238095238095;6139.706800529493;5992.43071908168;6012.218411606463;6029.944759667129;6042.244719410074;6064.969675151772;5731.484166425042;5800.59395842287;5809.419058094326;5911.467967882912;6022.1870047543025;4826.348442960156;5746.109353050284;5788.971055144697;5790.681512516852;5837.970810145922;5782.1615865698395;5807.767689292381;6005.099235114768;6037.27552693662;6064.181335519648;5772.336181339199;5789.739461724317;5815.79644712433;5908.3205431375945;5918.112283157561 15:26:36 INFO - PROCESS | 1640 | |1;ext.html;444.85764555342286;470.90984371180735;497.9726115063671;523.8637954131924;530.1755769777993;37796.622033779655;41042.17915641685;41064.973375665584;41190.99999999996;41275.79362103185;41920;42706.93232669185;42783.57216427835;42794.14411711764;43014.92462688434;9145.496997665126;9501.192398646124;9514.952425237863;9539.952300238523;11056.11551075912;11102.167337449684;11268.492917818718;11300.095992320594;11310.434478276095;11314.98165165135;11285.943570282137;11314.773704525946;11323.603673871416;11350.886491135107;11358;11214.719632009224;11281.605143819968;11319.886801132048;11324.03745681618;11329.150313726503;11159.776804463865;11267.098632109411;11275.887241127648;11279.548818047268;11344.149188810872;36767.4484882727;36963.07592310187;37110.25779484395;37231.441528377094;37232.25535489302;3768.321702093622;3782.1868298315717;3795.2599243147597;3808.0860593457646;3957.406389041667;22521.887390563104;22580.661290080498;27243;28384.29039274014;28501.144965651063;2673.786097112246;3025.183200535843;3144.2296637323775;3153.6057992750907;3212.9357412851846;379856;441423;449309;452000;457491.71254143515;44804.55195448004;45883.5411645886;46348.76825615918;55643;55897.44102559004;49369.753151234014;57321.71339143278;57336.71331643315;57698.84602308014;61671;14203.289835508183;14285.214313212666;14438.639034024234;14450.277486125651;14466.782998255034;10827.512761925733;11073.335599864035;11100.000999910048;11107.777844443228;11112.333260004425;17378.65242695164;17379.65240695179;17439.564010899576;17521.38675146389;17535;7558.395328373717;7583.464071228034;7592.924070759333;7661.118971318258;7730.652120654584;838.6393850644281;839.412411312084;844.1769274956868;861.642418396371;876.2814492116403;23740.64389034166;28490.572641410396;28640.71359286422;28914.06195370933;29102.27244318909;966.8743063401713;1023.6366090038078;1030.340582027503;1047.659510659039;1109.5728144664363;14743.483978060716;14745.336459859333;15020.248987550578;15105.39578416873;15105.622359441102;583916;585711;587419;589464.1053589409;590873;57532.42467575271;57889;58274.8345033097;58411.415885841445;58446.41553584495;1328.508451872794;1378.372840357635;1384.4946594492937;1388.2434073430004;1392.0673148990202;25152;27358.5896211553;28204.15387538377;29187.41625167442;29211.41577168487;48716.78208044686;49063;49078.75460622674;49147.26279105888;49416.023359066676;417719;417756;420485;421852;422678;23843.761562384156;24358.26925192247;24581;24817.751822482267;25912.22263332103;39671.40492892667;40600;40718.796406017784;40893.77318680444;41301.586984129775;32402.356751815714;32710.672893270763;33508.664913350556;33793.324133517686;34970.82514587411;27756;33267.33465330728;33698.66301336955;34650;34946.30107397889;33351.83324083364;33846;34026.829865851505;34055.48916766201;34086;22979.08083676634;29290.414191716474;30219.546706798978;30402.391952161277;30545.847270763505;21483.46291342729;22557.984890680287;22976.885115574314;23219.76780232176;23300.184493542645 15:26:36 INFO - PROCESS | 1640 | |2;jquery.html;348.9127718070482;379.4365367429367;384.88068698703404;399.6523024968278;409.9139180772038;13950.93024534876;14098;19262.614747705036;21275.36173914783;21515.354539363805;15751.369945202207;17416.39042633508;17936.730949035777;18100.370966613034;21182.83494407807;5781.421857814227;6013.977623803964;6016.067509536029;6037.154798328237;6042.033274676052;4813.735244561565;5615.9157612635845;5922.2597175353085;6063.969680151593;6086.300075491309;3519.8416071276724;3717.9814100929457;5990.430909063632;6212.875742485147;6508.284088750233;5575.745457272122;6554.41010309072;6563.245226798907;6566.967165164191;6573.375529324707;5744.712764361765;5784.421557844224;5812.070068788974;5813.128030795372;5831.970840145815;10892.509837057352;12982.935085324607;13130.540431084866;13175.275359855204;13336.599902002858;2426.6723992260995;2447.473793134485;2498.1381423408893;2526.4820711754046;2529.962050569243;9357.438553686732;9765.365251258645;10054;10172.44051577163;10265.538050787733;1717.450415866923;1768.1159420289855;1789.9284028638838;1797.164318591861;1801.081448461281;111655.32517012251;123675;124146.06831453463;124468.37765811113;124571;9605.519724013771;11568.363739994382;12055.336956467303;12058.095642826647;12252.326122063372;15184.240787960558;15237.771433428508;15238.009529380555;15263.694726105638;15293.694126117416;7017.61403122823;7920.6039698014865;8266.421350505407;8289.917100828914;8421.368397370221;7942.880856787153;7947.682092716226;7973.322267607203;8027.357811375076;8251.587420628945;4634.374359461497;4639.791209395517;4652.278896771006;4679.438467383868;4744.979829336709;1978.7229787829715;2012.118669044448;2046.8055534724178;2047.2834507922405;2049.7540295164677;994.6916455898695;1002.7693630464888;1006.4665727164614;1007.4183531855064;1050.4485145298627;20812.687809682866;21215.257465988616;21267.680984785242;21469;21474.23092289228;999.820032394176;1012.0587853296357;1024.6618615856748;1050.894910508943;1055.4195192644015;10566.682999510027;10941.83587246192;11142.944285278521;11208.943955280172;11248.212625116163;661331;668815;677486;680039;683274;108539;127470.36264818802;144942;154572;156182.30798834396;1071.3197119828965;1075.725689949058;1118.4463690473106;1122.820348744197;1126.808442564766;13976.860231397963;15262.465813696468;18369.81630183681;19644.705329419783;19703.40889773309;44536.77731611321;44981.453523830365;50390;57182.7140864293;58767.4123258762;69386.30613693799;81640.59179704302;84285;84788;87212;6471.611703297817;7116.786496405116;7924.564148971631;8058.758237252891;8458.915410846059;10434.37393756377;10618.415987120783;11001.579652476443;12983.870161298266;13247.933760331136;9401.764955876159;10736.463176841284;11020.338779673246;11247;11499;9278.11857873501;9966.40201587907;10347.586096556053;10454.947725261325;11144.996950274513;9653.855192172263;10641.095506882002;11249.437528123724;11280.307953806994;11541.307521548733;8091.757247282591;8288.917110829056;8300.958495207486;8477.491350518989;8577.699780507652;10621.203409744145;11249.437528123724;11255.943720281346;11426.314421134759;11445.111556593069 15:26:36 INFO - PROCESS | 1640 | |3;mootools.html;1290.5225066725313;1435.6482661747866;1457.83963763986;1471.359958418088;1478.6081688352585;6860.279670634586;8277.54473503957;8513.829723405528;8624.95687521563;8651.69719059833;8269.25576698097;8506;8525.872111918326;8540.402171847973;8544.658213671446;2270.489139943516;2315.455867871049;2315.988420057897;2317.432229103872;2320.9535809283802;2270.137347807839;2298.9195378161767;2301.033565902325;2312.1791763923816;2317.860928344296;2251.3020963501285;2262.3778460923213;2292.495650956787;2295.472041430472;2300.1259521381853;2251.6509940959095;2251.9324420267253;2258.503129311557;2291.0950174680993;2291.6104262275453;1510.750726130187;2000.1799262302386;2200.262911924507;2257.24382331919;2333.498297865967;8378.162183781635;8522.318214542822;8524.275436587897;8530.189631984951;8539.914600853974;4958.661161486414;5107.948920510822;5275.155975044013;5285.577153827685;5291.973540132313;3361.6638336166434;3434.3818112739696;3446.7759595626453;3541.043918142113;3546.8255910959806;1204.5362535423837;1212.1575505024011;1235.086036333116;1256.7360854220624;1257.7295881385546;9094.86357704635;9453.480058596842;10497.31767435122;10662.946685266525;10906.727331816688;4335.414719012956;4646.628269738413;4721.5750582447745;4731.219348807408;4746.121967436035;9607.183389411979;9667.9033209667;9671.9032809671;9680.177184939219;9704.428326493486;5178.249153872743;5271.6309858310315;5273.050850846807;5274.7098909560345;5288.127458969304;4525.728456292633;4669.439667239885;4759.6668233223345;4765.904681906342;4825.710457372569;3248.3016151527536;3554.4845997330244;3661.5972243053243;3892.96107038926;3897.8635747748694;1226.993865030687;1260.9810852837215;1272.7454509098031;1279.8976081913424;1300.843898732158;871.1661951591934;877.1579283887412;878.2359347367703;888.8933328000682;915.1169121797498;4323.740575565414;5427.674339539641;5548.55611551075;5696.202531645573;5729.713514324267;829.2163905109613;900.6217388696632;980.7106903463496;983.9458829764432;998.7003898830321;3555.040139162463;3777.414500752388;3822.120912190212;3836.7889766063136;3853.344931361675;8733.912660873437;9478.715638530855;9573.234141268682;9851.605935762489;9923.60305587783;9876.753081173028;10022.198224142052;10029.997000300058;10032.949835250776;10058.346207496636;7594.696212151563;7814.843703126019;7874.094479134858;7884.526928384315;7886.171951944963;5221.164613661796;5614.129809879475;5683.60214784961;5727.541796656341;5754.510866576388;8892.59983300766;9197.712320275034;9208.677696280598;9212.263018958602;9228.307876909394;8900;9198.724038278862;9272.582733777132;9327.347085703936;9344.112309330603;6686.3313668632745;6799.354061364163;6815.625140617115;6828.556143850634;6847.281035491202;7754.806129846799;7818.413618978713;7828.864814601965;7843.176466470938;7864.1742617026675;5889.94110058894;6956.443484521125;7019.157701075904;7164.391026762783;7203.891941620985;5799.536037117105;6896.586204827727;6960.025596416607;6995.405390541861;7072.5402848814665;6295.779647712308;6334.683265836782;6376.139221205263;6384.361563843764;6410.4871610272;4832.95167048339;4953.23224900141;4970.055689418999;5001.924971125363;5119.820806271762;4949.802007919787;4964.751762411937;5042.546170844642;5055.988802239641;5137.383513978347 15:26:36 INFO - PROCESS | 1640 | |4;prototype.html;336.6936088159775;345.9844307006185;356.2643141911952;365.63071297989023;367.42864845165775;4335.783210839461;5301.257823904656;5407.836865253896;5519.53083987861;5559.861003474915;4659.4175728034;5271.65734227275;5304.257403963448;5307.416184219733;5330.680159190451;3629.691476224524;4039.656998940622;4065.410515475254;4068.206699693546;4102.097538541516;3788.6779623731877;3859.903502412434;4119.949412899707;4120.381942708587;4131.2357213915375;3943.3099207638547;3998.340273854825;4004.339284018148;4015.3575427931537;4022.537408198051;3347.715444187247;3544.379733546619;3664.95548768601;3847.4998250227572;4058.228936502055;3232.628247751515;3487.9651203488147;3493.371193185226;3508;3528.558930133733;4394.846525202628;4884.829030983934;5173.611979101583;5254.579633629301;5367.302250707383;4609.257491792412;4615.446146462413;4621.353010578522;4630.536946305342;4633.305004249356;4537.342085397632;5669.8582535436535;5671.574631902583;5756.251687280626;5771.682557459338;3260.2990357073345;3825.5026846509777;3828.712846536493;3840.231953609289;3852.3451013327804;4530.864074077783;4879.780409881564;5867.295924489046;5874.765009399662;5895.4399332063385;3872.3997780344093;3873.7869417182324;3885.922281554353;3889.5138107736534;3907.4138879167785;3907.6873850091924;3935.5474120475938;3961.2869683457257;3964.1278918637854;3974.18529201513;3643.653852883972;4473.306637471197;4636.35091087248;4641.2109941310055;4648.3259927310355;5533.529649979797;5670.631408958405;5704;5729.656220626775;5758.4740043888405;1030.5929157982705;1140.885911408869;1146.9426528673532;1183.219075410225;1264.5826877130526;734.2400615363181;808.7573727881612;865.9523726194993;870.8911386076741;882.6734108379941;4433.069055498317;4727.763611819395;4913.828016019422;5129.8717532061255;5195.19474481456;4657.976710116495;5157.535821776059;5685.744141513642;5728.713564321767;5729.770809167587;3873.6394800391295;4996.800127994839;5080.771365288497;5095.267609012879;5098.974505127525;2545.440003199293;2693.340131667754;2732.8360298382163;2949.439606474763;2952.4242772659554;5096.668716533413;5802.912956305574;5804.7941782122525;5827.388124246978;5928.5989174383585;5325.87244885217;5749.338826034976;5831.620944638585;5900.734466948998;6013.308469525973;5374.328208973879;5844.47399734026;5945.61353512029;6105.206323177958;6149.292831324455;5012.067940254991;5917.082852157922;5935.525157987437;5991.700414979321;6007.438066102932;4868.488808675038;5419;5543.307086614173;5842.114993529255;5913.822585322448;4992.55811165831;5256.342957130359;5655.660660360227;6082.5438092142385;6178.41305076017;3488.9476657849646;3843.9429156982055;3896.9220615586964;3949.881503554898;3969.8015099244344;5938.435848594377;6011.368806275278;6013.789517366871;6014.789482368096;6031.668258245839;5328.200769884548;5654.40628733977;5698.886022279448;5709.972959599449;5739.938111449395;5088.44027157005;5686.34607020198;5709.714514274353;5712.314522257356;5811.099279611667;5162.922556161736;5502.019273061775;5591.412901645269;5606.915896261477;5621.241132447068;4878.902421951612;5636.887262254814;5645.576581756467;5692.402297758841;5703.971480142573;4689.437267527918;4792.257200133985;5465.945340546544;5612.7754889803955;5625.887482250414 15:26:36 INFO - PROCESS | 1640 | |5;yui.html;670.3028849996005;687.3161204601422;697.2260790522522;773.3349319585155;784.4940013691171;12852.614421567356;13665.931670341646;13696.589102326934;14310.642233944156;15631.609209769762;14009;14186.645333866658;14459.638509037279;14471.5658530244;14485;876.6712482818958;907.8865141857268;910.0580898769774;912.9863052054192;913.2146354135472;886.0607755778863;893.3523195683143;893.4460634406677;919.1176470588243;926.3422969691527;959.721680712596;963.7638778499243;963.9180669643089;964.5177411294353;966.0629189686028;917.7797328641111;958.1999030809247;959.8080383923174;960.2558017536395;961.1877963121151;702.0802748399561;713.9968344476019;715.6099925540593;717.3292971072065;717.9317964793337;14613.269336533238;14875.256237188098;15145.469908553148;15224.46714364992;15224.934254602182;13305.135166214262;13338.266395348252;13571.253581053039;13573.59279221625;13584.388702508411;10300.845487317696;10817.567297308176;11573.710657233552;11746.70633234176;12362.690932726753;3646.781193128421;3667.7615954962844;3712.87004954828;3741.56971948224;3850.268448994682;100103.49327293702;100216.49891750567;102942;104625;105682;10986.01125898657;11025.558977640805;11046.668599942015;11077.778444431066;11338.716532086764;22036.33890983273;22193.55612887733;22309.442263943205;22348.888255558617;22386.776132238796;7360.07999000125;7481.962590187123;7583.544987300669;7610.9238907610215;7707.152213256537;3281.5241789940324;4155.127423241092;4181.958180418218;4235.4917409910395;4399.6040356368085;3581.194231297989;3627.9818600907356;3677.191017976041;3689.0777305673582;3691.520102386726;609.387565496673;639.2999665366416;670.8859493886051;675.4630069095081;692.069166970434;458.5781081405115;587.6503480429138;614.1984709953464;636.2619361540591;643.2217017408988;9233.399829011092;9379.812403752023;9784.804303913881;9809.705708828747;9970.950145249228;531.4764956517827;548.9460236346225;557.8633234857405;587.9382664820132;676.1345477788439;4796.328514008042;4875.219964805614;4880.032130266464;4977.751112444364;5302;74603.62698186474;96881.51559242158;99382;100785.48036299004;100935;66277;73507.42724004634;74958.62520687362;81567.59216203881;88294.55852720696;47493;64883.10701358028;68327.3167268321;74144;74684;8446.704365347183;8914.509701966454;9310.674126405544;10044.146247569039;10624.20318476102;48393.75803120962;48620.756896215295;48848;50792.746036269586;51167;45983;63534.682326588074;63972;64534.418623256424;64597;12691.238525688119;12758.298293593942;12775.808362874379;12876.742465150457;13179.538716144889;13855.445782169003;13884.821016366961;13903.359080294626;13945.646101045882;14252.786208207093;12667.239965602093;12908.096433249582;13016.674583135497;13186.736265274832;13457.528986485426;12735.74528509406;12898.613041608767;13013.609591712264;13078.215307081606;13467.191968481922;12562.623121306375;12674.936625317183;12689.682757931125;13168.209907405586;13301.46794128224;10212.948935255276;10658.786824263627;10749.19381046409;11005.339679618928;11170;8254.628541715518;8527.403081784216;9281.72154835356;9464.384814987005;9847.901520984698 15:26:36 INFO - PROCESS | 1640 | __end_tp_report 15:26:36 INFO - PROCESS | 1640 | __start_cc_report 15:26:36 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,415 15:26:36 INFO - PROCESS | 1640 | __end_cc_report 15:26:36 INFO - PROCESS | 1640 | __startTimestamp1489188396421__endTimestamp 15:26:36 INFO - PROCESS | 1640 | 15:26:36 INFO - PROCESS | 1640 | ------- Summary: start ------- 15:26:36 INFO - PROCESS | 1640 | Number of tests: 6 15:26:36 INFO - PROCESS | 1640 | 15:26:36 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5599.37 Median:5772.34 stddev:650.88 (11.3%) stddev-sans-first:628.24 15:26:36 INFO - PROCESS | 1640 | Values: 3337.9 3340.9 3347.1 3359.8 3381.4 5400.6 5494.3 5540.3 5540.6 5552.3 5394.0 5549.4 5567.1 5576.2 5654.2 5051.3 5070.7 5103.8 5172.6 5174.8 4377.0 4914.0 5136.6 5210.2 5217.9 5029.4 5089.6 5090.9 5148.4 5160.4 5088.6 5097.2 5108.1 5113.8 5155.9 5088.3 5098.7 5115.9 5118.3 5122.3 5318.8 5409.0 5440.8 5472.9 5557.2 6112.7 6185.4 6187.4 6191.8 6193.3 6234.9 6241.0 6245.9 6259.6 6292.9 4861.6 5586.9 5755.2 5771.1 5823.1 6135.2 6234.4 6271.1 6275.3 6288.4 5016.0 5419.5 5568.6 5683.3 6015.4 4909.4 6017.8 6064.7 6075.1 6080.6 6081.7 6121.5 6137.2 6142.2 6200.1 5134.4 5846.5 6189.0 6240.0 6247.9 4475.6 4575.7 4780.1 4909.8 4911.5 3731.7 4355.3 4384.1 4392.1 4419.0 5734.9 5744.5 5751.6 5755.3 5755.4 6026.0 6033.2 6069.5 6107.8 6234.3 5685.5 5725.0 5750.1 5780.3 5818.0 5372.1 5390.8 5396.3 5399.8 5431.4 6118.2 6143.8 6246.5 6262.2 6291.7 6167.3 6169.0 6195.3 6223.6 6228.0 5581.9 6132.2 6252.3 6258.3 6262.8 5890.6 6008.4 6076.8 6101.5 6116.1 5992.2 6031.3 6078.8 6095.2 6139.7 5992.4 6012.2 6029.9 6042.2 6065.0 5731.5 5800.6 5809.4 5911.5 6022.2 4826.3 5746.1 5789.0 5790.7 5838.0 5782.2 5807.8 6005.1 6037.3 6064.2 5772.3 5789.7 5815.8 5908.3 5918.1 15:26:36 INFO - PROCESS | 1640 | 15:26:36 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:61297.35 Median:33603.66 stddev:129929.68 (386.7%) stddev-sans-first:130213.84 15:26:36 INFO - PROCESS | 1640 | Values: 444.9 470.9 498.0 523.9 530.2 37796.6 41042.2 41065.0 41191.0 41275.8 41920.0 42706.9 42783.6 42794.1 43014.9 9145.5 9501.2 9515.0 9540.0 11056.1 11102.2 11268.5 11300.1 11310.4 11315.0 11285.9 11314.8 11323.6 11350.9 11358.0 11214.7 11281.6 11319.9 11324.0 11329.2 11159.8 11267.1 11275.9 11279.5 11344.1 36767.4 36963.1 37110.3 37231.4 37232.3 3768.3 3782.2 3795.3 3808.1 3957.4 22521.9 22580.7 27243.0 28384.3 28501.1 2673.8 3025.2 3144.2 3153.6 3212.9 379856.0 441423.0 449309.0 452000.0 457491.7 44804.6 45883.5 46348.8 55643.0 55897.4 49369.8 57321.7 57336.7 57698.8 61671.0 14203.3 14285.2 14438.6 14450.3 14466.8 10827.5 11073.3 11100.0 11107.8 11112.3 17378.7 17379.7 17439.6 17521.4 17535.0 7558.4 7583.5 7592.9 7661.1 7730.7 838.6 839.4 844.2 861.6 876.3 23740.6 28490.6 28640.7 28914.1 29102.3 966.9 1023.6 1030.3 1047.7 1109.6 14743.5 14745.3 15020.2 15105.4 15105.6 583916.0 585711.0 587419.0 589464.1 590873.0 57532.4 57889.0 58274.8 58411.4 58446.4 1328.5 1378.4 1384.5 1388.2 1392.1 25152.0 27358.6 28204.2 29187.4 29211.4 48716.8 49063.0 49078.8 49147.3 49416.0 417719.0 417756.0 420485.0 421852.0 422678.0 23843.8 24358.3 24581.0 24817.8 25912.2 39671.4 40600.0 40718.8 40893.8 41301.6 32402.4 32710.7 33508.7 33793.3 34970.8 27756.0 33267.3 33698.7 34650.0 34946.3 33351.8 33846.0 34026.8 34055.5 34086.0 22979.1 29290.4 30219.5 30402.4 30545.8 21483.5 22558.0 22976.9 23219.8 23300.2 15:26:36 INFO - PROCESS | 1640 | 15:26:36 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:37006.59 Median:21241.47 stddev:112385.07 (529.1%) stddev-sans-first:112666.63 15:26:36 INFO - PROCESS | 1640 | Values: 348.9 379.4 384.9 399.7 409.9 13950.9 14098.0 19262.6 21275.4 21515.4 15751.4 17416.4 17936.7 18100.4 21182.8 5781.4 6014.0 6016.1 6037.2 6042.0 4813.7 5615.9 5922.3 6064.0 6086.3 3519.8 3718.0 5990.4 6212.9 6508.3 5575.7 6554.4 6563.2 6567.0 6573.4 5744.7 5784.4 5812.1 5813.1 5832.0 10892.5 12982.9 13130.5 13175.3 13336.6 2426.7 2447.5 2498.1 2526.5 2530.0 9357.4 9765.4 10054.0 10172.4 10265.5 1717.5 1768.1 1789.9 1797.2 1801.1 111655.3 123675.0 124146.1 124468.4 124571.0 9605.5 11568.4 12055.3 12058.1 12252.3 15184.2 15237.8 15238.0 15263.7 15293.7 7017.6 7920.6 8266.4 8289.9 8421.4 7942.9 7947.7 7973.3 8027.4 8251.6 4634.4 4639.8 4652.3 4679.4 4745.0 1978.7 2012.1 2046.8 2047.3 2049.8 994.7 1002.8 1006.5 1007.4 1050.4 20812.7 21215.3 21267.7 21469.0 21474.2 999.8 1012.1 1024.7 1050.9 1055.4 10566.7 10941.8 11142.9 11208.9 11248.2 661331.0 668815.0 677486.0 680039.0 683274.0 108539.0 127470.4 144942.0 154572.0 156182.3 1071.3 1075.7 1118.4 1122.8 1126.8 13976.9 15262.5 18369.8 19644.7 19703.4 44536.8 44981.5 50390.0 57182.7 58767.4 69386.3 81640.6 84285.0 84788.0 87212.0 6471.6 7116.8 7924.6 8058.8 8458.9 10434.4 10618.4 11001.6 12983.9 13247.9 9401.8 10736.5 11020.3 11247.0 11499.0 9278.1 9966.4 10347.6 10454.9 11145.0 9653.9 10641.1 11249.4 11280.3 11541.3 8091.8 8288.9 8301.0 8477.5 8577.7 10621.2 11249.4 11255.9 11426.3 11445.1 15:26:36 INFO - PROCESS | 1640 | 15:26:36 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5383.29 Median:5280.37 stddev:2923.54 (55.4%) stddev-sans-first:2915.56 15:26:36 INFO - PROCESS | 1640 | Values: 1290.5 1435.6 1457.8 1471.4 1478.6 6860.3 8277.5 8513.8 8625.0 8651.7 8269.3 8506.0 8525.9 8540.4 8544.7 2270.5 2315.5 2316.0 2317.4 2321.0 2270.1 2298.9 2301.0 2312.2 2317.9 2251.3 2262.4 2292.5 2295.5 2300.1 2251.7 2251.9 2258.5 2291.1 2291.6 1510.8 2000.2 2200.3 2257.2 2333.5 8378.2 8522.3 8524.3 8530.2 8539.9 4958.7 5107.9 5275.2 5285.6 5292.0 3361.7 3434.4 3446.8 3541.0 3546.8 1204.5 1212.2 1235.1 1256.7 1257.7 9094.9 9453.5 10497.3 10662.9 10906.7 4335.4 4646.6 4721.6 4731.2 4746.1 9607.2 9667.9 9671.9 9680.2 9704.4 5178.2 5271.6 5273.1 5274.7 5288.1 4525.7 4669.4 4759.7 4765.9 4825.7 3248.3 3554.5 3661.6 3893.0 3897.9 1227.0 1261.0 1272.7 1279.9 1300.8 871.2 877.2 878.2 888.9 915.1 4323.7 5427.7 5548.6 5696.2 5729.7 829.2 900.6 980.7 983.9 998.7 3555.0 3777.4 3822.1 3836.8 3853.3 8733.9 9478.7 9573.2 9851.6 9923.6 9876.8 10022.2 10030.0 10032.9 10058.3 7594.7 7814.8 7874.1 7884.5 7886.2 5221.2 5614.1 5683.6 5727.5 5754.5 8892.6 9197.7 9208.7 9212.3 9228.3 8900.0 9198.7 9272.6 9327.3 9344.1 6686.3 6799.4 6815.6 6828.6 6847.3 7754.8 7818.4 7828.9 7843.2 7864.2 5889.9 6956.4 7019.2 7164.4 7203.9 5799.5 6896.6 6960.0 6995.4 7072.5 6295.8 6334.7 6376.1 6384.4 6410.5 4833.0 4953.2 4970.1 5001.9 5119.8 4949.8 4964.8 5042.5 5056.0 5137.4 15:26:36 INFO - PROCESS | 1640 | 15:26:36 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4541.12 Median:5091.85 stddev:1434.24 (28.2%) stddev-sans-first:1403.12 15:26:36 INFO - PROCESS | 1640 | Values: 336.7 346.0 356.3 365.6 367.4 4335.8 5301.3 5407.8 5519.5 5559.9 4659.4 5271.7 5304.3 5307.4 5330.7 3629.7 4039.7 4065.4 4068.2 4102.1 3788.7 3859.9 4119.9 4120.4 4131.2 3943.3 3998.3 4004.3 4015.4 4022.5 3347.7 3544.4 3665.0 3847.5 4058.2 3232.6 3488.0 3493.4 3508.0 3528.6 4394.8 4884.8 5173.6 5254.6 5367.3 4609.3 4615.4 4621.4 4630.5 4633.3 4537.3 5669.9 5671.6 5756.3 5771.7 3260.3 3825.5 3828.7 3840.2 3852.3 4530.9 4879.8 5867.3 5874.8 5895.4 3872.4 3873.8 3885.9 3889.5 3907.4 3907.7 3935.5 3961.3 3964.1 3974.2 3643.7 4473.3 4636.4 4641.2 4648.3 5533.5 5670.6 5704.0 5729.7 5758.5 1030.6 1140.9 1146.9 1183.2 1264.6 734.2 808.8 866.0 870.9 882.7 4433.1 4727.8 4913.8 5129.9 5195.2 4658.0 5157.5 5685.7 5728.7 5729.8 3873.6 4996.8 5080.8 5095.3 5099.0 2545.4 2693.3 2732.8 2949.4 2952.4 5096.7 5802.9 5804.8 5827.4 5928.6 5325.9 5749.3 5831.6 5900.7 6013.3 5374.3 5844.5 5945.6 6105.2 6149.3 5012.1 5917.1 5935.5 5991.7 6007.4 4868.5 5419.0 5543.3 5842.1 5913.8 4992.6 5256.3 5655.7 6082.5 6178.4 3488.9 3843.9 3896.9 3949.9 3969.8 5938.4 6011.4 6013.8 6014.8 6031.7 5328.2 5654.4 5698.9 5710.0 5739.9 5088.4 5686.3 5709.7 5712.3 5811.1 5162.9 5502.0 5591.4 5606.9 5621.2 4878.9 5636.9 5645.6 5692.4 5704.0 4689.4 4792.3 5465.9 5612.8 5625.9 15:26:36 INFO - PROCESS | 1640 | 15:26:36 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19093.29 Median:46738.00 stddev:26945.32 (57.7%) stddev-sans-first:26985.40 15:26:36 INFO - PROCESS | 1640 | Values: 670.3 687.3 697.2 773.3 784.5 12852.6 13665.9 13696.6 14310.6 15631.6 14009.0 14186.6 14459.6 14471.6 14485.0 876.7 907.9 910.1 913.0 913.2 886.1 893.4 893.4 919.1 926.3 959.7 963.8 963.9 964.5 966.1 917.8 958.2 959.8 960.3 961.2 702.1 714.0 715.6 717.3 717.9 14613.3 14875.3 15145.5 15224.5 15224.9 13305.1 13338.3 13571.3 13573.6 13584.4 10300.8 10817.6 11573.7 11746.7 12362.7 3646.8 3667.8 3712.9 3741.6 3850.3 100103.5 100216.5 102942.0 104625.0 105682.0 10986.0 11025.6 11046.7 11077.8 11338.7 22036.3 22193.6 22309.4 22348.9 22386.8 7360.1 7482.0 7583.5 7610.9 7707.2 3281.5 4155.1 4182.0 4235.5 4399.6 3581.2 3628.0 3677.2 3689.1 3691.5 609.4 639.3 670.9 675.5 692.1 458.6 587.7 614.2 636.3 643.2 9233.4 9379.8 9784.8 9809.7 9971.0 531.5 548.9 557.9 587.9 676.1 4796.3 4875.2 4880.0 4977.8 5302.0 74603.6 96881.5 99382.0 100785.5 100935.0 66277.0 73507.4 74958.6 81567.6 88294.6 47493.0 64883.1 68327.3 74144.0 74684.0 8446.7 8914.5 9310.7 10044.1 10624.2 48393.8 48620.8 48848.0 50792.7 51167.0 45983.0 63534.7 63972.0 64534.4 64597.0 12691.2 12758.3 12775.8 12876.7 13179.5 13855.4 13884.8 13903.4 13945.6 14252.8 12667.2 12908.1 13016.7 13186.7 13457.5 12735.7 12898.6 13013.6 13078.2 13467.2 12562.6 12674.9 12689.7 13168.2 13301.5 10212.9 10658.8 10749.2 11005.3 11170.0 8254.6 8527.4 9281.7 9464.4 9847.9 15:26:36 INFO - PROCESS | 1640 | -------- Summary: end -------- 15:26:36 INFO - PROCESS | 1640 | 15:26:37 INFO - TEST-INFO | 1640: exit 0 15:26:37 INFO - TEST-OK | dromaeo_css | took 1117148ms 15:26:37 INFO - TEST-START | kraken 15:26:37 INFO - operating with platform_type : mac_ 15:26:37 INFO - Initialising browser for kraken test... 15:26:37 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpiDXeiT/profile http://localhost:49241/getInfo.html) 15:26:39 INFO - PROCESS | 1652 | 2017-03-10 15:26:39.778 plugin-container[1653:10075] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d43, name = 'com.apple.tsm.portname' 15:26:39 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:26:39 INFO - PROCESS | 1652 | 2017-03-10 15:26:39.781 plugin-container[1653:10075] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441b, name = 'com.apple.CFPasteboardClient' 15:26:39 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:26:39 INFO - PROCESS | 1652 | 2017-03-10 15:26:39.781 plugin-container[1653:10075] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:26:39 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 15:26:39 INFO - PROCESS | 1652 | colorDepth:24 15:26:39 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 15:26:39 INFO - PROCESS | 1652 | __metrics 15:26:39 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 15:26:40 INFO - TEST-INFO | 1652: exit 0 15:26:40 INFO - Browser initialized. 15:26:40 INFO - Running cycle 1/1 for kraken test... 15:26:40 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpiDXeiT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:26:43 INFO - PROCESS | 1654 | 2017-03-10 15:26:43.163 plugin-container[1655:10187] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 15:26:43 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:26:43 INFO - PROCESS | 1654 | 2017-03-10 15:26:43.164 plugin-container[1655:10187] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 15:26:43 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:26:43 INFO - PROCESS | 1654 | 2017-03-10 15:26:43.164 plugin-container[1655:10187] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:26:52 INFO - PROCESS | 1654 | RSS: Main: 233050112 15:26:52 INFO - PROCESS | 1654 | 15:26:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 15:26:57 INFO - PROCESS | 1654 | RSS: Main: 247775232 15:26:57 INFO - PROCESS | 1654 | 15:26:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 15:27:00 INFO - PROCESS | 1654 | RSS: Main: 255660032 15:27:00 INFO - PROCESS | 1654 | 15:27:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 15:27:04 INFO - PROCESS | 1654 | RSS: Main: 258285568 15:27:04 INFO - PROCESS | 1654 | 15:27:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 15:27:07 INFO - PROCESS | 1654 | RSS: Main: 260476928 15:27:07 INFO - PROCESS | 1654 | 15:27:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:27:09 INFO - PROCESS | 1654 | RSS: Main: 261136384 15:27:09 INFO - PROCESS | 1654 | 15:27:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 15:27:13 INFO - PROCESS | 1654 | RSS: Main: 266715136 15:27:13 INFO - PROCESS | 1654 | 15:27:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 15:27:17 INFO - PROCESS | 1654 | RSS: Main: 266944512 15:27:17 INFO - PROCESS | 1654 | 15:27:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 15:27:21 INFO - PROCESS | 1654 | RSS: Main: 266735616 15:27:21 INFO - PROCESS | 1654 | 15:27:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:27:23 INFO - PROCESS | 1654 | RSS: Main: 265494528 15:27:23 INFO - PROCESS | 1654 | 15:27:25 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:27:26 INFO - PROCESS | 1654 | RSS: Main: 265510912 15:27:26 INFO - PROCESS | 1654 | 15:27:28 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:27:29 INFO - PROCESS | 1654 | RSS: Main: 265531392 15:27:29 INFO - PROCESS | 1654 | 15:27:31 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:27:32 INFO - PROCESS | 1654 | RSS: Main: 265871360 15:27:32 INFO - PROCESS | 1654 | 15:27:35 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:27:36 INFO - PROCESS | 1654 | RSS: Main: 265662464 15:27:36 INFO - PROCESS | 1654 | 15:27:37 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 15:27:38 INFO - PROCESS | 1654 | RSS: Main: 269012992 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | __start_tp_report 15:27:38 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 15:27:38 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 15:27:38 INFO - PROCESS | 1654 | |i|pagename|runs| 15:27:38 INFO - PROCESS | 1654 | |0;ai-astar;152;172;137;117;119;120;126;172;175;119 15:27:38 INFO - PROCESS | 1654 | |1;audio-beat-detection;147;115;118;154;115;119;120;118;150;145 15:27:38 INFO - PROCESS | 1654 | |2;audio-dft;213;216;276;198;200;201;196;193;195;197 15:27:38 INFO - PROCESS | 1654 | |3;audio-fft;82;65;86;110;74;62;60;61;77;76 15:27:38 INFO - PROCESS | 1654 | |4;audio-oscillator;93;105;122;56;90;103;113;105;78;83 15:27:38 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;139;100;137;137;109;90;91;90;90;90 15:27:38 INFO - PROCESS | 1654 | |6;imaging-darkroom;102;92;134;157;129;98;144;96;99;99 15:27:38 INFO - PROCESS | 1654 | |7;imaging-desaturate;133;150;110;94;91;100;92;95;92;92 15:27:38 INFO - PROCESS | 1654 | |8;json-parse-financial;66;64;65;64;65;65;66;80;79;64 15:27:38 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;68;74;70;74;80;70;70;69;63;92 15:27:38 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;92;112;108;88;94;88;89;93;92;89 15:27:38 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;148;145;143;149;156;148;149;147;184;157 15:27:38 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;190;180;178;176;177;178;175;179;174;179 15:27:38 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;67;69;67;70;68;67;70;67;68;69 15:27:38 INFO - PROCESS | 1654 | __end_tp_report 15:27:38 INFO - PROCESS | 1654 | __start_cc_report 15:27:38 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1017 15:27:38 INFO - PROCESS | 1654 | __end_cc_report 15:27:38 INFO - PROCESS | 1654 | __startTimestamp1489188458223__endTimestamp 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | ------- Summary: start ------- 15:27:38 INFO - PROCESS | 1654 | Number of tests: 14 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:140.90 Median:144.50 stddev:24.55 (17.0%) stddev-sans-first:25.71 15:27:38 INFO - PROCESS | 1654 | Values: 152.0 172.0 137.0 117.0 119.0 120.0 126.0 172.0 175.0 119.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:130.10 Median:132.50 stddev:16.50 (12.4%) stddev-sans-first:16.32 15:27:38 INFO - PROCESS | 1654 | Values: 147.0 115.0 118.0 154.0 115.0 119.0 120.0 118.0 150.0 145.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:208.50 Median:200.50 stddev:24.91 (12.4%) stddev-sans-first:26.36 15:27:38 INFO - PROCESS | 1654 | Values: 213.0 216.0 276.0 198.0 200.0 201.0 196.0 193.0 195.0 197.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:75.30 Median:75.00 stddev:15.24 (20.3%) stddev-sans-first:15.97 15:27:38 INFO - PROCESS | 1654 | Values: 82.0 65.0 86.0 110.0 74.0 62.0 60.0 61.0 77.0 76.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:67.00 stddev:19.15 (28.6%) stddev-sans-first:20.30 15:27:38 INFO - PROCESS | 1654 | Values: 93.0 105.0 122.0 56.0 90.0 103.0 113.0 105.0 78.0 83.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:107.30 Median:90.00 stddev:21.83 (24.3%) stddev-sans-first:19.91 15:27:38 INFO - PROCESS | 1654 | Values: 139.0 100.0 137.0 137.0 109.0 90.0 91.0 90.0 90.0 90.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:115.00 Median:94.00 stddev:23.62 (25.1%) stddev-sans-first:24.58 15:27:38 INFO - PROCESS | 1654 | Values: 102.0 92.0 134.0 157.0 129.0 98.0 144.0 96.0 99.0 99.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:104.90 Median:92.00 stddev:20.50 (22.3%) stddev-sans-first:19.06 15:27:38 INFO - PROCESS | 1654 | Values: 133.0 150.0 110.0 94.0 91.0 100.0 92.0 95.0 92.0 92.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:65.50 stddev:6.21 (9.5%) stddev-sans-first:6.56 15:27:38 INFO - PROCESS | 1654 | Values: 66.0 64.0 65.0 64.0 65.0 65.0 66.0 80.0 79.0 64.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:72.00 stddev:8.03 (11.1%) stddev-sans-first:8.31 15:27:38 INFO - PROCESS | 1654 | Values: 68.0 74.0 70.0 74.0 80.0 70.0 70.0 69.0 63.0 92.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:90.50 stddev:8.49 (9.4%) stddev-sans-first:8.96 15:27:38 INFO - PROCESS | 1654 | Values: 92.0 112.0 108.0 88.0 94.0 88.0 89.0 93.0 92.0 89.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:152.60 Median:149.00 stddev:11.86 (8.0%) stddev-sans-first:12.46 15:27:38 INFO - PROCESS | 1654 | Values: 148.0 145.0 143.0 149.0 156.0 148.0 149.0 147.0 184.0 157.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:178.50 stddev:4.43 (2.5%) stddev-sans-first:2.00 15:27:38 INFO - PROCESS | 1654 | Values: 190.0 180.0 178.0 176.0 177.0 178.0 175.0 179.0 174.0 179.0 15:27:38 INFO - PROCESS | 1654 | 15:27:38 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.23 (1.8%) stddev-sans-first:1.22 15:27:38 INFO - PROCESS | 1654 | Values: 67.0 69.0 67.0 70.0 68.0 67.0 70.0 67.0 68.0 69.0 15:27:38 INFO - PROCESS | 1654 | -------- Summary: end -------- 15:27:38 INFO - PROCESS | 1654 | 15:27:39 INFO - TEST-INFO | 1654: exit 0 15:27:39 INFO - TEST-OK | kraken | took 61955ms 15:27:39 INFO - SUITE-END | took 1179s 15:27:39 INFO - Completed test suite (00:19:39) 15:27:39 INFO - javascript benchmark 15:27:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7107.309823409921, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.949930751039, 3340.89977300681, 3347.0962840033208, 3359.8320083995795, 3381.357542067007, 5400.648957817739, 5494.313210848644, 5540.307461567304, 5540.616969131699, 5552.278203833506, 5393.973030134854, 5549.445055494449, 5567.081431563797, 5576.219329293892, 5654.151877218409, 5051.292819005343, 5070.695758254507, 5103.770330335125, 5172.612054095939, 5174.793008279665, 4376.97811510942, 4913.950860491385, 5136.614753893455, 5210.19242017486, 5217.921731174036, 5029.3964724232965, 5089.618278629081, 5090.9236361454605, 5148.35645544305, 5160.432352441228, 5088.592912567023, 5097.158968770148, 5108.106081435771, 5113.846584602431, 5155.871103222412, 5088.287639730441, 5098.668586541863, 5115.87210319745, 5118.283440318359, 5122.33409656746, 5318.760655770499, 5409.0, 5440.7551660174995, 5472.91790623141, 5557.194206840026, 6112.685862051835, 6185.381461853824, 6187.350328215518, 6191.81424557264, 6193.256809182882, 6234.87530249397, 6241.0, 6245.937540624581, 6259.561830671855, 6292.937070629281, 4861.6353773467135, 5586.860328491739, 5755.194272801811, 5771.134329850556, 5823.068309070571, 6135.202044401884, 6234.37656234382, 6271.122042913996, 6275.341089185661, 6288.434040936338, 5016.046951079356, 5419.485148910847, 5568.582356323292, 5683.26117604717, 6015.428534289235, 4909.410870695468, 6017.789377371771, 6064.727087281083, 6075.1191077294425, 6080.604760690541, 6081.665508397081, 6121.54443000217, 6137.22377000893, 6142.201513803267, 6200.100985357098, 5134.409542902614, 5846.503047241032, 6188.9690551546955, 6240.0, 6247.875042499216, 4475.552444755498, 4575.656825738083, 4780.139574876555, 4909.754512274372, 4911.533404326583, 3731.6828069614385, 4355.303151495809, 4384.079343337871, 4392.077663690597, 4419.049904270597, 5734.942650573525, 5744.540436765049, 5751.597388182787, 5755.3381361143165, 5755.395683453261, 6025.969870150709, 6033.155358249848, 6069.544784141207, 6107.826086956522, 6234.314225435199, 5685.459881311269, 5724.971375143181, 5750.108733146369, 5780.277465316835, 5817.970910145422, 5372.140457526777, 5390.757415916293, 5396.325459317585, 5399.811006614749, 5431.37539182999, 6118.223266370627, 6143.846403839761, 6246.46905013079, 6262.2172228471445, 6291.685415729286, 6167.259928808572, 6168.9691551541955, 6195.2875419325555, 6223.595466294676, 6228.0, 5581.9162712560155, 6132.17215675878, 6252.280987686292, 6258.311585725475, 6262.843428914313, 5890.617109887844, 6008.429199226067, 6076.817695469143, 6101.450869421596, 6116.113163591165, 5992.191054207626, 6031.306399764083, 6078.817635470943, 6095.238095238095, 6139.706800529493, 5992.43071908168, 6012.218411606463, 6029.944759667129, 6042.244719410074, 6064.969675151772, 5731.484166425042, 5800.59395842287, 5809.419058094326, 5911.467967882912, 6022.1870047543025, 4826.348442960156, 5746.109353050284, 5788.971055144697, 5790.681512516852, 5837.970810145922, 5782.1615865698395, 5807.767689292381, 6005.099235114768, 6037.27552693662, 6064.181335519648, 5772.336181339199, 5789.739461724317, 5815.79644712433, 5908.3205431375945, 5918.112283157561], "value": 5558.8391258266065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.85764555342286, 470.90984371180735, 497.9726115063671, 523.8637954131924, 530.1755769777993, 37796.622033779655, 41042.17915641685, 41064.973375665584, 41190.99999999996, 41275.79362103185, 41920.0, 42706.93232669185, 42783.57216427835, 42794.14411711764, 43014.92462688434, 9145.496997665126, 9501.192398646124, 9514.952425237863, 9539.952300238523, 11056.11551075912, 11102.167337449684, 11268.492917818718, 11300.095992320594, 11310.434478276095, 11314.98165165135, 11285.943570282137, 11314.773704525946, 11323.603673871416, 11350.886491135107, 11358.0, 11214.719632009224, 11281.605143819968, 11319.886801132048, 11324.03745681618, 11329.150313726503, 11159.776804463865, 11267.098632109411, 11275.887241127648, 11279.548818047268, 11344.149188810872, 36767.4484882727, 36963.07592310187, 37110.25779484395, 37231.441528377094, 37232.25535489302, 3768.321702093622, 3782.1868298315717, 3795.2599243147597, 3808.0860593457646, 3957.406389041667, 22521.887390563104, 22580.661290080498, 27243.0, 28384.29039274014, 28501.144965651063, 2673.786097112246, 3025.183200535843, 3144.2296637323775, 3153.6057992750907, 3212.9357412851846, 379856.0, 441423.0, 449309.0, 452000.0, 457491.71254143515, 44804.55195448004, 45883.5411645886, 46348.76825615918, 55643.0, 55897.44102559004, 49369.753151234014, 57321.71339143278, 57336.71331643315, 57698.84602308014, 61671.0, 14203.289835508183, 14285.214313212666, 14438.639034024234, 14450.277486125651, 14466.782998255034, 10827.512761925733, 11073.335599864035, 11100.000999910048, 11107.777844443228, 11112.333260004425, 17378.65242695164, 17379.65240695179, 17439.564010899576, 17521.38675146389, 17535.0, 7558.395328373717, 7583.464071228034, 7592.924070759333, 7661.118971318258, 7730.652120654584, 838.6393850644281, 839.412411312084, 844.1769274956868, 861.642418396371, 876.2814492116403, 23740.64389034166, 28490.572641410396, 28640.71359286422, 28914.06195370933, 29102.27244318909, 966.8743063401713, 1023.6366090038078, 1030.340582027503, 1047.659510659039, 1109.5728144664363, 14743.483978060716, 14745.336459859333, 15020.248987550578, 15105.39578416873, 15105.622359441102, 583916.0, 585711.0, 587419.0, 589464.1053589409, 590873.0, 57532.42467575271, 57889.0, 58274.8345033097, 58411.415885841445, 58446.41553584495, 1328.508451872794, 1378.372840357635, 1384.4946594492937, 1388.2434073430004, 1392.0673148990202, 25152.0, 27358.5896211553, 28204.15387538377, 29187.41625167442, 29211.41577168487, 48716.78208044686, 49063.0, 49078.75460622674, 49147.26279105888, 49416.023359066676, 417719.0, 417756.0, 420485.0, 421852.0, 422678.0, 23843.761562384156, 24358.26925192247, 24581.0, 24817.751822482267, 25912.22263332103, 39671.40492892667, 40600.0, 40718.796406017784, 40893.77318680444, 41301.586984129775, 32402.356751815714, 32710.672893270763, 33508.664913350556, 33793.324133517686, 34970.82514587411, 27756.0, 33267.33465330728, 33698.66301336955, 34650.0, 34946.30107397889, 33351.83324083364, 33846.0, 34026.829865851505, 34055.48916766201, 34086.0, 22979.08083676634, 29290.414191716474, 30219.546706798978, 30402.391952161277, 30545.847270763505, 21483.46291342729, 22557.984890680287, 22976.885115574314, 23219.76780232176, 23300.184493542645], "value": 18925.0420803946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.9127718070482, 379.4365367429367, 384.88068698703404, 399.6523024968278, 409.9139180772038, 13950.93024534876, 14098.0, 19262.614747705036, 21275.36173914783, 21515.354539363805, 15751.369945202207, 17416.39042633508, 17936.730949035777, 18100.370966613034, 21182.83494407807, 5781.421857814227, 6013.977623803964, 6016.067509536029, 6037.154798328237, 6042.033274676052, 4813.735244561565, 5615.9157612635845, 5922.2597175353085, 6063.969680151593, 6086.300075491309, 3519.8416071276724, 3717.9814100929457, 5990.430909063632, 6212.875742485147, 6508.284088750233, 5575.745457272122, 6554.41010309072, 6563.245226798907, 6566.967165164191, 6573.375529324707, 5744.712764361765, 5784.421557844224, 5812.070068788974, 5813.128030795372, 5831.970840145815, 10892.509837057352, 12982.935085324607, 13130.540431084866, 13175.275359855204, 13336.599902002858, 2426.6723992260995, 2447.473793134485, 2498.1381423408893, 2526.4820711754046, 2529.962050569243, 9357.438553686732, 9765.365251258645, 10054.0, 10172.44051577163, 10265.538050787733, 1717.450415866923, 1768.1159420289855, 1789.9284028638838, 1797.164318591861, 1801.081448461281, 111655.32517012251, 123675.0, 124146.06831453463, 124468.37765811113, 124571.0, 9605.519724013771, 11568.363739994382, 12055.336956467303, 12058.095642826647, 12252.326122063372, 15184.240787960558, 15237.771433428508, 15238.009529380555, 15263.694726105638, 15293.694126117416, 7017.61403122823, 7920.6039698014865, 8266.421350505407, 8289.917100828914, 8421.368397370221, 7942.880856787153, 7947.682092716226, 7973.322267607203, 8027.357811375076, 8251.587420628945, 4634.374359461497, 4639.791209395517, 4652.278896771006, 4679.438467383868, 4744.979829336709, 1978.7229787829715, 2012.118669044448, 2046.8055534724178, 2047.2834507922405, 2049.7540295164677, 994.6916455898695, 1002.7693630464888, 1006.4665727164614, 1007.4183531855064, 1050.4485145298627, 20812.687809682866, 21215.257465988616, 21267.680984785242, 21469.0, 21474.23092289228, 999.820032394176, 1012.0587853296357, 1024.6618615856748, 1050.894910508943, 1055.4195192644015, 10566.682999510027, 10941.83587246192, 11142.944285278521, 11208.943955280172, 11248.212625116163, 661331.0, 668815.0, 677486.0, 680039.0, 683274.0, 108539.0, 127470.36264818802, 144942.0, 154572.0, 156182.30798834396, 1071.3197119828965, 1075.725689949058, 1118.4463690473106, 1122.820348744197, 1126.808442564766, 13976.860231397963, 15262.465813696468, 18369.81630183681, 19644.705329419783, 19703.40889773309, 44536.77731611321, 44981.453523830365, 50390.0, 57182.7140864293, 58767.4123258762, 69386.30613693799, 81640.59179704302, 84285.0, 84788.0, 87212.0, 6471.611703297817, 7116.786496405116, 7924.564148971631, 8058.758237252891, 8458.915410846059, 10434.37393756377, 10618.415987120783, 11001.579652476443, 12983.870161298266, 13247.933760331136, 9401.764955876159, 10736.463176841284, 11020.338779673246, 11247.0, 11499.0, 9278.11857873501, 9966.40201587907, 10347.586096556053, 10454.947725261325, 11144.996950274513, 9653.855192172263, 10641.095506882002, 11249.437528123724, 11280.307953806994, 11541.307521548733, 8091.757247282591, 8288.917110829056, 8300.958495207486, 8477.491350518989, 8577.699780507652, 10621.203409744145, 11249.437528123724, 11255.943720281346, 11426.314421134759, 11445.111556593069], "value": 9398.570561851488, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.5225066725313, 1435.6482661747866, 1457.83963763986, 1471.359958418088, 1478.6081688352585, 6860.279670634586, 8277.54473503957, 8513.829723405528, 8624.95687521563, 8651.69719059833, 8269.25576698097, 8506.0, 8525.872111918326, 8540.402171847973, 8544.658213671446, 2270.489139943516, 2315.455867871049, 2315.988420057897, 2317.432229103872, 2320.9535809283802, 2270.137347807839, 2298.9195378161767, 2301.033565902325, 2312.1791763923816, 2317.860928344296, 2251.3020963501285, 2262.3778460923213, 2292.495650956787, 2295.472041430472, 2300.1259521381853, 2251.6509940959095, 2251.9324420267253, 2258.503129311557, 2291.0950174680993, 2291.6104262275453, 1510.750726130187, 2000.1799262302386, 2200.262911924507, 2257.24382331919, 2333.498297865967, 8378.162183781635, 8522.318214542822, 8524.275436587897, 8530.189631984951, 8539.914600853974, 4958.661161486414, 5107.948920510822, 5275.155975044013, 5285.577153827685, 5291.973540132313, 3361.6638336166434, 3434.3818112739696, 3446.7759595626453, 3541.043918142113, 3546.8255910959806, 1204.5362535423837, 1212.1575505024011, 1235.086036333116, 1256.7360854220624, 1257.7295881385546, 9094.86357704635, 9453.480058596842, 10497.31767435122, 10662.946685266525, 10906.727331816688, 4335.414719012956, 4646.628269738413, 4721.5750582447745, 4731.219348807408, 4746.121967436035, 9607.183389411979, 9667.9033209667, 9671.9032809671, 9680.177184939219, 9704.428326493486, 5178.249153872743, 5271.6309858310315, 5273.050850846807, 5274.7098909560345, 5288.127458969304, 4525.728456292633, 4669.439667239885, 4759.6668233223345, 4765.904681906342, 4825.710457372569, 3248.3016151527536, 3554.4845997330244, 3661.5972243053243, 3892.96107038926, 3897.8635747748694, 1226.993865030687, 1260.9810852837215, 1272.7454509098031, 1279.8976081913424, 1300.843898732158, 871.1661951591934, 877.1579283887412, 878.2359347367703, 888.8933328000682, 915.1169121797498, 4323.740575565414, 5427.674339539641, 5548.55611551075, 5696.202531645573, 5729.713514324267, 829.2163905109613, 900.6217388696632, 980.7106903463496, 983.9458829764432, 998.7003898830321, 3555.040139162463, 3777.414500752388, 3822.120912190212, 3836.7889766063136, 3853.344931361675, 8733.912660873437, 9478.715638530855, 9573.234141268682, 9851.605935762489, 9923.60305587783, 9876.753081173028, 10022.198224142052, 10029.997000300058, 10032.949835250776, 10058.346207496636, 7594.696212151563, 7814.843703126019, 7874.094479134858, 7884.526928384315, 7886.171951944963, 5221.164613661796, 5614.129809879475, 5683.60214784961, 5727.541796656341, 5754.510866576388, 8892.59983300766, 9197.712320275034, 9208.677696280598, 9212.263018958602, 9228.307876909394, 8900.0, 9198.724038278862, 9272.582733777132, 9327.347085703936, 9344.112309330603, 6686.3313668632745, 6799.354061364163, 6815.625140617115, 6828.556143850634, 6847.281035491202, 7754.806129846799, 7818.413618978713, 7828.864814601965, 7843.176466470938, 7864.1742617026675, 5889.94110058894, 6956.443484521125, 7019.157701075904, 7164.391026762783, 7203.891941620985, 5799.536037117105, 6896.586204827727, 6960.025596416607, 6995.405390541861, 7072.5402848814665, 6295.779647712308, 6334.683265836782, 6376.139221205263, 6384.361563843764, 6410.4871610272, 4832.95167048339, 4953.23224900141, 4970.055689418999, 5001.924971125363, 5119.820806271762, 4949.802007919787, 4964.751762411937, 5042.546170844642, 5055.988802239641, 5137.383513978347], "value": 4382.374624112859, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.6936088159775, 345.9844307006185, 356.2643141911952, 365.63071297989023, 367.42864845165775, 4335.783210839461, 5301.257823904656, 5407.836865253896, 5519.53083987861, 5559.861003474915, 4659.4175728034, 5271.65734227275, 5304.257403963448, 5307.416184219733, 5330.680159190451, 3629.691476224524, 4039.656998940622, 4065.410515475254, 4068.206699693546, 4102.097538541516, 3788.6779623731877, 3859.903502412434, 4119.949412899707, 4120.381942708587, 4131.2357213915375, 3943.3099207638547, 3998.340273854825, 4004.339284018148, 4015.3575427931537, 4022.537408198051, 3347.715444187247, 3544.379733546619, 3664.95548768601, 3847.4998250227572, 4058.228936502055, 3232.628247751515, 3487.9651203488147, 3493.371193185226, 3508.0, 3528.558930133733, 4394.846525202628, 4884.829030983934, 5173.611979101583, 5254.579633629301, 5367.302250707383, 4609.257491792412, 4615.446146462413, 4621.353010578522, 4630.536946305342, 4633.305004249356, 4537.342085397632, 5669.8582535436535, 5671.574631902583, 5756.251687280626, 5771.682557459338, 3260.2990357073345, 3825.5026846509777, 3828.712846536493, 3840.231953609289, 3852.3451013327804, 4530.864074077783, 4879.780409881564, 5867.295924489046, 5874.765009399662, 5895.4399332063385, 3872.3997780344093, 3873.7869417182324, 3885.922281554353, 3889.5138107736534, 3907.4138879167785, 3907.6873850091924, 3935.5474120475938, 3961.2869683457257, 3964.1278918637854, 3974.18529201513, 3643.653852883972, 4473.306637471197, 4636.35091087248, 4641.2109941310055, 4648.3259927310355, 5533.529649979797, 5670.631408958405, 5704.0, 5729.656220626775, 5758.4740043888405, 1030.5929157982705, 1140.885911408869, 1146.9426528673532, 1183.219075410225, 1264.5826877130526, 734.2400615363181, 808.7573727881612, 865.9523726194993, 870.8911386076741, 882.6734108379941, 4433.069055498317, 4727.763611819395, 4913.828016019422, 5129.8717532061255, 5195.19474481456, 4657.976710116495, 5157.535821776059, 5685.744141513642, 5728.713564321767, 5729.770809167587, 3873.6394800391295, 4996.800127994839, 5080.771365288497, 5095.267609012879, 5098.974505127525, 2545.440003199293, 2693.340131667754, 2732.8360298382163, 2949.439606474763, 2952.4242772659554, 5096.668716533413, 5802.912956305574, 5804.7941782122525, 5827.388124246978, 5928.5989174383585, 5325.87244885217, 5749.338826034976, 5831.620944638585, 5900.734466948998, 6013.308469525973, 5374.328208973879, 5844.47399734026, 5945.61353512029, 6105.206323177958, 6149.292831324455, 5012.067940254991, 5917.082852157922, 5935.525157987437, 5991.700414979321, 6007.438066102932, 4868.488808675038, 5419.0, 5543.307086614173, 5842.114993529255, 5913.822585322448, 4992.55811165831, 5256.342957130359, 5655.660660360227, 6082.5438092142385, 6178.41305076017, 3488.9476657849646, 3843.9429156982055, 3896.9220615586964, 3949.881503554898, 3969.8015099244344, 5938.435848594377, 6011.368806275278, 6013.789517366871, 6014.789482368096, 6031.668258245839, 5328.200769884548, 5654.40628733977, 5698.886022279448, 5709.972959599449, 5739.938111449395, 5088.44027157005, 5686.34607020198, 5709.714514274353, 5712.314522257356, 5811.099279611667, 5162.922556161736, 5502.019273061775, 5591.412901645269, 5606.915896261477, 5621.241132447068, 4878.902421951612, 5636.887262254814, 5645.576581756467, 5692.402297758841, 5703.971480142573, 4689.437267527918, 4792.257200133985, 5465.945340546544, 5612.7754889803955, 5625.887482250414], "value": 4087.9275662105956, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.3028849996005, 687.3161204601422, 697.2260790522522, 773.3349319585155, 784.4940013691171, 12852.614421567356, 13665.931670341646, 13696.589102326934, 14310.642233944156, 15631.609209769762, 14009.0, 14186.645333866658, 14459.638509037279, 14471.5658530244, 14485.0, 876.6712482818958, 907.8865141857268, 910.0580898769774, 912.9863052054192, 913.2146354135472, 886.0607755778863, 893.3523195683143, 893.4460634406677, 919.1176470588243, 926.3422969691527, 959.721680712596, 963.7638778499243, 963.9180669643089, 964.5177411294353, 966.0629189686028, 917.7797328641111, 958.1999030809247, 959.8080383923174, 960.2558017536395, 961.1877963121151, 702.0802748399561, 713.9968344476019, 715.6099925540593, 717.3292971072065, 717.9317964793337, 14613.269336533238, 14875.256237188098, 15145.469908553148, 15224.46714364992, 15224.934254602182, 13305.135166214262, 13338.266395348252, 13571.253581053039, 13573.59279221625, 13584.388702508411, 10300.845487317696, 10817.567297308176, 11573.710657233552, 11746.70633234176, 12362.690932726753, 3646.781193128421, 3667.7615954962844, 3712.87004954828, 3741.56971948224, 3850.268448994682, 100103.49327293702, 100216.49891750567, 102942.0, 104625.0, 105682.0, 10986.01125898657, 11025.558977640805, 11046.668599942015, 11077.778444431066, 11338.716532086764, 22036.33890983273, 22193.55612887733, 22309.442263943205, 22348.888255558617, 22386.776132238796, 7360.07999000125, 7481.962590187123, 7583.544987300669, 7610.9238907610215, 7707.152213256537, 3281.5241789940324, 4155.127423241092, 4181.958180418218, 4235.4917409910395, 4399.6040356368085, 3581.194231297989, 3627.9818600907356, 3677.191017976041, 3689.0777305673582, 3691.520102386726, 609.387565496673, 639.2999665366416, 670.8859493886051, 675.4630069095081, 692.069166970434, 458.5781081405115, 587.6503480429138, 614.1984709953464, 636.2619361540591, 643.2217017408988, 9233.399829011092, 9379.812403752023, 9784.804303913881, 9809.705708828747, 9970.950145249228, 531.4764956517827, 548.9460236346225, 557.8633234857405, 587.9382664820132, 676.1345477788439, 4796.328514008042, 4875.219964805614, 4880.032130266464, 4977.751112444364, 5302.0, 74603.62698186474, 96881.51559242158, 99382.0, 100785.48036299004, 100935.0, 66277.0, 73507.42724004634, 74958.62520687362, 81567.59216203881, 88294.55852720696, 47493.0, 64883.10701358028, 68327.3167268321, 74144.0, 74684.0, 8446.704365347183, 8914.509701966454, 9310.674126405544, 10044.146247569039, 10624.20318476102, 48393.75803120962, 48620.756896215295, 48848.0, 50792.746036269586, 51167.0, 45983.0, 63534.682326588074, 63972.0, 64534.418623256424, 64597.0, 12691.238525688119, 12758.298293593942, 12775.808362874379, 12876.742465150457, 13179.538716144889, 13855.445782169003, 13884.821016366961, 13903.359080294626, 13945.646101045882, 14252.786208207093, 12667.239965602093, 12908.096433249582, 13016.674583135497, 13186.736265274832, 13457.528986485426, 12735.74528509406, 12898.613041608767, 13013.609591712264, 13078.215307081606, 13467.191968481922, 12562.623121306375, 12674.936625317183, 12689.682757931125, 13168.209907405586, 13301.46794128224, 10212.948935255276, 10658.786824263627, 10749.19381046409, 11005.339679618928, 11170.0, 8254.628541715518, 8527.403081784216, 9281.72154835356, 9464.384814987005, 9847.901520984698], "value": 7275.960990757649, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1611.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 172.0, 137.0, 117.0, 119.0, 120.0, 126.0, 172.0, 175.0, 119.0], "value": 140.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 118.0, 154.0, 115.0, 119.0, 120.0, 118.0, 150.0, 145.0], "value": 130.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 216.0, 276.0, 198.0, 200.0, 201.0, 196.0, 193.0, 195.0, 197.0], "value": 208.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 65.0, 86.0, 110.0, 74.0, 62.0, 60.0, 61.0, 77.0, 76.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 105.0, 122.0, 56.0, 90.0, 103.0, 113.0, 105.0, 78.0, 83.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 100.0, 137.0, 137.0, 109.0, 90.0, 91.0, 90.0, 90.0, 90.0], "value": 107.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 92.0, 134.0, 157.0, 129.0, 98.0, 144.0, 96.0, 99.0, 99.0], "value": 115.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 150.0, 110.0, 94.0, 91.0, 100.0, 92.0, 95.0, 92.0, 92.0], "value": 104.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 64.0, 65.0, 65.0, 66.0, 80.0, 79.0, 64.0], "value": 67.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 70.0, 74.0, 80.0, 70.0, 70.0, 69.0, 63.0, 92.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 112.0, 108.0, 88.0, 94.0, 88.0, 89.0, 93.0, 92.0, 89.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 143.0, 149.0, 156.0, 148.0, 149.0, 147.0, 184.0, 157.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 180.0, 178.0, 176.0, 177.0, 178.0, 175.0, 179.0, 174.0, 179.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 70.0, 68.0, 67.0, 70.0, 67.0, 68.0, 69.0], "value": 68.2, "unit": "score"}]}]} 15:27:39 INFO - Return code: 0 15:27:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:27:39 ERROR - # TBPL SUCCESS # 15:27:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:27:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:27:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:27:39 INFO - 2017-03-10 15:27:39.602 screenresolution[1659:10567] starting screenresolution argv=screenresolution get 15:27:39 INFO - 2017-03-10 15:27:39.605 screenresolution[1659:10567] Display 0: 1600x1200x32@60 15:27:39 INFO - 2017-03-10 15:27:39.611 screenresolution[1660:10570] starting screenresolution argv=screenresolution list 15:27:39 INFO - Available Modes on Display 0 15:27:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:27:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:27:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:27:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:27:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:27:39 INFO - Intel Iris: 15:27:39 INFO - Chipset Model: Intel Iris 15:27:39 INFO - Type: GPU 15:27:39 INFO - Bus: Built-In 15:27:39 INFO - VRAM (Dynamic, Max): 1536 MB 15:27:39 INFO - Vendor: Intel (0x8086) 15:27:39 INFO - Device ID: 0x0a2e 15:27:39 INFO - Revision ID: 0x0009 15:27:39 INFO - Displays: 15:27:39 INFO - Display: 15:27:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:27:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:27:39 INFO - Display Serial Number: 1600x1200 60 15:27:39 INFO - Main Display: Yes 15:27:39 INFO - Mirror: Off 15:27:39 INFO - Online: Yes 15:27:39 INFO - Rotation: Supported 15:27:39 INFO - Return code: 0 15:27:39 INFO - Running post-action listener: _resource_record_post_action 15:27:39 INFO - [mozharness: 2017-03-10 23:27:39.847322Z] Finished run-tests step (success) 15:27:39 INFO - Running post-run listener: _resource_record_post_run 15:27:39 INFO - Total resource usage - Wall time: 1202s; CPU: 55.0%; Read bytes: 38865408; Write bytes: 558988288; Read time: 245; Write time: 1720 15:27:39 INFO - TinderboxPrint: CPU usage
54.7% 15:27:39 INFO - TinderboxPrint: I/O read bytes / time
38,865,408 / 245 15:27:39 INFO - TinderboxPrint: I/O write bytes / time
558,988,288 / 1,720 15:27:39 INFO - TinderboxPrint: CPU idle
2,177.8 (45.3%) 15:27:39 INFO - TinderboxPrint: CPU system
973.5 (20.2%) 15:27:39 INFO - TinderboxPrint: CPU user
1,658.4 (34.5%) 15:27:39 INFO - TinderboxPrint: Swap in / out
291,758,080 / 0 15:27:39 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 246962688; Write bytes: 241928192; Read time: 17955; Write time: 496 15:27:39 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 36801024; Write bytes: 301671424; Read time: 225; Write time: 1181 15:27:40 INFO - Running post-run listener: _upload_blobber_files 15:27:40 INFO - Blob upload gear active. 15:27:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:27:40 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 15:27:40 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'] 15:27:40 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 15:27:40 INFO - (blobuploader) - INFO - Open directory for files ... 15:27:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:27:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:27:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:27:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:27:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:27:41 INFO - (blobuploader) - INFO - Done attempting. 15:27:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:27:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:27:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:27:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:27:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:27:42 INFO - (blobuploader) - INFO - Done attempting. 15:27:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:27:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:27:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:27:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:27:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:27:43 INFO - (blobuploader) - INFO - Done attempting. 15:27:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:27:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:27:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:27:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:27:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:27:46 INFO - (blobuploader) - INFO - Done attempting. 15:27:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:27:46 INFO - Return code: 0 15:27:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:27:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:27:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/197e72c94af7a6d48f2c980110235d93dc26c3bd69bbc0c34631b7b8ad022d89ced170830b8d186c984fee91062dc139788a8774d0a6408dd846b65b7f5e6dc7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e34c1409d9d130149739d31e2dd4671f8e25060cd253f00e0a38982055036ccdd3109723e1e7bfffb7b398e97d3185492df31973b45ef341661541329968065", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d71fa6539d0ef0ad3abc71f048843ff6cd7873b5f780f768cfb3a8c9377049bd3d052b4f9a7964ead2799459b733527ab7aeeba6ec0c3634a21f9f7c656b6c0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76af0c9cec53b5747fbd61e64689d998f1bd9bc7d8f66e98f012db923717c7014e8829eb16b8d22f0f994826376e7a4ec807752efd21443095265986a9429d9c"} 15:27:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:27:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:27:46 INFO - Contents: 15:27:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/197e72c94af7a6d48f2c980110235d93dc26c3bd69bbc0c34631b7b8ad022d89ced170830b8d186c984fee91062dc139788a8774d0a6408dd846b65b7f5e6dc7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e34c1409d9d130149739d31e2dd4671f8e25060cd253f00e0a38982055036ccdd3109723e1e7bfffb7b398e97d3185492df31973b45ef341661541329968065", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d71fa6539d0ef0ad3abc71f048843ff6cd7873b5f780f768cfb3a8c9377049bd3d052b4f9a7964ead2799459b733527ab7aeeba6ec0c3634a21f9f7c656b6c0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76af0c9cec53b5747fbd61e64689d998f1bd9bc7d8f66e98f012db923717c7014e8829eb16b8d22f0f994826376e7a4ec807752efd21443095265986a9429d9c"} 15:27:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:27:46 INFO - Copying logs to upload dir... 15:27:46 INFO - mkdir: /builds/slave/test/build/upload/logs 15:27:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.228124 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-10 15:27:46.480613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 15:27:46.484171) ========= 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.xfPsJCexSn/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.JPrXbsOmLM/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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/197e72c94af7a6d48f2c980110235d93dc26c3bd69bbc0c34631b7b8ad022d89ced170830b8d186c984fee91062dc139788a8774d0a6408dd846b65b7f5e6dc7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e34c1409d9d130149739d31e2dd4671f8e25060cd253f00e0a38982055036ccdd3109723e1e7bfffb7b398e97d3185492df31973b45ef341661541329968065", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d71fa6539d0ef0ad3abc71f048843ff6cd7873b5f780f768cfb3a8c9377049bd3d052b4f9a7964ead2799459b733527ab7aeeba6ec0c3634a21f9f7c656b6c0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76af0c9cec53b5747fbd61e64689d998f1bd9bc7d8f66e98f012db923717c7014e8829eb16b8d22f0f994826376e7a4ec807752efd21443095265986a9429d9c"} 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.010892 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/197e72c94af7a6d48f2c980110235d93dc26c3bd69bbc0c34631b7b8ad022d89ced170830b8d186c984fee91062dc139788a8774d0a6408dd846b65b7f5e6dc7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e34c1409d9d130149739d31e2dd4671f8e25060cd253f00e0a38982055036ccdd3109723e1e7bfffb7b398e97d3185492df31973b45ef341661541329968065", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d71fa6539d0ef0ad3abc71f048843ff6cd7873b5f780f768cfb3a8c9377049bd3d052b4f9a7964ead2799459b733527ab7aeeba6ec0c3634a21f9f7c656b6c0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76af0c9cec53b5747fbd61e64689d998f1bd9bc7d8f66e98f012db923717c7014e8829eb16b8d22f0f994826376e7a4ec807752efd21443095265986a9429d9c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 15:27:46.517472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:27:46.517783) ========= 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.xfPsJCexSn/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.JPrXbsOmLM/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.005121 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:27:46.566740) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 15:27:46.567060) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 15:27:46.567385) ========= ========= Total master_lag: 0.18 =========