builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0086 starttime: 1484949011.97 results: success (0) buildid: 20170120120024 builduid: ed64c51883f74d0eabd7f6fa6bd0860e revision: 2d482631e0f14763a95ab18680d154cd267b775b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:11.968204) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:11.973010) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:11.973306) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:11.998793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:11.999177) ========= 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.8YTFVhSlsL/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.8v9JndIvjg/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-20 13:50:12-- 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% 15.2M=0.001s 2017-01-20 13:50:12 (15.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121156 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:12.143603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:12.143934) ========= 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.8YTFVhSlsL/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.8v9JndIvjg/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.021130 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:12.192300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-20 13:50:12.192634) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2d482631e0f14763a95ab18680d154cd267b775b --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 2d482631e0f14763a95ab18680d154cd267b775b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8YTFVhSlsL/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.8v9JndIvjg/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-20 13:50:12,280 truncating revision to first 12 chars 2017-01-20 13:50:12,280 Setting DEBUG logging. 2017-01-20 13:50:12,280 attempt 1/10 2017-01-20 13:50:12,280 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2d482631e0f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 13:50:13,494 unpacking tar archive at: mozilla-aurora-2d482631e0f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.479940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-20 13:50:13.696259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:13.696584) ========= script_repo_revision: 2d482631e0f14763a95ab18680d154cd267b775b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:13.696992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:13.697259) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 13:50:13.717413) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-20 13:50:13.717833) ========= /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.8YTFVhSlsL/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.8v9JndIvjg/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 13:50:13 INFO - MultiFileLogger online at 20170120 13:50:13 in /builds/slave/test 13:50:13 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 13:50:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:13 INFO - {'append_to_log': False, 13:50:13 INFO - 'base_work_dir': '/builds/slave/test', 13:50:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:50:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:13 INFO - 'branch': 'Mozilla-Aurora', 13:50:13 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:13 INFO - 'config_files': ('talos/mac_config.py',), 13:50:13 INFO - 'default_actions': ('clobber', 13:50:13 INFO - 'read-buildbot-config', 13:50:13 INFO - 'download-and-extract', 13:50:13 INFO - 'populate-webroot', 13:50:13 INFO - 'create-virtualenv', 13:50:13 INFO - 'install', 13:50:13 INFO - 'run-tests'), 13:50:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:13 INFO - 'download_minidump_stackwalk': True, 13:50:13 INFO - 'download_symbols': 'ondemand', 13:50:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:13 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:13 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:13 INFO - 'installer_path': 'installer.exe', 13:50:13 INFO - 'log_level': 'info', 13:50:13 INFO - 'log_name': 'talos', 13:50:13 INFO - 'log_to_console': True, 13:50:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:13 INFO - 'opt_config_files': (), 13:50:13 INFO - 'pip_index': False, 13:50:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:13 INFO - 'cmd': ('bash', 13:50:13 INFO - '-c', 13:50:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:13 INFO - 'enabled': True, 13:50:13 INFO - 'halt_on_failure': False, 13:50:13 INFO - 'name': 'check_screen_resolution'},), 13:50:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:13 INFO - 'cmd': ('bash', 13:50:13 INFO - '-c', 13:50:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:13 INFO - 'enabled': True, 13:50:13 INFO - 'halt_on_failure': False, 13:50:13 INFO - 'name': 'check_screen_resolution'},), 13:50:13 INFO - 'run_cmd_checks_enabled': True, 13:50:13 INFO - 'sps_profile': False, 13:50:13 INFO - 'sps_profile_interval': 0, 13:50:13 INFO - 'suite': 'dromaeojs-e10s', 13:50:13 INFO - 'system_bits': '32', 13:50:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:13 INFO - 'title': 't-yosemite-r7-0086', 13:50:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:13 INFO - 'use_talos_json': True, 13:50:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:13 INFO - 'work_dir': 'build'} 13:50:13 INFO - [mozharness: 2017-01-20 21:50:13.934513Z] Running clobber step. 13:50:13 INFO - Running pre-action listener: _resource_record_pre_action 13:50:13 INFO - Running main action method: clobber 13:50:13 INFO - rmtree: /builds/slave/test/build 13:50:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:15 INFO - Running post-action listener: _resource_record_post_action 13:50:15 INFO - [mozharness: 2017-01-20 21:50:15.448250Z] Finished clobber step (success) 13:50:15 INFO - [mozharness: 2017-01-20 21:50:15.448399Z] Running read-buildbot-config step. 13:50:15 INFO - Running pre-action listener: _resource_record_pre_action 13:50:15 INFO - Running main action method: read_buildbot_config 13:50:15 INFO - Using buildbot properties: 13:50:15 INFO - { 13:50:15 INFO - "project": "", 13:50:15 INFO - "product": "firefox", 13:50:15 INFO - "script_repo_revision": "production", 13:50:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 13:50:15 INFO - "repository": "", 13:50:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 13:50:15 INFO - "buildid": "20170120120024", 13:50:15 INFO - "pgo_build": "False", 13:50:15 INFO - "basedir": "/builds/slave/test", 13:50:15 INFO - "buildnumber": 80, 13:50:15 INFO - "slavename": "t-yosemite-r7-0086", 13:50:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:50:15 INFO - "platform": "yosemite_r7", 13:50:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:50:15 INFO - "branch": "mozilla-aurora", 13:50:15 INFO - "repo_path": "releases/mozilla-aurora", 13:50:15 INFO - "revision": "2d482631e0f14763a95ab18680d154cd267b775b", 13:50:15 INFO - "stage_platform": "macosx64", 13:50:15 INFO - "builduid": "ed64c51883f74d0eabd7f6fa6bd0860e", 13:50:15 INFO - "slavebuilddir": "test" 13:50:15 INFO - } 13:50:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 13:50:15 INFO - Running post-action listener: _resource_record_post_action 13:50:15 INFO - [mozharness: 2017-01-20 21:50:15.451391Z] Finished read-buildbot-config step (success) 13:50:15 INFO - [mozharness: 2017-01-20 21:50:15.451507Z] Running download-and-extract step. 13:50:15 INFO - Running pre-action listener: _resource_record_pre_action 13:50:15 INFO - Running main action method: download_and_extract 13:50:15 INFO - mkdir: /builds/slave/test/build/tests 13:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:15 INFO - trying https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 13:50:15 INFO - Downloading https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/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 13:50:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/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 13:50:16 INFO - Downloaded 1199 bytes. 13:50:16 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 13:50:16 INFO - Using the following test package requirements: 13:50:16 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 13:50:16 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:16 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 13:50:16 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:16 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 13:50:16 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:16 INFO - u'jsshell-mac.zip'], 13:50:16 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:16 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 13:50:16 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 13:50:16 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:16 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 13:50:16 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:16 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 13:50:16 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:16 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 13:50:16 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:16 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 13:50:16 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:50:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 13:50:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:50:16 INFO - Fetch https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 13:50:17 INFO - Http code: 200 13:50:17 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 13:50:17 INFO - x-amz-cf-id: FBW5kIodrVqHd8yB7HVhsyYeVLxQWGwxl4-gddh47jXWq-8IT51arw== 13:50:17 INFO - x-amz-version-id: niLDcRRQaKNXMe7d1zVmY9jVk3530cZK 13:50:17 INFO - Expected file size: 16276143 13:50:17 INFO - Obtained file size: 16276143 13:50:24 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 13:50:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 13:50:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:50:24 INFO - Fetch https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 13:50:24 INFO - Http code: 200 13:50:24 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 13:50:24 INFO - x-amz-cf-id: Wh_dsLfeXhD-VQV5pZl4znfhLdSs5p-UPOg65XI9im4W1NGSvipeLw== 13:50:24 INFO - x-amz-version-id: niLDcRRQaKNXMe7d1zVmY9jVk3530cZK 13:50:25 INFO - Expected file size: 16276143 13:50:25 INFO - Obtained file size: 16276143 13:50:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 13:50:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:50:31 INFO - Fetch https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 13:50:32 INFO - Http code: 200 13:50:32 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 13:50:32 INFO - x-amz-cf-id: T0OisE3SES0vH5eRbwLtbq4bfD8T-nZq-WiCsgg1mvPgdh3X-J7GXQ== 13:50:32 INFO - x-amz-version-id: rSFJHEmOznScRcYlCQ3zeFzBkmSwU_aJ 13:50:32 INFO - Expected file size: 14409038 13:50:32 INFO - Obtained file size: 14409038 13:50:32 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')]} 13:50:32 INFO - trying https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:50:32 INFO - Downloading https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 13:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/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 13:50:35 INFO - Downloaded 109971984 bytes. 13:50:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:50:35 INFO - mkdir: /builds/slave/test/properties 13:50:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:50:35 INFO - Writing to file /builds/slave/test/properties/build_url 13:50:35 INFO - Contents: 13:50:35 INFO - build_url:https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:50:36 INFO - Running post-action listener: _resource_record_post_action 13:50:36 INFO - Running post-action listener: set_extra_try_arguments 13:50:36 INFO - [mozharness: 2017-01-20 21:50:36.404492Z] Finished download-and-extract step (success) 13:50:36 INFO - [mozharness: 2017-01-20 21:50:36.404634Z] Running populate-webroot step. 13:50:36 INFO - Running pre-action listener: _resource_record_pre_action 13:50:36 INFO - Running main action method: populate_webroot 13:50:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:50:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:50:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:50:36 INFO - '--tppagecycles', 13:50:36 INFO - '7'], 13:50:36 INFO - 'tests': ['tsvgm']}}, 13:50:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:50:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:50:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:50:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:50:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:50:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:50:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:36 INFO - 'talos_options': ['--disable-e10s'], 13:50:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:50:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:50:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:36 INFO - 'talos_options': ['--disable-e10s'], 13:50:36 INFO - 'tests': ['damp', 'tps']}, 13:50:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:36 INFO - 'tests': ['damp', 'tps']}, 13:50:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:50:36 INFO - 'tests': ['dromaeo_dom']}, 13:50:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:50:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:50:36 INFO - 'tests': ['basic_compositor_video']}, 13:50:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:50:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:50:36 INFO - 'tests': ['a11yr', 13:50:36 INFO - 'ts_paint', 13:50:36 INFO - 'tpaint', 13:50:36 INFO - 'sessionrestore', 13:50:36 INFO - 'sessionrestore_no_auto_restore', 13:50:36 INFO - 'tabpaint']}, 13:50:36 INFO - 'other-e10s': {'tests': ['a11yr', 13:50:36 INFO - 'ts_paint', 13:50:36 INFO - 'tpaint', 13:50:36 INFO - 'sessionrestore', 13:50:36 INFO - 'sessionrestore_no_auto_restore', 13:50:36 INFO - 'tabpaint']}, 13:50:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:50:36 INFO - 'ts_paint', 13:50:36 INFO - 'tpaint', 13:50:36 INFO - 'sessionrestore', 13:50:36 INFO - 'sessionrestore_no_auto_restore', 13:50:36 INFO - 'tabpaint']}, 13:50:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:50:36 INFO - 'ts_paint', 13:50:36 INFO - 'tpaint', 13:50:36 INFO - 'sessionrestore', 13:50:36 INFO - 'sessionrestore_no_auto_restore', 13:50:36 INFO - 'tabpaint']}, 13:50:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:50:36 INFO - 'tests': ['a11yr', 13:50:36 INFO - 'ts_paint', 13:50:36 INFO - 'tpaint', 13:50:36 INFO - 'sessionrestore', 13:50:36 INFO - 'sessionrestore_no_auto_restore', 13:50:36 INFO - 'tabpaint']}, 13:50:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:50:36 INFO - 'tests': ['a11yr', 13:50:36 INFO - 'ts_paint', 13:50:36 INFO - 'tpaint', 13:50:36 INFO - 'sessionrestore', 13:50:36 INFO - 'sessionrestore_no_auto_restore', 13:50:36 INFO - 'tabpaint']}, 13:50:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:50:36 INFO - 'tests': ['tsvgx', 13:50:36 INFO - 'tsvgr_opacity', 13:50:36 INFO - 'tart', 13:50:36 INFO - 'tscrollx', 13:50:36 INFO - 'cart']}, 13:50:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:50:36 INFO - 'tsvgr_opacity', 13:50:36 INFO - 'tart', 13:50:36 INFO - 'tscrollx', 13:50:36 INFO - 'cart']}, 13:50:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:36 INFO - 'talos_options': ['--disable-e10s'], 13:50:36 INFO - 'tests': ['tp5o']}, 13:50:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:36 INFO - 'tests': ['tp5o']}, 13:50:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:36 INFO - 'talos_options': ['--disable-e10s', 13:50:36 INFO - '--xperf_path', 13:50:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:50:36 INFO - 'tests': ['tp5n']}, 13:50:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:36 INFO - 'talos_options': ['--xperf_path', 13:50:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:50:36 INFO - 'tests': ['tp5n']}}, 13:50:36 INFO - 'talos.zip': {'path': '', 13:50:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:50:36 INFO - Running post-action listener: _resource_record_post_action 13:50:36 INFO - [mozharness: 2017-01-20 21:50:36.424049Z] Finished populate-webroot step (success) 13:50:36 INFO - [mozharness: 2017-01-20 21:50:36.424162Z] Running create-virtualenv step. 13:50:36 INFO - Running pre-action listener: _resource_record_pre_action 13:50:36 INFO - Running main action method: create_virtualenv 13:50:36 INFO - Creating virtualenv /builds/slave/test/build/venv 13:50:36 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 13:50:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:50:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:50:36 INFO - Using real prefix '/tools/python27' 13:50:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:50:37 INFO - Installing distribute.............................................................................................................................................................................................done. 13:50:40 INFO - Installing pip.................done. 13:50:40 INFO - Return code: 0 13:50:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:50:40 INFO - Reading from file tmpfile_stdout 13:50:40 INFO - Output received: 13:50:40 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) 13:50:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:50: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')]} 13:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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')]} 13:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10145d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf404d4f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012fbd30>, '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 0x101161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f3b20>, '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.8YTFVhSlsL/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.8v9JndIvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:50: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', 'pip>=1.5'] in /builds/slave/test/build 13:50: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 pip>=1.5 13:50:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YTFVhSlsL/Render', 13:50:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:40 INFO - 'HOME': '/Users/cltbld', 13:50:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:40 INFO - 'LOGNAME': 'cltbld', 13:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:40 INFO - 'MOZ_NO_REMOTE': '1', 13:50:40 INFO - 'NO_EM_RESTART': '1', 13:50:40 INFO - 'PAGER': '/bin/cat', 13:50:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:40 INFO - 'PWD': '/builds/slave/test', 13:50:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:40 INFO - 'SHELL': '/bin/bash', 13:50:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8v9JndIvjg/Listeners', 13:50:40 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 13:50:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:40 INFO - 'USER': 'cltbld', 13:50:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:40 INFO - 'XPC_FLAGS': '0x0', 13:50:40 INFO - 'XPC_SERVICE_NAME': '0', 13:50:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:40 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 13:50:40 INFO - Cleaning up... 13:50:40 INFO - Return code: 0 13:50:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:50: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')]} 13:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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')]} 13:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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', '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 0x1014e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10145d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf404d4f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012fbd30>, '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 0x101161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f3b20>, '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.8YTFVhSlsL/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.8v9JndIvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:50: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:50: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 psutil>=3.1.1 13:50:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YTFVhSlsL/Render', 13:50:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:40 INFO - 'HOME': '/Users/cltbld', 13:50:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:40 INFO - 'LOGNAME': 'cltbld', 13:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:40 INFO - 'MOZ_NO_REMOTE': '1', 13:50:40 INFO - 'NO_EM_RESTART': '1', 13:50:40 INFO - 'PAGER': '/bin/cat', 13:50:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:40 INFO - 'PWD': '/builds/slave/test', 13:50:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:40 INFO - 'SHELL': '/bin/bash', 13:50:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8v9JndIvjg/Listeners', 13:50:40 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 13:50:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:40 INFO - 'USER': 'cltbld', 13:50:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:40 INFO - 'XPC_FLAGS': '0x0', 13:50:40 INFO - 'XPC_SERVICE_NAME': '0', 13:50:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:41 INFO - Downloading/unpacking psutil>=3.1.1 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:50:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:50:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:50:44 INFO - Installing collected packages: psutil 13:50:44 INFO - Running setup.py install for psutil 13:50:44 INFO - building 'psutil._psutil_osx' extension 13:50:44 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 13:50:45 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 13:50:45 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 13:50:45 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 13:50:45 INFO - building 'psutil._psutil_posix' extension 13:50:45 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 13:50:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:50:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:50:45 INFO - ^ 13:50:45 INFO - 1 warning generated. 13:50:45 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 13:50:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:50:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:50:45 INFO - Successfully installed psutil 13:50:45 INFO - Cleaning up... 13:50:45 INFO - Return code: 0 13:50:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:50: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')]} 13:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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')]} 13:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:45 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 0x1014e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10145d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf404d4f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012fbd30>, '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 0x101161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f3b20>, '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.8YTFVhSlsL/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.8v9JndIvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:50:45 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 13:50:45 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 13:50:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YTFVhSlsL/Render', 13:50:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:45 INFO - 'HOME': '/Users/cltbld', 13:50:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:45 INFO - 'LOGNAME': 'cltbld', 13:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:45 INFO - 'MOZ_NO_REMOTE': '1', 13:50:45 INFO - 'NO_EM_RESTART': '1', 13:50:45 INFO - 'PAGER': '/bin/cat', 13:50:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:45 INFO - 'PWD': '/builds/slave/test', 13:50:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:45 INFO - 'SHELL': '/bin/bash', 13:50:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8v9JndIvjg/Listeners', 13:50:45 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 13:50:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:45 INFO - 'USER': 'cltbld', 13:50:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:45 INFO - 'XPC_FLAGS': '0x0', 13:50:45 INFO - 'XPC_SERVICE_NAME': '0', 13:50:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:50:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:50:48 INFO - Installing collected packages: mozsystemmonitor 13:50:48 INFO - Running setup.py install for mozsystemmonitor 13:50:48 INFO - Successfully installed mozsystemmonitor 13:50:48 INFO - Cleaning up... 13:50:48 INFO - Return code: 0 13:50:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:50:48 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')]} 13:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:48 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')]} 13:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:48 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 0x1014e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10145d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf404d4f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012fbd30>, '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 0x101161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f3b20>, '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.8YTFVhSlsL/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.8v9JndIvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:50:48 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 13:50:48 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 13:50:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YTFVhSlsL/Render', 13:50:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:48 INFO - 'HOME': '/Users/cltbld', 13:50:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:48 INFO - 'LOGNAME': 'cltbld', 13:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:48 INFO - 'MOZ_NO_REMOTE': '1', 13:50:48 INFO - 'NO_EM_RESTART': '1', 13:50:48 INFO - 'PAGER': '/bin/cat', 13:50:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:48 INFO - 'PWD': '/builds/slave/test', 13:50:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:48 INFO - 'SHELL': '/bin/bash', 13:50:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8v9JndIvjg/Listeners', 13:50:48 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 13:50:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:48 INFO - 'USER': 'cltbld', 13:50:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:48 INFO - 'XPC_FLAGS': '0x0', 13:50:48 INFO - 'XPC_SERVICE_NAME': '0', 13:50:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:48 INFO - Downloading/unpacking jsonschema==2.5.1 13:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:50:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:51 INFO - Downloading functools32-3.2.3-2.tar.gz 13:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:50:52 INFO - warning: no files found matching '*.txt' 13:50:52 INFO - no previously-included directories found matching 'build' 13:50:52 INFO - no previously-included directories found matching 'dist' 13:50:52 INFO - no previously-included directories found matching '.git*' 13:50:52 INFO - Installing collected packages: jsonschema, functools32 13:50:52 INFO - Running setup.py install for functools32 13:50:52 INFO - warning: no files found matching '*.txt' 13:50:52 INFO - no previously-included directories found matching 'build' 13:50:52 INFO - no previously-included directories found matching 'dist' 13:50:52 INFO - no previously-included directories found matching '.git*' 13:50:52 INFO - Successfully installed jsonschema functools32 13:50:52 INFO - Cleaning up... 13:50:52 INFO - Return code: 0 13:50:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1014e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10145d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf404d4f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012fbd30>, '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 0x101161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f3b20>, '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.8YTFVhSlsL/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.8v9JndIvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YTFVhSlsL/Render', 13:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:52 INFO - 'HOME': '/Users/cltbld', 13:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:52 INFO - 'LOGNAME': 'cltbld', 13:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:52 INFO - 'MOZ_NO_REMOTE': '1', 13:50:52 INFO - 'NO_EM_RESTART': '1', 13:50:52 INFO - 'PAGER': '/bin/cat', 13:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:52 INFO - 'PWD': '/builds/slave/test', 13:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:52 INFO - 'SHELL': '/bin/bash', 13:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8v9JndIvjg/Listeners', 13:50:52 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 13:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:52 INFO - 'USER': 'cltbld', 13:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:52 INFO - 'XPC_FLAGS': '0x0', 13:50:52 INFO - 'XPC_SERVICE_NAME': '0', 13:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:50:52 INFO - Cleaning up... 13:50:52 INFO - Return code: 0 13:50:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1014e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10145d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf404d4f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012fbd30>, '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 0x101161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f3b20>, '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.8YTFVhSlsL/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.8v9JndIvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YTFVhSlsL/Render', 13:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:52 INFO - 'HOME': '/Users/cltbld', 13:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:52 INFO - 'LOGNAME': 'cltbld', 13:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:52 INFO - 'MOZ_NO_REMOTE': '1', 13:50:52 INFO - 'NO_EM_RESTART': '1', 13:50:52 INFO - 'PAGER': '/bin/cat', 13:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:52 INFO - 'PWD': '/builds/slave/test', 13:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:52 INFO - 'SHELL': '/bin/bash', 13:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8v9JndIvjg/Listeners', 13:50:52 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 13:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:52 INFO - 'USER': 'cltbld', 13:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:52 INFO - 'XPC_FLAGS': '0x0', 13:50:52 INFO - 'XPC_SERVICE_NAME': '0', 13:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:52 INFO - Downloading/unpacking blobuploader==1.2.4 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50:55 INFO - Downloading blobuploader-1.2.4.tar.gz 13:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:50:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:50:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:56 INFO - Downloading docopt-0.6.1.tar.gz 13:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:50:56 INFO - Installing collected packages: blobuploader, requests, docopt 13:50:56 INFO - Running setup.py install for blobuploader 13:50:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:50:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:50:56 INFO - Running setup.py install for requests 13:50:57 INFO - Running setup.py install for docopt 13:50:57 INFO - Successfully installed blobuploader requests docopt 13:50:57 INFO - Cleaning up... 13:50:57 INFO - Return code: 0 13:50:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50:57 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')]} 13:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:57 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')]} 13:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:57 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 0x1014e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10145d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf404d4f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012fbd30>, '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 0x101161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f3b20>, '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.8YTFVhSlsL/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.8v9JndIvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YTFVhSlsL/Render', 13:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:57 INFO - 'HOME': '/Users/cltbld', 13:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:57 INFO - 'LOGNAME': 'cltbld', 13:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:57 INFO - 'MOZ_NO_REMOTE': '1', 13:50:57 INFO - 'NO_EM_RESTART': '1', 13:50:57 INFO - 'PAGER': '/bin/cat', 13:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:57 INFO - 'PWD': '/builds/slave/test', 13:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:57 INFO - 'SHELL': '/bin/bash', 13:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8v9JndIvjg/Listeners', 13:50:57 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 13:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:57 INFO - 'USER': 'cltbld', 13:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:57 INFO - 'XPC_FLAGS': '0x0', 13:50:57 INFO - 'XPC_SERVICE_NAME': '0', 13:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:50:57 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-gPOifP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:50:58 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-A0H1ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:50:58 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-fABWxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:50:58 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-eeJBjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:50:58 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-2DIqFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:50:58 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-z3gI4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:50:58 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-yDt9Xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:50:58 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-xwLrSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:50:58 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-pTcvOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:50:58 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-bygTE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:50:58 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-rLjyQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:50:59 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-kOjOP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:50:59 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-dHqjL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:50:59 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-rB19Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:59 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-864mbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:50:59 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-CoVMri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:50:59 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Cg0mu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:50:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:50:59 INFO - Running setup.py install for manifestparser 13:50:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:50:59 INFO - Running setup.py install for mozcrash 13:51:00 INFO - Running setup.py install for mozdebug 13:51:00 INFO - Running setup.py install for mozdevice 13:51:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:51:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:00 INFO - Running setup.py install for mozfile 13:51:00 INFO - Running setup.py install for mozhttpd 13:51:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:00 INFO - Running setup.py install for mozinfo 13:51:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:00 INFO - Running setup.py install for mozInstall 13:51:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:00 INFO - Running setup.py install for mozleak 13:51:01 INFO - Running setup.py install for mozlog 13:51:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:01 INFO - Running setup.py install for moznetwork 13:51:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:01 INFO - Running setup.py install for mozprocess 13:51:01 INFO - Running setup.py install for mozprofile 13:51:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:01 INFO - Running setup.py install for mozrunner 13:51:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:01 INFO - Running setup.py install for mozscreenshot 13:51:02 INFO - Running setup.py install for moztest 13:51:02 INFO - Running setup.py install for mozversion 13:51:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:02 INFO - Cleaning up... 13:51:02 INFO - Return code: 0 13:51:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:02 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 0x1014e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10145d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf404d4f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012fbd30>, '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 0x101161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f3b20>, '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.8YTFVhSlsL/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.8v9JndIvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YTFVhSlsL/Render', 13:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:02 INFO - 'HOME': '/Users/cltbld', 13:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:02 INFO - 'LOGNAME': 'cltbld', 13:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:02 INFO - 'MOZ_NO_REMOTE': '1', 13:51:02 INFO - 'NO_EM_RESTART': '1', 13:51:02 INFO - 'PAGER': '/bin/cat', 13:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:02 INFO - 'PWD': '/builds/slave/test', 13:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:02 INFO - 'SHELL': '/bin/bash', 13:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8v9JndIvjg/Listeners', 13:51:02 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 13:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:02 INFO - 'USER': 'cltbld', 13:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:02 INFO - 'XPC_FLAGS': '0x0', 13:51:02 INFO - 'XPC_SERVICE_NAME': '0', 13:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:02 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-aiBwLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:02 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-9Hw8Or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:02 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)) 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:02 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-tNiHNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:02 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-LP0eRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-UdhR0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-tYfDeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-bh5DEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-OKXmRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-qg3FEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-oQZXwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:03 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)) 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-aV9NtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-VjRNpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:03 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)) 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-YO7DZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-qQaDaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:04 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)) 13:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-LE1cZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-cejApK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Frwad1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:51:04 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)) 13:51:04 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)) 13:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:07 INFO - Downloading blessings-1.6.tar.gz 13:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:07 INFO - Installing collected packages: blessings 13:51:07 INFO - Running setup.py install for blessings 13:51:07 INFO - Successfully installed blessings 13:51:07 INFO - Cleaning up... 13:51:07 INFO - Return code: 0 13:51:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:07 INFO - Reading from file tmpfile_stdout 13:51:07 INFO - Current package versions: 13:51:07 INFO - blessings == 1.6 13:51:07 INFO - blobuploader == 1.2.4 13:51:07 INFO - docopt == 0.6.1 13:51:07 INFO - functools32 == 3.2.3-2 13:51:07 INFO - jsonschema == 2.5.1 13:51:07 INFO - manifestparser == 1.1 13:51:07 INFO - mozInstall == 1.12 13:51:07 INFO - mozcrash == 1.0 13:51:07 INFO - mozdebug == 0.1 13:51:07 INFO - mozdevice == 0.48 13:51:07 INFO - mozfile == 1.2 13:51:07 INFO - mozhttpd == 0.7 13:51:07 INFO - mozinfo == 0.9 13:51:07 INFO - mozleak == 0.1 13:51:07 INFO - mozlog == 3.4 13:51:07 INFO - moznetwork == 0.27 13:51:07 INFO - mozprocess == 0.23 13:51:07 INFO - mozprofile == 0.28 13:51:07 INFO - mozrunner == 6.13 13:51:07 INFO - mozscreenshot == 0.1 13:51:07 INFO - mozsystemmonitor == 0.3 13:51:07 INFO - moztest == 0.8 13:51:07 INFO - mozversion == 1.4 13:51:07 INFO - psutil == 3.1.1 13:51:07 INFO - requests == 1.2.3 13:51:07 INFO - wsgiref == 0.1.2 13:51:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:07 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 0x1014e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10145d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf404d4f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012fbd30>, '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 0x101161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f3b20>, '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.8YTFVhSlsL/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.8v9JndIvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YTFVhSlsL/Render', 13:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:07 INFO - 'HOME': '/Users/cltbld', 13:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:07 INFO - 'LOGNAME': 'cltbld', 13:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:07 INFO - 'MOZ_NO_REMOTE': '1', 13:51:07 INFO - 'NO_EM_RESTART': '1', 13:51:07 INFO - 'PAGER': '/bin/cat', 13:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:07 INFO - 'PWD': '/builds/slave/test', 13:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:07 INFO - 'SHELL': '/bin/bash', 13:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8v9JndIvjg/Listeners', 13:51:07 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 13:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:07 INFO - 'USER': 'cltbld', 13:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:07 INFO - 'XPC_FLAGS': '0x0', 13:51:07 INFO - 'XPC_SERVICE_NAME': '0', 13:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:51:08 INFO - Cleaning up... 13:51:08 INFO - Return code: 0 13:51:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:08 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')]} 13:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:08 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')]} 13:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:08 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 0x1014e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10145d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf404d4f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012fbd30>, '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 0x101161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f3b20>, '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.8YTFVhSlsL/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.8v9JndIvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:51:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:51:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YTFVhSlsL/Render', 13:51:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:08 INFO - 'HOME': '/Users/cltbld', 13:51:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:08 INFO - 'LOGNAME': 'cltbld', 13:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:08 INFO - 'MOZ_NO_REMOTE': '1', 13:51:08 INFO - 'NO_EM_RESTART': '1', 13:51:08 INFO - 'PAGER': '/bin/cat', 13:51:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:08 INFO - 'PWD': '/builds/slave/test', 13:51:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:08 INFO - 'SHELL': '/bin/bash', 13:51:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8v9JndIvjg/Listeners', 13:51:08 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 13:51:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:08 INFO - 'USER': 'cltbld', 13:51:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:08 INFO - 'XPC_FLAGS': '0x0', 13:51:08 INFO - 'XPC_SERVICE_NAME': '0', 13:51:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:09 INFO - Cleaning up... 13:51:09 INFO - Return code: 0 13:51:09 INFO - Running post-action listener: _resource_record_post_action 13:51:09 INFO - Running post-action listener: _start_resource_monitoring 13:51:09 INFO - Starting resource monitoring. 13:51:09 INFO - [mozharness: 2017-01-20 21:51:09.270188Z] Finished create-virtualenv step (success) 13:51:09 INFO - [mozharness: 2017-01-20 21:51:09.271297Z] Running install step. 13:51:09 INFO - Running pre-action listener: _resource_record_pre_action 13:51:09 INFO - Running main action method: install 13:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:09 INFO - Reading from file tmpfile_stdout 13:51:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:09 INFO - Reading from file tmpfile_stdout 13:51:09 INFO - Output received: 13:51:09 INFO - Usage: mozinstall [options] installer 13:51:09 INFO - Options: 13:51:09 INFO - -h, --help show this help message and exit 13:51:09 INFO - -d DEST, --destination=DEST 13:51:09 INFO - Directory to install application into. [default: 13:51:09 INFO - "/builds/slave/test"] 13:51:09 INFO - --app=APP Application being installed. [default: firefox] 13:51:09 INFO - mkdir: /builds/slave/test/build/application 13:51:09 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'] 13:51:09 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 13:51:40 INFO - Reading from file tmpfile_stdout 13:51:40 INFO - Output received: 13:51:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:51:40 INFO - Running post-action listener: _resource_record_post_action 13:51:40 INFO - [mozharness: 2017-01-20 21:51:40.726589Z] Finished install step (success) 13:51:40 INFO - [mozharness: 2017-01-20 21:51:40.726767Z] Running run-tests step. 13:51:40 INFO - Running pre-action listener: _resource_record_pre_action 13:51:40 INFO - Running main action method: run_tests 13:51:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:51:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:51:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:51:40 INFO - 2017-01-20 13:51:40.741 screenresolution[2150:20293] starting screenresolution argv=screenresolution get 13:51:40 INFO - 2017-01-20 13:51:40.744 screenresolution[2150:20293] Display 0: 1600x1200x32@60 13:51:40 INFO - 2017-01-20 13:51:40.749 screenresolution[2151:20295] starting screenresolution argv=screenresolution list 13:51:40 INFO - Available Modes on Display 0 13:51:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:51:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:51:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:51:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:51:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:51:40 INFO - Intel Iris: 13:51:40 INFO - Chipset Model: Intel Iris 13:51:40 INFO - Type: GPU 13:51:40 INFO - Bus: Built-In 13:51:40 INFO - VRAM (Dynamic, Max): 1536 MB 13:51:40 INFO - Vendor: Intel (0x8086) 13:51:40 INFO - Device ID: 0x0a2e 13:51:40 INFO - Revision ID: 0x0009 13:51:40 INFO - Displays: 13:51:40 INFO - Display: 13:51:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:51:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:51:40 INFO - Display Serial Number: 1600x1200 60 13:51:40 INFO - Main Display: Yes 13:51:40 INFO - Mirror: Off 13:51:40 INFO - Online: Yes 13:51:40 INFO - Rotation: Supported 13:51:40 INFO - Return code: 0 13:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:51:40 INFO - Python 2.7.3 13:51:40 INFO - Return code: 0 13:51:40 INFO - grabbing minidump binary from tooltool 13:51: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')]} 13:51:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012fbd30>, '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 0x101161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:51:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:51:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:51:40 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 13:51:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:51:41 INFO - Return code: 0 13:51:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:51:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:51:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:51:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:51:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:51:41 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/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:51:41 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/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:51:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8YTFVhSlsL/Render', 13:51:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:41 INFO - 'HOME': '/Users/cltbld', 13:51:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:41 INFO - 'LOGNAME': 'cltbld', 13:51:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:51:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:41 INFO - 'MOZ_NO_REMOTE': '1', 13:51:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:51:41 INFO - 'NO_EM_RESTART': '1', 13:51:41 INFO - 'PAGER': '/bin/cat', 13:51:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:41 INFO - 'PWD': '/builds/slave/test', 13:51:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:51:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:41 INFO - 'SHELL': '/bin/bash', 13:51:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8v9JndIvjg/Listeners', 13:51:41 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 13:51:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:41 INFO - 'USER': 'cltbld', 13:51:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:41 INFO - 'XPC_FLAGS': '0x0', 13:51:41 INFO - 'XPC_SERVICE_NAME': '0', 13:51:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:41 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/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:51:41 INFO - mozversion application_buildid: 20170120120024 13:51:41 INFO - mozversion application_changeset: 2d482631e0f14763a95ab18680d154cd267b775b 13:51:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:51:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:51:41 INFO - mozversion application_name: Firefox 13:51:41 INFO - mozversion application_remotingname: firefox-dev 13:51:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:51:41 INFO - mozversion application_vendor: Mozilla 13:51:41 INFO - mozversion application_version: 52.0a2 13:51:41 INFO - mozversion platform_buildid: 20170120120024 13:51:41 INFO - mozversion platform_changeset: 2d482631e0f14763a95ab18680d154cd267b775b 13:51:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:51:41 INFO - mozversion platform_version: 52.0a2 13:51:41 INFO - using testdate: 1484949101 13:51:41 INFO - actual date: 1484949101 13:51:41 INFO - starting webserver on 'localhost:54164' 13:51:41 INFO - SUITE-START | Running 2 tests 13:51:41 INFO - TEST-START | dromaeo_css 13:51:41 INFO - operating with platform_type : mac_ 13:51:41 INFO - Initialising browser for dromaeo_css test... 13:51:41 INFO - TEST-INFO | started process 2161 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpJgomeR/profile http://localhost:54164/getInfo.html) 13:51:44 INFO - PROCESS | 2161 | 2017-01-20 13:51:44.517 plugin-container[2163:20465] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x484f, name = 'com.apple.tsm.portname' 13:51:44 INFO - PROCESS | 2161 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:51:44 INFO - PROCESS | 2161 | 2017-01-20 13:51:44.520 plugin-container[2163:20465] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 13:51:44 INFO - PROCESS | 2161 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:51:44 INFO - PROCESS | 2161 | 2017-01-20 13:51:44.520 plugin-container[2163:20465] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:51:44 INFO - PROCESS | 2161 | __metrics Screen width/height:1600/1200 13:51:44 INFO - PROCESS | 2161 | colorDepth:24 13:51:44 INFO - PROCESS | 2161 | Browser inner width/height: 1024/689 13:51:44 INFO - PROCESS | 2161 | __metrics 13:51:44 ERROR - PROCESS | 2161 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 13:51:45 INFO - TEST-INFO | 2161: exit 0 13:51:45 INFO - Browser initialized. 13:51:45 INFO - Running cycle 1/1 for dromaeo_css test... 13:51:45 INFO - TEST-INFO | started process 2164 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpJgomeR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:48 INFO - PROCESS | 2164 | 2017-01-20 13:51:48.239 plugin-container[2165:20588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 13:51:48 INFO - PROCESS | 2164 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:51:48 INFO - PROCESS | 2164 | 2017-01-20 13:51:48.240 plugin-container[2165:20588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 13:51:48 INFO - PROCESS | 2164 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:51:48 INFO - PROCESS | 2164 | 2017-01-20 13:51:48.240 plugin-container[2165:20588] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:51:57 INFO - PROCESS | 2164 | RSS: Main: 228888576 13:51:57 INFO - PROCESS | 2164 | 13:55:00 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54164/tests/dromaeo/cssquery-ext.html) 13:55:02 INFO - PROCESS | 2164 | RSS: Main: 238329856 13:55:02 INFO - PROCESS | 2164 | 13:58:04 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-ext.html (next: http://localhost:54164/tests/dromaeo/cssquery-jquery.html) 13:58:05 INFO - PROCESS | 2164 | RSS: Main: 246816768 13:58:05 INFO - PROCESS | 2164 | 14:01:07 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54164/tests/dromaeo/cssquery-mootools.html) 14:01:07 INFO - PROCESS | 2164 | RSS: Main: 249712640 14:01:07 INFO - PROCESS | 2164 | 14:04:09 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54164/tests/dromaeo/cssquery-prototype.html) 14:04:10 INFO - PROCESS | 2164 | RSS: Main: 249503744 14:04:10 INFO - PROCESS | 2164 | 14:07:13 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54164/tests/dromaeo/cssquery-yui.html) 14:07:13 INFO - PROCESS | 2164 | RSS: Main: 253087744 14:07:13 INFO - PROCESS | 2164 | 14:10:16 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54164/tests/dromaeo/cssquery-yui.html (next: http://localhost:54164/tests/dromaeo/cssquery-dojo.html) 14:10:16 INFO - PROCESS | 2164 | RSS: Main: 254386176 14:10:16 INFO - PROCESS | 2164 | 14:10:16 INFO - PROCESS | 2164 | __start_tp_report 14:10:16 INFO - PROCESS | 2164 | _x_x_mozilla_page_load 14:10:16 INFO - PROCESS | 2164 | _x_x_mozilla_page_load_details 14:10:16 INFO - PROCESS | 2164 | |i|pagename|runs| 14:10:16 INFO - PROCESS | 2164 | |0;dojo.html;3144.2768163322435;3376.0378292186733;3403.1662242750513;3416.0947348952545;3455.8617655293797;5716.28546431696;5753.4246575342495;5772.971135144329;5825.912611310834;5861.589688721791;5759.424057594239;5852.209951656536;5862.149988251701;5880.059190529505;5896.351401345849;5295.179247216687;5303.23103150043;5323.494268044549;5343.358796944372;5368.812091576796;5376.4085950545405;5400.91898621521;5402.405735369106;5404;5405.486478784529;5226.712530810804;5236.92144617831;5338.946610533903;5383.353997520284;5387.78448862045;5301.3108295921475;5328.786848526035;5369.543588794957;5400.189971504266;5488.286522752057;5215.843524694227;5335.146376579729;5350.892982140374;5370.489803468703;5417.26866872975;5593.468620481089;5865.632945854538;5905.379935106838;5927.466528012456;5932.050871860525;6123.496151642696;6205.348438413992;6211.130441738161;6212.099245609361;6256.311805701369;6230.190075290228;6288.622682639057;6295;6341.143945567335;6353.078803573456;5906.852328691817;5913.733881975321;5929.881402371929;5934.898256754265;5972.671503067373;6222.875542489125;6258.530610204253;6289.40250676185;6318;6350.174477318012;6137.140800287963;6220.409061139185;6230.56386052981;6237.688115594202;6245.6252624842655;6309.49524038085;6328.398802113792;6329.272133704683;6344.302126766052;6366.6180029198395;4794.2808578713475;6007.429294217042;6147.893379191788;6258.217722784652;6337.683115844189;6193.597416167935;6231.096491008779;6295.590786598948;6308.589941653778;6318.020706790455;4976.4525902150735;5004.84985450437;5006.89986200274;5007.84976450707;5008.29883816266;4358.934615980763;4405.185040767404;4446.82212711488;4485.439320084989;4513.413256276663;5649.689267090267;5808.448197421323;5809.128630705343;5904.321003084614;5946.197263369476;5747.224124743189;6277.843053923689;6323.08315294289;6325.177726895474;6343.9682801585695;5715.828525144252;5792;5856.619319744203;5859.384764599656;5871.500922421556;5458.426865179178;5506.614536982373;5526.253955716007;5538.335399752055;5539.806106786243;6426.036094585849;6429.00350445691;6429.196350456193;6432.871342573028;6435.74257029723;6121.148138557293;6191.84520386994;6223.688815559113;6281.340459251713;6323.9683801580695;5047.974760126176;5075.873103172303;5300.2049692546425;6272.780452684134;6294.653794041372;5193.792248310026;5700;6286.465650419766;6291.245050593775;6319.083732858618;5455.318085239345;6140.785072522441;6317.936820631735;6320.841978950563;6339.049142628643;6098.664573448503;6114.0236562776045;6132.9080063799975;6145.832291864532;6180.042093475518;6149.877002459836;6167.660778657038;6221.782237621662;6253.78111766086;6264.780732674334;5970.820875373745;6080.665563394055;6087.330393656605;6118.816435506942;6144.170536977451;5402.702851343214;5829.854253643693;6047.244094488189;6113.358097399709;6214.844628884314;6085.726142323518;6090.725917333642;6098.054801505774;6119.143319935123;6119.755209791559 14:10:16 INFO - PROCESS | 2164 | |1;ext.html;464.5656311348889;474.5325854033777;482.4066398330056;508.9896555337654;516.5376987596102;29249.83000679973;32277.515837262432;38593;39557.60442395575;39736;41014.7949260254;41342.79328603353;41357.793211033975;41362.58637413633;41389;9259.120383563584;9426.717198484057;9432.669856555021;9443.527823608827;9480.336376453617;9357.39176953496;9466.574004169828;9484.90515094847;9497.240220782356;9504.95247523765;9434.716958491223;9451.054894510527;9462.290328225376;9501.287403444769;9507.857382139238;9310.348275620709;9398.436093834393;9433.811323773554;9462.668806591737;9474.857877131848;9237.076292370777;9297.67458138962;9341;9367.906320936772;9368.34421590489;31529.36941261162;38086.80956595199;38331.80834095839;38474.80762596197;38520;3159.3839201355513;3268.3790079884984;3334.733221342287;3383.6954674079207;3408.926188250693;19497.902510487358;25018.874905625355;28739.9941002066;29289.121326360244;30045;3179.6979286967703;3205.3909757146303;3214.67853214679;3223.629282632504;3245.805251684883;491985;497696;498081.9999999964;498992.50503747247;501030;60229;60474.69762651159;60660.696696516236;60932.08601870976;61059;51768.74115629473;61617.075743863876;62026;62642.37357626457;62778.68610657009;15480.612984675474;15986.440474583334;16133.596660083593;16188.514344569681;16207.027578345336;12280.815787763191;12388.81416778749;12525.43635536403;12538.498460061677;12614.558490452973;18174.000429976477;18565.44303670892;18581.814181858277;18583;18584.97782621969;7428.517146385576;7540.811479713051;7630.465867389341;7717.922820771832;7720.806979825437;844.3709436469869;954.4988880837477;990.5146478225762;1082.5277622433484;1128.6524030017545;23704.170354037527;24351.634725479133;27726.861365693043;29613.555796663066;29772.2556936074;917.6191880369572;1020.4030642074321;1033.78530226983;1086.1217772901716;1114.8272017837248;15032.022918510262;15413.5375938722;15444.382224711111;15485.148316842457;15532.912696111389;677438;680407;681101;684082;684406;55360;55765.16352254719;56058.43941560614;56181;56190.876182476124;1358.809766632672;1372.6568357910523;1382.453930697389;1384.8407433145317;1384.9446022159;28372.43255134927;28474.43051138924;29170.270743231587;29318;29490.705092948796;47867.521324787696;48021.75989120032;48273.27590086081;48377.274340884214;48411.75794121007;551838;552582;553160;554069;554950;25817.483650327264;26033.219003429927;26211.868940655175;26231.60652590251;26261.212163635122;44575;44711;44989.77505112453;45747.77126114348;46030.76984615056;37342;37665.62334376621;37795.81102094472;38786.0303492415;38857.222855543296;37158.44262336013;37241.068973275884;37555;38379;38559.80720096381;37070;37334.813325933195;37801.86594402172;37869;39219.80390098031;31115.910943116884;34200.802971895864;34504.65495345115;34533.48199776955;34586.654133458345;25521.744782551938;25613.359666007753;25731.099411520507;25761.871190644677;25937.96248150053 14:10:16 INFO - PROCESS | 2164 | |2;jquery.html;329.8779451602907;367.79587329032375;370.46837787774535;386.7408836079826;402.00303247945095;15006.924965375185;18904;20022.59954800903;20050.29823956162;20266.695999559983;17366.305347786074;19466.70799938002;19822.60354792907;20423.693644595307;20897.477563060933;5774.855628609276;5803.6517808931385;6045.969770151165;6047.7580896764075;6076.756929722806;5752.338481074688;5857.970710146444;5899;5941.10883367494;5941.821745347646;5745.827625171251;5817.069268916975;5862.853428664275;5896.764129434818;5913.9112913306335;5956.106584012389;5959.612625179349;6098.176746139259;6105.664188469655;6133.815985520419;5790.652560846321;5808.88382232353;5837.241158649391;5871.4715675589405;5905.320888097881;12888.097833151684;13037.86962130376;13084.018698597549;15262;24230.515389692282;2132.3816093332916;2239.3729755668437;2341.758867800069;2358.563665721847;2657.534931387019;9754.219662426989;9926.553305101288;9955.950220248926;10159.89840101597;10476.895231047669;1834.367143335547;1884.0579710144928;1888.9716654250196;1901.6672082385664;1936.5352315444193;110915;114027.42986285016;115660.26509602362;117087.41456292749;117458.99999999914;9375;11463.88536114645;11791.88208117925;11829.349385783864;11981.341026243641;14669;14694.265286735621;14699.338529766186;14703.852961470462;14746.188959607325;7714.80420534818;7756.961215193888;8492.40553161285;8495.74512764618;8505.192006759347;8340.833183336421;8345.54099524532;8386.916130838736;8482.872756908651;8513.404061715744;3960.5445373782386;4230.069384735353;4548.499665036843;4556.724117247176;4578.542145785462;1895.3699818156374;1941.2623203182982;1988.5923385705896;1993.7109119177637;1995.6208320419073;818.4148333941141;909.2998391238709;934.5747684803398;946.9668561600449;974.4835237324229;20135.597288054156;21160.365189044354;21190;21271.680924786142;21509.13963441476;821.3511326052471;895.8432274351962;900.6937641202023;917.1287277086794;946.4605175050293;9350;9842.557084931195;10731.570737170427;11333.546658133582;11376.488058037408;537818;543518;543708;550235;550372;114078;126550.36724816317;127243.72756272503;127510;129127;862.8101817599993;972.6158167523788;1007.4156988946394;1008.0675375277839;1025.6358992557684;14718.852811471748;16551.586210344838;19334.12996415193;19440.513987150436;19619.803801961796;54831.725841372136;56949.71525142348;57293.14060289182;59298.999999998276;59457.702711487895;73319;84992.57503712442;86092.56953715191;88505;90272.09727902636;6700.631465269457;8115.269625733712;8121.878171827546;8290.668373265002;8342.541160236246;11220;12980.935095324463;12994.415251313525;13156.80264796048;13443.529476468277;10943;11015.889841101487;11189.88810111921;11200.719982000515;11347.751747307955;9286.535673216447;10837.891621084003;10999.175061870232;11200.887991120311;11364.715882103013;11534.653960381202;11540.24988375753;11896.226745261876;11902.345371004332;11972.760544788882;7992.480488768211;8184.508929464251;8294;8381.371397145116;8395.538245396561;10285.382877027403;11181.440927953407;11365.977062064454;11531.250468719507;11681.591144309908 14:10:16 INFO - PROCESS | 2164 | |3;mootools.html;1432.298173894792;1444.5233073085878;1487.576040828364;1611.0897343001204;1660;7499.212582678809;7742;8050.718224862131;8397.58012099395;8582.570871456433;7986.682197437431;8241.917580824205;8302.54336011519;8397.53813540255;8470.830583388328;2301.424643839036;2338.5907466193435;2347.85912845229;2348.53029394121;2361.114582031738;2330.5222429402015;2369.2418426103654;2375.9881200593973;2379.3813608461837;2381.5951288281035;2317.7102862142233;2323.9535209295805;2348.0607756897207;2348.412896775806;2357.0571771291447;2305.8040066594276;2316.652502124678;2329.3827135809024;2340.777626125524;2345.7419683834764;2283.486215601493;2349.659299401594;2350.788429041377;2359.622460406327;2360.5160942006846;7606.163322034572;8049.1950804919625;8397.748067557983;8400.83198336036;8505.192006759347;5083.593312535026;5084.44071152173;5193.584513238932;5245.79016839326;5268.078086334876;2879.1506505580696;3130.780845340827;3526.4357702767434;3540.5751309842985;3620.348337299285;978.6819283732744;1025.5590096258607;1088.4829705889717;1096.7203363142428;1113.5156207049959;9307.16235538798;9898.505074746306;10928.945355273252;11006.944965275203;11038.834417483664;4529.524399937959;4624.745638989888;4707.929381059287;4736.8105275788585;4783.354247176656;9466.053394660617;9551.235901128031;9566.66516671913;9583.185429238592;9598;5256.1327380982475;5259.973700131475;5260.631755777059;5260.92108618371;5267.947320526822;4285.0358669299785;4308;4747.382840230748;4813.542713442217;4830.058138662997;3837.0407398150464;3878.3988481784804;3938.8030598470536;3960.861369852041;3964.147708242742;1280.8334916460801;1281.128832393981;1288.7358091591202;1296.3064760353166;1300.9154404963647;746.2723844251811;853.5007020892847;905.7011186308503;913.6893456224915;915.6657819895823;5568.693721845338;5667.008273552112;5668.8866222675315;5682.715864206773;5898.528117750569;913.7761248494162;953.4803532074897;978.3396207559869;981.66623348062;983.955721992512;3766.453864189677;3842.269968705937;3882.145927895858;3904.2581909437117;3906.316394630985;10044.497775111215;10364;10424.5830166794;10439.37363758177;10481.580736770444;10376.481175941173;10390.636327728493;10401.739956501147;10404.5838166474;10424.322419042737;6898.965505172542;7883.408744344197;7885.5662938538935;7895.131535531202;8011;5748.338941021836;5772.451617096369;5863.648181109147;5903.350631430625;5913.319968203712;9264.305177111879;9459.38513996588;9492.95253523728;9567.043295670655;9626.422414655142;9624.75938101525;9635.951820240854;9657.71026869195;9791.706248812547;9807.705768826947;6623.602583844985;6892.276310987475;7033.015377847003;7204.063471748639;7371.299726525972;7726.227377262228;7792.2986931176465;7817.570033648204;7824.765257042298;7827.45207835446;6037;6916.827079323057;7042.295770422917;7118.430525558047;7167.175774785758;6964;6977.8255543609785;6980.930190698231;6984.336488033832;7013.614251216028;6584.572002819801;6740.797776066725;6811.352921472452;6856.24581296067;6904.792856214322;3704.8329776120436;4149.647279981235;4191.392248123944;4219.599138081878;4240.809163587584;4962.776675049559;4964.478729733326;4990.326305948651;4997.700137991732;5056.6713163644245 14:10:16 INFO - PROCESS | 2164 | |4;prototype.html;292.6429755698049;300.79696205061583;308.68051566628543;313.3810723820455;315.5818540433926;4468.581535125623;5171.689698618081;5380.273663055486;5432.75552600133;5510.531604813591;4709;5310.07073762091;5347.25138480613;5383.842473868118;5395.838124856261;3619.5567991605626;3831.9233615327676;3949.743266687656;4037.919241615166;4084;3435.3472840160416;4107.691923105764;4127.195196936598;4130.545639979599;4150.896227594304;3574.749767516275;4134.958650413488;4138.896527586804;4151.958480415203;4151.965536886919;3788.337041017811;4041.1715598302276;4057.2494088593407;4120;4212.283911734997;2778.652668416448;2901.5792710057135;3489.6270536035486;3498.169504392686;3503.2643144939593;5233.188855727369;5237.738113094369;5246.921296180561;5259.316288882459;5290.523852853262;4104.630583247522;4337.956620433787;4646.628269738413;4651.2557990721325;4665.393498845128;4452.977735111336;4768.2370820668875;5404.378496472917;5483.820978489604;5735.311762588474;3758.8762349272574;3833.7316387852584;3843.903902402434;3865.4201869719486;3883.669888059518;5594;6051.878962420727;6070.180525629028;6085.117657939574;6168.797084568511;3300.5379246905454;3793.696504279651;3867.5165604299464;3888.811174836607;3901.668358189529;3497.8251087445524;3934.8555037504057;3955.3869150281753;3960.5643379228263;3986.3023970804993;3767.547894252707;3930.587288334741;3981.5023122109737;4604.493505714436;4639.953600463952;4542.636589072932;4606.815727370935;4989.777504511418;5253.474652534716;5592.664440133605;1273.4269578689627;1274.6367285323824;1277.393238211842;1277.4762347437506;1286.5239861251398;785.5600863516449;804.5494523067101;826.3348004856149;866.9566521674017;873.5544872115267;4266.402703621496;5197.506236907488;5397.220431477792;5453.454654534515;5467.835964921059;5392.541633961078;5476.288082549243;5934.673592952343;5956.255468066492;5959.374265702126;4775.617950563947;4974.388446065772;5131.999260144311;5406.864558442771;5445.467857446307;2909.3163106669917;2981.22745846365;2993.8593905357775;3000.3099287164073;3000.489916714164;4978.166811555082;5867.391554194225;5886.735096920649;5888.026546593943;5962.522998160137;5053.140966035783;5185.844424667266;5535.612507124462;5551.139573366135;5562.582806289544;5013.523715247045;5109.463506331856;5679.267823313847;5787.739551720267;5906.114082887515;4635.49009608936;4676.46220684612;4940.505949405175;5657.830265092054;5741.224934633771;4763.333133361263;5347.438518955453;5373.731313434391;5564.304461942257;5614.550835933034;5535.474129957647;5869.4717475427415;5928.584999050025;5933;5963.552733545088;3236.385086833494;3493.318802833423;3698.519192504957;3819.4461803038957;3882.204148149566;5274.7098909560345;5545.445455454423;5571.415001424792;5589.860253493695;5634.74576694593;4748.50422117032;4945.876353091057;5426;5447.066291466631;5512.747478987257;4807.230843065093;4844.442889067803;5088.295421033995;5148.613853961043;5399.352077750695;4696.506866778939;4732.455767586634;5292.792230176941;5300.814471493479;5315.3621565412395;5431.728413579384;5548.583856210719;5600.243967064394;5700.600957932905;5724.137931034483;5029.371328583927;5351.866203344792;5508.44915508446;5563.860903477445;5586.413426590149 14:10:16 INFO - PROCESS | 2164 | |5;yui.html;663.1677245057452;681.8159097043801;724.9347558719714;746;770.9190534993826;11926.522939082437;14795.038322509043;14799.704005919903;14805.481808136718;14825.332860021297;13208.471661133568;13264.867351326484;13272.270025148613;13355.599332020054;13376.130551514168;650.6974256970495;685.2154283345566;810.0320117459638;843.4180415513307;856.3149480415674;834.8205135895781;846.9195426434479;848.3594885861197;849.5454931611589;855.8331125430543;894.463322006794;895.3150839607705;895.852184389575;901.3735453859571;905.5698543191997;894.8970868350158;896.1576118448637;899.2626046641724;899.7660608241839;900.5092224737468;663.3697986912453;665.820228538292;667.562746401108;670.1723371636026;672.2302963107263;13586.320683965761;13662.453501859914;13860.653483662889;13865.37605807731;14331.355089021019;13465;13716.794248086288;13718.519851805138;13899.444022239099;13947.071115065848;11141.888581114166;11226.943865280622;11326;11330.886691133148;11425.942870285679;3499.9300013999577;3629;3684.318401095779;3691.151035261878;3736.794476303802;83938.58030709808;85673.14326856776;88283;89026.5548672259;89478.55260723655;10369.637062702921;10480.371177729361;10504.212184086224;10531.473426328654;10544.683659490227;20983.580328393346;21284.680729789066;21296.361109166748;21430.892845535986;21526.138954441645;7374.151972523228;7503.849923001619;7604.049493813273;7774.805629859299;7809.45333826638;4118.382242663624;4128.153728485653;4174.645155161785;4212;4234.513031001475;3287.1289108386295;3393.30437260366;3395.1172695099453;3398.694117529434;3403.863845446204;601.8916595012852;634.4543692424511;637.388107416885;639.7504973060417;658.9472842172614;630.9179806625109;642.7631841192675;654.9181352330959;660.6201434175368;673.3838537737915;8328.507239141289;8877.73366798997;8910.153535414125;9228.26173906086;9280.95359523198;576.4437317988162;608.458471959956;635.4408120853711;654.4077609763171;671.7078071039114;4280.122574872144;4301.204277208726;4543.864033991502;4544.113897789899;4551.840685576055;122582.38708806399;124422;124515.13227301597;127841;128394;65974;69042;103414.48292758488;109138.45430772795;111532.32701509484;89878;90485.09514904898;91339.5433022844;91690;93896;9487.620495180116;9621.230301575717;9671.661491847752;9684.41893486393;9765.80468390614;51023.48976510188;52555.73722131365;52843.47156528539;58909;59833.70083149557;69922.65038674774;80423;82180;83778.58110709651;84717.57641211755;12004.159708820298;12382.257064576153;12383.442745076673;12399.876001240233;12766.361681916052;13647.931760341531;14050.648733781738;14112.435502580192;14170.645733856736;14242.145471271757;12559.434825432694;12843.40761720213;12930.224186548838;13089.214647121204;13300.467981281028;12930.547430840252;13125.803112953505;13193.406296716863;13235.933820331222;13691.589252322447;12637.398147641856;12769.489220431078;13021.47914083426;13146.014048946176;13561.79657305161;10866.07638350749;11053.723656908642;11241.887581124083;11402.315861048364;11566.65300041;9555.952220238854;11280.32318060919;11482.77034459323;11592.188546801643;11624.302541847515 14:10:16 INFO - PROCESS | 2164 | __end_tp_report 14:10:16 INFO - PROCESS | 2164 | __start_cc_report 14:10:16 INFO - PROCESS | 2164 | _x_x_mozilla_cycle_collect,374 14:10:16 INFO - PROCESS | 2164 | __end_cc_report 14:10:16 INFO - PROCESS | 2164 | __startTimestamp1484950216669__endTimestamp 14:10:16 INFO - PROCESS | 2164 | 14:10:16 INFO - PROCESS | 2164 | ------- Summary: start ------- 14:10:16 INFO - PROCESS | 2164 | Number of tests: 6 14:10:16 INFO - PROCESS | 2164 | 14:10:16 INFO - PROCESS | 2164 | [#0] dojo.html Cycles:165 Average:5776.65 Median:5934.90 stddev:640.09 (10.8%) stddev-sans-first:607.84 14:10:16 INFO - PROCESS | 2164 | Values: 3144.3 3376.0 3403.2 3416.1 3455.9 5716.3 5753.4 5773.0 5825.9 5861.6 5759.4 5852.2 5862.1 5880.1 5896.4 5295.2 5303.2 5323.5 5343.4 5368.8 5376.4 5400.9 5402.4 5404.0 5405.5 5226.7 5236.9 5338.9 5383.4 5387.8 5301.3 5328.8 5369.5 5400.2 5488.3 5215.8 5335.1 5350.9 5370.5 5417.3 5593.5 5865.6 5905.4 5927.5 5932.1 6123.5 6205.3 6211.1 6212.1 6256.3 6230.2 6288.6 6295.0 6341.1 6353.1 5906.9 5913.7 5929.9 5934.9 5972.7 6222.9 6258.5 6289.4 6318.0 6350.2 6137.1 6220.4 6230.6 6237.7 6245.6 6309.5 6328.4 6329.3 6344.3 6366.6 4794.3 6007.4 6147.9 6258.2 6337.7 6193.6 6231.1 6295.6 6308.6 6318.0 4976.5 5004.8 5006.9 5007.8 5008.3 4358.9 4405.2 4446.8 4485.4 4513.4 5649.7 5808.4 5809.1 5904.3 5946.2 5747.2 6277.8 6323.1 6325.2 6344.0 5715.8 5792.0 5856.6 5859.4 5871.5 5458.4 5506.6 5526.3 5538.3 5539.8 6426.0 6429.0 6429.2 6432.9 6435.7 6121.1 6191.8 6223.7 6281.3 6324.0 5048.0 5075.9 5300.2 6272.8 6294.7 5193.8 5700.0 6286.5 6291.2 6319.1 5455.3 6140.8 6317.9 6320.8 6339.0 6098.7 6114.0 6132.9 6145.8 6180.0 6149.9 6167.7 6221.8 6253.8 6264.8 5970.8 6080.7 6087.3 6118.8 6144.2 5402.7 5829.9 6047.2 6113.4 6214.8 6085.7 6090.7 6098.1 6119.1 6119.8 14:10:16 INFO - PROCESS | 2164 | 14:10:16 INFO - PROCESS | 2164 | [#1] ext.html Cycles:180 Average:70166.59 Median:38689.52 stddev:155955.91 (403.1%) stddev-sans-first:156305.60 14:10:16 INFO - PROCESS | 2164 | Values: 464.6 474.5 482.4 509.0 516.5 29249.8 32277.5 38593.0 39557.6 39736.0 41014.8 41342.8 41357.8 41362.6 41389.0 9259.1 9426.7 9432.7 9443.5 9480.3 9357.4 9466.6 9484.9 9497.2 9505.0 9434.7 9451.1 9462.3 9501.3 9507.9 9310.3 9398.4 9433.8 9462.7 9474.9 9237.1 9297.7 9341.0 9367.9 9368.3 31529.4 38086.8 38331.8 38474.8 38520.0 3159.4 3268.4 3334.7 3383.7 3408.9 19497.9 25018.9 28740.0 29289.1 30045.0 3179.7 3205.4 3214.7 3223.6 3245.8 491985.0 497696.0 498082.0 498992.5 501030.0 60229.0 60474.7 60660.7 60932.1 61059.0 51768.7 61617.1 62026.0 62642.4 62778.7 15480.6 15986.4 16133.6 16188.5 16207.0 12280.8 12388.8 12525.4 12538.5 12614.6 18174.0 18565.4 18581.8 18583.0 18585.0 7428.5 7540.8 7630.5 7717.9 7720.8 844.4 954.5 990.5 1082.5 1128.7 23704.2 24351.6 27726.9 29613.6 29772.3 917.6 1020.4 1033.8 1086.1 1114.8 15032.0 15413.5 15444.4 15485.1 15532.9 677438.0 680407.0 681101.0 684082.0 684406.0 55360.0 55765.2 56058.4 56181.0 56190.9 1358.8 1372.7 1382.5 1384.8 1384.9 28372.4 28474.4 29170.3 29318.0 29490.7 47867.5 48021.8 48273.3 48377.3 48411.8 551838.0 552582.0 553160.0 554069.0 554950.0 25817.5 26033.2 26211.9 26231.6 26261.2 44575.0 44711.0 44989.8 45747.8 46030.8 37342.0 37665.6 37795.8 38786.0 38857.2 37158.4 37241.1 37555.0 38379.0 38559.8 37070.0 37334.8 37801.9 37869.0 39219.8 31115.9 34200.8 34504.7 34533.5 34586.7 25521.7 25613.4 25731.1 25761.9 25938.0 14:10:16 INFO - PROCESS | 2164 | 14:10:16 INFO - PROCESS | 2164 | [#2] jquery.html Cycles:180 Average:33351.56 Median:1493.71 stddev:91543.57 (6128.6%) stddev-sans-first:91766.80 14:10:16 INFO - PROCESS | 2164 | Values: 329.9 367.8 370.5 386.7 402.0 15006.9 18904.0 20022.6 20050.3 20266.7 17366.3 19466.7 19822.6 20423.7 20897.5 5774.9 5803.7 6046.0 6047.8 6076.8 5752.3 5858.0 5899.0 5941.1 5941.8 5745.8 5817.1 5862.9 5896.8 5913.9 5956.1 5959.6 6098.2 6105.7 6133.8 5790.7 5808.9 5837.2 5871.5 5905.3 12888.1 13037.9 13084.0 15262.0 24230.5 2132.4 2239.4 2341.8 2358.6 2657.5 9754.2 9926.6 9956.0 10159.9 10476.9 1834.4 1884.1 1889.0 1901.7 1936.5 110915.0 114027.4 115660.3 117087.4 117459.0 9375.0 11463.9 11791.9 11829.3 11981.3 14669.0 14694.3 14699.3 14703.9 14746.2 7714.8 7757.0 8492.4 8495.7 8505.2 8340.8 8345.5 8386.9 8482.9 8513.4 3960.5 4230.1 4548.5 4556.7 4578.5 1895.4 1941.3 1988.6 1993.7 1995.6 818.4 909.3 934.6 947.0 974.5 20135.6 21160.4 21190.0 21271.7 21509.1 821.4 895.8 900.7 917.1 946.5 9350.0 9842.6 10731.6 11333.5 11376.5 537818.0 543518.0 543708.0 550235.0 550372.0 114078.0 126550.4 127243.7 127510.0 129127.0 862.8 972.6 1007.4 1008.1 1025.6 14718.9 16551.6 19334.1 19440.5 19619.8 54831.7 56949.7 57293.1 59299.0 59457.7 73319.0 84992.6 86092.6 88505.0 90272.1 6700.6 8115.3 8121.9 8290.7 8342.5 11220.0 12980.9 12994.4 13156.8 13443.5 10943.0 11015.9 11189.9 11200.7 11347.8 9286.5 10837.9 10999.2 11200.9 11364.7 11534.7 11540.2 11896.2 11902.3 11972.8 7992.5 8184.5 8294.0 8381.4 8395.5 10285.4 11181.4 11366.0 11531.3 11681.6 14:10:16 INFO - PROCESS | 2164 | 14:10:16 INFO - PROCESS | 2164 | [#3] mootools.html Cycles:180 Average:5457.99 Median:5250.96 stddev:2999.02 (57.1%) stddev-sans-first:2992.18 14:10:16 INFO - PROCESS | 2164 | Values: 1432.3 1444.5 1487.6 1611.1 1660.0 7499.2 7742.0 8050.7 8397.6 8582.6 7986.7 8241.9 8302.5 8397.5 8470.8 2301.4 2338.6 2347.9 2348.5 2361.1 2330.5 2369.2 2376.0 2379.4 2381.6 2317.7 2324.0 2348.1 2348.4 2357.1 2305.8 2316.7 2329.4 2340.8 2345.7 2283.5 2349.7 2350.8 2359.6 2360.5 7606.2 8049.2 8397.7 8400.8 8505.2 5083.6 5084.4 5193.6 5245.8 5268.1 2879.2 3130.8 3526.4 3540.6 3620.3 978.7 1025.6 1088.5 1096.7 1113.5 9307.2 9898.5 10928.9 11006.9 11038.8 4529.5 4624.7 4707.9 4736.8 4783.4 9466.1 9551.2 9566.7 9583.2 9598.0 5256.1 5260.0 5260.6 5260.9 5267.9 4285.0 4308.0 4747.4 4813.5 4830.1 3837.0 3878.4 3938.8 3960.9 3964.1 1280.8 1281.1 1288.7 1296.3 1300.9 746.3 853.5 905.7 913.7 915.7 5568.7 5667.0 5668.9 5682.7 5898.5 913.8 953.5 978.3 981.7 984.0 3766.5 3842.3 3882.1 3904.3 3906.3 10044.5 10364.0 10424.6 10439.4 10481.6 10376.5 10390.6 10401.7 10404.6 10424.3 6899.0 7883.4 7885.6 7895.1 8011.0 5748.3 5772.5 5863.6 5903.4 5913.3 9264.3 9459.4 9493.0 9567.0 9626.4 9624.8 9636.0 9657.7 9791.7 9807.7 6623.6 6892.3 7033.0 7204.1 7371.3 7726.2 7792.3 7817.6 7824.8 7827.5 6037.0 6916.8 7042.3 7118.4 7167.2 6964.0 6977.8 6980.9 6984.3 7013.6 6584.6 6740.8 6811.4 6856.2 6904.8 3704.8 4149.6 4191.4 4219.6 4240.8 4962.8 4964.5 4990.3 4997.7 5056.7 14:10:16 INFO - PROCESS | 2164 | 14:10:16 INFO - PROCESS | 2164 | [#4] prototype.html Cycles:180 Average:4472.26 Median:5001.65 stddev:1382.85 (27.6%) stddev-sans-first:1350.68 14:10:16 INFO - PROCESS | 2164 | Values: 292.6 300.8 308.7 313.4 315.6 4468.6 5171.7 5380.3 5432.8 5510.5 4709.0 5310.1 5347.3 5383.8 5395.8 3619.6 3831.9 3949.7 4037.9 4084.0 3435.3 4107.7 4127.2 4130.5 4150.9 3574.7 4135.0 4138.9 4152.0 4152.0 3788.3 4041.2 4057.2 4120.0 4212.3 2778.7 2901.6 3489.6 3498.2 3503.3 5233.2 5237.7 5246.9 5259.3 5290.5 4104.6 4338.0 4646.6 4651.3 4665.4 4453.0 4768.2 5404.4 5483.8 5735.3 3758.9 3833.7 3843.9 3865.4 3883.7 5594.0 6051.9 6070.2 6085.1 6168.8 3300.5 3793.7 3867.5 3888.8 3901.7 3497.8 3934.9 3955.4 3960.6 3986.3 3767.5 3930.6 3981.5 4604.5 4640.0 4542.6 4606.8 4989.8 5253.5 5592.7 1273.4 1274.6 1277.4 1277.5 1286.5 785.6 804.5 826.3 867.0 873.6 4266.4 5197.5 5397.2 5453.5 5467.8 5392.5 5476.3 5934.7 5956.3 5959.4 4775.6 4974.4 5132.0 5406.9 5445.5 2909.3 2981.2 2993.9 3000.3 3000.5 4978.2 5867.4 5886.7 5888.0 5962.5 5053.1 5185.8 5535.6 5551.1 5562.6 5013.5 5109.5 5679.3 5787.7 5906.1 4635.5 4676.5 4940.5 5657.8 5741.2 4763.3 5347.4 5373.7 5564.3 5614.6 5535.5 5869.5 5928.6 5933.0 5963.6 3236.4 3493.3 3698.5 3819.4 3882.2 5274.7 5545.4 5571.4 5589.9 5634.7 4748.5 4945.9 5426.0 5447.1 5512.7 4807.2 4844.4 5088.3 5148.6 5399.4 4696.5 4732.5 5292.8 5300.8 5315.4 5431.7 5548.6 5600.2 5700.6 5724.1 5029.4 5351.9 5508.4 5563.9 5586.4 14:10:16 INFO - PROCESS | 2164 | 14:10:16 INFO - PROCESS | 2164 | [#5] yui.html Cycles:180 Average:21279.90 Median:4223.26 stddev:31998.21 (757.7%) stddev-sans-first:32050.53 14:10:16 INFO - PROCESS | 2164 | Values: 663.2 681.8 724.9 746.0 770.9 11926.5 14795.0 14799.7 14805.5 14825.3 13208.5 13264.9 13272.3 13355.6 13376.1 650.7 685.2 810.0 843.4 856.3 834.8 846.9 848.4 849.5 855.8 894.5 895.3 895.9 901.4 905.6 894.9 896.2 899.3 899.8 900.5 663.4 665.8 667.6 670.2 672.2 13586.3 13662.5 13860.7 13865.4 14331.4 13465.0 13716.8 13718.5 13899.4 13947.1 11141.9 11226.9 11326.0 11330.9 11425.9 3499.9 3629.0 3684.3 3691.2 3736.8 83938.6 85673.1 88283.0 89026.6 89478.6 10369.6 10480.4 10504.2 10531.5 10544.7 20983.6 21284.7 21296.4 21430.9 21526.1 7374.2 7503.8 7604.0 7774.8 7809.5 4118.4 4128.2 4174.6 4212.0 4234.5 3287.1 3393.3 3395.1 3398.7 3403.9 601.9 634.5 637.4 639.8 658.9 630.9 642.8 654.9 660.6 673.4 8328.5 8877.7 8910.2 9228.3 9281.0 576.4 608.5 635.4 654.4 671.7 4280.1 4301.2 4543.9 4544.1 4551.8 122582.4 124422.0 124515.1 127841.0 128394.0 65974.0 69042.0 103414.5 109138.5 111532.3 89878.0 90485.1 91339.5 91690.0 93896.0 9487.6 9621.2 9671.7 9684.4 9765.8 51023.5 52555.7 52843.5 58909.0 59833.7 69922.7 80423.0 82180.0 83778.6 84717.6 12004.2 12382.3 12383.4 12399.9 12766.4 13647.9 14050.6 14112.4 14170.6 14242.1 12559.4 12843.4 12930.2 13089.2 13300.5 12930.5 13125.8 13193.4 13235.9 13691.6 12637.4 12769.5 13021.5 13146.0 13561.8 10866.1 11053.7 11241.9 11402.3 11566.7 9556.0 11280.3 11482.8 11592.2 11624.3 14:10:16 INFO - PROCESS | 2164 | -------- Summary: end -------- 14:10:16 INFO - PROCESS | 2164 | 14:10:17 INFO - TEST-INFO | 2164: exit 0 14:10:17 INFO - TEST-OK | dromaeo_css | took 1116013ms 14:10:17 INFO - TEST-START | kraken 14:10:17 INFO - operating with platform_type : mac_ 14:10:17 INFO - Initialising browser for kraken test... 14:10:17 INFO - TEST-INFO | started process 2168 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpSUTYJo/profile http://localhost:54164/getInfo.html) 14:10:20 INFO - PROCESS | 2168 | 2017-01-20 14:10:20.238 plugin-container[2169:23099] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 14:10:20 INFO - PROCESS | 2168 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:20 INFO - PROCESS | 2168 | 2017-01-20 14:10:20.241 plugin-container[2169:23099] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 14:10:20 INFO - PROCESS | 2168 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:20 INFO - PROCESS | 2168 | 2017-01-20 14:10:20.241 plugin-container[2169:23099] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:10:20 INFO - PROCESS | 2168 | __metrics Screen width/height:1600/1200 14:10:20 INFO - PROCESS | 2168 | colorDepth:24 14:10:20 INFO - PROCESS | 2168 | Browser inner width/height: 1024/689 14:10:20 INFO - PROCESS | 2168 | __metrics 14:10:20 ERROR - PROCESS | 2168 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 14:10:21 INFO - TEST-INFO | 2168: exit 0 14:10:21 INFO - Browser initialized. 14:10:21 INFO - Running cycle 1/1 for kraken test... 14:10:21 INFO - TEST-INFO | started process 2170 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpSUTYJo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:24 INFO - PROCESS | 2170 | 2017-01-20 14:10:24.000 plugin-container[2171:23225] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8437, name = 'com.apple.tsm.portname' 14:10:24 INFO - PROCESS | 2170 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:24 INFO - PROCESS | 2170 | 2017-01-20 14:10:24.001 plugin-container[2171:23225] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x432b, name = 'com.apple.CFPasteboardClient' 14:10:24 INFO - PROCESS | 2170 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:24 INFO - PROCESS | 2170 | 2017-01-20 14:10:24.001 plugin-container[2171:23225] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:10:33 INFO - PROCESS | 2170 | RSS: Main: 229052416 14:10:33 INFO - PROCESS | 2170 | 14:10:36 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54164/tests/kraken/driver.html?testName=audio-beat-detection) 14:10:37 INFO - PROCESS | 2170 | RSS: Main: 241405952 14:10:37 INFO - PROCESS | 2170 | 14:10:39 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54164/tests/kraken/driver.html?testName=audio-dft) 14:10:40 INFO - PROCESS | 2170 | RSS: Main: 249503744 14:10:40 INFO - PROCESS | 2170 | 14:10:44 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54164/tests/kraken/driver.html?testName=audio-fft) 14:10:44 INFO - PROCESS | 2170 | RSS: Main: 251465728 14:10:44 INFO - PROCESS | 2170 | 14:10:46 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54164/tests/kraken/driver.html?testName=audio-oscillator) 14:10:47 INFO - PROCESS | 2170 | RSS: Main: 254054400 14:10:47 INFO - PROCESS | 2170 | 14:10:49 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54164/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:10:49 INFO - PROCESS | 2170 | RSS: Main: 254582784 14:10:49 INFO - PROCESS | 2170 | 14:10:52 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54164/tests/kraken/driver.html?testName=imaging-darkroom) 14:10:53 INFO - PROCESS | 2170 | RSS: Main: 258338816 14:10:53 INFO - PROCESS | 2170 | 14:10:56 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54164/tests/kraken/driver.html?testName=imaging-desaturate) 14:10:57 INFO - PROCESS | 2170 | RSS: Main: 257945600 14:10:57 INFO - PROCESS | 2170 | 14:11:00 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54164/tests/kraken/driver.html?testName=json-parse-financial) 14:11:00 INFO - PROCESS | 2170 | RSS: Main: 258355200 14:11:00 INFO - PROCESS | 2170 | 14:11:02 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54164/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:03 INFO - PROCESS | 2170 | RSS: Main: 257138688 14:11:03 INFO - PROCESS | 2170 | 14:11:05 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:05 INFO - PROCESS | 2170 | RSS: Main: 257175552 14:11:05 INFO - PROCESS | 2170 | 14:11:07 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:08 INFO - PROCESS | 2170 | RSS: Main: 257175552 14:11:08 INFO - PROCESS | 2170 | 14:11:11 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:12 INFO - PROCESS | 2170 | RSS: Main: 257445888 14:11:12 INFO - PROCESS | 2170 | 14:11:15 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:16 INFO - PROCESS | 2170 | RSS: Main: 257634304 14:11:16 INFO - PROCESS | 2170 | 14:11:17 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54164/tests/kraken/driver.html?testName=ai-astar) 14:11:18 INFO - PROCESS | 2170 | RSS: Main: 259444736 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | __start_tp_report 14:11:18 INFO - PROCESS | 2170 | _x_x_mozilla_page_load 14:11:18 INFO - PROCESS | 2170 | _x_x_mozilla_page_load_details 14:11:18 INFO - PROCESS | 2170 | |i|pagename|runs| 14:11:18 INFO - PROCESS | 2170 | |0;ai-astar;115;117;118;118;127;104;175;174;176;120 14:11:18 INFO - PROCESS | 2170 | |1;audio-beat-detection;145;115;114;148;124;119;113;112;142;127 14:11:18 INFO - PROCESS | 2170 | |2;audio-dft;200;194;198;207;256;285;198;275;280;204 14:11:18 INFO - PROCESS | 2170 | |3;audio-fft;84;59;60;85;60;59;59;60;80;61 14:11:18 INFO - PROCESS | 2170 | |4;audio-oscillator;86;69;87;73;70;71;86;69;73;88 14:11:18 INFO - PROCESS | 2170 | |5;imaging-gaussian-blur;88;86;88;105;112;103;92;77;93;87 14:11:18 INFO - PROCESS | 2170 | |6;imaging-darkroom;158;124;100;100;112;130;106;166;135;119 14:11:18 INFO - PROCESS | 2170 | |7;imaging-desaturate;119;139;87;97;137;91;95;91;140;121 14:11:18 INFO - PROCESS | 2170 | |8;json-parse-financial;54;57;57;58;59;61;59;60;60;61 14:11:18 INFO - PROCESS | 2170 | |9;json-stringify-tinderbox;68;76;72;88;62;69;82;107;103;74 14:11:18 INFO - PROCESS | 2170 | |10;stanford-crypto-aes;102;86;85;83;88;88;84;87;85;85 14:11:18 INFO - PROCESS | 2170 | |11;stanford-crypto-ccm;150;160;131;142;149;160;148;156;229;165 14:11:18 INFO - PROCESS | 2170 | |12;stanford-crypto-pbkdf2;186;173;167;174;169;170;173;199;238;197 14:11:18 INFO - PROCESS | 2170 | |13;stanford-crypto-sha256-iterative;71;71;68;70;69;66;71;72;67;71 14:11:18 INFO - PROCESS | 2170 | __end_tp_report 14:11:18 INFO - PROCESS | 2170 | __start_cc_report 14:11:18 INFO - PROCESS | 2170 | _x_x_mozilla_cycle_collect,959 14:11:18 INFO - PROCESS | 2170 | __end_cc_report 14:11:18 INFO - PROCESS | 2170 | __startTimestamp1484950278110__endTimestamp 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | ------- Summary: start ------- 14:11:18 INFO - PROCESS | 2170 | Number of tests: 14 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#0] ai-astar Cycles:10 Average:134.40 Median:123.50 stddev:28.58 (23.1%) stddev-sans-first:29.44 14:11:18 INFO - PROCESS | 2170 | Values: 115.0 117.0 118.0 118.0 127.0 104.0 175.0 174.0 176.0 120.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:125.50 stddev:14.08 (11.2%) stddev-sans-first:13.13 14:11:18 INFO - PROCESS | 2170 | Values: 145.0 115.0 114.0 148.0 124.0 119.0 113.0 112.0 142.0 127.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#2] audio-dft Cycles:10 Average:229.70 Median:231.50 stddev:38.98 (16.8%) stddev-sans-first:39.83 14:11:18 INFO - PROCESS | 2170 | Values: 200.0 194.0 198.0 207.0 256.0 285.0 198.0 275.0 280.0 204.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#3] audio-fft Cycles:10 Average:66.70 Median:60.50 stddev:11.33 (18.7%) stddev-sans-first:10.15 14:11:18 INFO - PROCESS | 2170 | Values: 84.0 59.0 60.0 85.0 60.0 59.0 59.0 60.0 80.0 61.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.50 stddev:8.35 (10.5%) stddev-sans-first:8.23 14:11:18 INFO - PROCESS | 2170 | Values: 86.0 69.0 87.0 73.0 70.0 71.0 86.0 69.0 73.0 88.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:87.50 stddev:10.52 (12.0%) stddev-sans-first:11.00 14:11:18 INFO - PROCESS | 2170 | Values: 88.0 86.0 88.0 105.0 112.0 103.0 92.0 77.0 93.0 87.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#6] imaging-darkroom Cycles:10 Average:125.00 Median:127.00 stddev:22.88 (18.0%) stddev-sans-first:20.92 14:11:18 INFO - PROCESS | 2170 | Values: 158.0 124.0 100.0 100.0 112.0 130.0 106.0 166.0 135.0 119.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#7] imaging-desaturate Cycles:10 Average:111.70 Median:89.00 stddev:21.83 (24.5%) stddev-sans-first:22.99 14:11:18 INFO - PROCESS | 2170 | Values: 119.0 139.0 87.0 97.0 137.0 91.0 95.0 91.0 140.0 121.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:59.50 stddev:2.17 (3.6%) stddev-sans-first:1.54 14:11:18 INFO - PROCESS | 2170 | Values: 54.0 57.0 57.0 58.0 59.0 61.0 59.0 60.0 60.0 61.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#9] json-stringify-tinderbox Cycles:10 Average:80.10 Median:73.00 stddev:15.02 (20.6%) stddev-sans-first:15.28 14:11:18 INFO - PROCESS | 2170 | Values: 68.0 76.0 72.0 88.0 62.0 69.0 82.0 107.0 103.0 74.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:85.50 stddev:5.42 (6.3%) stddev-sans-first:1.73 14:11:18 INFO - PROCESS | 2170 | Values: 102.0 86.0 85.0 83.0 88.0 88.0 84.0 87.0 85.0 85.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#11] stanford-crypto-ccm Cycles:10 Average:159.00 Median:158.00 stddev:26.50 (16.8%) stddev-sans-first:27.91 14:11:18 INFO - PROCESS | 2170 | Values: 150.0 160.0 131.0 142.0 149.0 160.0 148.0 156.0 229.0 165.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.60 Median:180.00 stddev:22.02 (12.2%) stddev-sans-first:23.35 14:11:18 INFO - PROCESS | 2170 | Values: 186.0 173.0 167.0 174.0 169.0 170.0 173.0 199.0 238.0 197.0 14:11:18 INFO - PROCESS | 2170 | 14:11:18 INFO - PROCESS | 2170 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:71.00 stddev:2.01 (2.8%) stddev-sans-first:2.07 14:11:18 INFO - PROCESS | 2170 | Values: 71.0 71.0 68.0 70.0 69.0 66.0 71.0 72.0 67.0 71.0 14:11:18 INFO - PROCESS | 2170 | -------- Summary: end -------- 14:11:18 INFO - PROCESS | 2170 | 14:11:19 INFO - TEST-INFO | 2170: exit 0 14:11:19 INFO - TEST-OK | kraken | took 62004ms 14:11:19 INFO - SUITE-END | took 1178s 14:11:19 INFO - Completed test suite (00:19:38) 14:11:19 INFO - javascript benchmark 14:11:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7193.918382515525, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3144.2768163322435, 3376.0378292186733, 3403.1662242750513, 3416.0947348952545, 3455.8617655293797, 5716.28546431696, 5753.4246575342495, 5772.971135144329, 5825.912611310834, 5861.589688721791, 5759.424057594239, 5852.209951656536, 5862.149988251701, 5880.059190529505, 5896.351401345849, 5295.179247216687, 5303.23103150043, 5323.494268044549, 5343.358796944372, 5368.812091576796, 5376.4085950545405, 5400.91898621521, 5402.405735369106, 5404.0, 5405.486478784529, 5226.712530810804, 5236.92144617831, 5338.946610533903, 5383.353997520284, 5387.78448862045, 5301.3108295921475, 5328.786848526035, 5369.543588794957, 5400.189971504266, 5488.286522752057, 5215.843524694227, 5335.146376579729, 5350.892982140374, 5370.489803468703, 5417.26866872975, 5593.468620481089, 5865.632945854538, 5905.379935106838, 5927.466528012456, 5932.050871860525, 6123.496151642696, 6205.348438413992, 6211.130441738161, 6212.099245609361, 6256.311805701369, 6230.190075290228, 6288.622682639057, 6295.0, 6341.143945567335, 6353.078803573456, 5906.852328691817, 5913.733881975321, 5929.881402371929, 5934.898256754265, 5972.671503067373, 6222.875542489125, 6258.530610204253, 6289.40250676185, 6318.0, 6350.174477318012, 6137.140800287963, 6220.409061139185, 6230.56386052981, 6237.688115594202, 6245.6252624842655, 6309.49524038085, 6328.398802113792, 6329.272133704683, 6344.302126766052, 6366.6180029198395, 4794.2808578713475, 6007.429294217042, 6147.893379191788, 6258.217722784652, 6337.683115844189, 6193.597416167935, 6231.096491008779, 6295.590786598948, 6308.589941653778, 6318.020706790455, 4976.4525902150735, 5004.84985450437, 5006.89986200274, 5007.84976450707, 5008.29883816266, 4358.934615980763, 4405.185040767404, 4446.82212711488, 4485.439320084989, 4513.413256276663, 5649.689267090267, 5808.448197421323, 5809.128630705343, 5904.321003084614, 5946.197263369476, 5747.224124743189, 6277.843053923689, 6323.08315294289, 6325.177726895474, 6343.9682801585695, 5715.828525144252, 5792.0, 5856.619319744203, 5859.384764599656, 5871.500922421556, 5458.426865179178, 5506.614536982373, 5526.253955716007, 5538.335399752055, 5539.806106786243, 6426.036094585849, 6429.00350445691, 6429.196350456193, 6432.871342573028, 6435.74257029723, 6121.148138557293, 6191.84520386994, 6223.688815559113, 6281.340459251713, 6323.9683801580695, 5047.974760126176, 5075.873103172303, 5300.2049692546425, 6272.780452684134, 6294.653794041372, 5193.792248310026, 5700.0, 6286.465650419766, 6291.245050593775, 6319.083732858618, 5455.318085239345, 6140.785072522441, 6317.936820631735, 6320.841978950563, 6339.049142628643, 6098.664573448503, 6114.0236562776045, 6132.9080063799975, 6145.832291864532, 6180.042093475518, 6149.877002459836, 6167.660778657038, 6221.782237621662, 6253.78111766086, 6264.780732674334, 5970.820875373745, 6080.665563394055, 6087.330393656605, 6118.816435506942, 6144.170536977451, 5402.702851343214, 5829.854253643693, 6047.244094488189, 6113.358097399709, 6214.844628884314, 6085.726142323518, 6090.725917333642, 6098.054801505774, 6119.143319935123, 6119.755209791559], "value": 5737.570161403281, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.5656311348889, 474.5325854033777, 482.4066398330056, 508.9896555337654, 516.5376987596102, 29249.83000679973, 32277.515837262432, 38593.0, 39557.60442395575, 39736.0, 41014.7949260254, 41342.79328603353, 41357.793211033975, 41362.58637413633, 41389.0, 9259.120383563584, 9426.717198484057, 9432.669856555021, 9443.527823608827, 9480.336376453617, 9357.39176953496, 9466.574004169828, 9484.90515094847, 9497.240220782356, 9504.95247523765, 9434.716958491223, 9451.054894510527, 9462.290328225376, 9501.287403444769, 9507.857382139238, 9310.348275620709, 9398.436093834393, 9433.811323773554, 9462.668806591737, 9474.857877131848, 9237.076292370777, 9297.67458138962, 9341.0, 9367.906320936772, 9368.34421590489, 31529.36941261162, 38086.80956595199, 38331.80834095839, 38474.80762596197, 38520.0, 3159.3839201355513, 3268.3790079884984, 3334.733221342287, 3383.6954674079207, 3408.926188250693, 19497.902510487358, 25018.874905625355, 28739.9941002066, 29289.121326360244, 30045.0, 3179.6979286967703, 3205.3909757146303, 3214.67853214679, 3223.629282632504, 3245.805251684883, 491985.0, 497696.0, 498081.9999999964, 498992.50503747247, 501030.0, 60229.0, 60474.69762651159, 60660.696696516236, 60932.08601870976, 61059.0, 51768.74115629473, 61617.075743863876, 62026.0, 62642.37357626457, 62778.68610657009, 15480.612984675474, 15986.440474583334, 16133.596660083593, 16188.514344569681, 16207.027578345336, 12280.815787763191, 12388.81416778749, 12525.43635536403, 12538.498460061677, 12614.558490452973, 18174.000429976477, 18565.44303670892, 18581.814181858277, 18583.0, 18584.97782621969, 7428.517146385576, 7540.811479713051, 7630.465867389341, 7717.922820771832, 7720.806979825437, 844.3709436469869, 954.4988880837477, 990.5146478225762, 1082.5277622433484, 1128.6524030017545, 23704.170354037527, 24351.634725479133, 27726.861365693043, 29613.555796663066, 29772.2556936074, 917.6191880369572, 1020.4030642074321, 1033.78530226983, 1086.1217772901716, 1114.8272017837248, 15032.022918510262, 15413.5375938722, 15444.382224711111, 15485.148316842457, 15532.912696111389, 677438.0, 680407.0, 681101.0, 684082.0, 684406.0, 55360.0, 55765.16352254719, 56058.43941560614, 56181.0, 56190.876182476124, 1358.809766632672, 1372.6568357910523, 1382.453930697389, 1384.8407433145317, 1384.9446022159, 28372.43255134927, 28474.43051138924, 29170.270743231587, 29318.0, 29490.705092948796, 47867.521324787696, 48021.75989120032, 48273.27590086081, 48377.274340884214, 48411.75794121007, 551838.0, 552582.0, 553160.0, 554069.0, 554950.0, 25817.483650327264, 26033.219003429927, 26211.868940655175, 26231.60652590251, 26261.212163635122, 44575.0, 44711.0, 44989.77505112453, 45747.77126114348, 46030.76984615056, 37342.0, 37665.62334376621, 37795.81102094472, 38786.0303492415, 38857.222855543296, 37158.44262336013, 37241.068973275884, 37555.0, 38379.0, 38559.80720096381, 37070.0, 37334.813325933195, 37801.86594402172, 37869.0, 39219.80390098031, 31115.910943116884, 34200.802971895864, 34504.65495345115, 34533.48199776955, 34586.654133458345, 25521.744782551938, 25613.359666007753, 25731.099411520507, 25761.871190644677, 25937.96248150053], "value": 19506.59214851251, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.8779451602907, 367.79587329032375, 370.46837787774535, 386.7408836079826, 402.00303247945095, 15006.924965375185, 18904.0, 20022.59954800903, 20050.29823956162, 20266.695999559983, 17366.305347786074, 19466.70799938002, 19822.60354792907, 20423.693644595307, 20897.477563060933, 5774.855628609276, 5803.6517808931385, 6045.969770151165, 6047.7580896764075, 6076.756929722806, 5752.338481074688, 5857.970710146444, 5899.0, 5941.10883367494, 5941.821745347646, 5745.827625171251, 5817.069268916975, 5862.853428664275, 5896.764129434818, 5913.9112913306335, 5956.106584012389, 5959.612625179349, 6098.176746139259, 6105.664188469655, 6133.815985520419, 5790.652560846321, 5808.88382232353, 5837.241158649391, 5871.4715675589405, 5905.320888097881, 12888.097833151684, 13037.86962130376, 13084.018698597549, 15262.0, 24230.515389692282, 2132.3816093332916, 2239.3729755668437, 2341.758867800069, 2358.563665721847, 2657.534931387019, 9754.219662426989, 9926.553305101288, 9955.950220248926, 10159.89840101597, 10476.895231047669, 1834.367143335547, 1884.0579710144928, 1888.9716654250196, 1901.6672082385664, 1936.5352315444193, 110915.0, 114027.42986285016, 115660.26509602362, 117087.41456292749, 117458.99999999914, 9375.0, 11463.88536114645, 11791.88208117925, 11829.349385783864, 11981.341026243641, 14669.0, 14694.265286735621, 14699.338529766186, 14703.852961470462, 14746.188959607325, 7714.80420534818, 7756.961215193888, 8492.40553161285, 8495.74512764618, 8505.192006759347, 8340.833183336421, 8345.54099524532, 8386.916130838736, 8482.872756908651, 8513.404061715744, 3960.5445373782386, 4230.069384735353, 4548.499665036843, 4556.724117247176, 4578.542145785462, 1895.3699818156374, 1941.2623203182982, 1988.5923385705896, 1993.7109119177637, 1995.6208320419073, 818.4148333941141, 909.2998391238709, 934.5747684803398, 946.9668561600449, 974.4835237324229, 20135.597288054156, 21160.365189044354, 21190.0, 21271.680924786142, 21509.13963441476, 821.3511326052471, 895.8432274351962, 900.6937641202023, 917.1287277086794, 946.4605175050293, 9350.0, 9842.557084931195, 10731.570737170427, 11333.546658133582, 11376.488058037408, 537818.0, 543518.0, 543708.0, 550235.0, 550372.0, 114078.0, 126550.36724816317, 127243.72756272503, 127510.0, 129127.0, 862.8101817599993, 972.6158167523788, 1007.4156988946394, 1008.0675375277839, 1025.6358992557684, 14718.852811471748, 16551.586210344838, 19334.12996415193, 19440.513987150436, 19619.803801961796, 54831.725841372136, 56949.71525142348, 57293.14060289182, 59298.999999998276, 59457.702711487895, 73319.0, 84992.57503712442, 86092.56953715191, 88505.0, 90272.09727902636, 6700.631465269457, 8115.269625733712, 8121.878171827546, 8290.668373265002, 8342.541160236246, 11220.0, 12980.935095324463, 12994.415251313525, 13156.80264796048, 13443.529476468277, 10943.0, 11015.889841101487, 11189.88810111921, 11200.719982000515, 11347.751747307955, 9286.535673216447, 10837.891621084003, 10999.175061870232, 11200.887991120311, 11364.715882103013, 11534.653960381202, 11540.24988375753, 11896.226745261876, 11902.345371004332, 11972.760544788882, 7992.480488768211, 8184.508929464251, 8294.0, 8381.371397145116, 8395.538245396561, 10285.382877027403, 11181.440927953407, 11365.977062064454, 11531.250468719507, 11681.591144309908], "value": 9404.320730882035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.298173894792, 1444.5233073085878, 1487.576040828364, 1611.0897343001204, 1660.0, 7499.212582678809, 7742.0, 8050.718224862131, 8397.58012099395, 8582.570871456433, 7986.682197437431, 8241.917580824205, 8302.54336011519, 8397.53813540255, 8470.830583388328, 2301.424643839036, 2338.5907466193435, 2347.85912845229, 2348.53029394121, 2361.114582031738, 2330.5222429402015, 2369.2418426103654, 2375.9881200593973, 2379.3813608461837, 2381.5951288281035, 2317.7102862142233, 2323.9535209295805, 2348.0607756897207, 2348.412896775806, 2357.0571771291447, 2305.8040066594276, 2316.652502124678, 2329.3827135809024, 2340.777626125524, 2345.7419683834764, 2283.486215601493, 2349.659299401594, 2350.788429041377, 2359.622460406327, 2360.5160942006846, 7606.163322034572, 8049.1950804919625, 8397.748067557983, 8400.83198336036, 8505.192006759347, 5083.593312535026, 5084.44071152173, 5193.584513238932, 5245.79016839326, 5268.078086334876, 2879.1506505580696, 3130.780845340827, 3526.4357702767434, 3540.5751309842985, 3620.348337299285, 978.6819283732744, 1025.5590096258607, 1088.4829705889717, 1096.7203363142428, 1113.5156207049959, 9307.16235538798, 9898.505074746306, 10928.945355273252, 11006.944965275203, 11038.834417483664, 4529.524399937959, 4624.745638989888, 4707.929381059287, 4736.8105275788585, 4783.354247176656, 9466.053394660617, 9551.235901128031, 9566.66516671913, 9583.185429238592, 9598.0, 5256.1327380982475, 5259.973700131475, 5260.631755777059, 5260.92108618371, 5267.947320526822, 4285.0358669299785, 4308.0, 4747.382840230748, 4813.542713442217, 4830.058138662997, 3837.0407398150464, 3878.3988481784804, 3938.8030598470536, 3960.861369852041, 3964.147708242742, 1280.8334916460801, 1281.128832393981, 1288.7358091591202, 1296.3064760353166, 1300.9154404963647, 746.2723844251811, 853.5007020892847, 905.7011186308503, 913.6893456224915, 915.6657819895823, 5568.693721845338, 5667.008273552112, 5668.8866222675315, 5682.715864206773, 5898.528117750569, 913.7761248494162, 953.4803532074897, 978.3396207559869, 981.66623348062, 983.955721992512, 3766.453864189677, 3842.269968705937, 3882.145927895858, 3904.2581909437117, 3906.316394630985, 10044.497775111215, 10364.0, 10424.5830166794, 10439.37363758177, 10481.580736770444, 10376.481175941173, 10390.636327728493, 10401.739956501147, 10404.5838166474, 10424.322419042737, 6898.965505172542, 7883.408744344197, 7885.5662938538935, 7895.131535531202, 8011.0, 5748.338941021836, 5772.451617096369, 5863.648181109147, 5903.350631430625, 5913.319968203712, 9264.305177111879, 9459.38513996588, 9492.95253523728, 9567.043295670655, 9626.422414655142, 9624.75938101525, 9635.951820240854, 9657.71026869195, 9791.706248812547, 9807.705768826947, 6623.602583844985, 6892.276310987475, 7033.015377847003, 7204.063471748639, 7371.299726525972, 7726.227377262228, 7792.2986931176465, 7817.570033648204, 7824.765257042298, 7827.45207835446, 6037.0, 6916.827079323057, 7042.295770422917, 7118.430525558047, 7167.175774785758, 6964.0, 6977.8255543609785, 6980.930190698231, 6984.336488033832, 7013.614251216028, 6584.572002819801, 6740.797776066725, 6811.352921472452, 6856.24581296067, 6904.792856214322, 3704.8329776120436, 4149.647279981235, 4191.392248123944, 4219.599138081878, 4240.809163587584, 4962.776675049559, 4964.478729733326, 4990.326305948651, 4997.700137991732, 5056.6713163644245], "value": 4428.242632573065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.6429755698049, 300.79696205061583, 308.68051566628543, 313.3810723820455, 315.5818540433926, 4468.581535125623, 5171.689698618081, 5380.273663055486, 5432.75552600133, 5510.531604813591, 4709.0, 5310.07073762091, 5347.25138480613, 5383.842473868118, 5395.838124856261, 3619.5567991605626, 3831.9233615327676, 3949.743266687656, 4037.919241615166, 4084.0, 3435.3472840160416, 4107.691923105764, 4127.195196936598, 4130.545639979599, 4150.896227594304, 3574.749767516275, 4134.958650413488, 4138.896527586804, 4151.958480415203, 4151.965536886919, 3788.337041017811, 4041.1715598302276, 4057.2494088593407, 4120.0, 4212.283911734997, 2778.652668416448, 2901.5792710057135, 3489.6270536035486, 3498.169504392686, 3503.2643144939593, 5233.188855727369, 5237.738113094369, 5246.921296180561, 5259.316288882459, 5290.523852853262, 4104.630583247522, 4337.956620433787, 4646.628269738413, 4651.2557990721325, 4665.393498845128, 4452.977735111336, 4768.2370820668875, 5404.378496472917, 5483.820978489604, 5735.311762588474, 3758.8762349272574, 3833.7316387852584, 3843.903902402434, 3865.4201869719486, 3883.669888059518, 5594.0, 6051.878962420727, 6070.180525629028, 6085.117657939574, 6168.797084568511, 3300.5379246905454, 3793.696504279651, 3867.5165604299464, 3888.811174836607, 3901.668358189529, 3497.8251087445524, 3934.8555037504057, 3955.3869150281753, 3960.5643379228263, 3986.3023970804993, 3767.547894252707, 3930.587288334741, 3981.5023122109737, 4604.493505714436, 4639.953600463952, 4542.636589072932, 4606.815727370935, 4989.777504511418, 5253.474652534716, 5592.664440133605, 1273.4269578689627, 1274.6367285323824, 1277.393238211842, 1277.4762347437506, 1286.5239861251398, 785.5600863516449, 804.5494523067101, 826.3348004856149, 866.9566521674017, 873.5544872115267, 4266.402703621496, 5197.506236907488, 5397.220431477792, 5453.454654534515, 5467.835964921059, 5392.541633961078, 5476.288082549243, 5934.673592952343, 5956.255468066492, 5959.374265702126, 4775.617950563947, 4974.388446065772, 5131.999260144311, 5406.864558442771, 5445.467857446307, 2909.3163106669917, 2981.22745846365, 2993.8593905357775, 3000.3099287164073, 3000.489916714164, 4978.166811555082, 5867.391554194225, 5886.735096920649, 5888.026546593943, 5962.522998160137, 5053.140966035783, 5185.844424667266, 5535.612507124462, 5551.139573366135, 5562.582806289544, 5013.523715247045, 5109.463506331856, 5679.267823313847, 5787.739551720267, 5906.114082887515, 4635.49009608936, 4676.46220684612, 4940.505949405175, 5657.830265092054, 5741.224934633771, 4763.333133361263, 5347.438518955453, 5373.731313434391, 5564.304461942257, 5614.550835933034, 5535.474129957647, 5869.4717475427415, 5928.584999050025, 5933.0, 5963.552733545088, 3236.385086833494, 3493.318802833423, 3698.519192504957, 3819.4461803038957, 3882.204148149566, 5274.7098909560345, 5545.445455454423, 5571.415001424792, 5589.860253493695, 5634.74576694593, 4748.50422117032, 4945.876353091057, 5426.0, 5447.066291466631, 5512.747478987257, 4807.230843065093, 4844.442889067803, 5088.295421033995, 5148.613853961043, 5399.352077750695, 4696.506866778939, 4732.455767586634, 5292.792230176941, 5300.814471493479, 5315.3621565412395, 5431.728413579384, 5548.583856210719, 5600.243967064394, 5700.600957932905, 5724.137931034483, 5029.371328583927, 5351.866203344792, 5508.44915508446, 5563.860903477445, 5586.413426590149], "value": 4029.4483591981834, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.1677245057452, 681.8159097043801, 724.9347558719714, 746.0, 770.9190534993826, 11926.522939082437, 14795.038322509043, 14799.704005919903, 14805.481808136718, 14825.332860021297, 13208.471661133568, 13264.867351326484, 13272.270025148613, 13355.599332020054, 13376.130551514168, 650.6974256970495, 685.2154283345566, 810.0320117459638, 843.4180415513307, 856.3149480415674, 834.8205135895781, 846.9195426434479, 848.3594885861197, 849.5454931611589, 855.8331125430543, 894.463322006794, 895.3150839607705, 895.852184389575, 901.3735453859571, 905.5698543191997, 894.8970868350158, 896.1576118448637, 899.2626046641724, 899.7660608241839, 900.5092224737468, 663.3697986912453, 665.820228538292, 667.562746401108, 670.1723371636026, 672.2302963107263, 13586.320683965761, 13662.453501859914, 13860.653483662889, 13865.37605807731, 14331.355089021019, 13465.0, 13716.794248086288, 13718.519851805138, 13899.444022239099, 13947.071115065848, 11141.888581114166, 11226.943865280622, 11326.0, 11330.886691133148, 11425.942870285679, 3499.9300013999577, 3629.0, 3684.318401095779, 3691.151035261878, 3736.794476303802, 83938.58030709808, 85673.14326856776, 88283.0, 89026.5548672259, 89478.55260723655, 10369.637062702921, 10480.371177729361, 10504.212184086224, 10531.473426328654, 10544.683659490227, 20983.580328393346, 21284.680729789066, 21296.361109166748, 21430.892845535986, 21526.138954441645, 7374.151972523228, 7503.849923001619, 7604.049493813273, 7774.805629859299, 7809.45333826638, 4118.382242663624, 4128.153728485653, 4174.645155161785, 4212.0, 4234.513031001475, 3287.1289108386295, 3393.30437260366, 3395.1172695099453, 3398.694117529434, 3403.863845446204, 601.8916595012852, 634.4543692424511, 637.388107416885, 639.7504973060417, 658.9472842172614, 630.9179806625109, 642.7631841192675, 654.9181352330959, 660.6201434175368, 673.3838537737915, 8328.507239141289, 8877.73366798997, 8910.153535414125, 9228.26173906086, 9280.95359523198, 576.4437317988162, 608.458471959956, 635.4408120853711, 654.4077609763171, 671.7078071039114, 4280.122574872144, 4301.204277208726, 4543.864033991502, 4544.113897789899, 4551.840685576055, 122582.38708806399, 124422.0, 124515.13227301597, 127841.0, 128394.0, 65974.0, 69042.0, 103414.48292758488, 109138.45430772795, 111532.32701509484, 89878.0, 90485.09514904898, 91339.5433022844, 91690.0, 93896.0, 9487.620495180116, 9621.230301575717, 9671.661491847752, 9684.41893486393, 9765.80468390614, 51023.48976510188, 52555.73722131365, 52843.47156528539, 58909.0, 59833.70083149557, 69922.65038674774, 80423.0, 82180.0, 83778.58110709651, 84717.57641211755, 12004.159708820298, 12382.257064576153, 12383.442745076673, 12399.876001240233, 12766.361681916052, 13647.931760341531, 14050.648733781738, 14112.435502580192, 14170.645733856736, 14242.145471271757, 12559.434825432694, 12843.40761720213, 12930.224186548838, 13089.214647121204, 13300.467981281028, 12930.547430840252, 13125.803112953505, 13193.406296716863, 13235.933820331222, 13691.589252322447, 12637.398147641856, 12769.489220431078, 13021.47914083426, 13146.014048946176, 13561.79657305161, 10866.07638350749, 11053.723656908642, 11241.887581124083, 11402.315861048364, 11566.65300041, 9555.952220238854, 11280.32318060919, 11482.77034459323, 11592.188546801643, 11624.302541847515], "value": 7379.595858126059, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 118.0, 118.0, 127.0, 104.0, 175.0, 174.0, 176.0, 120.0], "value": 134.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 114.0, 148.0, 124.0, 119.0, 113.0, 112.0, 142.0, 127.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 194.0, 198.0, 207.0, 256.0, 285.0, 198.0, 275.0, 280.0, 204.0], "value": 229.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 60.0, 85.0, 60.0, 59.0, 59.0, 60.0, 80.0, 61.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 87.0, 73.0, 70.0, 71.0, 86.0, 69.0, 73.0, 88.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 105.0, 112.0, 103.0, 92.0, 77.0, 93.0, 87.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 100.0, 100.0, 112.0, 130.0, 106.0, 166.0, 135.0, 119.0], "value": 125.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 139.0, 87.0, 97.0, 137.0, 91.0, 95.0, 91.0, 140.0, 121.0], "value": 111.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 57.0, 58.0, 59.0, 61.0, 59.0, 60.0, 60.0, 61.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 72.0, 88.0, 62.0, 69.0, 82.0, 107.0, 103.0, 74.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 86.0, 85.0, 83.0, 88.0, 88.0, 84.0, 87.0, 85.0, 85.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 160.0, 131.0, 142.0, 149.0, 160.0, 148.0, 156.0, 229.0, 165.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 173.0, 167.0, 174.0, 169.0, 170.0, 173.0, 199.0, 238.0, 197.0], "value": 184.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 68.0, 70.0, 69.0, 66.0, 71.0, 72.0, 67.0, 71.0], "value": 69.6, "unit": "score"}]}]} 14:11:19 INFO - Return code: 0 14:11:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:11:19 ERROR - # TBPL SUCCESS # 14:11:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:11:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:11:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:11:19 INFO - 2017-01-20 14:11:19.939 screenresolution[2175:23602] starting screenresolution argv=screenresolution get 14:11:19 INFO - 2017-01-20 14:11:19.941 screenresolution[2175:23602] Display 0: 1600x1200x32@60 14:11:19 INFO - 2017-01-20 14:11:19.947 screenresolution[2176:23605] starting screenresolution argv=screenresolution list 14:11:19 INFO - Available Modes on Display 0 14:11:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:11:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:11:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:11:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:11:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:11:20 INFO - Intel Iris: 14:11:20 INFO - Chipset Model: Intel Iris 14:11:20 INFO - Type: GPU 14:11:20 INFO - Bus: Built-In 14:11:20 INFO - VRAM (Dynamic, Max): 1536 MB 14:11:20 INFO - Vendor: Intel (0x8086) 14:11:20 INFO - Device ID: 0x0a2e 14:11:20 INFO - Revision ID: 0x0009 14:11:20 INFO - Displays: 14:11:20 INFO - Display: 14:11:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:11:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:11:20 INFO - Display Serial Number: 1600x1200 60 14:11:20 INFO - Main Display: Yes 14:11:20 INFO - Mirror: Off 14:11:20 INFO - Online: Yes 14:11:20 INFO - Rotation: Supported 14:11:20 INFO - Return code: 0 14:11:20 INFO - Running post-action listener: _resource_record_post_action 14:11:20 INFO - [mozharness: 2017-01-20 22:11:20.182052Z] Finished run-tests step (success) 14:11:20 INFO - Running post-run listener: _resource_record_post_run 14:11:20 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 307200; Write bytes: 662753280; Read time: 5; Write time: 2070 14:11:20 INFO - TinderboxPrint: CPU usage
54.5% 14:11:20 INFO - TinderboxPrint: I/O read bytes / time
307,200 / 5 14:11:20 INFO - TinderboxPrint: I/O write bytes / time
662,753,280 / 2,070 14:11:20 INFO - TinderboxPrint: CPU idle
2,203.9 (45.5%) 14:11:20 INFO - TinderboxPrint: CPU system
980.5 (20.3%) 14:11:20 INFO - TinderboxPrint: CPU user
1,657.3 (34.2%) 14:11:20 INFO - TinderboxPrint: Swap in / out
349,179,904 / 0 14:11:20 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 346325504; Write bytes: 346388480; Read time: 26805; Write time: 694 14:11:20 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 307200; Write bytes: 309393408; Read time: 5; Write time: 1347 14:11:20 INFO - Running post-run listener: _upload_blobber_files 14:11:20 INFO - Blob upload gear active. 14:11:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:11:20 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 14:11:20 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'] 14:11:20 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 14:11:21 INFO - (blobuploader) - INFO - Open directory for files ... 14:11:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:11:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:11:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:22 INFO - (blobuploader) - INFO - Done attempting. 14:11:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:11:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:23 INFO - (blobuploader) - INFO - Done attempting. 14:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:25 INFO - (blobuploader) - INFO - Done attempting. 14:11:25 INFO - (blobuploader) - INFO - Iteration through files over. 14:11:25 INFO - Return code: 0 14:11:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:11:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:11:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19e3b335e0e6b97fb699f6a091cb434f08e9abde7cae595c54821b14bf59fb3e29469cea280bf76808c57c3c8a93abfe82cd26080fd5fb9fc852ecdcb099eb6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0b2f3d30a658f8e0a160f78c1fa6da095fd30a4df0dc0991d7914aa9e0367d9fa59da26a5538cad102bd4e93627662b1d4a36210c52180defa8ecd35ebf25ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b2a6710691efe0968dc0a29645db2405083bd966e2c2efb9ef3f728bf64e6bfdad82e06aec4f07a0ff3db1b49dc4ce014b5d80f0991aadac6f4bcbe5461143c"} 14:11:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:11:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:11:25 INFO - Contents: 14:11:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19e3b335e0e6b97fb699f6a091cb434f08e9abde7cae595c54821b14bf59fb3e29469cea280bf76808c57c3c8a93abfe82cd26080fd5fb9fc852ecdcb099eb6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0b2f3d30a658f8e0a160f78c1fa6da095fd30a4df0dc0991d7914aa9e0367d9fa59da26a5538cad102bd4e93627662b1d4a36210c52180defa8ecd35ebf25ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b2a6710691efe0968dc0a29645db2405083bd966e2c2efb9ef3f728bf64e6bfdad82e06aec4f07a0ff3db1b49dc4ce014b5d80f0991aadac6f4bcbe5461143c"} 14:11:25 INFO - Running post-run listener: copy_logs_to_upload_dir 14:11:25 INFO - Copying logs to upload dir... 14:11:25 INFO - mkdir: /builds/slave/test/build/upload/logs 14:11:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.089206 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-20 14:11:25.850130) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 14:11:25.854225) ========= 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.8YTFVhSlsL/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.8v9JndIvjg/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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/19e3b335e0e6b97fb699f6a091cb434f08e9abde7cae595c54821b14bf59fb3e29469cea280bf76808c57c3c8a93abfe82cd26080fd5fb9fc852ecdcb099eb6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0b2f3d30a658f8e0a160f78c1fa6da095fd30a4df0dc0991d7914aa9e0367d9fa59da26a5538cad102bd4e93627662b1d4a36210c52180defa8ecd35ebf25ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b2a6710691efe0968dc0a29645db2405083bd966e2c2efb9ef3f728bf64e6bfdad82e06aec4f07a0ff3db1b49dc4ce014b5d80f0991aadac6f4bcbe5461143c"} build_url:https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/SuEFX0ZiSNymPmmbWimWLw/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/19e3b335e0e6b97fb699f6a091cb434f08e9abde7cae595c54821b14bf59fb3e29469cea280bf76808c57c3c8a93abfe82cd26080fd5fb9fc852ecdcb099eb6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0b2f3d30a658f8e0a160f78c1fa6da095fd30a4df0dc0991d7914aa9e0367d9fa59da26a5538cad102bd4e93627662b1d4a36210c52180defa8ecd35ebf25ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b2a6710691efe0968dc0a29645db2405083bd966e2c2efb9ef3f728bf64e6bfdad82e06aec4f07a0ff3db1b49dc4ce014b5d80f0991aadac6f4bcbe5461143c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 14:11:25.889978) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 14:11:25.890350) ========= 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.8YTFVhSlsL/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.8v9JndIvjg/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005178 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 14:11:25.942178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 14:11:25.942823) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 14:11:25.943555) ========= ========= Total master_lag: 0.19 =========