builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0001 starttime: 1480421517.71 results: success (0) buildid: 20161129013042 builduid: 9cd7125dfaf544a3b0aeea89149aafb6 revision: 94dac74c74a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 04:11:57.707724) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 04:11:57.708204) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 04:11:57.708485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 04:11:57.734890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 04:11:57.735223) ========= 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.WkUSXj5JLw/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.WmLITJVecH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-29 04:11:57-- 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% 16.0M=0.001s 2016-11-29 04:11:57 (16.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126727 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 04:11:57.885924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 04:11:57.886252) ========= 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.WkUSXj5JLw/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.WmLITJVecH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.025941 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 04:11:57.934637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-29 04:11:57.934992) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94dac74c74a6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94dac74c74a6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WkUSXj5JLw/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.WmLITJVecH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-29 04:11:58,029 Setting DEBUG logging. 2016-11-29 04:11:58,029 attempt 1/10 2016-11-29 04:11:58,029 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/94dac74c74a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 04:11:59,103 unpacking tar archive at: mozilla-aurora-94dac74c74a6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.337856 ========= master_lag: 0.78 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-29 04:12:00.052939) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 04:12:00.053303) ========= script_repo_revision: 94dac74c74a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 04:12:00.053728) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 04:12:00.054001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 04:12:00.077909) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-29 04:12:00.078312) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WkUSXj5JLw/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.WmLITJVecH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:12:00 INFO - MultiFileLogger online at 20161129 04:12:00 in /builds/slave/test 04:12:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:12:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:12:00 INFO - {'append_to_log': False, 04:12:00 INFO - 'base_work_dir': '/builds/slave/test', 04:12:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:12:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:12:00 INFO - 'branch': 'Mozilla-Aurora', 04:12:00 INFO - 'buildbot_json_path': 'buildprops.json', 04:12:00 INFO - 'config_files': ('talos/mac_config.py',), 04:12:00 INFO - 'default_actions': ('clobber', 04:12:00 INFO - 'read-buildbot-config', 04:12:00 INFO - 'download-and-extract', 04:12:00 INFO - 'populate-webroot', 04:12:00 INFO - 'create-virtualenv', 04:12:00 INFO - 'install', 04:12:00 INFO - 'run-tests'), 04:12:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:12:00 INFO - 'download_minidump_stackwalk': True, 04:12:00 INFO - 'download_symbols': 'ondemand', 04:12:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:12:00 INFO - 'tooltool.py': '/tools/tooltool.py', 04:12:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:12:00 INFO - '/tools/misc-python/virtualenv.py')}, 04:12:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:12:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:12:00 INFO - 'installer_path': 'installer.exe', 04:12:00 INFO - 'log_level': 'info', 04:12:00 INFO - 'log_name': 'talos', 04:12:00 INFO - 'log_to_console': True, 04:12:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:12:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:12:00 INFO - 'opt_config_files': (), 04:12:00 INFO - 'pip_index': False, 04:12:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:12:00 INFO - 'cmd': ('bash', 04:12:00 INFO - '-c', 04:12:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:12:00 INFO - 'enabled': True, 04:12:00 INFO - 'halt_on_failure': False, 04:12:00 INFO - 'name': 'check_screen_resolution'},), 04:12:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:12:00 INFO - 'cmd': ('bash', 04:12:00 INFO - '-c', 04:12:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:12:00 INFO - 'enabled': True, 04:12:00 INFO - 'halt_on_failure': False, 04:12:00 INFO - 'name': 'check_screen_resolution'},), 04:12:00 INFO - 'run_cmd_checks_enabled': True, 04:12:00 INFO - 'sps_profile': False, 04:12:00 INFO - 'sps_profile_interval': 0, 04:12:00 INFO - 'suite': 'dromaeojs-e10s', 04:12:00 INFO - 'system_bits': '32', 04:12:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:12:00 INFO - 'title': 't-yosemite-r7-0001', 04:12:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:12:00 INFO - 'use_talos_json': True, 04:12:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:12:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:12:00 INFO - 'work_dir': 'build'} 04:12:00 INFO - [mozharness: 2016-11-29 12:12:00.281068Z] Running clobber step. 04:12:00 INFO - Running pre-action listener: _resource_record_pre_action 04:12:00 INFO - Running main action method: clobber 04:12:00 INFO - rmtree: /builds/slave/test/build 04:12:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:12:02 INFO - Running post-action listener: _resource_record_post_action 04:12:02 INFO - [mozharness: 2016-11-29 12:12:02.839862Z] Finished clobber step (success) 04:12:02 INFO - [mozharness: 2016-11-29 12:12:02.840083Z] Running read-buildbot-config step. 04:12:02 INFO - Running pre-action listener: _resource_record_pre_action 04:12:02 INFO - Running main action method: read_buildbot_config 04:12:02 INFO - Using buildbot properties: 04:12:02 INFO - { 04:12:02 INFO - "project": "", 04:12:02 INFO - "product": "firefox", 04:12:02 INFO - "script_repo_revision": "production", 04:12:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 04:12:02 INFO - "repository": "", 04:12:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 04:12:02 INFO - "buildid": "20161129013042", 04:12:02 INFO - "stage_platform": "macosx64", 04:12:02 INFO - "basedir": "/builds/slave/test", 04:12:02 INFO - "nightly_build": "True", 04:12:02 INFO - "buildnumber": 465, 04:12:02 INFO - "slavename": "t-yosemite-r7-0001", 04:12:02 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:12:02 INFO - "platform": "yosemite_r7", 04:12:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:12:02 INFO - "branch": "mozilla-aurora", 04:12:02 INFO - "repo_path": "releases/mozilla-aurora", 04:12:02 INFO - "revision": "94dac74c74a6", 04:12:02 INFO - "pgo_build": "False", 04:12:02 INFO - "builduid": "9cd7125dfaf544a3b0aeea89149aafb6", 04:12:02 INFO - "slavebuilddir": "test" 04:12:02 INFO - } 04:12:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 04:12:02 INFO - Running post-action listener: _resource_record_post_action 04:12:02 INFO - [mozharness: 2016-11-29 12:12:02.845765Z] Finished read-buildbot-config step (success) 04:12:02 INFO - [mozharness: 2016-11-29 12:12:02.845979Z] Running download-and-extract step. 04:12:02 INFO - Running pre-action listener: _resource_record_pre_action 04:12:02 INFO - Running main action method: download_and_extract 04:12:02 INFO - mkdir: /builds/slave/test/build/tests 04:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:02 INFO - trying https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 04:12:02 INFO - Downloading https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 04:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 04:12:04 INFO - Downloaded 1199 bytes. 04:12:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 04:12:04 INFO - Using the following test package requirements: 04:12:04 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 04:12:04 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 04:12:04 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 04:12:04 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 04:12:04 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 04:12:04 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 04:12:04 INFO - u'jsshell-mac.zip'], 04:12:04 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 04:12:04 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 04:12:04 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 04:12:04 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 04:12:04 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 04:12:04 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 04:12:04 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 04:12:04 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 04:12:04 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 04:12:04 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 04:12:04 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 04:12:04 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:12:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 04:12:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:12:04 INFO - Fetch https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 04:12:04 INFO - Http code: 200 04:12:04 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 04:12:04 INFO - x-amz-cf-id: xHFMcYntgAOGDqPr-_iXGiWMqb4sg0R-htNQz1sMs_m2tDEg9qk6lg== 04:12:04 INFO - x-amz-version-id: mYPk6eBxtcMcbmRD7DSsMfFvScbRRXLo 04:12:05 INFO - Expected file size: 16283426 04:12:05 INFO - Obtained file size: 16283426 04:12:12 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 04:12:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 04:12:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:12:12 INFO - Fetch https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 04:12:12 INFO - Http code: 200 04:12:12 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 04:12:12 INFO - x-amz-cf-id: LwGAIfOHINFPtk9wBIqQPb8Q0wwwXmvrcwRyxNvND9WucSCV_xPJxg== 04:12:12 INFO - x-amz-version-id: mYPk6eBxtcMcbmRD7DSsMfFvScbRRXLo 04:12:13 INFO - Expected file size: 16283426 04:12:13 INFO - Obtained file size: 16283426 04:12:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 04:12:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:12:19 INFO - Fetch https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 04:12:20 INFO - Http code: 200 04:12:20 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 04:12:20 INFO - x-amz-cf-id: tlzPcFteAkHpPGVvKN3u02zJpGJ5-7XatKfIMbPmAerbVQe4cJludA== 04:12:20 INFO - x-amz-version-id: WM_GdZn8Dh6bzL06XifOccN1Vzge.yVJ 04:12:20 INFO - Expected file size: 14409038 04:12:20 INFO - Obtained file size: 14409038 04:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:21 INFO - trying https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 04:12:21 INFO - Downloading https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 04:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 04:12:23 INFO - Downloaded 109784411 bytes. 04:12:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 04:12:23 INFO - mkdir: /builds/slave/test/properties 04:12:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:12:23 INFO - Writing to file /builds/slave/test/properties/build_url 04:12:23 INFO - Contents: 04:12:23 INFO - build_url:https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 04:12:24 INFO - Running post-action listener: _resource_record_post_action 04:12:24 INFO - Running post-action listener: set_extra_try_arguments 04:12:24 INFO - [mozharness: 2016-11-29 12:12:24.577428Z] Finished download-and-extract step (success) 04:12:24 INFO - [mozharness: 2016-11-29 12:12:24.577569Z] Running populate-webroot step. 04:12:24 INFO - Running pre-action listener: _resource_record_pre_action 04:12:24 INFO - Running main action method: populate_webroot 04:12:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:12:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:12:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:12:24 INFO - '--tppagecycles', 04:12:24 INFO - '7'], 04:12:24 INFO - 'tests': ['tsvgm']}}, 04:12:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:12:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:12:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:12:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:12:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:24 INFO - 'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:24 INFO - 'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['damp', 'tps']}, 04:12:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:24 INFO - 'tests': ['damp', 'tps']}, 04:12:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['dromaeo_dom']}, 04:12:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:12:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['basic_compositor_video']}, 04:12:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:12:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'other-e10s': {'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['tsvgx', 04:12:24 INFO - 'tsvgr_opacity', 04:12:24 INFO - 'tart', 04:12:24 INFO - 'tscrollx', 04:12:24 INFO - 'cart']}, 04:12:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:12:24 INFO - 'tsvgr_opacity', 04:12:24 INFO - 'tart', 04:12:24 INFO - 'tscrollx', 04:12:24 INFO - 'cart']}, 04:12:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:24 INFO - 'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['tp5o']}, 04:12:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:24 INFO - 'tests': ['tp5o']}, 04:12:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:24 INFO - 'talos_options': ['--disable-e10s', 04:12:24 INFO - '--xperf_path', 04:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:24 INFO - 'tests': ['tp5n']}, 04:12:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:24 INFO - 'talos_options': ['--xperf_path', 04:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:24 INFO - 'tests': ['tp5n']}}, 04:12:24 INFO - 'talos.zip': {'path': '', 04:12:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:12:24 INFO - Running post-action listener: _resource_record_post_action 04:12:24 INFO - [mozharness: 2016-11-29 12:12:24.596105Z] Finished populate-webroot step (success) 04:12:24 INFO - [mozharness: 2016-11-29 12:12:24.596234Z] Running create-virtualenv step. 04:12:24 INFO - Running pre-action listener: _resource_record_pre_action 04:12:24 INFO - Running main action method: create_virtualenv 04:12:24 INFO - Creating virtualenv /builds/slave/test/build/venv 04:12:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:12:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:12:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:12:24 INFO - Using real prefix '/tools/python27' 04:12:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:12:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:12:28 INFO - Installing pip.................done. 04:12:28 INFO - Return code: 0 04:12:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:12:28 INFO - Reading from file tmpfile_stdout 04:12:28 INFO - Output received: 04:12:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:12:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104090490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6394a4080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea4d30>, '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 0x103d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cb20>, '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.WkUSXj5JLw/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.WmLITJVecH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:12:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkUSXj5JLw/Render', 04:12:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:28 INFO - 'HOME': '/Users/cltbld', 04:12:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:28 INFO - 'LOGNAME': 'cltbld', 04:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:28 INFO - 'MOZ_NO_REMOTE': '1', 04:12:28 INFO - 'NO_EM_RESTART': '1', 04:12:28 INFO - 'PAGER': '/bin/cat', 04:12:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:28 INFO - 'PWD': '/builds/slave/test', 04:12:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:28 INFO - 'SHELL': '/bin/bash', 04:12:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmLITJVecH/Listeners', 04:12:28 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:12:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:28 INFO - 'USER': 'cltbld', 04:12:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:28 INFO - 'XPC_FLAGS': '0x0', 04:12:28 INFO - 'XPC_SERVICE_NAME': '0', 04:12:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:12:28 INFO - Cleaning up... 04:12:28 INFO - Return code: 0 04:12:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104090490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6394a4080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea4d30>, '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 0x103d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cb20>, '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.WkUSXj5JLw/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.WmLITJVecH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:12:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkUSXj5JLw/Render', 04:12:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:28 INFO - 'HOME': '/Users/cltbld', 04:12:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:28 INFO - 'LOGNAME': 'cltbld', 04:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:28 INFO - 'MOZ_NO_REMOTE': '1', 04:12:28 INFO - 'NO_EM_RESTART': '1', 04:12:28 INFO - 'PAGER': '/bin/cat', 04:12:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:28 INFO - 'PWD': '/builds/slave/test', 04:12:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:28 INFO - 'SHELL': '/bin/bash', 04:12:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmLITJVecH/Listeners', 04:12:28 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:12:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:28 INFO - 'USER': 'cltbld', 04:12:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:28 INFO - 'XPC_FLAGS': '0x0', 04:12:28 INFO - 'XPC_SERVICE_NAME': '0', 04:12:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:29 INFO - Downloading/unpacking psutil>=3.1.1 04:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:32 INFO - Installing collected packages: psutil 04:12:32 INFO - Running setup.py install for psutil 04:12:32 INFO - building 'psutil._psutil_osx' extension 04:12:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:12:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:12:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:12:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:12:33 INFO - building 'psutil._psutil_posix' extension 04:12:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:12:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:12:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:12:33 INFO - ^ 04:12:33 INFO - 1 warning generated. 04:12:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:12:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:33 INFO - Successfully installed psutil 04:12:33 INFO - Cleaning up... 04:12:33 INFO - Return code: 0 04:12:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104090490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6394a4080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea4d30>, '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 0x103d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cb20>, '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.WkUSXj5JLw/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.WmLITJVecH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:12:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkUSXj5JLw/Render', 04:12:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:33 INFO - 'HOME': '/Users/cltbld', 04:12:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:33 INFO - 'LOGNAME': 'cltbld', 04:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:33 INFO - 'MOZ_NO_REMOTE': '1', 04:12:33 INFO - 'NO_EM_RESTART': '1', 04:12:33 INFO - 'PAGER': '/bin/cat', 04:12:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:33 INFO - 'PWD': '/builds/slave/test', 04:12:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:33 INFO - 'SHELL': '/bin/bash', 04:12:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmLITJVecH/Listeners', 04:12:33 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:12:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:33 INFO - 'USER': 'cltbld', 04:12:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:33 INFO - 'XPC_FLAGS': '0x0', 04:12:33 INFO - 'XPC_SERVICE_NAME': '0', 04:12:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:12:36 INFO - Installing collected packages: mozsystemmonitor 04:12:36 INFO - Running setup.py install for mozsystemmonitor 04:12:36 INFO - Successfully installed mozsystemmonitor 04:12:36 INFO - Cleaning up... 04:12:36 INFO - Return code: 0 04:12:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104090490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6394a4080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea4d30>, '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 0x103d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cb20>, '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.WkUSXj5JLw/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.WmLITJVecH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkUSXj5JLw/Render', 04:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:36 INFO - 'HOME': '/Users/cltbld', 04:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:36 INFO - 'LOGNAME': 'cltbld', 04:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:36 INFO - 'MOZ_NO_REMOTE': '1', 04:12:36 INFO - 'NO_EM_RESTART': '1', 04:12:36 INFO - 'PAGER': '/bin/cat', 04:12:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:36 INFO - 'PWD': '/builds/slave/test', 04:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:36 INFO - 'SHELL': '/bin/bash', 04:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmLITJVecH/Listeners', 04:12:36 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:36 INFO - 'USER': 'cltbld', 04:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:36 INFO - 'XPC_FLAGS': '0x0', 04:12:36 INFO - 'XPC_SERVICE_NAME': '0', 04:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:37 INFO - Downloading/unpacking jsonschema==2.5.1 04:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:40 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:40 INFO - warning: no files found matching '*.txt' 04:12:40 INFO - no previously-included directories found matching 'build' 04:12:40 INFO - no previously-included directories found matching 'dist' 04:12:40 INFO - no previously-included directories found matching '.git*' 04:12:40 INFO - Installing collected packages: jsonschema, functools32 04:12:40 INFO - Running setup.py install for functools32 04:12:40 INFO - warning: no files found matching '*.txt' 04:12:40 INFO - no previously-included directories found matching 'build' 04:12:40 INFO - no previously-included directories found matching 'dist' 04:12:40 INFO - no previously-included directories found matching '.git*' 04:12:40 INFO - Successfully installed jsonschema functools32 04:12:40 INFO - Cleaning up... 04:12:40 INFO - Return code: 0 04:12:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104090490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6394a4080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea4d30>, '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 0x103d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cb20>, '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.WkUSXj5JLw/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.WmLITJVecH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkUSXj5JLw/Render', 04:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:40 INFO - 'HOME': '/Users/cltbld', 04:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:40 INFO - 'LOGNAME': 'cltbld', 04:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:40 INFO - 'MOZ_NO_REMOTE': '1', 04:12:40 INFO - 'NO_EM_RESTART': '1', 04:12:40 INFO - 'PAGER': '/bin/cat', 04:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:40 INFO - 'PWD': '/builds/slave/test', 04:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:40 INFO - 'SHELL': '/bin/bash', 04:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmLITJVecH/Listeners', 04:12:40 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:40 INFO - 'USER': 'cltbld', 04:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:40 INFO - 'XPC_FLAGS': '0x0', 04:12:40 INFO - 'XPC_SERVICE_NAME': '0', 04:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:12:40 INFO - Cleaning up... 04:12:40 INFO - Return code: 0 04:12:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104090490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6394a4080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea4d30>, '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 0x103d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cb20>, '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.WkUSXj5JLw/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.WmLITJVecH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkUSXj5JLw/Render', 04:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:40 INFO - 'HOME': '/Users/cltbld', 04:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:40 INFO - 'LOGNAME': 'cltbld', 04:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:40 INFO - 'MOZ_NO_REMOTE': '1', 04:12:40 INFO - 'NO_EM_RESTART': '1', 04:12:40 INFO - 'PAGER': '/bin/cat', 04:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:40 INFO - 'PWD': '/builds/slave/test', 04:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:40 INFO - 'SHELL': '/bin/bash', 04:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmLITJVecH/Listeners', 04:12:40 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:40 INFO - 'USER': 'cltbld', 04:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:40 INFO - 'XPC_FLAGS': '0x0', 04:12:40 INFO - 'XPC_SERVICE_NAME': '0', 04:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:44 INFO - Downloading docopt-0.6.1.tar.gz 04:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:45 INFO - Running setup.py install for blobuploader 04:12:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:45 INFO - Running setup.py install for requests 04:12:45 INFO - Running setup.py install for docopt 04:12:45 INFO - Successfully installed blobuploader requests docopt 04:12:45 INFO - Cleaning up... 04:12:45 INFO - Return code: 0 04:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104090490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6394a4080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea4d30>, '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 0x103d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cb20>, '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.WkUSXj5JLw/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.WmLITJVecH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkUSXj5JLw/Render', 04:12:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:45 INFO - 'HOME': '/Users/cltbld', 04:12:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:45 INFO - 'LOGNAME': 'cltbld', 04:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:45 INFO - 'MOZ_NO_REMOTE': '1', 04:12:45 INFO - 'NO_EM_RESTART': '1', 04:12:45 INFO - 'PAGER': '/bin/cat', 04:12:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:45 INFO - 'PWD': '/builds/slave/test', 04:12:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:45 INFO - 'SHELL': '/bin/bash', 04:12:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmLITJVecH/Listeners', 04:12:45 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:12:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:45 INFO - 'USER': 'cltbld', 04:12:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:45 INFO - 'XPC_FLAGS': '0x0', 04:12:45 INFO - 'XPC_SERVICE_NAME': '0', 04:12:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-A_D9d5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Kurszh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Vxfk29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-PU1Xf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-G0p3E0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-FxOm5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Eizcge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-2nDmq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-gPy5sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-MDnvD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-ERItBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-G822Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-hJVhQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-PvIfCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-SEhibF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-r2ynpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Jx8P0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:47 INFO - Running setup.py install for manifestparser 04:12:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:48 INFO - Running setup.py install for mozcrash 04:12:48 INFO - Running setup.py install for mozdebug 04:12:48 INFO - Running setup.py install for mozdevice 04:12:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:12:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:12:48 INFO - Running setup.py install for mozfile 04:12:48 INFO - Running setup.py install for mozhttpd 04:12:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:12:48 INFO - Running setup.py install for mozinfo 04:12:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:48 INFO - Running setup.py install for mozInstall 04:12:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Running setup.py install for mozleak 04:12:49 INFO - Running setup.py install for mozlog 04:12:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Running setup.py install for moznetwork 04:12:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Running setup.py install for mozprocess 04:12:49 INFO - Running setup.py install for mozprofile 04:12:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Running setup.py install for mozrunner 04:12:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Running setup.py install for mozscreenshot 04:12:50 INFO - Running setup.py install for moztest 04:12:50 INFO - Running setup.py install for mozversion 04:12:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:12:50 INFO - Cleaning up... 04:12:50 INFO - Return code: 0 04:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:50 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 0x104090490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6394a4080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea4d30>, '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 0x103d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cb20>, '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.WkUSXj5JLw/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.WmLITJVecH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkUSXj5JLw/Render', 04:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:50 INFO - 'HOME': '/Users/cltbld', 04:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:50 INFO - 'LOGNAME': 'cltbld', 04:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:50 INFO - 'MOZ_NO_REMOTE': '1', 04:12:50 INFO - 'NO_EM_RESTART': '1', 04:12:50 INFO - 'PAGER': '/bin/cat', 04:12:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:50 INFO - 'PWD': '/builds/slave/test', 04:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:50 INFO - 'SHELL': '/bin/bash', 04:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmLITJVecH/Listeners', 04:12:50 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:50 INFO - 'USER': 'cltbld', 04:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:50 INFO - 'XPC_FLAGS': '0x0', 04:12:50 INFO - 'XPC_SERVICE_NAME': '0', 04:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:50 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-ajt3Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:50 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-_ta81q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:50 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-1vHSsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-9wBaOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-PYeC2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-_qiklM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-zZb7uH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-0yVxhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-IwJ5Q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-xqJJtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-u8vYGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-sVxwfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:52 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-i7Nryv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:52 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-IxfrUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:52 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-SWguGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:52 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-u8d7Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:52 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-YLofhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:55 INFO - Downloading blessings-1.6.tar.gz 04:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:12:55 INFO - Installing collected packages: blessings 04:12:55 INFO - Running setup.py install for blessings 04:12:55 INFO - Successfully installed blessings 04:12:55 INFO - Cleaning up... 04:12:55 INFO - Return code: 0 04:12:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:55 INFO - Reading from file tmpfile_stdout 04:12:55 INFO - Current package versions: 04:12:55 INFO - blessings == 1.6 04:12:55 INFO - blobuploader == 1.2.4 04:12:55 INFO - docopt == 0.6.1 04:12:55 INFO - functools32 == 3.2.3-2 04:12:55 INFO - jsonschema == 2.5.1 04:12:55 INFO - manifestparser == 1.1 04:12:55 INFO - mozInstall == 1.12 04:12:55 INFO - mozcrash == 1.0 04:12:55 INFO - mozdebug == 0.1 04:12:55 INFO - mozdevice == 0.48 04:12:55 INFO - mozfile == 1.2 04:12:55 INFO - mozhttpd == 0.7 04:12:55 INFO - mozinfo == 0.9 04:12:55 INFO - mozleak == 0.1 04:12:55 INFO - mozlog == 3.4 04:12:55 INFO - moznetwork == 0.27 04:12:55 INFO - mozprocess == 0.23 04:12:55 INFO - mozprofile == 0.28 04:12:55 INFO - mozrunner == 6.13 04:12:55 INFO - mozscreenshot == 0.1 04:12:55 INFO - mozsystemmonitor == 0.3 04:12:55 INFO - moztest == 0.7 04:12:55 INFO - mozversion == 1.4 04:12:55 INFO - psutil == 3.1.1 04:12:55 INFO - requests == 1.2.3 04:12:55 INFO - wsgiref == 0.1.2 04:12:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:56 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 0x104090490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6394a4080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea4d30>, '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 0x103d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cb20>, '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.WkUSXj5JLw/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.WmLITJVecH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkUSXj5JLw/Render', 04:12:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:56 INFO - 'HOME': '/Users/cltbld', 04:12:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:56 INFO - 'LOGNAME': 'cltbld', 04:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:56 INFO - 'MOZ_NO_REMOTE': '1', 04:12:56 INFO - 'NO_EM_RESTART': '1', 04:12:56 INFO - 'PAGER': '/bin/cat', 04:12:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:56 INFO - 'PWD': '/builds/slave/test', 04:12:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:56 INFO - 'SHELL': '/bin/bash', 04:12:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmLITJVecH/Listeners', 04:12:56 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:12:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:56 INFO - 'USER': 'cltbld', 04:12:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:56 INFO - 'XPC_FLAGS': '0x0', 04:12:56 INFO - 'XPC_SERVICE_NAME': '0', 04:12:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:12:56 INFO - Cleaning up... 04:12:56 INFO - Return code: 0 04:12:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:57 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 0x104090490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104006570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6394a4080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea4d30>, '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 0x103d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cb20>, '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.WkUSXj5JLw/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.WmLITJVecH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:12:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkUSXj5JLw/Render', 04:12:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:57 INFO - 'HOME': '/Users/cltbld', 04:12:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:57 INFO - 'LOGNAME': 'cltbld', 04:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:57 INFO - 'MOZ_NO_REMOTE': '1', 04:12:57 INFO - 'NO_EM_RESTART': '1', 04:12:57 INFO - 'PAGER': '/bin/cat', 04:12:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:57 INFO - 'PWD': '/builds/slave/test', 04:12:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:57 INFO - 'SHELL': '/bin/bash', 04:12:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmLITJVecH/Listeners', 04:12:57 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:12:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:57 INFO - 'USER': 'cltbld', 04:12:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:57 INFO - 'XPC_FLAGS': '0x0', 04:12:57 INFO - 'XPC_SERVICE_NAME': '0', 04:12:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:12:57 INFO - Cleaning up... 04:12:57 INFO - Return code: 0 04:12:57 INFO - Running post-action listener: _resource_record_post_action 04:12:57 INFO - Running post-action listener: _start_resource_monitoring 04:12:57 INFO - Starting resource monitoring. 04:12:57 INFO - [mozharness: 2016-11-29 12:12:57.295008Z] Finished create-virtualenv step (success) 04:12:57 INFO - [mozharness: 2016-11-29 12:12:57.295806Z] Running install step. 04:12:57 INFO - Running pre-action listener: _resource_record_pre_action 04:12:57 INFO - Running main action method: install 04:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:57 INFO - Reading from file tmpfile_stdout 04:12:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:12:57 INFO - Reading from file tmpfile_stdout 04:12:57 INFO - Output received: 04:12:57 INFO - Usage: mozinstall [options] installer 04:12:57 INFO - Options: 04:12:57 INFO - -h, --help show this help message and exit 04:12:57 INFO - -d DEST, --destination=DEST 04:12:57 INFO - Directory to install application into. [default: 04:12:57 INFO - "/builds/slave/test"] 04:12:57 INFO - --app=APP Application being installed. [default: firefox] 04:12:57 INFO - mkdir: /builds/slave/test/build/application 04:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 04:13:29 INFO - Reading from file tmpfile_stdout 04:13:29 INFO - Output received: 04:13:29 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:13:29 INFO - Running post-action listener: _resource_record_post_action 04:13:29 INFO - [mozharness: 2016-11-29 12:13:29.352567Z] Finished install step (success) 04:13:29 INFO - [mozharness: 2016-11-29 12:13:29.352704Z] Running run-tests step. 04:13:29 INFO - Running pre-action listener: _resource_record_pre_action 04:13:29 INFO - Running main action method: run_tests 04:13:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:13:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:13:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:13:29 INFO - 2016-11-29 04:13:29.367 screenresolution[1629:7439] starting screenresolution argv=screenresolution get 04:13:29 INFO - 2016-11-29 04:13:29.369 screenresolution[1629:7439] Display 0: 1600x1200x32@60 04:13:29 INFO - 2016-11-29 04:13:29.375 screenresolution[1630:7442] starting screenresolution argv=screenresolution list 04:13:29 INFO - Available Modes on Display 0 04:13:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:13:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:13:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:13:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:13:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:13:29 INFO - Intel Iris: 04:13:29 INFO - Chipset Model: Intel Iris 04:13:29 INFO - Type: GPU 04:13:29 INFO - Bus: Built-In 04:13:29 INFO - VRAM (Dynamic, Max): 1536 MB 04:13:29 INFO - Vendor: Intel (0x8086) 04:13:29 INFO - Device ID: 0x0a2e 04:13:29 INFO - Revision ID: 0x0009 04:13:29 INFO - Displays: 04:13:29 INFO - Display: 04:13:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:13:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:13:29 INFO - Display Serial Number: 1600x1200 60 04:13:29 INFO - Main Display: Yes 04:13:29 INFO - Mirror: Off 04:13:29 INFO - Online: Yes 04:13:29 INFO - Rotation: Supported 04:13:29 INFO - Return code: 0 04:13:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:29 INFO - Python 2.7.3 04:13:29 INFO - Return code: 0 04:13:29 INFO - grabbing minidump binary from tooltool 04:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:29 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 0x103ea4d30>, '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 0x103d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:13:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:13:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:13:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:29 INFO - Return code: 0 04:13:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:13:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:13:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:13:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkUSXj5JLw/Render', 04:13:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:29 INFO - 'HOME': '/Users/cltbld', 04:13:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:29 INFO - 'LOGNAME': 'cltbld', 04:13:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:29 INFO - 'MOZ_NO_REMOTE': '1', 04:13:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:29 INFO - 'NO_EM_RESTART': '1', 04:13:29 INFO - 'PAGER': '/bin/cat', 04:13:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:29 INFO - 'PWD': '/builds/slave/test', 04:13:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:29 INFO - 'SHELL': '/bin/bash', 04:13:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmLITJVecH/Listeners', 04:13:29 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:13:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:29 INFO - 'USER': 'cltbld', 04:13:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:29 INFO - 'XPC_FLAGS': '0x0', 04:13:29 INFO - 'XPC_SERVICE_NAME': '0', 04:13:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:13:29 INFO - mozversion application_buildid: 20161129013042 04:13:29 INFO - mozversion application_changeset: 94dac74c74a6e462fbbf9a1e1cad9fda3024122e 04:13:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:13:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:29 INFO - mozversion application_name: Firefox 04:13:29 INFO - mozversion application_remotingname: firefox-dev 04:13:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:13:29 INFO - mozversion application_vendor: Mozilla 04:13:29 INFO - mozversion application_version: 52.0a2 04:13:29 INFO - mozversion platform_buildid: 20161129013042 04:13:29 INFO - mozversion platform_changeset: 94dac74c74a6e462fbbf9a1e1cad9fda3024122e 04:13:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:13:29 INFO - mozversion platform_version: 52.0a2 04:13:29 INFO - using testdate: 1480421609 04:13:29 INFO - actual date: 1480421609 04:13:29 INFO - starting webserver on 'localhost:49244' 04:13:29 INFO - SUITE-START | Running 2 tests 04:13:29 INFO - TEST-START | dromaeo_css 04:13:29 INFO - operating with platform_type : mac_ 04:13:29 INFO - Initialising browser for dromaeo_css test... 04:13:30 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpcmrb33/profile http://localhost:49244/getInfo.html) 04:13:33 INFO - PROCESS | 1640 | 2016-11-29 04:13:33.721 plugin-container[1644:7620] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 04:13:33 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:33 INFO - PROCESS | 1640 | 2016-11-29 04:13:33.722 plugin-container[1644:7620] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 04:13:33 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:33 INFO - PROCESS | 1640 | 2016-11-29 04:13:33.722 plugin-container[1644:7620] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:13:33 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 04:13:33 INFO - PROCESS | 1640 | colorDepth:24 04:13:33 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 04:13:33 INFO - PROCESS | 1640 | __metrics 04:13:33 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 04:13:34 INFO - TEST-INFO | 1640: exit 0 04:13:34 INFO - Browser initialized. 04:13:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:34 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpcmrb33/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:37 INFO - PROCESS | 1645 | 2016-11-29 04:13:37.183 plugin-container[1646:7753] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 04:13:37 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:37 INFO - PROCESS | 1645 | 2016-11-29 04:13:37.183 plugin-container[1646:7753] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 04:13:37 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:37 INFO - PROCESS | 1645 | 2016-11-29 04:13:37.183 plugin-container[1646:7753] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:13:46 INFO - PROCESS | 1645 | RSS: Main: 230178816 04:13:46 INFO - PROCESS | 1645 | 04:14:36 INFO - PROCESS | 1645 | 1480421676514 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:16:50 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 04:16:52 INFO - PROCESS | 1645 | RSS: Main: 232980480 04:16:52 INFO - PROCESS | 1645 | 04:19:54 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 04:19:55 INFO - PROCESS | 1645 | RSS: Main: 244166656 04:19:55 INFO - PROCESS | 1645 | 04:22:57 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 04:22:58 INFO - PROCESS | 1645 | RSS: Main: 247066624 04:22:58 INFO - PROCESS | 1645 | 04:26:00 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 04:26:00 INFO - PROCESS | 1645 | RSS: Main: 247132160 04:26:00 INFO - PROCESS | 1645 | 04:29:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 04:29:04 INFO - PROCESS | 1645 | RSS: Main: 250568704 04:29:04 INFO - PROCESS | 1645 | 04:32:06 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 04:32:07 INFO - PROCESS | 1645 | RSS: Main: 251949056 04:32:07 INFO - PROCESS | 1645 | 04:32:07 INFO - PROCESS | 1645 | __start_tp_report 04:32:07 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 04:32:07 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 04:32:07 INFO - PROCESS | 1645 | |i|pagename|runs| 04:32:07 INFO - PROCESS | 1645 | |0;dojo.html;2950;3308.7353011759046;3310.9834450827757;3315.270640459098;3358.496225566165;4483.955160448395;5367.06076436624;5445.945540544599;5470.425605311445;5500.80747173849;5722.284714410699;5764.193012978176;5769.596128271022;5770.278715160605;5773;5183.222516622509;5230.084735171349;5271.894562108756;5290.338707661543;5336.359636843584;5186.896262074756;5254.579633629301;5256.526912577886;5285.550728188108;5314.9468505315035;4291.785410729467;5145.151050076733;5153.2785410042625;5282.920756188661;5289;5203.791848326081;5222.9477705223035;5237.004969055905;5269.525742683177;5350;5179.067767801795;5207.427183009904;5226.346706661668;5227.111391063529;5240.292560504321;5534.4742249486235;5716.514096301819;5734.770609175628;5784.30588329399;5794.913076303858;6128.540359473057;6138.480361557102;6139.478144357735;6166.229221347332;6176.505879529627;6148.354422785588;6175.907361389583;6179.938200617981;6204.844878878019;6222.906656400158;5903.291605007426;5923.141144534062;5933.080372542263;5945.405459454107;5973.342932277446;6140.478059364915;6198.411150940653;6201.596896201732;6204.534659900435;6249;6094.085887116879;6113.786017489367;6139.171211886338;6140.141335722124;6154.292256390572;6177.135201071854;6195.008798592204;6198.411150940653;6201.534884883652;6204.038374052029;5949.899268635317;6137.662428566472;6186.041163619646;6210.596311239755;6220.937790622126;6133.916185115316;6158.599691020069;6170.598911070856;6171.228596425447;6172.22847144107;4897.877553061202;4926.729029903389;4927.236278376858;4943.90112197754;4974.651774375831;4404.603585677304;4427.734335939854;4441.511433742286;4465.37484752135;4478.171538265431;5762.855928601818;5949.167116603679;5961.940380596226;5975.641461512323;5999.220101386879;6114.6942652868065;6124.106319906353;6130.917941862977;6144.9246381882995;6158.04550294705;5753.626014309057;5760.711964401763;5806.216160818235;5939.732712027969;5954.285485741739;5369.624126311121;5375.543078838265;5408;5442.482964118402;5445.319335083114;6215.782447614311;6223.782167624111;6224.782132625427;6246.718897649707;6250.468710159596;5039.52124548182;6112.625067133324;6115.4190351916495;6145.754169833335;6218.751249949952;5297.284866542967;6130.938690613037;6175.104609831639;6215.689215539114;6257.812265632038;5275.208718692227;6030.758769649165;6186.969065154645;6209.348018458178;6227;5984.970075149597;6132.814448934826;6136.6722581676495;6183.103449999635;6225.62646241227;6070.332263450929;6075.787347442818;6112.847178820565;6127.295361033538;6127.5866022601795;6128.050152226412;6136.662483563447;6157.199564056644;6161.383861613803;6169.167162433194;5817.94182058174;5899.852503687443;5958.076498142795;6070.605410648293;6094.969525152346;6074.939250607614;6090.482309003784;6121.204243448323;6121.602095863755;6143.262808463013;5912.49743771767;5980.102984552352;5990.4908082813445;5997.940020599738;6002.759889604542 04:32:07 INFO - PROCESS | 1645 | |1;ext.html;476.4282860567319;490.80858465198565;503.6499632755232;506.62256618818964;535.871390866192;30099.849500752494;37808.432873506885;39714;39871.20257594846;41820.58179418205;33202.16994575137;41325.79337103318;41994.58005419953;42005.579944200625;42174.57825421745;8990.32572557056;9298.907010929872;9321.533923303808;9335;9346.392484488486;9249.676261330855;9322.114399132071;9333.766655833624;9350.532473376337;9357;9305.395149315307;9344.81310373792;9351.205147562465;9352.859707104399;9358.625654973794;9226.815463690757;9335.11316424942;9353.532323383804;9353.579088940945;9380.108889655472;9212.309076819265;9299.953500232523;9312.674056407994;9323.114304141096;9399.919009313948;39711.40432893509;39799.40300895489;39841.80079099615;39921.80039099786;39982.20035599301;3258.96741032589;3266.6406695263504;3350.4974253861874;3509.1051781795736;3748.250349930025;29326;29473.11580652584;30185.641646125976;30266.54600180999;30666.846665766752;3166.4142133705336;3183.9522407163913;3192.952105718416;3214.3089235814414;3300.14196308959;486859;493327;494852;495518.0448195544;495556;57741.422585774446;58080.128798068064;58098.41901581015;58150.836983260095;58166;60061.699691501264;60811;60857.08714369288;60964.695176523834;61119.69440152771;15793;15889.841101589067;15996.920015399848;16006.199690015686;16067.035977841368;10134.949325253474;11733.4719937603;12447;12481;12495.75008499825;14069.366878490493;14715.632109197142;15760.369585216464;15791.921040394724;15960.36158553668;5550.111982082847;5824.922389357982;6401.455876250571;6461.224653041571;6577.112089867902;801.8356236971407;802.9518228906285;929.1126973740062;983.9275190042888;991.3803872579638;27728.584071238947;29632.962846300277;31574.526382104286;32323.838380808415;32371.028869133963;941.7221919533754;956.1729104324709;995.9800803983879;998.9211651416452;1015.5328548867603;12532.937335313265;14689.92655036718;15296.464623738339;15538.446155384598;15873;604066;607133;607591;607960;608911;45493.31760023536;54521.90956180854;54889.72555137199;54890.17664735032;54946;1323.2589749740175;1324.708564115893;1338.491373278148;1346.6094832498661;1355.9355905614243;25366.873165634053;28063.859680701466;28759;28997;29436.705632943398;49011.26483102685;49240.26139607837;49272.26091608557;49278;49470.257946131554;565361.3463865473;568100;568359;569991;571014;25099.99600016052;25231.495370092864;25475.61786573166;25594.616080759177;25641.487170256118;43612.34581481344;43680.689579312675;43861.34207986819;44271.557284426744;44712.77643611761;30827.53758693666;36716.89849304525;37021.81489092537;37505.437418439295;37610.247795044495;37173;37213.813930931254;37598.43602346021;38328.85013449601;38424;36070.8196459016;36191.27617447689;36217.094572634844;36474.635253648186;37392;32968;33009;33115.00654980355;33585.49621755627;33647.822326219444;19845.503862403555;24689.753102468745;24769;25171.622425663994;25194.244172674848 04:32:07 INFO - PROCESS | 1645 | |2;jquery.html;297.1296696956585;303.6113774368808;314.73090507615984;378.1850113006472;380.38187944590044;18952.715709264372;19076.523086922833;19681.704774428395;20004.59990800183;20154.49613759657;19056.0471976401;19919.904405257705;20224.29214977476;20308.390748277576;20434.284800032;5728.16941543477;6010.789622363218;6076.997295446246;6081.452669259766;6107.5113990880845;5447.618666693333;5721.113227449731;5796.362400136003;5853.531717462614;5933;5736.713164341787;5826.15520749491;5842.707864606774;5849.239598852143;5862.237909071815;4654.720716756989;5867;5906.763729450817;5948.702564871783;5955.136505206764;5539.530287756144;5583.35791383992;5751.1085781703905;5761.481466667978;5781.161731548944;19307;24604.89277982495;24908.501829963297;25080.122195723245;25094.372640683945;2298.10373954158;2343.6836027136287;2367.573836709392;2419.0444774314224;2693.488237234919;9355.251579873593;9808.21534277256;10146.594136234615;10356.171506279556;12748.681282968;1780.6972814621545;1814.3649722597117;1898.1837809741805;1899.1169106365605;1994.6210220058142;107249;108130.45934770354;109247.45376273147;110351.89648103497;110968;11385.032272256785;11439.256448330832;11516.712082198012;11562.132840037031;11719.414029298501;14507.854921450651;14539.491117810825;14543.563693089225;14555.563333099812;14564.563063107911;8370.581470926429;8435.409521333571;8457.534835584102;8494.193051660082;8612.913870861212;8290.958545207235;8323.66705331792;8470;8497.915020849836;8513.744587662257;4381.079973205662;4508.143452743968;4515.81936722534;4571.634269258451;4576.290674945389;1853.2123847364817;1912.1873203888292;1949.9220031198877;1952.384998725397;1958.5984873101265;756.9735059272899;814.2142832166987;876.3996662286227;912.7444315591645;927.6196759328643;16693.83306166947;19667.803321966883;20864.895675521828;21070.894645526674;21106.78893211048;770.4722265248323;880.8414485392562;891.9420237684529;911.3939230411835;935.218408930974;7850.665386884243;10275.332103413255;10381.84427233592;11223.60717374888;11253.099752019818;572030;580861;583250.0837495786;584157;586885;95759;110703;112925;131057.37885242433;131991.34004329916;923.0492592629603;977.3207620703542;988.5353883674661;989.2975987049275;998.1116806042628;18091.638167236844;19025.33411330597;19346;19364;19376.515587110436;35546.57813687423;46721;53110.734446329065;54259;54461;64495;71473;82175.589122054;82429.1449636573;83815.16184838074;7472.738454154079;7890.53205839754;7970.4929830874225;8288.875666864882;8352.415330926777;10505.842412363667;12429.502819887104;12436.440360183633;12442.937785311016;12532.373381330715;10123.848142277724;10349.586016559253;10469.9476502617;10734.73163170927;10972.23194376386;10693.839592406275;10729.980651838063;10750.784984300113;10871.836922446328;10890.346579205274;10587.841182382117;10731.678049658523;10752.354858708502;11133.332000080021;11357.261777984404;6891.620960847001;8000.919990800017;8212.876806848022;8236.50580965144;8243.629036693243;10755.516001779783;10982.450877456255;11084.445777711244;11113.333200008025;11174.888251117385 04:32:07 INFO - PROCESS | 1645 | |3;mootools.html;1160.9303441793493;1199.226498908204;1504.5787179589718;1726.1541844496185;1790.6687262856365;7360.595167265798;7718;7875.684972601096;8356.707515236967;8363.414560980726;7722.227777222275;8124.634391452384;8178.9367382240225;8256.628451719673;8265.83468330633;2322.953540929185;2336.836421450499;2343.472718638301;2347.85912845229;2349.2952114365708;2319.7796209360167;2345.835791494596;2362.244081893795;2366.124533922451;2371.312319427364;2275.465265662568;2283.8694846051226;2290.393045842853;2301.723793144825;2308.6998690170253;2284.6230371988604;2296.644020176875;2297.2993237062688;2323.5585238804656;2331.0908745589236;2314.2478694424212;2338.894749736266;2339.0643742502966;2342.4143964009;2348.6964734572307;8202.835943281161;8224.38317126218;8284.46151000183;8284.792880177984;8337.791555211108;4973.4280557735965;5117.48825117489;5146.125158723026;5159.896802063975;5169.948300516984;2928.2240206345336;3345.866165353383;3437.329720704464;3467.910911066282;3593.658602432765;1010.4190090697878;1041.283354384424;1083.7886612110642;1088.0914436445578;1098.0721290509507;10783.892161078445;10820.188485863591;10911.945440272906;10947.56209751609;10953;4458.799354029076;4563.0873825235085;4654.930176047362;4661.953380466152;4725.740084295397;9228.907710922806;9268.304877134242;9305.069493050776;9305.860412093823;9319.953400233091;5136.5890728741615;5140.331756871583;5143.048536020848;5150.690958542425;5159.17453207485;4186.874393768192;4308.497619987121;4584.358189853423;4689.20283551797;4718.575328220477;3732.701383889282;3787.962120378816;3829.5978922213326;3848.0572259795968;3888.51393575803;1210;1213.83006379107;1221.3404761428906;1230.5754514692417;1248.2260998181187;866.9523176225368;874.6501399440275;891.9509426981449;895.417978314101;903.0923921458892;5638.633488823213;5740.397258287903;5743.712814359265;5765;5822.650640961556;904.5567671840882;919.7838507950627;935.4901578639658;946.5882341181608;974.6637410093506;3123.5470856725647;3771.5097037384962;3860.247251785931;3900.3369427197445;3900.570937196906;9738.805223895624;10074.848877266846;10098.444585547719;10123.9493802532;10128.189744820396;10047.648332308334;10052.246081543914;10057.145142662956;10061.496925153713;10148.340357876714;7684.884726729104;7796.649150788228;7838.137804841463;7843.803904902309;7874.6850125994315;5376.274202982548;5543.52880005204;5643.494152776879;5673.8297851064535;5714.657120572779;9214.216791572791;9270.44377337362;9287.76780580491;9299.163075322982;9304.674336398193;9285.35002549815;9300.069993000645;9306.72079837606;9309.348345616012;9492.572834222614;5867.882642347215;6560.770373036921;6617.106690596708;6698.66506674674;6715.630640314829;7821.843563128819;7898;7904.6838126474295;7925.0886148093705;7929.841403172019;6323.146375239284;6977.1278590176225;7013.4038606719005;7118.25258347866;7277.526960747535;6953.582785032914;6993.545419547713;7018.684159212746;7019.824504387431;7044.647767611496;6507.967460162668;6602.438792702674;6658.900116498353;6679.933200668125;6686.69909854048;4192.538820729778;4607.75590590532;4797.64017698667;4835.516448355136;5182.6113041521285;4496.77516124186;4818;4897.510248975074;4984.352034235526;5071.290019397214 04:32:07 INFO - PROCESS | 1645 | |4;prototype.html;274.5634441238431;301.41826275288696;304.79274093616334;310.1904030480446;313.7113855253167;5317.9468205317935;5339.759710813013;5393.487618676224;5492.725363731807;5499.7250137493165;4898.951010489894;5184.896302073957;5290.418054014065;5305.920411193835;5335.946640533593;3450.1374656335915;3591.317649646559;4133.3386658134705;4133.937990930123;4148.315527937887;3402.778819376745;4021.3364794808967;4148;4148.485802682029;4148.647364973981;3534.4625088086636;4026.4296924199584;4051.852518165362;4065.10567675111;4121.299379105544;3511.2801875615564;4094.7133700640966;4098.159877225176;4105.7331273467125;4112.588741125864;3321.618013928405;3499.7550171488006;3551.2655255453415;3606.0804494853646;3606.0804494853905;5167.250748641426;5196.58427325813;5210.557102646279;5214.210397437353;5235.267062611238;3860.108546812042;4269.252880745888;4595.770211489412;4601.217792975202;4691.624670026424;4878.926816097762;5333.519983201491;5636.943630563683;5640.464155905182;5668.348139963874;3370.713489353408;3815.6947444204397;3830.5211848518934;3841.865534706272;3844.192719528902;4730.8344207952905;5478.91781623272;5858.882822343572;5865.59510600656;5913.438223368773;3371.679690429405;3720.534933133358;3749.8312575934146;3879.9718074710227;3911.9804400977814;3674.4488326751202;3704.5739739929713;3893.7469064510715;3917.6865850731874;3937.6062393760394;3748.493953316322;4609.539046095364;4613.0773845230415;4631.95368046322;4633.536646335339;4963;4970.627202959792;5332.533553272881;5406.999705054577;5536.197251398606;1149.4999675141341;1268.7312687312688;1271.593090211142;1271.6901591360913;1284.293638498822;849.46908182386;863.6933888469629;868.2316150206985;877.5783231165425;883.8099808541194;4484.686071974996;4994.001199760062;5079.4348853829315;5085.771140298695;5106.110739026584;4809.326694262806;5094.592432605383;5192.792288308501;5197.610179236573;5559.972200138974;3925.92148157041;4326.394304797331;4562.384078149474;4733;5088.542031217208;2604.1406335909105;2733.658292713411;2907.418516296749;2909.0654714614966;2919.153445500781;4666.346711460398;4672.953270467252;5459.08931873841;5699.116636921284;5751.884962300731;4817.566419022305;5090.800089925826;5124.692518448905;5714.828460165739;5772.6536407815665;5485.835424937259;5513.5037846594805;5646.548276137899;5661.433856614306;5720.628159169641;4725.235737093702;5172.094883395466;5320.787168513216;5504.53211477029;5505.632577991342;4576.702514336557;4581.93127103087;4898.632602554751;4975.880426903917;5520.150749498802;5056.926660069354;5614.726035955445;5663.348714897839;5675.687837168995;5691.004074287066;3668.0279725872133;3678.3378991780664;3683.557973043252;3708.721845861517;3715.6405682391337;4507.323901414814;5089.287499749964;5155.664881782672;5503.257060296809;5597.944020559905;4866.48901865299;5563.304586926634;5737.99170290395;5795.130730390475;5809.215755872903;5035.7985680572365;5723.513501352431;5729.570282228933;5805.680687562224;5827.213326200908;4875.6109506342345;5050.863555699938;5550.833474995757;5618.747156378055;5724.513416359489;5030.585319046952;5038.345015148007;5399.866028134136;5786.826395208151;5821.806529661325;4883.438404583376;5145.8095980492335;5327.360716714019;5420.75606597712;5463.180522921593 04:32:07 INFO - PROCESS | 1645 | |5;yui.html;698.7030512032386;705.4603228530174;763.961801909905;770.9553554933066;772.6677528662673;13508.986825988053;14082.084664496813;14204.218767967757;14775.261236938137;14914.403423863032;13111.54109606164;13313.134646247987;13574;13575.185488870675;13581;794.5312265763199;816.6121092481084;819.0130892274794;819.7049062337554;819.7868554175927;640.3212594649663;662.0730976632705;795.4471642208667;809.6356639512213;822.4859462835727;575.5711994564056;625.3496363781661;643.5591619740493;655.977040803572;660.7390080918035;641.3234038089813;650.720190318163;653.9019147127922;654.035297935546;655.7344275568403;482.83824918652294;484.36548121960345;484.6098890393232;485.64062593680774;487.0794198963961;13641.795373069412;13711.245881476514;13715.657108572266;13727;13747.862521374758;11788.646340609796;13324.333783310796;13427.462901483928;13517.188968661912;13609.455621775118;10430.895691043068;10735.892641073568;10969.670909872717;11027.503762330714;11157.163212758995;3190.88831890885;3389.881354152593;3655.8354874030733;3677.9080522986874;3778.8299526521373;48437.75781121107;77830.22169778286;78905.21094789094;83870.58064709698;83927.06255281036;10185.134263587677;10323.174146068297;10445.529951152217;10543.367397956146;10650.201234907412;19046.52383690391;19872.70190947137;20652.277170298967;20873.060712267983;20884.686729699068;6770.966145169243;7437.107547094275;7732.420068494773;7738.729144479917;7823.647935842901;4160.126373461547;4177.227212965611;4224.683148763855;4281.743095414286;4313.180495705806;2993;3370.4775759757276;3457.3258214647904;3488.0930957951114;3496.615372309044;633.9334369891187;650.6356440393395;653.1737352249409;663.2571519897746;664.1697877652933;421.588950773;606.2603623579226;638.5370606310388;645.4062262718311;653.1411194279507;8508.276796472246;8628.654853805903;8872.911270887338;8913.562881270554;8963;547.6002518161685;558.1858958385247;654.084282005187;667.4993754683987;673.1652750589234;4155.916881662411;4240.321548552217;4476.037651904856;4533.116042371706;4546.477155127137;76001;109307;113533.86466135397;113570.43214783873;113936.43031784787;97244;100038;100040;102825;103624;84637;85030;89065.55467222622;92149.0785092154;94382.5280873605;8542.18849209324;8683.782905427415;8783.868241976248;8808.163224493663;8963.955180224057;50042.499575003785;54136.729316353165;56793;57339.46999459901;58698.119528206254;77186.61406692931;81658;82369.58815205886;83999;84706;11023.393713345842;11058.889411105785;11151.275167114112;11227.101831853268;11373.772524549628;11345.432728363714;11960.282383057045;12069.396530173632;12085.395730213279;12244.265344079384;11247.100231981585;11532.423378831192;11678.941605292259;11777.932544025402;11825.52697892109;11761.764764704829;11810.881891181321;11837.171398002058;11920.701982450508;11933.940330298294;10629.627963021258;10966.506507207354;12031.398430078636;12600.621981340575;12868.678283042998;10481.685549433529;10694.89305106939;10802.621908233174;10867.891321086689;11189.832152517556;10943.507542160463;11057.366933397248;11078.501467434146;11112.333260004425;11208.215424920178 04:32:07 INFO - PROCESS | 1645 | __end_tp_report 04:32:07 INFO - PROCESS | 1645 | __start_cc_report 04:32:07 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,374 04:32:07 INFO - PROCESS | 1645 | __end_cc_report 04:32:07 INFO - PROCESS | 1645 | __startTimestamp1480422727179__endTimestamp 04:32:07 INFO - PROCESS | 1645 | 04:32:07 INFO - PROCESS | 1645 | ------- Summary: start ------- 04:32:07 INFO - PROCESS | 1645 | Number of tests: 6 04:32:07 INFO - PROCESS | 1645 | 04:32:07 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5708.88 Median:5980.10 stddev:648.39 (10.8%) stddev-sans-first:613.19 04:32:07 INFO - PROCESS | 1645 | Values: 2950.0 3308.7 3311.0 3315.3 3358.5 4484.0 5367.1 5445.9 5470.4 5500.8 5722.3 5764.2 5769.6 5770.3 5773.0 5183.2 5230.1 5271.9 5290.3 5336.4 5186.9 5254.6 5256.5 5285.6 5314.9 4291.8 5145.2 5153.3 5282.9 5289.0 5203.8 5222.9 5237.0 5269.5 5350.0 5179.1 5207.4 5226.3 5227.1 5240.3 5534.5 5716.5 5734.8 5784.3 5794.9 6128.5 6138.5 6139.5 6166.2 6176.5 6148.4 6175.9 6179.9 6204.8 6222.9 5903.3 5923.1 5933.1 5945.4 5973.3 6140.5 6198.4 6201.6 6204.5 6249.0 6094.1 6113.8 6139.2 6140.1 6154.3 6177.1 6195.0 6198.4 6201.5 6204.0 5949.9 6137.7 6186.0 6210.6 6220.9 6133.9 6158.6 6170.6 6171.2 6172.2 4897.9 4926.7 4927.2 4943.9 4974.7 4404.6 4427.7 4441.5 4465.4 4478.2 5762.9 5949.2 5961.9 5975.6 5999.2 6114.7 6124.1 6130.9 6144.9 6158.0 5753.6 5760.7 5806.2 5939.7 5954.3 5369.6 5375.5 5408.0 5442.5 5445.3 6215.8 6223.8 6224.8 6246.7 6250.5 5039.5 6112.6 6115.4 6145.8 6218.8 5297.3 6130.9 6175.1 6215.7 6257.8 5275.2 6030.8 6187.0 6209.3 6227.0 5985.0 6132.8 6136.7 6183.1 6225.6 6070.3 6075.8 6112.8 6127.3 6127.6 6128.1 6136.7 6157.2 6161.4 6169.2 5817.9 5899.9 5958.1 6070.6 6095.0 6074.9 6090.5 6121.2 6121.6 6143.3 5912.5 5980.1 5990.5 5997.9 6002.8 04:32:07 INFO - PROCESS | 1645 | 04:32:07 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:68176.48 Median:40654.00 stddev:149216.51 (367.0%) stddev-sans-first:149548.52 04:32:07 INFO - PROCESS | 1645 | Values: 476.4 490.8 503.6 506.6 535.9 30099.8 37808.4 39714.0 39871.2 41820.6 33202.2 41325.8 41994.6 42005.6 42174.6 8990.3 9298.9 9321.5 9335.0 9346.4 9249.7 9322.1 9333.8 9350.5 9357.0 9305.4 9344.8 9351.2 9352.9 9358.6 9226.8 9335.1 9353.5 9353.6 9380.1 9212.3 9300.0 9312.7 9323.1 9399.9 39711.4 39799.4 39841.8 39921.8 39982.2 3259.0 3266.6 3350.5 3509.1 3748.3 29326.0 29473.1 30185.6 30266.5 30666.8 3166.4 3184.0 3193.0 3214.3 3300.1 486859.0 493327.0 494852.0 495518.0 495556.0 57741.4 58080.1 58098.4 58150.8 58166.0 60061.7 60811.0 60857.1 60964.7 61119.7 15793.0 15889.8 15996.9 16006.2 16067.0 10134.9 11733.5 12447.0 12481.0 12495.8 14069.4 14715.6 15760.4 15791.9 15960.4 5550.1 5824.9 6401.5 6461.2 6577.1 801.8 803.0 929.1 983.9 991.4 27728.6 29633.0 31574.5 32323.8 32371.0 941.7 956.2 996.0 998.9 1015.5 12532.9 14689.9 15296.5 15538.4 15873.0 604066.0 607133.0 607591.0 607960.0 608911.0 45493.3 54521.9 54889.7 54890.2 54946.0 1323.3 1324.7 1338.5 1346.6 1355.9 25366.9 28063.9 28759.0 28997.0 29436.7 49011.3 49240.3 49272.3 49278.0 49470.3 565361.3 568100.0 568359.0 569991.0 571014.0 25100.0 25231.5 25475.6 25594.6 25641.5 43612.3 43680.7 43861.3 44271.6 44712.8 30827.5 36716.9 37021.8 37505.4 37610.2 37173.0 37213.8 37598.4 38328.9 38424.0 36070.8 36191.3 36217.1 36474.6 37392.0 32968.0 33009.0 33115.0 33585.5 33647.8 19845.5 24689.8 24769.0 25171.6 25194.2 04:32:07 INFO - PROCESS | 1645 | 04:32:07 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:33685.41 Median:1495.31 stddev:96747.66 (6470.1%) stddev-sans-first:96986.58 04:32:07 INFO - PROCESS | 1645 | Values: 297.1 303.6 314.7 378.2 380.4 18952.7 19076.5 19681.7 20004.6 20154.5 19056.0 19919.9 20224.3 20308.4 20434.3 5728.2 6010.8 6077.0 6081.5 6107.5 5447.6 5721.1 5796.4 5853.5 5933.0 5736.7 5826.2 5842.7 5849.2 5862.2 4654.7 5867.0 5906.8 5948.7 5955.1 5539.5 5583.4 5751.1 5761.5 5781.2 19307.0 24604.9 24908.5 25080.1 25094.4 2298.1 2343.7 2367.6 2419.0 2693.5 9355.3 9808.2 10146.6 10356.2 12748.7 1780.7 1814.4 1898.2 1899.1 1994.6 107249.0 108130.5 109247.5 110351.9 110968.0 11385.0 11439.3 11516.7 11562.1 11719.4 14507.9 14539.5 14543.6 14555.6 14564.6 8370.6 8435.4 8457.5 8494.2 8612.9 8291.0 8323.7 8470.0 8497.9 8513.7 4381.1 4508.1 4515.8 4571.6 4576.3 1853.2 1912.2 1949.9 1952.4 1958.6 757.0 814.2 876.4 912.7 927.6 16693.8 19667.8 20864.9 21070.9 21106.8 770.5 880.8 891.9 911.4 935.2 7850.7 10275.3 10381.8 11223.6 11253.1 572030.0 580861.0 583250.1 584157.0 586885.0 95759.0 110703.0 112925.0 131057.4 131991.3 923.0 977.3 988.5 989.3 998.1 18091.6 19025.3 19346.0 19364.0 19376.5 35546.6 46721.0 53110.7 54259.0 54461.0 64495.0 71473.0 82175.6 82429.1 83815.2 7472.7 7890.5 7970.5 8288.9 8352.4 10505.8 12429.5 12436.4 12442.9 12532.4 10123.8 10349.6 10469.9 10734.7 10972.2 10693.8 10730.0 10750.8 10871.8 10890.3 10587.8 10731.7 10752.4 11133.3 11357.3 6891.6 8000.9 8212.9 8236.5 8243.6 10755.5 10982.5 11084.4 11113.3 11174.9 04:32:07 INFO - PROCESS | 1645 | 04:32:07 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5398.61 Median:5138.46 stddev:2955.74 (57.5%) stddev-sans-first:2946.87 04:32:07 INFO - PROCESS | 1645 | Values: 1160.9 1199.2 1504.6 1726.2 1790.7 7360.6 7718.0 7875.7 8356.7 8363.4 7722.2 8124.6 8178.9 8256.6 8265.8 2323.0 2336.8 2343.5 2347.9 2349.3 2319.8 2345.8 2362.2 2366.1 2371.3 2275.5 2283.9 2290.4 2301.7 2308.7 2284.6 2296.6 2297.3 2323.6 2331.1 2314.2 2338.9 2339.1 2342.4 2348.7 8202.8 8224.4 8284.5 8284.8 8337.8 4973.4 5117.5 5146.1 5159.9 5169.9 2928.2 3345.9 3437.3 3467.9 3593.7 1010.4 1041.3 1083.8 1088.1 1098.1 10783.9 10820.2 10911.9 10947.6 10953.0 4458.8 4563.1 4654.9 4662.0 4725.7 9228.9 9268.3 9305.1 9305.9 9320.0 5136.6 5140.3 5143.0 5150.7 5159.2 4186.9 4308.5 4584.4 4689.2 4718.6 3732.7 3788.0 3829.6 3848.1 3888.5 1210.0 1213.8 1221.3 1230.6 1248.2 867.0 874.7 892.0 895.4 903.1 5638.6 5740.4 5743.7 5765.0 5822.7 904.6 919.8 935.5 946.6 974.7 3123.5 3771.5 3860.2 3900.3 3900.6 9738.8 10074.8 10098.4 10123.9 10128.2 10047.6 10052.2 10057.1 10061.5 10148.3 7684.9 7796.6 7838.1 7843.8 7874.7 5376.3 5543.5 5643.5 5673.8 5714.7 9214.2 9270.4 9287.8 9299.2 9304.7 9285.4 9300.1 9306.7 9309.3 9492.6 5867.9 6560.8 6617.1 6698.7 6715.6 7821.8 7898.0 7904.7 7925.1 7929.8 6323.1 6977.1 7013.4 7118.3 7277.5 6953.6 6993.5 7018.7 7019.8 7044.6 6508.0 6602.4 6658.9 6679.9 6686.7 4192.5 4607.8 4797.6 4835.5 5182.6 4496.8 4818.0 4897.5 4984.4 5071.3 04:32:07 INFO - PROCESS | 1645 | 04:32:07 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4426.00 Median:4966.81 stddev:1350.32 (27.2%) stddev-sans-first:1317.67 04:32:07 INFO - PROCESS | 1645 | Values: 274.6 301.4 304.8 310.2 313.7 5317.9 5339.8 5393.5 5492.7 5499.7 4899.0 5184.9 5290.4 5305.9 5335.9 3450.1 3591.3 4133.3 4133.9 4148.3 3402.8 4021.3 4148.0 4148.5 4148.6 3534.5 4026.4 4051.9 4065.1 4121.3 3511.3 4094.7 4098.2 4105.7 4112.6 3321.6 3499.8 3551.3 3606.1 3606.1 5167.3 5196.6 5210.6 5214.2 5235.3 3860.1 4269.3 4595.8 4601.2 4691.6 4878.9 5333.5 5636.9 5640.5 5668.3 3370.7 3815.7 3830.5 3841.9 3844.2 4730.8 5478.9 5858.9 5865.6 5913.4 3371.7 3720.5 3749.8 3880.0 3912.0 3674.4 3704.6 3893.7 3917.7 3937.6 3748.5 4609.5 4613.1 4632.0 4633.5 4963.0 4970.6 5332.5 5407.0 5536.2 1149.5 1268.7 1271.6 1271.7 1284.3 849.5 863.7 868.2 877.6 883.8 4484.7 4994.0 5079.4 5085.8 5106.1 4809.3 5094.6 5192.8 5197.6 5560.0 3925.9 4326.4 4562.4 4733.0 5088.5 2604.1 2733.7 2907.4 2909.1 2919.2 4666.3 4673.0 5459.1 5699.1 5751.9 4817.6 5090.8 5124.7 5714.8 5772.7 5485.8 5513.5 5646.5 5661.4 5720.6 4725.2 5172.1 5320.8 5504.5 5505.6 4576.7 4581.9 4898.6 4975.9 5520.2 5056.9 5614.7 5663.3 5675.7 5691.0 3668.0 3678.3 3683.6 3708.7 3715.6 4507.3 5089.3 5155.7 5503.3 5597.9 4866.5 5563.3 5738.0 5795.1 5809.2 5035.8 5723.5 5729.6 5805.7 5827.2 4875.6 5050.9 5550.8 5618.7 5724.5 5030.6 5038.3 5399.9 5786.8 5821.8 4883.4 5145.8 5327.4 5420.8 5463.2 04:32:07 INFO - PROCESS | 1645 | 04:32:07 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20276.63 Median:2299.41 stddev:30236.62 (1315.0%) stddev-sans-first:30285.71 04:32:07 INFO - PROCESS | 1645 | Values: 698.7 705.5 764.0 771.0 772.7 13509.0 14082.1 14204.2 14775.3 14914.4 13111.5 13313.1 13574.0 13575.2 13581.0 794.5 816.6 819.0 819.7 819.8 640.3 662.1 795.4 809.6 822.5 575.6 625.3 643.6 656.0 660.7 641.3 650.7 653.9 654.0 655.7 482.8 484.4 484.6 485.6 487.1 13641.8 13711.2 13715.7 13727.0 13747.9 11788.6 13324.3 13427.5 13517.2 13609.5 10430.9 10735.9 10969.7 11027.5 11157.2 3190.9 3389.9 3655.8 3677.9 3778.8 48437.8 77830.2 78905.2 83870.6 83927.1 10185.1 10323.2 10445.5 10543.4 10650.2 19046.5 19872.7 20652.3 20873.1 20884.7 6771.0 7437.1 7732.4 7738.7 7823.6 4160.1 4177.2 4224.7 4281.7 4313.2 2993.0 3370.5 3457.3 3488.1 3496.6 633.9 650.6 653.2 663.3 664.2 421.6 606.3 638.5 645.4 653.1 8508.3 8628.7 8872.9 8913.6 8963.0 547.6 558.2 654.1 667.5 673.2 4155.9 4240.3 4476.0 4533.1 4546.5 76001.0 109307.0 113533.9 113570.4 113936.4 97244.0 100038.0 100040.0 102825.0 103624.0 84637.0 85030.0 89065.6 92149.1 94382.5 8542.2 8683.8 8783.9 8808.2 8964.0 50042.5 54136.7 56793.0 57339.5 58698.1 77186.6 81658.0 82369.6 83999.0 84706.0 11023.4 11058.9 11151.3 11227.1 11373.8 11345.4 11960.3 12069.4 12085.4 12244.3 11247.1 11532.4 11678.9 11777.9 11825.5 11761.8 11810.9 11837.2 11920.7 11933.9 10629.6 10966.5 12031.4 12600.6 12868.7 10481.7 10694.9 10802.6 10867.9 11189.8 10943.5 11057.4 11078.5 11112.3 11208.2 04:32:07 INFO - PROCESS | 1645 | -------- Summary: end -------- 04:32:07 INFO - PROCESS | 1645 | 04:32:07 INFO - TEST-INFO | 1645: exit 0 04:32:07 INFO - TEST-OK | dromaeo_css | took 1117909ms 04:32:07 INFO - TEST-START | kraken 04:32:07 INFO - operating with platform_type : mac_ 04:32:07 INFO - Initialising browser for kraken test... 04:32:07 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpCxmIgI/profile http://localhost:49244/getInfo.html) 04:32:10 INFO - PROCESS | 1658 | 2016-11-29 04:32:10.811 plugin-container[1660:10099] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 04:32:10 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:10 INFO - PROCESS | 1658 | 2016-11-29 04:32:10.811 plugin-container[1660:10099] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:32:10 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:10 INFO - PROCESS | 1658 | 2016-11-29 04:32:10.812 plugin-container[1660:10099] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:32:10 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 04:32:10 INFO - PROCESS | 1658 | colorDepth:24 04:32:10 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 04:32:10 INFO - PROCESS | 1658 | __metrics 04:32:11 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 04:32:11 INFO - TEST-INFO | 1658: exit 0 04:32:11 INFO - Browser initialized. 04:32:11 INFO - Running cycle 1/1 for kraken test... 04:32:11 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpCxmIgI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:14 INFO - PROCESS | 1661 | 2016-11-29 04:32:14.561 plugin-container[1662:10224] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454f, name = 'com.apple.tsm.portname' 04:32:14 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:14 INFO - PROCESS | 1661 | 2016-11-29 04:32:14.562 plugin-container[1662:10224] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 04:32:14 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:14 INFO - PROCESS | 1661 | 2016-11-29 04:32:14.562 plugin-container[1662:10224] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:32:24 INFO - PROCESS | 1661 | RSS: Main: 230031360 04:32:24 INFO - PROCESS | 1661 | 04:32:27 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:28 INFO - PROCESS | 1661 | RSS: Main: 242094080 04:32:28 INFO - PROCESS | 1661 | 04:32:30 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 04:32:31 INFO - PROCESS | 1661 | RSS: Main: 249544704 04:32:31 INFO - PROCESS | 1661 | 04:32:34 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 04:32:35 INFO - PROCESS | 1661 | RSS: Main: 253353984 04:32:35 INFO - PROCESS | 1661 | 04:32:37 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 04:32:38 INFO - PROCESS | 1661 | RSS: Main: 253566976 04:32:38 INFO - PROCESS | 1661 | 04:32:40 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:32:40 INFO - PROCESS | 1661 | RSS: Main: 254787584 04:32:40 INFO - PROCESS | 1661 | 04:32:43 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 04:32:44 INFO - PROCESS | 1661 | RSS: Main: 258621440 04:32:44 INFO - PROCESS | 1661 | 04:32:47 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 04:32:47 INFO - PROCESS | 1661 | RSS: Main: 257978368 04:32:47 INFO - PROCESS | 1661 | 04:32:50 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 04:32:51 INFO - PROCESS | 1661 | RSS: Main: 258076672 04:32:51 INFO - PROCESS | 1661 | 04:32:52 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:53 INFO - PROCESS | 1661 | RSS: Main: 257277952 04:32:53 INFO - PROCESS | 1661 | 04:32:55 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:56 INFO - PROCESS | 1661 | RSS: Main: 257380352 04:32:56 INFO - PROCESS | 1661 | 04:32:58 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:59 INFO - PROCESS | 1661 | RSS: Main: 257290240 04:32:59 INFO - PROCESS | 1661 | 04:33:02 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:02 INFO - PROCESS | 1661 | RSS: Main: 257630208 04:33:02 INFO - PROCESS | 1661 | 04:33:05 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:06 INFO - PROCESS | 1661 | RSS: Main: 257748992 04:33:06 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 04:33:08 INFO - PROCESS | 1661 | RSS: Main: 259772416 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | __start_tp_report 04:33:08 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 04:33:08 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 04:33:08 INFO - PROCESS | 1661 | |i|pagename|runs| 04:33:08 INFO - PROCESS | 1661 | |0;ai-astar;109;120;109;176;176;166;120;120;120;127 04:33:08 INFO - PROCESS | 1661 | |1;audio-beat-detection;150;117;135;183;118;116;119;116;141;114 04:33:08 INFO - PROCESS | 1661 | |2;audio-dft;198;205;201;204;197;198;192;200;200;196 04:33:08 INFO - PROCESS | 1661 | |3;audio-fft;84;50;59;99;87;82;59;61;82;61 04:33:08 INFO - PROCESS | 1661 | |4;audio-oscillator;91;69;92;72;70;71;89;93;103;120 04:33:08 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;89;124;99;86;104;89;91;87;90;87 04:33:08 INFO - PROCESS | 1661 | |6;imaging-darkroom;95;152;136;97;116;106;152;96;95;95 04:33:08 INFO - PROCESS | 1661 | |7;imaging-desaturate;88;88;85;89;88;87;91;92;88;91 04:33:08 INFO - PROCESS | 1661 | |8;json-parse-financial;58;56;56;59;59;61;60;72;89;91 04:33:08 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;72;78;80;82;78;70;69;78;105;100 04:33:08 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;84;87;88;88;93;105;75;76;80;104 04:33:08 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;152;150;167;156;161;152;150;173;213;186 04:33:08 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;174;173;170;171;181;167;169;212;168;175 04:33:08 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;67;68;69;68;92;87;72;68;67;68 04:33:08 INFO - PROCESS | 1661 | __end_tp_report 04:33:08 INFO - PROCESS | 1661 | __start_cc_report 04:33:08 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1020 04:33:08 INFO - PROCESS | 1661 | __end_cc_report 04:33:08 INFO - PROCESS | 1661 | __startTimestamp1480422788527__endTimestamp 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | ------- Summary: start ------- 04:33:08 INFO - PROCESS | 1661 | Number of tests: 14 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:134.30 Median:123.50 stddev:27.15 (22.0%) stddev-sans-first:27.21 04:33:08 INFO - PROCESS | 1661 | Values: 109.0 120.0 109.0 176.0 176.0 166.0 120.0 120.0 120.0 127.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:127.00 stddev:22.18 (17.5%) stddev-sans-first:22.43 04:33:08 INFO - PROCESS | 1661 | Values: 150.0 117.0 135.0 183.0 118.0 116.0 119.0 116.0 141.0 114.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:199.10 Median:200.00 stddev:3.81 (1.9%) stddev-sans-first:4.02 04:33:08 INFO - PROCESS | 1661 | Values: 198.0 205.0 201.0 204.0 197.0 198.0 192.0 200.0 200.0 196.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:72.40 Median:82.00 stddev:16.19 (19.7%) stddev-sans-first:16.62 04:33:08 INFO - PROCESS | 1661 | Values: 84.0 50.0 59.0 99.0 87.0 82.0 59.0 61.0 82.0 61.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:87.00 Median:80.50 stddev:16.73 (20.8%) stddev-sans-first:17.69 04:33:08 INFO - PROCESS | 1661 | Values: 91.0 69.0 92.0 72.0 70.0 71.0 89.0 93.0 103.0 120.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:89.00 stddev:11.82 (13.3%) stddev-sans-first:12.37 04:33:08 INFO - PROCESS | 1661 | Values: 89.0 124.0 99.0 86.0 104.0 89.0 91.0 87.0 90.0 87.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:114.00 Median:95.00 stddev:23.89 (25.1%) stddev-sans-first:24.33 04:33:08 INFO - PROCESS | 1661 | Values: 95.0 152.0 136.0 97.0 116.0 106.0 152.0 96.0 95.0 95.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:88.70 Median:88.50 stddev:2.11 (2.4%) stddev-sans-first:2.22 04:33:08 INFO - PROCESS | 1661 | Values: 88.0 88.0 85.0 89.0 88.0 87.0 91.0 92.0 88.0 91.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:60.50 stddev:13.39 (22.1%) stddev-sans-first:13.87 04:33:08 INFO - PROCESS | 1661 | Values: 58.0 56.0 56.0 59.0 59.0 61.0 60.0 72.0 89.0 91.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:81.20 Median:78.00 stddev:12.07 (15.5%) stddev-sans-first:12.34 04:33:08 INFO - PROCESS | 1661 | Values: 72.0 78.0 80.0 82.0 78.0 70.0 69.0 78.0 105.0 100.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:85.50 stddev:10.35 (12.1%) stddev-sans-first:10.88 04:33:08 INFO - PROCESS | 1661 | Values: 84.0 87.0 88.0 88.0 93.0 105.0 75.0 76.0 80.0 104.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:166.00 Median:164.00 stddev:20.24 (12.3%) stddev-sans-first:20.83 04:33:08 INFO - PROCESS | 1661 | Values: 152.0 150.0 167.0 156.0 161.0 152.0 150.0 173.0 213.0 186.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:173.50 stddev:13.29 (7.7%) stddev-sans-first:14.08 04:33:08 INFO - PROCESS | 1661 | Values: 174.0 173.0 170.0 171.0 181.0 167.0 169.0 212.0 168.0 175.0 04:33:08 INFO - PROCESS | 1661 | 04:33:08 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:68.50 stddev:9.09 (13.3%) stddev-sans-first:9.42 04:33:08 INFO - PROCESS | 1661 | Values: 67.0 68.0 69.0 68.0 92.0 87.0 72.0 68.0 67.0 68.0 04:33:08 INFO - PROCESS | 1661 | -------- Summary: end -------- 04:33:08 INFO - PROCESS | 1661 | 04:33:09 INFO - TEST-INFO | 1661: exit 0 04:33:09 INFO - TEST-OK | kraken | took 61739ms 04:33:09 INFO - SUITE-END | took 1179s 04:33:09 INFO - Completed test suite (00:19:39) 04:33:09 INFO - javascript benchmark 04:33:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7047.600503319636, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2950.0, 3308.7353011759046, 3310.9834450827757, 3315.270640459098, 3358.496225566165, 4483.955160448395, 5367.06076436624, 5445.945540544599, 5470.425605311445, 5500.80747173849, 5722.284714410699, 5764.193012978176, 5769.596128271022, 5770.278715160605, 5773.0, 5183.222516622509, 5230.084735171349, 5271.894562108756, 5290.338707661543, 5336.359636843584, 5186.896262074756, 5254.579633629301, 5256.526912577886, 5285.550728188108, 5314.9468505315035, 4291.785410729467, 5145.151050076733, 5153.2785410042625, 5282.920756188661, 5289.0, 5203.791848326081, 5222.9477705223035, 5237.004969055905, 5269.525742683177, 5350.0, 5179.067767801795, 5207.427183009904, 5226.346706661668, 5227.111391063529, 5240.292560504321, 5534.4742249486235, 5716.514096301819, 5734.770609175628, 5784.30588329399, 5794.913076303858, 6128.540359473057, 6138.480361557102, 6139.478144357735, 6166.229221347332, 6176.505879529627, 6148.354422785588, 6175.907361389583, 6179.938200617981, 6204.844878878019, 6222.906656400158, 5903.291605007426, 5923.141144534062, 5933.080372542263, 5945.405459454107, 5973.342932277446, 6140.478059364915, 6198.411150940653, 6201.596896201732, 6204.534659900435, 6249.0, 6094.085887116879, 6113.786017489367, 6139.171211886338, 6140.141335722124, 6154.292256390572, 6177.135201071854, 6195.008798592204, 6198.411150940653, 6201.534884883652, 6204.038374052029, 5949.899268635317, 6137.662428566472, 6186.041163619646, 6210.596311239755, 6220.937790622126, 6133.916185115316, 6158.599691020069, 6170.598911070856, 6171.228596425447, 6172.22847144107, 4897.877553061202, 4926.729029903389, 4927.236278376858, 4943.90112197754, 4974.651774375831, 4404.603585677304, 4427.734335939854, 4441.511433742286, 4465.37484752135, 4478.171538265431, 5762.855928601818, 5949.167116603679, 5961.940380596226, 5975.641461512323, 5999.220101386879, 6114.6942652868065, 6124.106319906353, 6130.917941862977, 6144.9246381882995, 6158.04550294705, 5753.626014309057, 5760.711964401763, 5806.216160818235, 5939.732712027969, 5954.285485741739, 5369.624126311121, 5375.543078838265, 5408.0, 5442.482964118402, 5445.319335083114, 6215.782447614311, 6223.782167624111, 6224.782132625427, 6246.718897649707, 6250.468710159596, 5039.52124548182, 6112.625067133324, 6115.4190351916495, 6145.754169833335, 6218.751249949952, 5297.284866542967, 6130.938690613037, 6175.104609831639, 6215.689215539114, 6257.812265632038, 5275.208718692227, 6030.758769649165, 6186.969065154645, 6209.348018458178, 6227.0, 5984.970075149597, 6132.814448934826, 6136.6722581676495, 6183.103449999635, 6225.62646241227, 6070.332263450929, 6075.787347442818, 6112.847178820565, 6127.295361033538, 6127.5866022601795, 6128.050152226412, 6136.662483563447, 6157.199564056644, 6161.383861613803, 6169.167162433194, 5817.94182058174, 5899.852503687443, 5958.076498142795, 6070.605410648293, 6094.969525152346, 6074.939250607614, 6090.482309003784, 6121.204243448323, 6121.602095863755, 6143.262808463013, 5912.49743771767, 5980.102984552352, 5990.4908082813445, 5997.940020599738, 6002.759889604542], "value": 5666.958950426397, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.4282860567319, 490.80858465198565, 503.6499632755232, 506.62256618818964, 535.871390866192, 30099.849500752494, 37808.432873506885, 39714.0, 39871.20257594846, 41820.58179418205, 33202.16994575137, 41325.79337103318, 41994.58005419953, 42005.579944200625, 42174.57825421745, 8990.32572557056, 9298.907010929872, 9321.533923303808, 9335.0, 9346.392484488486, 9249.676261330855, 9322.114399132071, 9333.766655833624, 9350.532473376337, 9357.0, 9305.395149315307, 9344.81310373792, 9351.205147562465, 9352.859707104399, 9358.625654973794, 9226.815463690757, 9335.11316424942, 9353.532323383804, 9353.579088940945, 9380.108889655472, 9212.309076819265, 9299.953500232523, 9312.674056407994, 9323.114304141096, 9399.919009313948, 39711.40432893509, 39799.40300895489, 39841.80079099615, 39921.80039099786, 39982.20035599301, 3258.96741032589, 3266.6406695263504, 3350.4974253861874, 3509.1051781795736, 3748.250349930025, 29326.0, 29473.11580652584, 30185.641646125976, 30266.54600180999, 30666.846665766752, 3166.4142133705336, 3183.9522407163913, 3192.952105718416, 3214.3089235814414, 3300.14196308959, 486859.0, 493327.0, 494852.0, 495518.0448195544, 495556.0, 57741.422585774446, 58080.128798068064, 58098.41901581015, 58150.836983260095, 58166.0, 60061.699691501264, 60811.0, 60857.08714369288, 60964.695176523834, 61119.69440152771, 15793.0, 15889.841101589067, 15996.920015399848, 16006.199690015686, 16067.035977841368, 10134.949325253474, 11733.4719937603, 12447.0, 12481.0, 12495.75008499825, 14069.366878490493, 14715.632109197142, 15760.369585216464, 15791.921040394724, 15960.36158553668, 5550.111982082847, 5824.922389357982, 6401.455876250571, 6461.224653041571, 6577.112089867902, 801.8356236971407, 802.9518228906285, 929.1126973740062, 983.9275190042888, 991.3803872579638, 27728.584071238947, 29632.962846300277, 31574.526382104286, 32323.838380808415, 32371.028869133963, 941.7221919533754, 956.1729104324709, 995.9800803983879, 998.9211651416452, 1015.5328548867603, 12532.937335313265, 14689.92655036718, 15296.464623738339, 15538.446155384598, 15873.0, 604066.0, 607133.0, 607591.0, 607960.0, 608911.0, 45493.31760023536, 54521.90956180854, 54889.72555137199, 54890.17664735032, 54946.0, 1323.2589749740175, 1324.708564115893, 1338.491373278148, 1346.6094832498661, 1355.9355905614243, 25366.873165634053, 28063.859680701466, 28759.0, 28997.0, 29436.705632943398, 49011.26483102685, 49240.26139607837, 49272.26091608557, 49278.0, 49470.257946131554, 565361.3463865473, 568100.0, 568359.0, 569991.0, 571014.0, 25099.99600016052, 25231.495370092864, 25475.61786573166, 25594.616080759177, 25641.487170256118, 43612.34581481344, 43680.689579312675, 43861.34207986819, 44271.557284426744, 44712.77643611761, 30827.53758693666, 36716.89849304525, 37021.81489092537, 37505.437418439295, 37610.247795044495, 37173.0, 37213.813930931254, 37598.43602346021, 38328.85013449601, 38424.0, 36070.8196459016, 36191.27617447689, 36217.094572634844, 36474.635253648186, 37392.0, 32968.0, 33009.0, 33115.00654980355, 33585.49621755627, 33647.822326219444, 19845.503862403555, 24689.753102468745, 24769.0, 25171.622425663994, 25194.244172674848], "value": 19101.574953078398, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.1296696956585, 303.6113774368808, 314.73090507615984, 378.1850113006472, 380.38187944590044, 18952.715709264372, 19076.523086922833, 19681.704774428395, 20004.59990800183, 20154.49613759657, 19056.0471976401, 19919.904405257705, 20224.29214977476, 20308.390748277576, 20434.284800032, 5728.16941543477, 6010.789622363218, 6076.997295446246, 6081.452669259766, 6107.5113990880845, 5447.618666693333, 5721.113227449731, 5796.362400136003, 5853.531717462614, 5933.0, 5736.713164341787, 5826.15520749491, 5842.707864606774, 5849.239598852143, 5862.237909071815, 4654.720716756989, 5867.0, 5906.763729450817, 5948.702564871783, 5955.136505206764, 5539.530287756144, 5583.35791383992, 5751.1085781703905, 5761.481466667978, 5781.161731548944, 19307.0, 24604.89277982495, 24908.501829963297, 25080.122195723245, 25094.372640683945, 2298.10373954158, 2343.6836027136287, 2367.573836709392, 2419.0444774314224, 2693.488237234919, 9355.251579873593, 9808.21534277256, 10146.594136234615, 10356.171506279556, 12748.681282968, 1780.6972814621545, 1814.3649722597117, 1898.1837809741805, 1899.1169106365605, 1994.6210220058142, 107249.0, 108130.45934770354, 109247.45376273147, 110351.89648103497, 110968.0, 11385.032272256785, 11439.256448330832, 11516.712082198012, 11562.132840037031, 11719.414029298501, 14507.854921450651, 14539.491117810825, 14543.563693089225, 14555.563333099812, 14564.563063107911, 8370.581470926429, 8435.409521333571, 8457.534835584102, 8494.193051660082, 8612.913870861212, 8290.958545207235, 8323.66705331792, 8470.0, 8497.915020849836, 8513.744587662257, 4381.079973205662, 4508.143452743968, 4515.81936722534, 4571.634269258451, 4576.290674945389, 1853.2123847364817, 1912.1873203888292, 1949.9220031198877, 1952.384998725397, 1958.5984873101265, 756.9735059272899, 814.2142832166987, 876.3996662286227, 912.7444315591645, 927.6196759328643, 16693.83306166947, 19667.803321966883, 20864.895675521828, 21070.894645526674, 21106.78893211048, 770.4722265248323, 880.8414485392562, 891.9420237684529, 911.3939230411835, 935.218408930974, 7850.665386884243, 10275.332103413255, 10381.84427233592, 11223.60717374888, 11253.099752019818, 572030.0, 580861.0, 583250.0837495786, 584157.0, 586885.0, 95759.0, 110703.0, 112925.0, 131057.37885242433, 131991.34004329916, 923.0492592629603, 977.3207620703542, 988.5353883674661, 989.2975987049275, 998.1116806042628, 18091.638167236844, 19025.33411330597, 19346.0, 19364.0, 19376.515587110436, 35546.57813687423, 46721.0, 53110.734446329065, 54259.0, 54461.0, 64495.0, 71473.0, 82175.589122054, 82429.1449636573, 83815.16184838074, 7472.738454154079, 7890.53205839754, 7970.4929830874225, 8288.875666864882, 8352.415330926777, 10505.842412363667, 12429.502819887104, 12436.440360183633, 12442.937785311016, 12532.373381330715, 10123.848142277724, 10349.586016559253, 10469.9476502617, 10734.73163170927, 10972.23194376386, 10693.839592406275, 10729.980651838063, 10750.784984300113, 10871.836922446328, 10890.346579205274, 10587.841182382117, 10731.678049658523, 10752.354858708502, 11133.332000080021, 11357.261777984404, 6891.620960847001, 8000.919990800017, 8212.876806848022, 8236.50580965144, 8243.629036693243, 10755.516001779783, 10982.450877456255, 11084.445777711244, 11113.333200008025, 11174.888251117385], "value": 9330.814709668706, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1160.9303441793493, 1199.226498908204, 1504.5787179589718, 1726.1541844496185, 1790.6687262856365, 7360.595167265798, 7718.0, 7875.684972601096, 8356.707515236967, 8363.414560980726, 7722.227777222275, 8124.634391452384, 8178.9367382240225, 8256.628451719673, 8265.83468330633, 2322.953540929185, 2336.836421450499, 2343.472718638301, 2347.85912845229, 2349.2952114365708, 2319.7796209360167, 2345.835791494596, 2362.244081893795, 2366.124533922451, 2371.312319427364, 2275.465265662568, 2283.8694846051226, 2290.393045842853, 2301.723793144825, 2308.6998690170253, 2284.6230371988604, 2296.644020176875, 2297.2993237062688, 2323.5585238804656, 2331.0908745589236, 2314.2478694424212, 2338.894749736266, 2339.0643742502966, 2342.4143964009, 2348.6964734572307, 8202.835943281161, 8224.38317126218, 8284.46151000183, 8284.792880177984, 8337.791555211108, 4973.4280557735965, 5117.48825117489, 5146.125158723026, 5159.896802063975, 5169.948300516984, 2928.2240206345336, 3345.866165353383, 3437.329720704464, 3467.910911066282, 3593.658602432765, 1010.4190090697878, 1041.283354384424, 1083.7886612110642, 1088.0914436445578, 1098.0721290509507, 10783.892161078445, 10820.188485863591, 10911.945440272906, 10947.56209751609, 10953.0, 4458.799354029076, 4563.0873825235085, 4654.930176047362, 4661.953380466152, 4725.740084295397, 9228.907710922806, 9268.304877134242, 9305.069493050776, 9305.860412093823, 9319.953400233091, 5136.5890728741615, 5140.331756871583, 5143.048536020848, 5150.690958542425, 5159.17453207485, 4186.874393768192, 4308.497619987121, 4584.358189853423, 4689.20283551797, 4718.575328220477, 3732.701383889282, 3787.962120378816, 3829.5978922213326, 3848.0572259795968, 3888.51393575803, 1210.0, 1213.83006379107, 1221.3404761428906, 1230.5754514692417, 1248.2260998181187, 866.9523176225368, 874.6501399440275, 891.9509426981449, 895.417978314101, 903.0923921458892, 5638.633488823213, 5740.397258287903, 5743.712814359265, 5765.0, 5822.650640961556, 904.5567671840882, 919.7838507950627, 935.4901578639658, 946.5882341181608, 974.6637410093506, 3123.5470856725647, 3771.5097037384962, 3860.247251785931, 3900.3369427197445, 3900.570937196906, 9738.805223895624, 10074.848877266846, 10098.444585547719, 10123.9493802532, 10128.189744820396, 10047.648332308334, 10052.246081543914, 10057.145142662956, 10061.496925153713, 10148.340357876714, 7684.884726729104, 7796.649150788228, 7838.137804841463, 7843.803904902309, 7874.6850125994315, 5376.274202982548, 5543.52880005204, 5643.494152776879, 5673.8297851064535, 5714.657120572779, 9214.216791572791, 9270.44377337362, 9287.76780580491, 9299.163075322982, 9304.674336398193, 9285.35002549815, 9300.069993000645, 9306.72079837606, 9309.348345616012, 9492.572834222614, 5867.882642347215, 6560.770373036921, 6617.106690596708, 6698.66506674674, 6715.630640314829, 7821.843563128819, 7898.0, 7904.6838126474295, 7925.0886148093705, 7929.841403172019, 6323.146375239284, 6977.1278590176225, 7013.4038606719005, 7118.25258347866, 7277.526960747535, 6953.582785032914, 6993.545419547713, 7018.684159212746, 7019.824504387431, 7044.647767611496, 6507.967460162668, 6602.438792702674, 6658.900116498353, 6679.933200668125, 6686.69909854048, 4192.538820729778, 4607.75590590532, 4797.64017698667, 4835.516448355136, 5182.6113041521285, 4496.77516124186, 4818.0, 4897.510248975074, 4984.352034235526, 5071.290019397214], "value": 4382.313012357329, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.5634441238431, 301.41826275288696, 304.79274093616334, 310.1904030480446, 313.7113855253167, 5317.9468205317935, 5339.759710813013, 5393.487618676224, 5492.725363731807, 5499.7250137493165, 4898.951010489894, 5184.896302073957, 5290.418054014065, 5305.920411193835, 5335.946640533593, 3450.1374656335915, 3591.317649646559, 4133.3386658134705, 4133.937990930123, 4148.315527937887, 3402.778819376745, 4021.3364794808967, 4148.0, 4148.485802682029, 4148.647364973981, 3534.4625088086636, 4026.4296924199584, 4051.852518165362, 4065.10567675111, 4121.299379105544, 3511.2801875615564, 4094.7133700640966, 4098.159877225176, 4105.7331273467125, 4112.588741125864, 3321.618013928405, 3499.7550171488006, 3551.2655255453415, 3606.0804494853646, 3606.0804494853905, 5167.250748641426, 5196.58427325813, 5210.557102646279, 5214.210397437353, 5235.267062611238, 3860.108546812042, 4269.252880745888, 4595.770211489412, 4601.217792975202, 4691.624670026424, 4878.926816097762, 5333.519983201491, 5636.943630563683, 5640.464155905182, 5668.348139963874, 3370.713489353408, 3815.6947444204397, 3830.5211848518934, 3841.865534706272, 3844.192719528902, 4730.8344207952905, 5478.91781623272, 5858.882822343572, 5865.59510600656, 5913.438223368773, 3371.679690429405, 3720.534933133358, 3749.8312575934146, 3879.9718074710227, 3911.9804400977814, 3674.4488326751202, 3704.5739739929713, 3893.7469064510715, 3917.6865850731874, 3937.6062393760394, 3748.493953316322, 4609.539046095364, 4613.0773845230415, 4631.95368046322, 4633.536646335339, 4963.0, 4970.627202959792, 5332.533553272881, 5406.999705054577, 5536.197251398606, 1149.4999675141341, 1268.7312687312688, 1271.593090211142, 1271.6901591360913, 1284.293638498822, 849.46908182386, 863.6933888469629, 868.2316150206985, 877.5783231165425, 883.8099808541194, 4484.686071974996, 4994.001199760062, 5079.4348853829315, 5085.771140298695, 5106.110739026584, 4809.326694262806, 5094.592432605383, 5192.792288308501, 5197.610179236573, 5559.972200138974, 3925.92148157041, 4326.394304797331, 4562.384078149474, 4733.0, 5088.542031217208, 2604.1406335909105, 2733.658292713411, 2907.418516296749, 2909.0654714614966, 2919.153445500781, 4666.346711460398, 4672.953270467252, 5459.08931873841, 5699.116636921284, 5751.884962300731, 4817.566419022305, 5090.800089925826, 5124.692518448905, 5714.828460165739, 5772.6536407815665, 5485.835424937259, 5513.5037846594805, 5646.548276137899, 5661.433856614306, 5720.628159169641, 4725.235737093702, 5172.094883395466, 5320.787168513216, 5504.53211477029, 5505.632577991342, 4576.702514336557, 4581.93127103087, 4898.632602554751, 4975.880426903917, 5520.150749498802, 5056.926660069354, 5614.726035955445, 5663.348714897839, 5675.687837168995, 5691.004074287066, 3668.0279725872133, 3678.3378991780664, 3683.557973043252, 3708.721845861517, 3715.6405682391337, 4507.323901414814, 5089.287499749964, 5155.664881782672, 5503.257060296809, 5597.944020559905, 4866.48901865299, 5563.304586926634, 5737.99170290395, 5795.130730390475, 5809.215755872903, 5035.7985680572365, 5723.513501352431, 5729.570282228933, 5805.680687562224, 5827.213326200908, 4875.6109506342345, 5050.863555699938, 5550.833474995757, 5618.747156378055, 5724.513416359489, 5030.585319046952, 5038.345015148007, 5399.866028134136, 5786.826395208151, 5821.806529661325, 4883.438404583376, 5145.8095980492335, 5327.360716714019, 5420.75606597712, 5463.180522921593], "value": 3994.74733594562, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.7030512032386, 705.4603228530174, 763.961801909905, 770.9553554933066, 772.6677528662673, 13508.986825988053, 14082.084664496813, 14204.218767967757, 14775.261236938137, 14914.403423863032, 13111.54109606164, 13313.134646247987, 13574.0, 13575.185488870675, 13581.0, 794.5312265763199, 816.6121092481084, 819.0130892274794, 819.7049062337554, 819.7868554175927, 640.3212594649663, 662.0730976632705, 795.4471642208667, 809.6356639512213, 822.4859462835727, 575.5711994564056, 625.3496363781661, 643.5591619740493, 655.977040803572, 660.7390080918035, 641.3234038089813, 650.720190318163, 653.9019147127922, 654.035297935546, 655.7344275568403, 482.83824918652294, 484.36548121960345, 484.6098890393232, 485.64062593680774, 487.0794198963961, 13641.795373069412, 13711.245881476514, 13715.657108572266, 13727.0, 13747.862521374758, 11788.646340609796, 13324.333783310796, 13427.462901483928, 13517.188968661912, 13609.455621775118, 10430.895691043068, 10735.892641073568, 10969.670909872717, 11027.503762330714, 11157.163212758995, 3190.88831890885, 3389.881354152593, 3655.8354874030733, 3677.9080522986874, 3778.8299526521373, 48437.75781121107, 77830.22169778286, 78905.21094789094, 83870.58064709698, 83927.06255281036, 10185.134263587677, 10323.174146068297, 10445.529951152217, 10543.367397956146, 10650.201234907412, 19046.52383690391, 19872.70190947137, 20652.277170298967, 20873.060712267983, 20884.686729699068, 6770.966145169243, 7437.107547094275, 7732.420068494773, 7738.729144479917, 7823.647935842901, 4160.126373461547, 4177.227212965611, 4224.683148763855, 4281.743095414286, 4313.180495705806, 2993.0, 3370.4775759757276, 3457.3258214647904, 3488.0930957951114, 3496.615372309044, 633.9334369891187, 650.6356440393395, 653.1737352249409, 663.2571519897746, 664.1697877652933, 421.588950773, 606.2603623579226, 638.5370606310388, 645.4062262718311, 653.1411194279507, 8508.276796472246, 8628.654853805903, 8872.911270887338, 8913.562881270554, 8963.0, 547.6002518161685, 558.1858958385247, 654.084282005187, 667.4993754683987, 673.1652750589234, 4155.916881662411, 4240.321548552217, 4476.037651904856, 4533.116042371706, 4546.477155127137, 76001.0, 109307.0, 113533.86466135397, 113570.43214783873, 113936.43031784787, 97244.0, 100038.0, 100040.0, 102825.0, 103624.0, 84637.0, 85030.0, 89065.55467222622, 92149.0785092154, 94382.5280873605, 8542.18849209324, 8683.782905427415, 8783.868241976248, 8808.163224493663, 8963.955180224057, 50042.499575003785, 54136.729316353165, 56793.0, 57339.46999459901, 58698.119528206254, 77186.61406692931, 81658.0, 82369.58815205886, 83999.0, 84706.0, 11023.393713345842, 11058.889411105785, 11151.275167114112, 11227.101831853268, 11373.772524549628, 11345.432728363714, 11960.282383057045, 12069.396530173632, 12085.395730213279, 12244.265344079384, 11247.100231981585, 11532.423378831192, 11678.941605292259, 11777.932544025402, 11825.52697892109, 11761.764764704829, 11810.881891181321, 11837.171398002058, 11920.701982450508, 11933.940330298294, 10629.627963021258, 10966.506507207354, 12031.398430078636, 12600.621981340575, 12868.678283042998, 10481.685549433529, 10694.89305106939, 10802.621908233174, 10867.891321086689, 11189.832152517556, 10943.507542160463, 11057.366933397248, 11078.501467434146, 11112.333260004425, 11208.215424920178], "value": 6928.982859786936, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 120.0, 109.0, 176.0, 176.0, 166.0, 120.0, 120.0, 120.0, 127.0], "value": 134.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 135.0, 183.0, 118.0, 116.0, 119.0, 116.0, 141.0, 114.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 205.0, 201.0, 204.0, 197.0, 198.0, 192.0, 200.0, 200.0, 196.0], "value": 199.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 50.0, 59.0, 99.0, 87.0, 82.0, 59.0, 61.0, 82.0, 61.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 92.0, 72.0, 70.0, 71.0, 89.0, 93.0, 103.0, 120.0], "value": 87.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 124.0, 99.0, 86.0, 104.0, 89.0, 91.0, 87.0, 90.0, 87.0], "value": 94.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 152.0, 136.0, 97.0, 116.0, 106.0, 152.0, 96.0, 95.0, 95.0], "value": 114.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 85.0, 89.0, 88.0, 87.0, 91.0, 92.0, 88.0, 91.0], "value": 88.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 59.0, 59.0, 61.0, 60.0, 72.0, 89.0, 91.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 78.0, 80.0, 82.0, 78.0, 70.0, 69.0, 78.0, 105.0, 100.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 88.0, 88.0, 93.0, 105.0, 75.0, 76.0, 80.0, 104.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 167.0, 156.0, 161.0, 152.0, 150.0, 173.0, 213.0, 186.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 170.0, 171.0, 181.0, 167.0, 169.0, 212.0, 168.0, 175.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 68.0, 92.0, 87.0, 72.0, 68.0, 67.0, 68.0], "value": 72.6, "unit": "score"}]}]} 04:33:09 INFO - Return code: 0 04:33:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:09 ERROR - # TBPL SUCCESS # 04:33:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:09 INFO - 2016-11-29 04:33:09.815 screenresolution[1666:10603] starting screenresolution argv=screenresolution get 04:33:09 INFO - 2016-11-29 04:33:09.818 screenresolution[1666:10603] Display 0: 1600x1200x32@60 04:33:09 INFO - 2016-11-29 04:33:09.824 screenresolution[1667:10606] starting screenresolution argv=screenresolution list 04:33:09 INFO - Available Modes on Display 0 04:33:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:10 INFO - Intel Iris: 04:33:10 INFO - Chipset Model: Intel Iris 04:33:10 INFO - Type: GPU 04:33:10 INFO - Bus: Built-In 04:33:10 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:10 INFO - Vendor: Intel (0x8086) 04:33:10 INFO - Device ID: 0x0a2e 04:33:10 INFO - Revision ID: 0x0009 04:33:10 INFO - Displays: 04:33:10 INFO - Display: 04:33:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:10 INFO - Display Serial Number: 1600x1200 60 04:33:10 INFO - Main Display: Yes 04:33:10 INFO - Mirror: Off 04:33:10 INFO - Online: Yes 04:33:10 INFO - Rotation: Supported 04:33:10 INFO - Return code: 0 04:33:10 INFO - Running post-action listener: _resource_record_post_action 04:33:10 INFO - [mozharness: 2016-11-29 12:33:10.068243Z] Finished run-tests step (success) 04:33:10 INFO - Running post-run listener: _resource_record_post_run 04:33:10 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 39467008; Write bytes: 659454464; Read time: 393; Write time: 2042 04:33:10 INFO - TinderboxPrint: CPU usage
54.2% 04:33:10 INFO - TinderboxPrint: I/O read bytes / time
39,467,008 / 393 04:33:10 INFO - TinderboxPrint: I/O write bytes / time
659,454,464 / 2,042 04:33:10 INFO - TinderboxPrint: CPU idle
2,221.8 (45.8%) 04:33:10 INFO - TinderboxPrint: CPU system
977.6 (20.2%) 04:33:10 INFO - TinderboxPrint: CPU user
1,650.3 (34.0%) 04:33:10 INFO - TinderboxPrint: Swap in / out
402,448,384 / 0 04:33:10 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 349422080; Write bytes: 350668800; Read time: 27778; Write time: 720 04:33:10 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35878912; Write bytes: 307417600; Read time: 361; Write time: 1317 04:33:10 INFO - Running post-run listener: _upload_blobber_files 04:33:10 INFO - Blob upload gear active. 04:33:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:33:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:33:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:33:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:11 INFO - (blobuploader) - INFO - Done attempting. 04:33:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:33:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:33:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:12 INFO - (blobuploader) - INFO - Done attempting. 04:33:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:33:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:15 INFO - (blobuploader) - INFO - Done attempting. 04:33:15 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:15 INFO - Return code: 0 04:33:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd46febccfbcf4c9522daaeec8855de09dfa1aa20a2585bae37f335d0170bb09b0b303d4a18901510a39fa1ccdb2a4ee0019b470cac16c5339bfc2497c5b5188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2690480987b8886eb3e8ea444b2aa748e33b5a46e3c60f87d8631a3f239b1d51bf6c17a551d1fbebbe6b136e05e2434f05f9b2611c828f50272059cb5a2c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f66b26a99a9cb5619193b045dd4a8b5a1567c8fb87a50e767950e34a56ad122b305641dc8157063cb8078b78fc2af2a7754c81e5e14e72b7e30e1a9607c0520e"} 04:33:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:15 INFO - Contents: 04:33:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd46febccfbcf4c9522daaeec8855de09dfa1aa20a2585bae37f335d0170bb09b0b303d4a18901510a39fa1ccdb2a4ee0019b470cac16c5339bfc2497c5b5188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2690480987b8886eb3e8ea444b2aa748e33b5a46e3c60f87d8631a3f239b1d51bf6c17a551d1fbebbe6b136e05e2434f05f9b2611c828f50272059cb5a2c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f66b26a99a9cb5619193b045dd4a8b5a1567c8fb87a50e767950e34a56ad122b305641dc8157063cb8078b78fc2af2a7754c81e5e14e72b7e30e1a9607c0520e"} 04:33:15 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:15 INFO - Copying logs to upload dir... 04:33:15 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.426847 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-29 04:33:15.810393) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 04:33:15.813982) ========= 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.WkUSXj5JLw/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.WmLITJVecH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd46febccfbcf4c9522daaeec8855de09dfa1aa20a2585bae37f335d0170bb09b0b303d4a18901510a39fa1ccdb2a4ee0019b470cac16c5339bfc2497c5b5188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2690480987b8886eb3e8ea444b2aa748e33b5a46e3c60f87d8631a3f239b1d51bf6c17a551d1fbebbe6b136e05e2434f05f9b2611c828f50272059cb5a2c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f66b26a99a9cb5619193b045dd4a8b5a1567c8fb87a50e767950e34a56ad122b305641dc8157063cb8078b78fc2af2a7754c81e5e14e72b7e30e1a9607c0520e"} build_url:https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010898 build_url: 'https://queue.taskcluster.net/v1/task/e8qWOIJySVyBT4cN16LGVw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd46febccfbcf4c9522daaeec8855de09dfa1aa20a2585bae37f335d0170bb09b0b303d4a18901510a39fa1ccdb2a4ee0019b470cac16c5339bfc2497c5b5188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2690480987b8886eb3e8ea444b2aa748e33b5a46e3c60f87d8631a3f239b1d51bf6c17a551d1fbebbe6b136e05e2434f05f9b2611c828f50272059cb5a2c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f66b26a99a9cb5619193b045dd4a8b5a1567c8fb87a50e767950e34a56ad122b305641dc8157063cb8078b78fc2af2a7754c81e5e14e72b7e30e1a9607c0520e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 04:33:15.847007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 04:33:15.847314) ========= 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.WkUSXj5JLw/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.WmLITJVecH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.004975 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 04:33:15.895361) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 04:33:15.895695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 04:33:15.896011) ========= ========= Total master_lag: 1.20 =========