builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0119 starttime: 1478960530.34 results: success (0) buildid: 20161112030203 builduid: 23c34e790bc34cf797db52ba6a41c026 revision: fc104971a4db41e38808e6412bc32e1900172f14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:10.337207) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:10.337732) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:10.338074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:10.363830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:10.364572) ========= 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.BlvS2g2h7o/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.WCpR6RubgC/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-12 06:22:10-- 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% 14.3M=0.001s 2016-11-12 06:22:11 (14.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.631929 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:11.022971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:11.023450) ========= 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.BlvS2g2h7o/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.WCpR6RubgC/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.025224 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:11.125727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-12 06:22:11.126111) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fc104971a4db41e38808e6412bc32e1900172f14 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fc104971a4db41e38808e6412bc32e1900172f14 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BlvS2g2h7o/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.WCpR6RubgC/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-12 06:22:11,203 truncating revision to first 12 chars 2016-11-12 06:22:11,203 Setting DEBUG logging. 2016-11-12 06:22:11,203 attempt 1/10 2016-11-12 06:22:11,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fc104971a4db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-12 06:22:12,552 unpacking tar archive at: mozilla-central-fc104971a4db/testing/mozharness/ program finished with exit code 0 elapsedTime=1.605716 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-12 06:22:12.757865) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:12.759203) ========= script_repo_revision: fc104971a4db41e38808e6412bc32e1900172f14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:12.759978) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:12.760490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 06:22:12.781520) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-12 06:22:12.782152) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BlvS2g2h7o/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.WCpR6RubgC/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 06:22:12 INFO - MultiFileLogger online at 20161112 06:22:12 in /builds/slave/test 06:22:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:22:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:22:12 INFO - {'append_to_log': False, 06:22:12 INFO - 'base_work_dir': '/builds/slave/test', 06:22:12 INFO - 'blob_upload_branch': 'Firefox', 06:22:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:22:12 INFO - 'branch': 'Firefox', 06:22:12 INFO - 'buildbot_json_path': 'buildprops.json', 06:22:12 INFO - 'config_files': ('talos/mac_config.py',), 06:22:12 INFO - 'default_actions': ('clobber', 06:22:12 INFO - 'read-buildbot-config', 06:22:12 INFO - 'download-and-extract', 06:22:12 INFO - 'populate-webroot', 06:22:12 INFO - 'create-virtualenv', 06:22:12 INFO - 'install', 06:22:12 INFO - 'run-tests'), 06:22:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:22:12 INFO - 'download_minidump_stackwalk': True, 06:22:12 INFO - 'download_symbols': 'ondemand', 06:22:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:22:12 INFO - 'tooltool.py': '/tools/tooltool.py', 06:22:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:22:12 INFO - '/tools/misc-python/virtualenv.py')}, 06:22:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:22:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:22:12 INFO - 'installer_path': 'installer.exe', 06:22:12 INFO - 'log_level': 'info', 06:22:12 INFO - 'log_name': 'talos', 06:22:12 INFO - 'log_to_console': True, 06:22:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:22:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:22:12 INFO - 'opt_config_files': (), 06:22:12 INFO - 'pip_index': False, 06:22:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:22:12 INFO - 'cmd': ('bash', 06:22:12 INFO - '-c', 06:22:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:22:12 INFO - 'enabled': True, 06:22:12 INFO - 'halt_on_failure': False, 06:22:12 INFO - 'name': 'check_screen_resolution'},), 06:22:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:22:12 INFO - 'cmd': ('bash', 06:22:12 INFO - '-c', 06:22:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:22:12 INFO - 'enabled': True, 06:22:12 INFO - 'halt_on_failure': False, 06:22:12 INFO - 'name': 'check_screen_resolution'},), 06:22:12 INFO - 'run_cmd_checks_enabled': True, 06:22:12 INFO - 'sps_profile': False, 06:22:12 INFO - 'sps_profile_interval': 0, 06:22:12 INFO - 'suite': 'dromaeojs', 06:22:12 INFO - 'system_bits': '32', 06:22:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:22:12 INFO - 'title': 't-yosemite-r7-0119', 06:22:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:22:12 INFO - 'use_talos_json': True, 06:22:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:22:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:22:12 INFO - 'work_dir': 'build'} 06:22:12 INFO - [mozharness: 2016-11-12 14:22:12.988712Z] Running clobber step. 06:22:12 INFO - Running pre-action listener: _resource_record_pre_action 06:22:12 INFO - Running main action method: clobber 06:22:12 INFO - rmtree: /builds/slave/test/build 06:22:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:22:15 INFO - Running post-action listener: _resource_record_post_action 06:22:15 INFO - [mozharness: 2016-11-12 14:22:15.321791Z] Finished clobber step (success) 06:22:15 INFO - [mozharness: 2016-11-12 14:22:15.321918Z] Running read-buildbot-config step. 06:22:15 INFO - Running pre-action listener: _resource_record_pre_action 06:22:15 INFO - Running main action method: read_buildbot_config 06:22:15 INFO - Using buildbot properties: 06:22:15 INFO - { 06:22:15 INFO - "project": "", 06:22:15 INFO - "product": "firefox", 06:22:15 INFO - "script_repo_revision": "production", 06:22:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:22:15 INFO - "repository": "", 06:22:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:22:15 INFO - "buildid": "20161112030203", 06:22:15 INFO - "stage_platform": "macosx64", 06:22:15 INFO - "basedir": "/builds/slave/test", 06:22:15 INFO - "nightly_build": "True", 06:22:15 INFO - "buildnumber": 6, 06:22:15 INFO - "slavename": "t-yosemite-r7-0119", 06:22:15 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:22:15 INFO - "platform": "yosemite_r7", 06:22:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:22:15 INFO - "branch": "mozilla-central", 06:22:15 INFO - "repo_path": "mozilla-central", 06:22:15 INFO - "revision": "fc104971a4db41e38808e6412bc32e1900172f14", 06:22:15 INFO - "pgo_build": "False", 06:22:15 INFO - "builduid": "23c34e790bc34cf797db52ba6a41c026", 06:22:15 INFO - "slavebuilddir": "test" 06:22:15 INFO - } 06:22:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:22:15 INFO - Running post-action listener: _resource_record_post_action 06:22:15 INFO - [mozharness: 2016-11-12 14:22:15.325218Z] Finished read-buildbot-config step (success) 06:22:15 INFO - [mozharness: 2016-11-12 14:22:15.325318Z] Running download-and-extract step. 06:22:15 INFO - Running pre-action listener: _resource_record_pre_action 06:22:15 INFO - Running main action method: download_and_extract 06:22:15 INFO - mkdir: /builds/slave/test/build/tests 06:22: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')]} 06:22:15 INFO - trying https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:22:15 INFO - Downloading https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 06:22:16 INFO - Downloaded 1199 bytes. 06:22:16 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:22:16 INFO - Using the following test package requirements: 06:22:16 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:22:16 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:22:16 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:22:16 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:22:16 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:22:16 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:22:16 INFO - u'jsshell-mac.zip'], 06:22:16 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:22:16 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:22:16 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:22:16 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:22:16 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:22:16 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:22:16 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:22:16 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:22:16 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:22:16 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:22:16 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:22:16 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:22:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:22:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:22:16 INFO - Fetch https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:22:17 INFO - Http code: 200 06:22:17 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 06:22:17 INFO - x-amz-cf-id: NGTsRfvwrRRk8d1BxFq3uZ9y3ClTLyFT9AhdKVARTiqDeU7w9lUYdw== 06:22:17 INFO - x-amz-version-id: tSDCK4fMj2GtUcrBilYaAEa4YowXTtz7 06:22:17 INFO - Expected file size: 16334061 06:22:17 INFO - Obtained file size: 16334061 06:22:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:22:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:22:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:22:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:22:24 INFO - Http code: 200 06:22:24 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 06:22:24 INFO - x-amz-cf-id: dk_BQsYumtn07GCcZ8kB0zfVXa6Ru7mRGi4khQStzOqI89Oqe5yadQ== 06:22:24 INFO - x-amz-version-id: tSDCK4fMj2GtUcrBilYaAEa4YowXTtz7 06:22:25 INFO - Expected file size: 16334061 06:22:25 INFO - Obtained file size: 16334061 06:22:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:22:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:22:31 INFO - Fetch https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:22:32 INFO - Http code: 200 06:22:32 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 06:22:32 INFO - x-amz-cf-id: gG5Oi4mjTsa3GF7wzVt3eAL476rg996AObWLKG8M-puryuyEwJVa0w== 06:22:32 INFO - x-amz-version-id: rHayc_rmJmJORFywTNNqd_gaP2NgFJIF 06:22:32 INFO - Expected file size: 14409038 06:22:32 INFO - Obtained file size: 14409038 06:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:22:33 INFO - trying https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:22:33 INFO - Downloading https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:22:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 06:22:35 INFO - Downloaded 111217061 bytes. 06:22:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:22:35 INFO - mkdir: /builds/slave/test/properties 06:22:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:22:35 INFO - Writing to file /builds/slave/test/properties/build_url 06:22:35 INFO - Contents: 06:22:35 INFO - build_url:https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:22:36 INFO - Running post-action listener: _resource_record_post_action 06:22:36 INFO - Running post-action listener: set_extra_try_arguments 06:22:36 INFO - [mozharness: 2016-11-12 14:22:36.546554Z] Finished download-and-extract step (success) 06:22:36 INFO - [mozharness: 2016-11-12 14:22:36.546679Z] Running populate-webroot step. 06:22:36 INFO - Running pre-action listener: _resource_record_pre_action 06:22:36 INFO - Running main action method: populate_webroot 06:22:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:22:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:22:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:22:36 INFO - '--tppagecycles', 06:22:36 INFO - '7'], 06:22:36 INFO - 'tests': ['tsvgm']}}, 06:22:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:22:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:22:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:22:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:22:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:22:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:22:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:36 INFO - 'talos_options': ['--disable-e10s'], 06:22:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:22:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:22:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:36 INFO - 'talos_options': ['--disable-e10s'], 06:22:36 INFO - 'tests': ['damp', 'tps']}, 06:22:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:36 INFO - 'tests': ['damp', 'tps']}, 06:22:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:22:36 INFO - 'tests': ['dromaeo_dom']}, 06:22:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:22:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:22:36 INFO - 'tests': ['basic_compositor_video']}, 06:22:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:22:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:22:36 INFO - 'tests': ['a11yr', 06:22:36 INFO - 'ts_paint', 06:22:36 INFO - 'tpaint', 06:22:36 INFO - 'sessionrestore', 06:22:36 INFO - 'sessionrestore_no_auto_restore', 06:22:36 INFO - 'tabpaint']}, 06:22:36 INFO - 'other-e10s': {'tests': ['a11yr', 06:22:36 INFO - 'ts_paint', 06:22:36 INFO - 'tpaint', 06:22:36 INFO - 'sessionrestore', 06:22:36 INFO - 'sessionrestore_no_auto_restore', 06:22:36 INFO - 'tabpaint']}, 06:22:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:22:36 INFO - 'ts_paint', 06:22:36 INFO - 'tpaint', 06:22:36 INFO - 'sessionrestore', 06:22:36 INFO - 'sessionrestore_no_auto_restore', 06:22:36 INFO - 'tabpaint']}, 06:22:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:22:36 INFO - 'ts_paint', 06:22:36 INFO - 'tpaint', 06:22:36 INFO - 'sessionrestore', 06:22:36 INFO - 'sessionrestore_no_auto_restore', 06:22:36 INFO - 'tabpaint']}, 06:22:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:22:36 INFO - 'tests': ['a11yr', 06:22:36 INFO - 'ts_paint', 06:22:36 INFO - 'tpaint', 06:22:36 INFO - 'sessionrestore', 06:22:36 INFO - 'sessionrestore_no_auto_restore', 06:22:36 INFO - 'tabpaint']}, 06:22:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:22:36 INFO - 'tests': ['a11yr', 06:22:36 INFO - 'ts_paint', 06:22:36 INFO - 'tpaint', 06:22:36 INFO - 'sessionrestore', 06:22:36 INFO - 'sessionrestore_no_auto_restore', 06:22:36 INFO - 'tabpaint']}, 06:22:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:22:36 INFO - 'tests': ['tsvgx', 06:22:36 INFO - 'tsvgr_opacity', 06:22:36 INFO - 'tart', 06:22:36 INFO - 'tscrollx', 06:22:36 INFO - 'cart']}, 06:22:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:22:36 INFO - 'tsvgr_opacity', 06:22:36 INFO - 'tart', 06:22:36 INFO - 'tscrollx', 06:22:36 INFO - 'cart']}, 06:22:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:36 INFO - 'talos_options': ['--disable-e10s'], 06:22:36 INFO - 'tests': ['tp5o']}, 06:22:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:36 INFO - 'tests': ['tp5o']}, 06:22:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:36 INFO - 'talos_options': ['--disable-e10s', 06:22:36 INFO - '--xperf_path', 06:22:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:22:36 INFO - 'tests': ['tp5n']}, 06:22:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:36 INFO - 'talos_options': ['--xperf_path', 06:22:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:22:36 INFO - 'tests': ['tp5n']}}, 06:22:36 INFO - 'talos.zip': {'path': '', 06:22:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:22:36 INFO - Running post-action listener: _resource_record_post_action 06:22:36 INFO - [mozharness: 2016-11-12 14:22:36.565310Z] Finished populate-webroot step (success) 06:22:36 INFO - [mozharness: 2016-11-12 14:22:36.565390Z] Running create-virtualenv step. 06:22:36 INFO - Running pre-action listener: _resource_record_pre_action 06:22:36 INFO - Running main action method: create_virtualenv 06:22:36 INFO - Creating virtualenv /builds/slave/test/build/venv 06:22: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 06:22:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:22:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:22:36 INFO - Using real prefix '/tools/python27' 06:22:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:22:37 INFO - Installing distribute.............................................................................................................................................................................................done. 06:22:40 INFO - Installing pip.................done. 06:22:40 INFO - Return code: 0 06:22:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:22:40 INFO - Reading from file tmpfile_stdout 06:22:40 INFO - Output received: 06:22: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) 06:22:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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 0x10ed7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecf0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb69d850b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8ed30>, '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 0x10e9b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb86b20>, '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.BlvS2g2h7o/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.WCpR6RubgC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 06:22: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 06:22: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 06:22:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlvS2g2h7o/Render', 06:22:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:40 INFO - 'HOME': '/Users/cltbld', 06:22:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:40 INFO - 'LOGNAME': 'cltbld', 06:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:40 INFO - 'MOZ_NO_REMOTE': '1', 06:22:40 INFO - 'NO_EM_RESTART': '1', 06:22:40 INFO - 'PAGER': '/bin/cat', 06:22:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:40 INFO - 'PWD': '/builds/slave/test', 06:22:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:40 INFO - 'SHELL': '/bin/bash', 06:22:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCpR6RubgC/Listeners', 06:22:40 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 06:22:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:40 INFO - 'USER': 'cltbld', 06:22:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:40 INFO - 'XPC_FLAGS': '0x0', 06:22:40 INFO - 'XPC_SERVICE_NAME': '0', 06:22:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22: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 06:22:40 INFO - Cleaning up... 06:22:40 INFO - Return code: 0 06:22:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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 0x10ed7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecf0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb69d850b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8ed30>, '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 0x10e9b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb86b20>, '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.BlvS2g2h7o/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.WCpR6RubgC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 06:22: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 06:22: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 06:22:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlvS2g2h7o/Render', 06:22:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:40 INFO - 'HOME': '/Users/cltbld', 06:22:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:40 INFO - 'LOGNAME': 'cltbld', 06:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:40 INFO - 'MOZ_NO_REMOTE': '1', 06:22:40 INFO - 'NO_EM_RESTART': '1', 06:22:40 INFO - 'PAGER': '/bin/cat', 06:22:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:40 INFO - 'PWD': '/builds/slave/test', 06:22:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:40 INFO - 'SHELL': '/bin/bash', 06:22:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCpR6RubgC/Listeners', 06:22:40 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 06:22:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:40 INFO - 'USER': 'cltbld', 06:22:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:40 INFO - 'XPC_FLAGS': '0x0', 06:22:40 INFO - 'XPC_SERVICE_NAME': '0', 06:22:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:41 INFO - Downloading/unpacking psutil>=3.1.1 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:22:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:22:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:22:45 INFO - Installing collected packages: psutil 06:22:45 INFO - Running setup.py install for psutil 06:22:45 INFO - building 'psutil._psutil_osx' extension 06:22: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:22: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 06:22: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 06:22: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 06:22:45 INFO - building 'psutil._psutil_posix' extension 06:22: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 06:22:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:22:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:22:45 INFO - ^ 06:22:46 INFO - 1 warning generated. 06:22:46 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 06:22:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:22:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:22:46 INFO - Successfully installed psutil 06:22:46 INFO - Cleaning up... 06:22:46 INFO - Return code: 0 06:22:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:22:46 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')]} 06:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:46 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')]} 06:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:46 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 0x10ed7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecf0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb69d850b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8ed30>, '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 0x10e9b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb86b20>, '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.BlvS2g2h7o/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.WCpR6RubgC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 06:22:46 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 06:22:46 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 06:22:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlvS2g2h7o/Render', 06:22:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:46 INFO - 'HOME': '/Users/cltbld', 06:22:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:46 INFO - 'LOGNAME': 'cltbld', 06:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:46 INFO - 'MOZ_NO_REMOTE': '1', 06:22:46 INFO - 'NO_EM_RESTART': '1', 06:22:46 INFO - 'PAGER': '/bin/cat', 06:22:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:46 INFO - 'PWD': '/builds/slave/test', 06:22:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:46 INFO - 'SHELL': '/bin/bash', 06:22:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCpR6RubgC/Listeners', 06:22:46 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 06:22:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:46 INFO - 'USER': 'cltbld', 06:22:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:46 INFO - 'XPC_FLAGS': '0x0', 06:22:46 INFO - 'XPC_SERVICE_NAME': '0', 06:22:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:22:46 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 06:22:46 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 06:22:46 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 06:22:46 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 06:22:46 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 06:22:46 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 06:22:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:22:49 INFO - Installing collected packages: mozsystemmonitor 06:22:49 INFO - Running setup.py install for mozsystemmonitor 06:22:49 INFO - Successfully installed mozsystemmonitor 06:22:49 INFO - Cleaning up... 06:22:49 INFO - Return code: 0 06:22:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:49 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 0x10ed7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecf0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb69d850b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8ed30>, '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 0x10e9b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb86b20>, '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.BlvS2g2h7o/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.WCpR6RubgC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 06:22:49 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 06:22:49 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 06:22:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlvS2g2h7o/Render', 06:22:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:49 INFO - 'HOME': '/Users/cltbld', 06:22:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:49 INFO - 'LOGNAME': 'cltbld', 06:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:49 INFO - 'MOZ_NO_REMOTE': '1', 06:22:49 INFO - 'NO_EM_RESTART': '1', 06:22:49 INFO - 'PAGER': '/bin/cat', 06:22:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:49 INFO - 'PWD': '/builds/slave/test', 06:22:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:49 INFO - 'SHELL': '/bin/bash', 06:22:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCpR6RubgC/Listeners', 06:22:49 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 06:22:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:49 INFO - 'USER': 'cltbld', 06:22:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:49 INFO - 'XPC_FLAGS': '0x0', 06:22:49 INFO - 'XPC_SERVICE_NAME': '0', 06:22:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:49 INFO - Downloading/unpacking jsonschema==2.5.1 06:22:49 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 06:22:49 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 06:22:49 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 06:22:49 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 06:22:49 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 06:22:49 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 06:22:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:22:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22:52 INFO - Downloading functools32-3.2.3-2.tar.gz 06:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:22:52 INFO - warning: no files found matching '*.txt' 06:22:52 INFO - no previously-included directories found matching 'build' 06:22:52 INFO - no previously-included directories found matching 'dist' 06:22:52 INFO - no previously-included directories found matching '.git*' 06:22:52 INFO - Installing collected packages: jsonschema, functools32 06:22:52 INFO - Running setup.py install for functools32 06:22:52 INFO - warning: no files found matching '*.txt' 06:22:52 INFO - no previously-included directories found matching 'build' 06:22:52 INFO - no previously-included directories found matching 'dist' 06:22:52 INFO - no previously-included directories found matching '.git*' 06:22:52 INFO - Successfully installed jsonschema functools32 06:22:52 INFO - Cleaning up... 06:22:52 INFO - Return code: 0 06:22:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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 0x10ed7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecf0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb69d850b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8ed30>, '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 0x10e9b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb86b20>, '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.BlvS2g2h7o/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.WCpR6RubgC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 06:22: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 06:22: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 06:22:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlvS2g2h7o/Render', 06:22:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:52 INFO - 'HOME': '/Users/cltbld', 06:22:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:52 INFO - 'LOGNAME': 'cltbld', 06:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:52 INFO - 'MOZ_NO_REMOTE': '1', 06:22:52 INFO - 'NO_EM_RESTART': '1', 06:22:52 INFO - 'PAGER': '/bin/cat', 06:22:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:52 INFO - 'PWD': '/builds/slave/test', 06:22:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:52 INFO - 'SHELL': '/bin/bash', 06:22:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCpR6RubgC/Listeners', 06:22:52 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 06:22:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:52 INFO - 'USER': 'cltbld', 06:22:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:52 INFO - 'XPC_FLAGS': '0x0', 06:22:52 INFO - 'XPC_SERVICE_NAME': '0', 06:22:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:22:53 INFO - Cleaning up... 06:22:53 INFO - Return code: 0 06:22:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:22:53 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')]} 06:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:53 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')]} 06:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:53 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 0x10ed7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecf0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb69d850b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8ed30>, '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 0x10e9b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb86b20>, '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.BlvS2g2h7o/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.WCpR6RubgC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 06:22:53 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 06:22:53 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 06:22:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlvS2g2h7o/Render', 06:22:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:53 INFO - 'HOME': '/Users/cltbld', 06:22:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:53 INFO - 'LOGNAME': 'cltbld', 06:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:53 INFO - 'MOZ_NO_REMOTE': '1', 06:22:53 INFO - 'NO_EM_RESTART': '1', 06:22:53 INFO - 'PAGER': '/bin/cat', 06:22:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:53 INFO - 'PWD': '/builds/slave/test', 06:22:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:53 INFO - 'SHELL': '/bin/bash', 06:22:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCpR6RubgC/Listeners', 06:22:53 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 06:22:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:53 INFO - 'USER': 'cltbld', 06:22:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:53 INFO - 'XPC_FLAGS': '0x0', 06:22:53 INFO - 'XPC_SERVICE_NAME': '0', 06:22:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:53 INFO - Downloading/unpacking blobuploader==1.2.4 06:22:53 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 06:22:53 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 06:22:53 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 06:22:53 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 06:22:53 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 06:22:53 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 06:22:55 INFO - Downloading blobuploader-1.2.4.tar.gz 06:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:22:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:22:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22:56 INFO - Downloading docopt-0.6.1.tar.gz 06:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:22:57 INFO - Installing collected packages: blobuploader, requests, docopt 06:22:57 INFO - Running setup.py install for blobuploader 06:22:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:22:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:22:57 INFO - Running setup.py install for requests 06:22:57 INFO - Running setup.py install for docopt 06:22:57 INFO - Successfully installed blobuploader requests docopt 06:22:57 INFO - Cleaning up... 06:22:58 INFO - Return code: 0 06:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:58 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 0x10ed7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecf0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb69d850b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8ed30>, '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 0x10e9b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb86b20>, '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.BlvS2g2h7o/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.WCpR6RubgC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 06:22:58 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 06:22:58 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 06:22:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlvS2g2h7o/Render', 06:22:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:58 INFO - 'HOME': '/Users/cltbld', 06:22:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:58 INFO - 'LOGNAME': 'cltbld', 06:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:58 INFO - 'MOZ_NO_REMOTE': '1', 06:22:58 INFO - 'NO_EM_RESTART': '1', 06:22:58 INFO - 'PAGER': '/bin/cat', 06:22:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:58 INFO - 'PWD': '/builds/slave/test', 06:22:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:58 INFO - 'SHELL': '/bin/bash', 06:22:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCpR6RubgC/Listeners', 06:22:58 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 06:22:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:58 INFO - 'USER': 'cltbld', 06:22:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:58 INFO - 'XPC_FLAGS': '0x0', 06:22:58 INFO - 'XPC_SERVICE_NAME': '0', 06:22:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:22:58 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-7gVPV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:22:58 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-3Rf5lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:22:58 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Ea_yvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:22:58 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-uiv7id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:22:58 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Pdszab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:22:58 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-zA5rsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:22:58 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-XlzdtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:22:59 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-qJRM7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:22:59 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-egUOUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:22:59 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-cnXUID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:22:59 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-MyRdns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:22:59 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-txxgaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:22:59 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-X5mddJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:22:59 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-xRTE4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:59 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-6QeWPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:22:59 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-p5zrqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:22:59 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-TdaynR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:23:00 INFO - Running setup.py install for manifestparser 06:23:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:23:00 INFO - Running setup.py install for mozcrash 06:23:00 INFO - Running setup.py install for mozdebug 06:23:00 INFO - Running setup.py install for mozdevice 06:23:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:23:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:23:00 INFO - Running setup.py install for mozfile 06:23:00 INFO - Running setup.py install for mozhttpd 06:23:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:23:00 INFO - Running setup.py install for mozinfo 06:23:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:23:01 INFO - Running setup.py install for mozInstall 06:23:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:23:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:23:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:23:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:23:01 INFO - Running setup.py install for mozleak 06:23:01 INFO - Running setup.py install for mozlog 06:23:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:23:01 INFO - Running setup.py install for moznetwork 06:23:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:23:01 INFO - Running setup.py install for mozprocess 06:23:01 INFO - Running setup.py install for mozprofile 06:23:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:23:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:23:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:23:02 INFO - Running setup.py install for mozrunner 06:23:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:23:02 INFO - Running setup.py install for mozscreenshot 06:23:02 INFO - Running setup.py install for moztest 06:23:02 INFO - Running setup.py install for mozversion 06:23:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:23:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:23:02 INFO - Cleaning up... 06:23:02 INFO - Return code: 0 06:23:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23: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')]} 06:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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')]} 06:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x10ed7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecf0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb69d850b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8ed30>, '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 0x10e9b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb86b20>, '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.BlvS2g2h7o/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.WCpR6RubgC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 06:23: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 06:23: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 06:23:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlvS2g2h7o/Render', 06:23:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:23:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:23:02 INFO - 'HOME': '/Users/cltbld', 06:23:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:23:02 INFO - 'LOGNAME': 'cltbld', 06:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:02 INFO - 'MOZ_NO_REMOTE': '1', 06:23:02 INFO - 'NO_EM_RESTART': '1', 06:23:02 INFO - 'PAGER': '/bin/cat', 06:23:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:02 INFO - 'PWD': '/builds/slave/test', 06:23:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:23:02 INFO - 'SHELL': '/bin/bash', 06:23:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCpR6RubgC/Listeners', 06:23:02 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 06:23:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:23:02 INFO - 'USER': 'cltbld', 06:23:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:23:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:02 INFO - 'XPC_FLAGS': '0x0', 06:23:02 INFO - 'XPC_SERVICE_NAME': '0', 06:23:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:02 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-4XL6Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:03 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)) 06:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-gpgBBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:03 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)) 06:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-qeplqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:03 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)) 06:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-dgRLEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23: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)) 06:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-nGJT9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23: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)) 06:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-QnYn94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23: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)) 06:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-5dhM9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23: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)) 06:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-CTwWLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23: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)) 06:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-o7F6_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23: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)) 06:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-N7VgrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23: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)) 06:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-F6itEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:04 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)) 06:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-CM4fU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:04 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)) 06:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-e3Cdz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23: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)) 06:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-4AXH0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23: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)) 06:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-MLhM8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23: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)) 06:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-wJduvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-pJpL5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23: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)) 06:23: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)) 06:23: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)) 06:23: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)) 06:23: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)) 06:23: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)) 06:23:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23:07 INFO - Downloading blessings-1.6.tar.gz 06:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:23:07 INFO - Installing collected packages: blessings 06:23:07 INFO - Running setup.py install for blessings 06:23:07 INFO - Successfully installed blessings 06:23:07 INFO - Cleaning up... 06:23:07 INFO - Return code: 0 06:23:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:07 INFO - Reading from file tmpfile_stdout 06:23:07 INFO - Current package versions: 06:23:07 INFO - blessings == 1.6 06:23:07 INFO - blobuploader == 1.2.4 06:23:07 INFO - docopt == 0.6.1 06:23:07 INFO - functools32 == 3.2.3-2 06:23:07 INFO - jsonschema == 2.5.1 06:23:07 INFO - manifestparser == 1.1 06:23:07 INFO - mozInstall == 1.12 06:23:07 INFO - mozcrash == 1.0 06:23:07 INFO - mozdebug == 0.1 06:23:07 INFO - mozdevice == 0.48 06:23:07 INFO - mozfile == 1.2 06:23:07 INFO - mozhttpd == 0.7 06:23:07 INFO - mozinfo == 0.9 06:23:07 INFO - mozleak == 0.1 06:23:07 INFO - mozlog == 3.4 06:23:07 INFO - moznetwork == 0.27 06:23:07 INFO - mozprocess == 0.23 06:23:07 INFO - mozprofile == 0.28 06:23:07 INFO - mozrunner == 6.13 06:23:07 INFO - mozscreenshot == 0.1 06:23:07 INFO - mozsystemmonitor == 0.3 06:23:07 INFO - moztest == 0.7 06:23:07 INFO - mozversion == 1.4 06:23:07 INFO - psutil == 3.1.1 06:23:07 INFO - requests == 1.2.3 06:23:07 INFO - wsgiref == 0.1.2 06:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23: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')]} 06:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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')]} 06:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x10ed7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecf0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb69d850b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8ed30>, '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 0x10e9b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb86b20>, '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.BlvS2g2h7o/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.WCpR6RubgC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 06:23: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 06:23: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 06:23:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlvS2g2h7o/Render', 06:23:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:23:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:23:07 INFO - 'HOME': '/Users/cltbld', 06:23:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:23:07 INFO - 'LOGNAME': 'cltbld', 06:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:07 INFO - 'MOZ_NO_REMOTE': '1', 06:23:07 INFO - 'NO_EM_RESTART': '1', 06:23:07 INFO - 'PAGER': '/bin/cat', 06:23:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:07 INFO - 'PWD': '/builds/slave/test', 06:23:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:23:07 INFO - 'SHELL': '/bin/bash', 06:23:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCpR6RubgC/Listeners', 06:23:07 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 06:23:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:23:07 INFO - 'USER': 'cltbld', 06:23:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:23:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:07 INFO - 'XPC_FLAGS': '0x0', 06:23:07 INFO - 'XPC_SERVICE_NAME': '0', 06:23:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23: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)) 06:23: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)) 06:23: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)) 06:23: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)) 06:23: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)) 06:23: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)) 06:23: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)) 06:23: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)) 06:23: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)) 06:23: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)) 06:23: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)) 06:23:08 INFO - Cleaning up... 06:23:08 INFO - Return code: 0 06:23:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:23: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')]} 06:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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')]} 06:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x10ed7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecf0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb69d850b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb8ed30>, '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 0x10e9b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb86b20>, '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.BlvS2g2h7o/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.WCpR6RubgC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 06:23: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 06:23: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 06:23:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlvS2g2h7o/Render', 06:23:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:23:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:23:08 INFO - 'HOME': '/Users/cltbld', 06:23:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:23:08 INFO - 'LOGNAME': 'cltbld', 06:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:08 INFO - 'MOZ_NO_REMOTE': '1', 06:23:08 INFO - 'NO_EM_RESTART': '1', 06:23:08 INFO - 'PAGER': '/bin/cat', 06:23:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:08 INFO - 'PWD': '/builds/slave/test', 06:23:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:23:08 INFO - 'SHELL': '/bin/bash', 06:23:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCpR6RubgC/Listeners', 06:23:08 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 06:23:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:23:08 INFO - 'USER': 'cltbld', 06:23:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:23:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:08 INFO - 'XPC_FLAGS': '0x0', 06:23:08 INFO - 'XPC_SERVICE_NAME': '0', 06:23:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:23:08 INFO - Cleaning up... 06:23:08 INFO - Return code: 0 06:23:08 INFO - Running post-action listener: _resource_record_post_action 06:23:08 INFO - Running post-action listener: _start_resource_monitoring 06:23:08 INFO - Starting resource monitoring. 06:23:08 INFO - [mozharness: 2016-11-12 14:23:08.453027Z] Finished create-virtualenv step (success) 06:23:08 INFO - [mozharness: 2016-11-12 14:23:08.454006Z] Running install step. 06:23:08 INFO - Running pre-action listener: _resource_record_pre_action 06:23:08 INFO - Running main action method: install 06:23:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:08 INFO - Reading from file tmpfile_stdout 06:23:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:23:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:23:08 INFO - Reading from file tmpfile_stdout 06:23:08 INFO - Output received: 06:23:08 INFO - Usage: mozinstall [options] installer 06:23:08 INFO - Options: 06:23:08 INFO - -h, --help show this help message and exit 06:23:08 INFO - -d DEST, --destination=DEST 06:23:08 INFO - Directory to install application into. [default: 06:23:08 INFO - "/builds/slave/test"] 06:23:08 INFO - --app=APP Application being installed. [default: firefox] 06:23:08 INFO - mkdir: /builds/slave/test/build/application 06:23:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:23:42 INFO - Reading from file tmpfile_stdout 06:23:42 INFO - Output received: 06:23:42 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:23:42 INFO - Running post-action listener: _resource_record_post_action 06:23:42 INFO - [mozharness: 2016-11-12 14:23:42.322541Z] Finished install step (success) 06:23:42 INFO - [mozharness: 2016-11-12 14:23:42.322666Z] Running run-tests step. 06:23:42 INFO - Running pre-action listener: _resource_record_pre_action 06:23:42 INFO - Running main action method: run_tests 06:23:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:23:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:23:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:23:42 INFO - 2016-11-12 06:23:42.337 screenresolution[1650:8329] starting screenresolution argv=screenresolution get 06:23:42 INFO - 2016-11-12 06:23:42.340 screenresolution[1650:8329] Display 0: 1600x1200x32@60 06:23:42 INFO - 2016-11-12 06:23:42.345 screenresolution[1651:8331] starting screenresolution argv=screenresolution list 06:23:42 INFO - Available Modes on Display 0 06:23:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:23:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:23:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:23:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:23:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:23:42 INFO - Intel Iris: 06:23:42 INFO - Chipset Model: Intel Iris 06:23:42 INFO - Type: GPU 06:23:42 INFO - Bus: Built-In 06:23:42 INFO - VRAM (Dynamic, Max): 1536 MB 06:23:42 INFO - Vendor: Intel (0x8086) 06:23:42 INFO - Device ID: 0x0a2e 06:23:42 INFO - Revision ID: 0x0009 06:23:42 INFO - Displays: 06:23:42 INFO - Display: 06:23:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:23:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:23:42 INFO - Display Serial Number: 1600x1200 60 06:23:42 INFO - Main Display: Yes 06:23:42 INFO - Mirror: Off 06:23:42 INFO - Online: Yes 06:23:42 INFO - Rotation: Supported 06:23:42 INFO - Return code: 0 06:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:23:42 INFO - Python 2.7.3 06:23:42 INFO - Return code: 0 06:23:42 INFO - grabbing minidump binary from tooltool 06:23:42 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')]} 06:23:42 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 0x10eb8ed30>, '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 0x10e9b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb86b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:23:42 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 06:23:42 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 06:23:42 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 06:23:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:23:42 INFO - Return code: 0 06:23:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:23:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:23:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:23:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:23:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0119 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlvS2g2h7o/Render', 06:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:23:42 INFO - 'HOME': '/Users/cltbld', 06:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:23:42 INFO - 'LOGNAME': 'cltbld', 06:23:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:23:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:42 INFO - 'MOZ_NO_REMOTE': '1', 06:23:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:23:42 INFO - 'NO_EM_RESTART': '1', 06:23:42 INFO - 'PAGER': '/bin/cat', 06:23:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:42 INFO - 'PWD': '/builds/slave/test', 06:23:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:23:42 INFO - 'SHELL': '/bin/bash', 06:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCpR6RubgC/Listeners', 06:23:42 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 06:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:23:42 INFO - 'USER': 'cltbld', 06:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:42 INFO - 'XPC_FLAGS': '0x0', 06:23:42 INFO - 'XPC_SERVICE_NAME': '0', 06:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:23:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:23:42 INFO - mozversion application_buildid: 20161112030203 06:23:42 INFO - mozversion application_changeset: fc104971a4db41e38808e6412bc32e1900172f14 06:23:42 INFO - mozversion application_display_name: Nightly 06:23:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:23:42 INFO - mozversion application_name: Firefox 06:23:42 INFO - mozversion application_remotingname: firefox 06:23:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:23:42 INFO - mozversion application_vendor: Mozilla 06:23:42 INFO - mozversion application_version: 52.0a1 06:23:42 INFO - mozversion platform_buildid: 20161112030203 06:23:42 INFO - mozversion platform_changeset: fc104971a4db41e38808e6412bc32e1900172f14 06:23:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:23:42 INFO - mozversion platform_version: 52.0a1 06:23:42 INFO - using testdate: 1478960622 06:23:42 INFO - actual date: 1478960622 06:23:42 INFO - starting webserver on 'localhost:49271' 06:23:42 INFO - SUITE-START | Running 2 tests 06:23:42 INFO - TEST-START | dromaeo_css 06:23:42 INFO - operating with platform_type : mac_ 06:23:42 INFO - Initialising browser for dromaeo_css test... 06:23:42 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpOnPpCa/profile http://localhost:49271/getInfo.html) 06:23:45 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 06:23:45 INFO - PROCESS | 1661 | colorDepth:24 06:23:45 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 06:23:45 INFO - PROCESS | 1661 | __metrics 06:23:45 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:23:45 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:23:46 INFO - TEST-INFO | 1661: exit 0 06:23:46 INFO - Browser initialized. 06:23:46 INFO - Running cycle 1/1 for dromaeo_css test... 06:23:46 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpOnPpCa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:23:58 INFO - PROCESS | 1665 | RSS: Main: 230944768 06:23:58 INFO - PROCESS | 1665 | 06:24:49 INFO - PROCESS | 1665 | 1478960689245 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:27:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 06:27:04 INFO - PROCESS | 1665 | RSS: Main: 420421632 06:27:04 INFO - PROCESS | 1665 | 06:30:07 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 06:30:08 INFO - PROCESS | 1665 | RSS: Main: 371982336 06:30:08 INFO - PROCESS | 1665 | 06:33:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 06:33:11 INFO - PROCESS | 1665 | RSS: Main: 347439104 06:33:11 INFO - PROCESS | 1665 | 06:36:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 06:36:14 INFO - PROCESS | 1665 | RSS: Main: 345350144 06:36:14 INFO - PROCESS | 1665 | 06:39:17 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 06:39:18 INFO - PROCESS | 1665 | RSS: Main: 341983232 06:39:18 INFO - PROCESS | 1665 | 06:42:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 06:42:21 INFO - PROCESS | 1665 | RSS: Main: 518098944 06:42:21 INFO - PROCESS | 1665 | 06:42:21 INFO - PROCESS | 1665 | __start_tp_report 06:42:21 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 06:42:21 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 06:42:21 INFO - PROCESS | 1665 | |i|pagename|runs| 06:42:21 INFO - PROCESS | 1665 | |0;dojo.html;3279.8852040178585;3286.5234540991555;3333.30000699853;3339.3321335732853;3341.198112453012;5635.21107045014;5707.400722924091;5719.342275638302;5828.708564571771;5829.825105246844;5674.801381951633;5706.600537962334;5768.826935191941;5790.68151251681;5797.188393624896;4314.37441570972;5122.282880396748;5190.480951904817;5228.712420816853;5279.736013199325;5337.359516857982;5344.385395679488;5354.785808567653;5359.919601205985;5396.811111611094;5333.626646134772;5336.9733151334185;5340.866478338073;5366.302380690505;5411.161270003156;5151.5106064923775;5209.531142197183;5229.2417599448245;5235.057689615867;5297.205419187153;5256.710880901549;5269.604779641542;5270.367555893279;5297.602679799031;5330.76011579476;5738.397468265855;5766.452187042224;5774.364819869811;5776.8844623107725;5779.190913272145;6125.571219981368;6129.08063790435;6154.815355539341;6223.471004964584;6266.749330026793;4549.363089167519;6160.5687601867885;6236.688165591702;6271.96864015677;6282.963311053671;5736.856578585569;5814.156947242626;5821.476067153934;5844.532437404998;5844.736986835603;6206.131141640174;6236.563440559208;6301.558890877686;6322.683865806691;6335.68321583919;5108.565771909355;6066.241719785027;6128.080787881853;6139.508839292846;6153.753849845956;6291.496680265568;6293.244810622755;6296.0555916612875;6305.8108256752375;6314.55798094129;6180.7527698891545;6195.31851496335;6231.283402408691;6231.781887633911;6253.405926436982;6132.4778862607845;6134.294556126013;6146.0473626587955;6151.384861513902;6248.4064013918605;4902.068606964665;4906.803727850846;4909.631777616693;4914.311996320518;4918.286848407032;4375.387445757597;4445.044315472189;4473.575010374009;4481.708688935209;4483.394741709827;5711.942880571224;5780.988327042751;5789.392113828072;5793.015187418149;5797.9420205797405;6228.252609686867;6230.688465576703;6239.844003899848;6247.687615619292;6249.6562689052535;5762.9135562966585;5773.797917072882;5784.161296611967;5787.536997040227;5789.015867302569;5365.302510673588;5372.838814835562;5373.247745315659;5382.434844341366;5392.622516423813;6348.841278968062;6356.77751278703;6358.046293056079;6360.84097897547;6368.872622547616;6128.3503509891225;6219.222597175353;6301.936980630135;6307.211598550181;6320.873582528416;5678.858028549319;5726.627769194989;6156.692165391623;6341.207349081365;6354.4916406686425;6199.5040396767245;6208.751649933952;6213.316535181036;6215.440610345091;6233.0338797486465;6212.409821066992;6263.78076767311;6274.780382686584;6276.905846412216;6285.057241413824;4979.377577802775;5967.46292833647;6040.063790112539;6041.69791510414;6043.244594425697;6105.308121371012;6119.045604113885;6134.773364742599;6134.773364742599;6137.5302083125;5925.792597259076;5972.731227094878;5981.611195272293;5984.521238300838;6006.369331220334;5929.229200203946;6095.451409373178;6143.938560614515;6146.354632763496;6149.077638354103;5813.76744930198;5841.269841269841;5865.178874957594;5888.087346461305;5897.64614123154 06:42:21 INFO - PROCESS | 1665 | |1;ext.html;471.5708705078378;497.5099526965938;511.2612275262246;523.4922125538229;551.8510002299377;30177.54733678994;39020.804895975554;40131.598684013115;40253.59746402542;41713.374299385534;31840.522392164137;41542.75371738845;41957;42005.15989680205;42067.37258901518;9243.768905777359;9418.058194180561;9424.96325404205;9426.905730942672;9428.481433521154;9271.443713377184;9358.578863951105;9381.530923453834;9385.296102792283;9402.717918462457;9379.202767764747;9395.906040939606;9396.295277854188;9403.482808445533;9425.010373910744;9313.580888859984;9348.766280842965;9360.110789475057;9374.718758437259;9414.670486532972;9151.496667683276;9233.907660923373;9255.352125351228;9324.766880827965;9331.973482916874;39008.60991390078;39374.212515749525;39433;39472.01319966995;39502.40746388806;3275.197576593726;3328.4508056170703;3370.6292307846115;3639.3813051781262;3880.06878349197;29674.70325296741;30537;30565.38869222603;30684;30854.537181942287;2753.2703833483943;2973.509370953812;3115.7195852373397;3198.1365031441615;3212.180893872048;498089;500144.99999999633;501000;505342;515803;59315.40684593185;59932.700336498914;60044;60063.69968150131;60200.69899650474;33630.66369336275;34298.48552271718;34328.313433731186;34740.652593473744;35287.82356088203;15678.529644110695;15790.684186316439;15800.762988555181;15812.60468488297;15819.05085694862;11953.983911367457;12045.096617753703;12049.397530123459;12053.457594408097;12059.517619295306;18547.814521854878;18555.793873398456;18578.814211857978;18582.721259181122;18586.79185852915;7685.538867667958;7715.344195743424;7722.802965540351;7798.961005194938;7889.382676551293;791.9128895821455;819.0539926385035;837.8575642140851;872.0189786490198;977.3695966101825;28947.56578651322;29627.522038196264;29737.10788676343;30035.549466758017;30150.547741783892;979.4612962870393;1038.4755698372273;1053;1085.46812062089;1103.4648195625116;12775.552855650008;14704.75009624194;14755.631109222355;15250.389984400721;15255.084694918118;670983.6450817714;675911;677519.6124019348;678214;679316;55895.882082358126;56509;56519.71740141273;56522;56531;1059.1156384419096;1146.7305183281921;1155.7457359381092;1253.9498420063096;1254.3163975633483;24391.756082439657;28510.144695659164;29296.56055159217;30063.699363006966;30606.387872242874;52494.73752631212;52898.73550632222;53097.734511328745;53169.734151328994;53265;594644;602479;602873;603463;603571;22558.548829023657;23114.53770924606;24797;25435.6184657234;25734.970601175744;36072.4589131158;44410.66767996965;44959.32561011522;45957.080858381974;46493.53506464892;37338.81330593438;37647.81176094102;37695.623043769214;38778.22443551169;39400.40899386454;32311.838440807645;32369.35261294808;37818.81090594529;38468;38632.42051369175;36102.63897360993;36874.262514750095;36928.44607330946;36930.44604330883;37416;31488.370232595676;31952;32277.51583726293;33904.83047584845;34190;24245;24460.388490287885;24636.876815615808;25179.370515737253;25271 06:42:21 INFO - PROCESS | 1665 | |2;jquery.html;299.74521656591895;352.54697713438236;367.53139746822796;370.6515875077426;407.2161089901938;14565.854341456583;14823.925880370596;15610.985285956405;15712.685746285068;17124.657506849857;19150;19431.652811833417;19729.506762330948;20094.497637559067;20262.797372026274;5731.168980497825;6097.725602347905;6111.083337499366;6122.693865306739;6124.877502449948;5901.114832775075;5929.9703501482645;5957.731902064417;6018.15745795589;6089.177960975278;6036.3360030396625;6038.69806509675;6039.1243269725865;6047.848803779919;6048.697565121748;5795.095921232086;5872.735726892279;5964.701764911737;5991.850203744942;5995.850103747442;5026.195808670632;5185.325907632021;5188.533032027098;5188.8183913563225;5195.610329225323;24488.265352039467;24982;25001.749982500307;25352.492950140895;25375.873120634464;2248.977510224893;2322.303309007308;2386.3198988288427;2441.011390386896;2758.434520923206;12295.508179672803;15254.923725381414;15334.923325383414;15535.844641553553;15992.12043337616;1662.2270644150528;1764.1884733022825;1818.6544556534216;1822.5534743987675;1827.2142978519232;102424.97575024229;118566;121061.39469302686;123347.38326308312;124971.3751431237;10125.848112278321;10329.380237185793;10843.78312433747;10847.349159050482;11155.888441115647;12218.511259549696;12479.627241003482;13466.326683665777;13487.393067311994;13498.055136140376;7027.683754231072;7283.490155689157;8219;8250.711225107092;8399.41204115706;8257.47236761201;8317.164917838076;8356.498610083292;8371.414001019992;8495.27790137833;5403.783848646089;6439.67801609927;6538.280789113193;6549.738010479623;6644.302348253461;1623.342546268763;1767.8762486625812;1804.8556115510728;1810.3482746211353;1813.3925135079896;761.7486229544237;843.6035063520259;871.6252011635058;937.2876613773445;986.5856340337076;20442.95729764174;21660.783392165875;21809.56380872374;21886.274860601712;21940.81896981176;932.5523748600709;939.1594522901964;948.8766460360109;1021.8313978193663;1044.6448207609449;9780.217582593375;9786.706398808046;11476;11589.76820463586;11611.59359422433;479612;530547.3890522168;566094;587431;599155;65017;83769;114488;118434.22348664605;118855;995.3182070281736;995.5868314649484;1013.7364285285879;1061.5010944855906;1064.4518073192157;15018.699626007201;19668.311609093613;19931.402057938285;19994.400167994983;20010;49432;50280;51065;51916.740416297675;55231;73463.53072938405;73622.63188684022;73835;74359;74669.50660986858;7845.372370210255;7848.60756962161;7912.525248484879;7999.400044996532;8017.599120044091;12906.225626462443;12954.352282385655;13146.21122732639;13169.47322107105;13245.933770331472;9369.81260374775;11079.058280046287;11193.944030280123;11357.318560886373;11428.14288928317;10843.891561084289;10943.616973405893;11081.667549973514;11296.096312294832;11400.771984560428;10371.636992705218;10750.784984300426;11122.110231181648;11279.492422840827;11352.94323528377;6101.389861013863;7779.611019448892;7821.726239581587;7835.804104897423;8063.113057563546;10682.305650132717;10779.353238805697;11088.944555277172;11093.778124437627;11148.05241554477 06:42:21 INFO - PROCESS | 1665 | |3;mootools.html;1309.6202101390597;1451.5427640293303;1481.9629509262268;1632.444968710639;1816.6003479234564;6506.902396464056;7339.963300183498;7786.221377862211;8165.265126138646;8168.673253069885;8153.470024448421;8229.67081316748;8233.259006689412;8235.752927412172;8272.751817445485;2275.294658655818;2315.0855412112205;2315.22439982606;2316.3745788637057;2319.6056670365992;2288;2331.0209711920947;2345.179187284445;2345.847519911209;2346.3312955807596;2276.237460450751;2280.372897453197;2307.365474494519;2311.2257393773107;2313.699219101523;2234.765349638289;2257.6387777955447;2298.1152256381247;2301.6547517872455;2302.976970230293;2305.5965206088867;2320.0951628864755;2324.3491822289784;2325.546518428907;2334.8132149428006;8006.839863202762;8153.388495862775;8219.054808697016;8223.301019413357;8235.917640823574;4954.479779623124;5119.052975199563;5126.5642420394315;5132.0505706444055;5153.845384638467;3322.4517954537473;3449.689527942472;3466.2547552276383;3531.04661741331;3532.5054492371087;1048.6644273832376;1057.3761480726332;1059.7615536504302;1075.8924107589178;1092.5684354679856;10579.576816927314;10624.62813801521;10720.410377429316;10721.678349649444;10742.624008159755;3425.72594192464;3508.122969257686;4207.158568286355;4291.6137547620865;4347.760873152007;8470.449420787629;8472.66109355619;8483.660653573788;8503.574821258911;8507.914920850711;4380.255356589388;4952.430470495867;4954.603631709455;4956.702597844069;5051.494850514992;4015.558288588253;4259.531451540328;4399.186150562156;4420.491643460979;4759.119562880878;3534.4344904815107;3589.4077477215965;3637.9818100909324;3650.8904732858055;3658.0123366690846;1129.2377645089532;1131.1064259235277;1136.0400461609927;1141.2125633313153;1145.5188820695328;776.7242628866671;863.8488264553678;893.5487578772808;925.2043242811177;937.3485427627869;5558.888822223533;5664.858378540487;5768.913466298009;5791.478766910914;5943.405659434108;868.5700578213824;882.9779255518534;893.4058850864103;902.444996327254;919.5723988345318;3081.245094951751;3213.550102985584;3683.1528748388023;3746.3069332173636;3777.905552361158;9397.76505587352;9922.553485093189;10113.342632728849;10118.342307749972;10147.036031576989;9586.760330991641;9902.108810207115;10056.296059275926;10084.294099412971;10088.949555252177;7543.73596924116;7673.961630191813;7873.645685944146;7875.6062196889925;7876.960615196887;4544.931826022678;5449.373322067854;5536.480901189869;5593.944060559343;5636.436356364331;9113.863292050757;9261.907380926104;9328.860067098864;9362.765930851783;9461.053894610484;8640.740777776677;9299.395539289924;9484;9608.375455595364;9612.615495380107;6306.810795676137;6480.481561475165;6521.347865213441;6691.59850408977;6727;7859.724909628136;7860.371170306247;7877.527348359117;7941.126476087741;7955.5226686399;5979.820605381671;6996.125484314461;7061.364477196871;7073.893891591527;7074.68163932614;6836.418904393182;6909.516333856582;6914.377706006484;6952.930470695228;6969.407600354027;6515.869682606227;6653.5009874260595;6666.200055993312;6673.265940746611;6674.733010679518;3691.3724666807243;4222.809973551259;4736.431628204499;4818.180909245507;4882.8759489622125;4063.8577649782114;4165.687573431944;4892.241702536113;4893.168161412497;5057.14028615129 06:42:21 INFO - PROCESS | 1665 | |4;prototype.html;279.971106184771;307.38522954091815;309.54496889572334;317.43971889614846;318.79915653138517;5219.556337711294;5258.474152584745;5270.973645131774;5296.629235953485;5309.681419114846;4192.727472714271;5043.470435604264;5197.596648904803;5233.371995360552;5237.685738855671;3812.2947254757887;3866.4973553438012;3876.8061596920043;3957.9208415831667;3960.485136932209;3589.402715791474;3974.682025437958;3979.86070487533;4009;4037.454943582623;3567.6075631680496;3642.488367327556;3970.0868800175977;3972.7616343019513;3975.741576797499;3866.2022159695593;3903.8048097595006;3938.2698174156535;3983.5020622422344;3990.1022269989166;3441.4513468939076;3448.930831442236;3459.68862802349;3474.9826250868837;3482.9477557836653;4356.4772227332605;5030.4215015272985;5043.041822053835;5046.596272298208;5056.494350564951;3749.343864823645;4286.464191976003;4501.954980450187;4510.233260345749;4515.148788996528;5131.384233891957;5384.811531596375;5438.7280635968045;5458.8263523342275;5477.917831232535;3754.7747135171976;3811.6760075393627;3811.8094095295123;3813.5423749150004;3813.8855834325013;5087.34172851427;5154.768035438415;5722.62802917809;5748.683822389767;5755.568332375046;3477.565304336958;3574.910627234288;3811.561670407883;3838.7696738195796;3871.3031654302495;3920.6471417572557;3921.9803900980314;3926.293267211929;3930.587288334741;3936.271789718854;3795.066413662283;4257.083897530201;4470.351798989128;4484.910301793946;4528.864134075917;5150.510701483353;5496.258005169331;5498.285222920995;5516.172574113834;5525.364583072998;1094.9890501095047;1169.7368092179192;1257.7736007518733;1262.7916393795106;1267.3473161321742;778.591239599215;833.8832563441123;864.9221570058725;879.5118709116374;879.9880137841534;3927.666148377363;4480.641548676098;4657.208274593328;5052.292679024939;5125.206177837727;4792.784324705397;5223.850752834371;5540.418256083134;5629.509703983556;5704.657720536781;4618.122556714214;4618.56123668251;4633.976830115827;4919.819243381634;5247.606429517801;2122.2678176029244;2371.6205407134776;2497.700275966896;2517.5216708825265;2816.7324104210065;4788.592969597554;5413.83758487246;5437.891242175214;5465.508104270635;5503.7066289421955;5089.007643509554;5242.217646000378;5459.454054594588;5534.280543529396;5554.77780888768;4963.851084467472;5220.634555581149;5343.5457986071615;5837.6497410155525;5838.883222335615;4561.977190114028;5042.495750425075;5367.543758780547;5520.944790552204;5740.971295143498;4475.70907890986;4754.95682763025;5460.853220823671;5604.467575580314;5656.5757568181725;5408.671853930831;5420.566354691694;5890.4698577128265;5890.793822216202;5918.408159184047;3456.3951308520404;3770.2836461072307;3821.9235615288094;3857.363535016803;3880.6820168755307;4104.363823607346;5503.147012213113;5678.3186017678145;5706.857328566819;5714.599978001666;4595.37962375075;5540.667559946416;5540.924786743396;5554.0843705186935;5556.527695145796;4568.748718820364;5531.612787104864;5538.307711536058;5545.528630066328;5547.583931205095;4747.2672474547235;5024.648274620888;5216.817411390735;5381.973090134681;5399.677079115641;4549.93076626999;4789.209780386197;5320.627556071193;5337.279467271868;5472.972635136799;5021.72380519075;5288.920666189933;5331.413544510023;5357.8392648220615;5361.758720857492 06:42:21 INFO - PROCESS | 1665 | |5;yui.html;694.6839188169383;745.1021519069521;762.2910693055456;792.2394501278773;828.2876726015626;13992.230427326505;14013.089149205294;14557;14585.708285834276;14764;13071.673208169777;13212.801807972888;13244.801327980063;13251.933740331286;13268.137571057874;657.1752450674409;722.6964674836581;844.501743971057;864.6498168241872;865.273170536749;850.4642075492432;851.6508231625035;852.2287329966359;854.2098558833086;856.6915910272328;902.7066203483861;903.4353529044347;906.0531744327194;906.4017748286133;906.9138431848963;898.9595468203946;900.6082354175954;901.6078006067349;904.656230632362;905.112989270512;670.6780745242262;671.5332843673649;672.4418732452053;673.6463356737703;673.9123913891211;13464.798028029587;13645.522406715718;13741.725165496635;13743.312834358341;14246.430142794276;13249.07256492046;13341.933290333487;13475.460981560725;13567.321633918364;13736.244506552135;10876.456177191109;11005;11139.944300278446;11220.158488113424;11287;3767.830447629863;4332.718373305725;4393.758343291118;4398.64810815134;4455.888602784924;80275.19724802794;89787;92619.61070583947;92628.53685731595;92662.53668731681;10126.898731012743;10209.591616335412;10241.385516868862;10445.582176712845;10631.787364252672;18946.715799263024;18949.052547372576;18963.33628323002;18971.71542426865;18982.050897455072;7129.14450265961;7365.116186057708;7426.2945020223;7469.88795168062;7474.364679002237;3878.8642397516514;3999.7800120993625;4036.777977211223;4137.54487006429;4176.206520761046;3129.85915633797;3178.698023687746;3224.5485632011537;3225.951610725841;3235.692609202122;584.8099367705428;601.1463721515458;603.4418163199024;604.114971566657;619.2723549829022;559.4712996218534;593.6734795862259;604.283923550594;604.9516038716893;623.1089541955048;8123.228293312126;8436.36727245459;8515.787105322293;8549.529775862264;8730.69442569507;502.8692539939642;553.6014069869688;605.3552966091099;643.4787821864305;646.2890820097855;3307.371599396107;4200.390943313202;4249.596288352602;4307.138572285493;4379.3430985351815;89849;98282.5772840224;102072.9013622781;108443;108535;61932.69033654803;62212;62296.06555901665;90619;91202;57793.71103144541;75220.24779752242;81070.78393824097;84162;85661.71507427518;9206.907930920874;9335.393199442015;9348.691183234216;9399.20106790903;9426.07032953896;46927.53072469368;48528;53124.20313695375;53852;54353;66633.00050499344;67129;71534;72795;76224;12181.451834667285;12284.877151228373;12645.241285522898;12803.35983200855;12893.48426062947;13543.119697219649;14181.220032897876;14227.573172804832;14392.20842853653;14868.256587170381;12917.677058073623;13067.803982940073;13186;13769.518066867611;13797.586072417844;12773.297468638943;13067.607971760863;13092.410841511964;13204.933975330447;13220.867791321964;12576.937115314731;12882.098253122567;13412.597622071353;13432.731345372842;13456.327183640584;10865.343438467733;11182.496787644413;11446.656600302003;11517.942410287895;11536.884631153582;9144.3598948073;10085.344452610558;10380.844287335847;11355.318680879174;11385.259958102697 06:42:21 INFO - PROCESS | 1665 | __end_tp_report 06:42:21 INFO - PROCESS | 1665 | __start_cc_report 06:42:21 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1763 06:42:21 INFO - PROCESS | 1665 | __end_cc_report 06:42:21 INFO - PROCESS | 1665 | __startTimestamp1478961741830__endTimestamp 06:42:21 INFO - PROCESS | 1665 | 06:42:21 INFO - PROCESS | 1665 | ------- Summary: start ------- 06:42:21 INFO - PROCESS | 1665 | Number of tests: 6 06:42:21 INFO - PROCESS | 1665 | 06:42:21 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5731.68 Median:5865.18 stddev:648.54 (11.1%) stddev-sans-first:621.35 06:42:21 INFO - PROCESS | 1665 | Values: 3279.9 3286.5 3333.3 3339.3 3341.2 5635.2 5707.4 5719.3 5828.7 5829.8 5674.8 5706.6 5768.8 5790.7 5797.2 4314.4 5122.3 5190.5 5228.7 5279.7 5337.4 5344.4 5354.8 5359.9 5396.8 5333.6 5337.0 5340.9 5366.3 5411.2 5151.5 5209.5 5229.2 5235.1 5297.2 5256.7 5269.6 5270.4 5297.6 5330.8 5738.4 5766.5 5774.4 5776.9 5779.2 6125.6 6129.1 6154.8 6223.5 6266.7 4549.4 6160.6 6236.7 6272.0 6283.0 5736.9 5814.2 5821.5 5844.5 5844.7 6206.1 6236.6 6301.6 6322.7 6335.7 5108.6 6066.2 6128.1 6139.5 6153.8 6291.5 6293.2 6296.1 6305.8 6314.6 6180.8 6195.3 6231.3 6231.8 6253.4 6132.5 6134.3 6146.0 6151.4 6248.4 4902.1 4906.8 4909.6 4914.3 4918.3 4375.4 4445.0 4473.6 4481.7 4483.4 5711.9 5781.0 5789.4 5793.0 5797.9 6228.3 6230.7 6239.8 6247.7 6249.7 5762.9 5773.8 5784.2 5787.5 5789.0 5365.3 5372.8 5373.2 5382.4 5392.6 6348.8 6356.8 6358.0 6360.8 6368.9 6128.4 6219.2 6301.9 6307.2 6320.9 5678.9 5726.6 6156.7 6341.2 6354.5 6199.5 6208.8 6213.3 6215.4 6233.0 6212.4 6263.8 6274.8 6276.9 6285.1 4979.4 5967.5 6040.1 6041.7 6043.2 6105.3 6119.0 6134.8 6134.8 6137.5 5925.8 5972.7 5981.6 5984.5 6006.4 5929.2 6095.5 6143.9 6146.4 6149.1 5813.8 5841.3 5865.2 5888.1 5897.6 06:42:21 INFO - PROCESS | 1665 | 06:42:21 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:70939.91 Median:21444.34 stddev:160306.26 (747.5%) stddev-sans-first:160668.65 06:42:21 INFO - PROCESS | 1665 | Values: 471.6 497.5 511.3 523.5 551.9 30177.5 39020.8 40131.6 40253.6 41713.4 31840.5 41542.8 41957.0 42005.2 42067.4 9243.8 9418.1 9425.0 9426.9 9428.5 9271.4 9358.6 9381.5 9385.3 9402.7 9379.2 9395.9 9396.3 9403.5 9425.0 9313.6 9348.8 9360.1 9374.7 9414.7 9151.5 9233.9 9255.4 9324.8 9332.0 39008.6 39374.2 39433.0 39472.0 39502.4 3275.2 3328.5 3370.6 3639.4 3880.1 29674.7 30537.0 30565.4 30684.0 30854.5 2753.3 2973.5 3115.7 3198.1 3212.2 498089.0 500145.0 501000.0 505342.0 515803.0 59315.4 59932.7 60044.0 60063.7 60200.7 33630.7 34298.5 34328.3 34740.7 35287.8 15678.5 15790.7 15800.8 15812.6 15819.1 11954.0 12045.1 12049.4 12053.5 12059.5 18547.8 18555.8 18578.8 18582.7 18586.8 7685.5 7715.3 7722.8 7799.0 7889.4 791.9 819.1 837.9 872.0 977.4 28947.6 29627.5 29737.1 30035.5 30150.5 979.5 1038.5 1053.0 1085.5 1103.5 12775.6 14704.8 14755.6 15250.4 15255.1 670983.6 675911.0 677519.6 678214.0 679316.0 55895.9 56509.0 56519.7 56522.0 56531.0 1059.1 1146.7 1155.7 1253.9 1254.3 24391.8 28510.1 29296.6 30063.7 30606.4 52494.7 52898.7 53097.7 53169.7 53265.0 594644.0 602479.0 602873.0 603463.0 603571.0 22558.5 23114.5 24797.0 25435.6 25735.0 36072.5 44410.7 44959.3 45957.1 46493.5 37338.8 37647.8 37695.6 38778.2 39400.4 32311.8 32369.4 37818.8 38468.0 38632.4 36102.6 36874.3 36928.4 36930.4 37416.0 31488.4 31952.0 32277.5 33904.8 34190.0 24245.0 24460.4 24636.9 25179.4 25271.0 06:42:21 INFO - PROCESS | 1665 | 06:42:21 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:32774.89 Median:24991.87 stddev:92305.58 (369.3%) stddev-sans-first:92532.31 06:42:21 INFO - PROCESS | 1665 | Values: 299.7 352.5 367.5 370.7 407.2 14565.9 14823.9 15611.0 15712.7 17124.7 19150.0 19431.7 19729.5 20094.5 20262.8 5731.2 6097.7 6111.1 6122.7 6124.9 5901.1 5930.0 5957.7 6018.2 6089.2 6036.3 6038.7 6039.1 6047.8 6048.7 5795.1 5872.7 5964.7 5991.9 5995.9 5026.2 5185.3 5188.5 5188.8 5195.6 24488.3 24982.0 25001.7 25352.5 25375.9 2249.0 2322.3 2386.3 2441.0 2758.4 12295.5 15254.9 15334.9 15535.8 15992.1 1662.2 1764.2 1818.7 1822.6 1827.2 102425.0 118566.0 121061.4 123347.4 124971.4 10125.8 10329.4 10843.8 10847.3 11155.9 12218.5 12479.6 13466.3 13487.4 13498.1 7027.7 7283.5 8219.0 8250.7 8399.4 8257.5 8317.2 8356.5 8371.4 8495.3 5403.8 6439.7 6538.3 6549.7 6644.3 1623.3 1767.9 1804.9 1810.3 1813.4 761.7 843.6 871.6 937.3 986.6 20443.0 21660.8 21809.6 21886.3 21940.8 932.6 939.2 948.9 1021.8 1044.6 9780.2 9786.7 11476.0 11589.8 11611.6 479612.0 530547.4 566094.0 587431.0 599155.0 65017.0 83769.0 114488.0 118434.2 118855.0 995.3 995.6 1013.7 1061.5 1064.5 15018.7 19668.3 19931.4 19994.4 20010.0 49432.0 50280.0 51065.0 51916.7 55231.0 73463.5 73622.6 73835.0 74359.0 74669.5 7845.4 7848.6 7912.5 7999.4 8017.6 12906.2 12954.4 13146.2 13169.5 13245.9 9369.8 11079.1 11193.9 11357.3 11428.1 10843.9 10943.6 11081.7 11296.1 11400.8 10371.6 10750.8 11122.1 11279.5 11352.9 6101.4 7779.6 7821.7 7835.8 8063.1 10682.3 10779.4 11088.9 11093.8 11148.1 06:42:21 INFO - PROCESS | 1665 | 06:42:21 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5287.97 Median:5004.10 stddev:2925.44 (58.5%) stddev-sans-first:2918.36 06:42:21 INFO - PROCESS | 1665 | Values: 1309.6 1451.5 1482.0 1632.4 1816.6 6506.9 7340.0 7786.2 8165.3 8168.7 8153.5 8229.7 8233.3 8235.8 8272.8 2275.3 2315.1 2315.2 2316.4 2319.6 2288.0 2331.0 2345.2 2345.8 2346.3 2276.2 2280.4 2307.4 2311.2 2313.7 2234.8 2257.6 2298.1 2301.7 2303.0 2305.6 2320.1 2324.3 2325.5 2334.8 8006.8 8153.4 8219.1 8223.3 8235.9 4954.5 5119.1 5126.6 5132.1 5153.8 3322.5 3449.7 3466.3 3531.0 3532.5 1048.7 1057.4 1059.8 1075.9 1092.6 10579.6 10624.6 10720.4 10721.7 10742.6 3425.7 3508.1 4207.2 4291.6 4347.8 8470.4 8472.7 8483.7 8503.6 8507.9 4380.3 4952.4 4954.6 4956.7 5051.5 4015.6 4259.5 4399.2 4420.5 4759.1 3534.4 3589.4 3638.0 3650.9 3658.0 1129.2 1131.1 1136.0 1141.2 1145.5 776.7 863.8 893.5 925.2 937.3 5558.9 5664.9 5768.9 5791.5 5943.4 868.6 883.0 893.4 902.4 919.6 3081.2 3213.6 3683.2 3746.3 3777.9 9397.8 9922.6 10113.3 10118.3 10147.0 9586.8 9902.1 10056.3 10084.3 10088.9 7543.7 7674.0 7873.6 7875.6 7877.0 4544.9 5449.4 5536.5 5593.9 5636.4 9113.9 9261.9 9328.9 9362.8 9461.1 8640.7 9299.4 9484.0 9608.4 9612.6 6306.8 6480.5 6521.3 6691.6 6727.0 7859.7 7860.4 7877.5 7941.1 7955.5 5979.8 6996.1 7061.4 7073.9 7074.7 6836.4 6909.5 6914.4 6952.9 6969.4 6515.9 6653.5 6666.2 6673.3 6674.7 3691.4 4222.8 4736.4 4818.2 4882.9 4063.9 4165.7 4892.2 4893.2 5057.1 06:42:21 INFO - PROCESS | 1665 | 06:42:21 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4384.35 Median:4992.79 stddev:1352.88 (27.1%) stddev-sans-first:1321.14 06:42:21 INFO - PROCESS | 1665 | Values: 280.0 307.4 309.5 317.4 318.8 5219.6 5258.5 5271.0 5296.6 5309.7 4192.7 5043.5 5197.6 5233.4 5237.7 3812.3 3866.5 3876.8 3957.9 3960.5 3589.4 3974.7 3979.9 4009.0 4037.5 3567.6 3642.5 3970.1 3972.8 3975.7 3866.2 3903.8 3938.3 3983.5 3990.1 3441.5 3448.9 3459.7 3475.0 3482.9 4356.5 5030.4 5043.0 5046.6 5056.5 3749.3 4286.5 4502.0 4510.2 4515.1 5131.4 5384.8 5438.7 5458.8 5477.9 3754.8 3811.7 3811.8 3813.5 3813.9 5087.3 5154.8 5722.6 5748.7 5755.6 3477.6 3574.9 3811.6 3838.8 3871.3 3920.6 3922.0 3926.3 3930.6 3936.3 3795.1 4257.1 4470.4 4484.9 4528.9 5150.5 5496.3 5498.3 5516.2 5525.4 1095.0 1169.7 1257.8 1262.8 1267.3 778.6 833.9 864.9 879.5 880.0 3927.7 4480.6 4657.2 5052.3 5125.2 4792.8 5223.9 5540.4 5629.5 5704.7 4618.1 4618.6 4634.0 4919.8 5247.6 2122.3 2371.6 2497.7 2517.5 2816.7 4788.6 5413.8 5437.9 5465.5 5503.7 5089.0 5242.2 5459.5 5534.3 5554.8 4963.9 5220.6 5343.5 5837.6 5838.9 4562.0 5042.5 5367.5 5520.9 5741.0 4475.7 4755.0 5460.9 5604.5 5656.6 5408.7 5420.6 5890.5 5890.8 5918.4 3456.4 3770.3 3821.9 3857.4 3880.7 4104.4 5503.1 5678.3 5706.9 5714.6 4595.4 5540.7 5540.9 5554.1 5556.5 4568.7 5531.6 5538.3 5545.5 5547.6 4747.3 5024.6 5216.8 5382.0 5399.7 4549.9 4789.2 5320.6 5337.3 5473.0 5021.7 5288.9 5331.4 5357.8 5361.8 06:42:21 INFO - PROCESS | 1665 | 06:42:21 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:19292.88 Median:4427.27 stddev:27480.67 (620.7%) stddev-sans-first:27522.28 06:42:21 INFO - PROCESS | 1665 | Values: 694.7 745.1 762.3 792.2 828.3 13992.2 14013.1 14557.0 14585.7 14764.0 13071.7 13212.8 13244.8 13251.9 13268.1 657.2 722.7 844.5 864.6 865.3 850.5 851.7 852.2 854.2 856.7 902.7 903.4 906.1 906.4 906.9 899.0 900.6 901.6 904.7 905.1 670.7 671.5 672.4 673.6 673.9 13464.8 13645.5 13741.7 13743.3 14246.4 13249.1 13341.9 13475.5 13567.3 13736.2 10876.5 11005.0 11139.9 11220.2 11287.0 3767.8 4332.7 4393.8 4398.6 4455.9 80275.2 89787.0 92619.6 92628.5 92662.5 10126.9 10209.6 10241.4 10445.6 10631.8 18946.7 18949.1 18963.3 18971.7 18982.1 7129.1 7365.1 7426.3 7469.9 7474.4 3878.9 3999.8 4036.8 4137.5 4176.2 3129.9 3178.7 3224.5 3226.0 3235.7 584.8 601.1 603.4 604.1 619.3 559.5 593.7 604.3 605.0 623.1 8123.2 8436.4 8515.8 8549.5 8730.7 502.9 553.6 605.4 643.5 646.3 3307.4 4200.4 4249.6 4307.1 4379.3 89849.0 98282.6 102072.9 108443.0 108535.0 61932.7 62212.0 62296.1 90619.0 91202.0 57793.7 75220.2 81070.8 84162.0 85661.7 9206.9 9335.4 9348.7 9399.2 9426.1 46927.5 48528.0 53124.2 53852.0 54353.0 66633.0 67129.0 71534.0 72795.0 76224.0 12181.5 12284.9 12645.2 12803.4 12893.5 13543.1 14181.2 14227.6 14392.2 14868.3 12917.7 13067.8 13186.0 13769.5 13797.6 12773.3 13067.6 13092.4 13204.9 13220.9 12576.9 12882.1 13412.6 13432.7 13456.3 10865.3 11182.5 11446.7 11517.9 11536.9 9144.4 10085.3 10380.8 11355.3 11385.3 06:42:21 INFO - PROCESS | 1665 | -------- Summary: end -------- 06:42:21 INFO - PROCESS | 1665 | 06:42:22 INFO - TEST-INFO | 1665: exit 0 06:42:22 INFO - TEST-OK | dromaeo_css | took 1119538ms 06:42:22 INFO - TEST-START | kraken 06:42:22 INFO - operating with platform_type : mac_ 06:42:22 INFO - Initialising browser for kraken test... 06:42:22 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpYR41jr/profile http://localhost:49271/getInfo.html) 06:42:24 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 06:42:24 INFO - PROCESS | 1672 | colorDepth:24 06:42:24 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 06:42:24 INFO - PROCESS | 1672 | __metrics 06:42:24 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:42:24 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:42:25 INFO - TEST-INFO | 1672: exit 0 06:42:25 INFO - Browser initialized. 06:42:25 INFO - Running cycle 1/1 for kraken test... 06:42:25 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpYR41jr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:37 INFO - PROCESS | 1674 | RSS: Main: 229609472 06:42:37 INFO - PROCESS | 1674 | 06:42:40 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 06:42:41 INFO - PROCESS | 1674 | RSS: Main: 289472512 06:42:41 INFO - PROCESS | 1674 | 06:42:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 06:42:44 INFO - PROCESS | 1674 | RSS: Main: 291889152 06:42:44 INFO - PROCESS | 1674 | 06:42:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 06:42:48 INFO - PROCESS | 1674 | RSS: Main: 380559360 06:42:48 INFO - PROCESS | 1674 | 06:42:50 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 06:42:51 INFO - PROCESS | 1674 | RSS: Main: 285671424 06:42:51 INFO - PROCESS | 1674 | 06:42:53 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:42:54 INFO - PROCESS | 1674 | RSS: Main: 287846400 06:42:54 INFO - PROCESS | 1674 | 06:42:56 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 06:42:57 INFO - PROCESS | 1674 | RSS: Main: 333090816 06:42:57 INFO - PROCESS | 1674 | 06:43:00 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 06:43:01 INFO - PROCESS | 1674 | RSS: Main: 332115968 06:43:01 INFO - PROCESS | 1674 | 06:43:03 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 06:43:04 INFO - PROCESS | 1674 | RSS: Main: 332087296 06:43:04 INFO - PROCESS | 1674 | 06:43:06 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:43:06 INFO - PROCESS | 1674 | RSS: Main: 304377856 06:43:06 INFO - PROCESS | 1674 | 06:43:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:43:09 INFO - PROCESS | 1674 | RSS: Main: 305922048 06:43:09 INFO - PROCESS | 1674 | 06:43:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:43:12 INFO - PROCESS | 1674 | RSS: Main: 312528896 06:43:12 INFO - PROCESS | 1674 | 06:43:14 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:43:15 INFO - PROCESS | 1674 | RSS: Main: 324784128 06:43:15 INFO - PROCESS | 1674 | 06:43:18 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:43:19 INFO - PROCESS | 1674 | RSS: Main: 319037440 06:43:19 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 06:43:21 INFO - PROCESS | 1674 | RSS: Main: 362737664 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | __start_tp_report 06:43:21 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 06:43:21 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 06:43:21 INFO - PROCESS | 1674 | |i|pagename|runs| 06:43:21 INFO - PROCESS | 1674 | |0;ai-astar;110;112;113;112;112;114;112;112;113;111 06:43:21 INFO - PROCESS | 1674 | |1;audio-beat-detection;141;113;110;149;139;138;137;110;142;113 06:43:21 INFO - PROCESS | 1674 | |2;audio-dft;184;182;183;186;180;182;183;181;182;186 06:43:21 INFO - PROCESS | 1674 | |3;audio-fft;80;58;59;87;63;75;83;82;93;58 06:43:21 INFO - PROCESS | 1674 | |4;audio-oscillator;88;69;94;72;70;70;89;68;69;93 06:43:21 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;87;84;86;84;87;83;87;84;86;84 06:43:21 INFO - PROCESS | 1674 | |6;imaging-darkroom;95;95;96;95;95;94;94;95;95;108 06:43:21 INFO - PROCESS | 1674 | |7;imaging-desaturate;84;82;81;80;85;128;135;83;84;82 06:43:21 INFO - PROCESS | 1674 | |8;json-parse-financial;55;54;54;53;54;55;53;51;53;54 06:43:21 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;65;78;82;71;73;70;70;71;71;73 06:43:21 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;87;87;89;88;90;86;90;86;88;86 06:43:21 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;145;146;147;147;146;152;161;157;187;157 06:43:21 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;176;174;178;174;173;171;169;176;173;173 06:43:21 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;68;68;68;78;87;89;71;67;68 06:43:21 INFO - PROCESS | 1674 | __end_tp_report 06:43:21 INFO - PROCESS | 1674 | __start_cc_report 06:43:21 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,2002 06:43:21 INFO - PROCESS | 1674 | __end_cc_report 06:43:21 INFO - PROCESS | 1674 | __startTimestamp1478961801403__endTimestamp 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | ------- Summary: start ------- 06:43:21 INFO - PROCESS | 1674 | Number of tests: 14 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:1.10 (1.0%) stddev-sans-first:0.87 06:43:21 INFO - PROCESS | 1674 | Values: 110.0 112.0 113.0 112.0 112.0 114.0 112.0 112.0 113.0 111.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:138.50 stddev:15.60 (11.3%) stddev-sans-first:15.96 06:43:21 INFO - PROCESS | 1674 | Values: 141.0 113.0 110.0 149.0 139.0 138.0 137.0 110.0 142.0 113.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.00 stddev:1.97 (1.1%) stddev-sans-first:2.05 06:43:21 INFO - PROCESS | 1674 | Values: 184.0 182.0 183.0 186.0 180.0 182.0 183.0 181.0 182.0 186.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:73.80 Median:81.00 stddev:13.21 (16.3%) stddev-sans-first:13.82 06:43:21 INFO - PROCESS | 1674 | Values: 80.0 58.0 59.0 87.0 63.0 75.0 83.0 82.0 93.0 58.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:80.00 stddev:11.19 (14.0%) stddev-sans-first:11.30 06:43:21 INFO - PROCESS | 1674 | Values: 88.0 69.0 94.0 72.0 70.0 70.0 89.0 68.0 69.0 93.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:1.55 (1.8%) stddev-sans-first:1.50 06:43:21 INFO - PROCESS | 1674 | Values: 87.0 84.0 86.0 84.0 87.0 83.0 87.0 84.0 86.0 84.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:95.00 stddev:4.18 (4.4%) stddev-sans-first:4.42 06:43:21 INFO - PROCESS | 1674 | Values: 95.0 95.0 96.0 95.0 95.0 94.0 94.0 95.0 95.0 108.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:82.50 stddev:20.73 (25.1%) stddev-sans-first:21.76 06:43:21 INFO - PROCESS | 1674 | Values: 84.0 82.0 81.0 80.0 85.0 128.0 135.0 83.0 84.0 82.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.17 (2.2%) stddev-sans-first:1.13 06:43:21 INFO - PROCESS | 1674 | Values: 55.0 54.0 54.0 53.0 54.0 55.0 53.0 51.0 53.0 54.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.00 stddev:4.67 (6.5%) stddev-sans-first:4.12 06:43:21 INFO - PROCESS | 1674 | Values: 65.0 78.0 82.0 71.0 73.0 70.0 70.0 71.0 71.0 73.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:88.00 stddev:1.57 (1.8%) stddev-sans-first:1.64 06:43:21 INFO - PROCESS | 1674 | Values: 87.0 87.0 89.0 88.0 90.0 86.0 90.0 86.0 88.0 86.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:154.50 stddev:12.76 (8.3%) stddev-sans-first:13.06 06:43:21 INFO - PROCESS | 1674 | Values: 145.0 146.0 147.0 147.0 146.0 152.0 161.0 157.0 187.0 157.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:174.00 stddev:2.58 (1.5%) stddev-sans-first:2.60 06:43:21 INFO - PROCESS | 1674 | Values: 176.0 174.0 178.0 174.0 173.0 171.0 169.0 176.0 173.0 173.0 06:43:21 INFO - PROCESS | 1674 | 06:43:21 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:69.50 stddev:8.52 (12.3%) stddev-sans-first:8.74 06:43:21 INFO - PROCESS | 1674 | Values: 67.0 68.0 68.0 68.0 78.0 87.0 89.0 71.0 67.0 68.0 06:43:21 INFO - PROCESS | 1674 | -------- Summary: end -------- 06:43:21 INFO - PROCESS | 1674 | 06:43:22 INFO - TEST-INFO | 1674: exit 0 06:43:22 INFO - TEST-OK | kraken | took 59850ms 06:43:22 INFO - SUITE-END | took 1179s 06:43:22 INFO - Completed test suite (00:19:39) 06:43:22 INFO - javascript benchmark 06:43:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.8852040178585, 3286.5234540991555, 3333.30000699853, 3339.3321335732853, 3341.198112453012, 5635.21107045014, 5707.400722924091, 5719.342275638302, 5828.708564571771, 5829.825105246844, 5674.801381951633, 5706.600537962334, 5768.826935191941, 5790.68151251681, 5797.188393624896, 4314.37441570972, 5122.282880396748, 5190.480951904817, 5228.712420816853, 5279.736013199325, 5337.359516857982, 5344.385395679488, 5354.785808567653, 5359.919601205985, 5396.811111611094, 5333.626646134772, 5336.9733151334185, 5340.866478338073, 5366.302380690505, 5411.161270003156, 5151.5106064923775, 5209.531142197183, 5229.2417599448245, 5235.057689615867, 5297.205419187153, 5256.710880901549, 5269.604779641542, 5270.367555893279, 5297.602679799031, 5330.76011579476, 5738.397468265855, 5766.452187042224, 5774.364819869811, 5776.8844623107725, 5779.190913272145, 6125.571219981368, 6129.08063790435, 6154.815355539341, 6223.471004964584, 6266.749330026793, 4549.363089167519, 6160.5687601867885, 6236.688165591702, 6271.96864015677, 6282.963311053671, 5736.856578585569, 5814.156947242626, 5821.476067153934, 5844.532437404998, 5844.736986835603, 6206.131141640174, 6236.563440559208, 6301.558890877686, 6322.683865806691, 6335.68321583919, 5108.565771909355, 6066.241719785027, 6128.080787881853, 6139.508839292846, 6153.753849845956, 6291.496680265568, 6293.244810622755, 6296.0555916612875, 6305.8108256752375, 6314.55798094129, 6180.7527698891545, 6195.31851496335, 6231.283402408691, 6231.781887633911, 6253.405926436982, 6132.4778862607845, 6134.294556126013, 6146.0473626587955, 6151.384861513902, 6248.4064013918605, 4902.068606964665, 4906.803727850846, 4909.631777616693, 4914.311996320518, 4918.286848407032, 4375.387445757597, 4445.044315472189, 4473.575010374009, 4481.708688935209, 4483.394741709827, 5711.942880571224, 5780.988327042751, 5789.392113828072, 5793.015187418149, 5797.9420205797405, 6228.252609686867, 6230.688465576703, 6239.844003899848, 6247.687615619292, 6249.6562689052535, 5762.9135562966585, 5773.797917072882, 5784.161296611967, 5787.536997040227, 5789.015867302569, 5365.302510673588, 5372.838814835562, 5373.247745315659, 5382.434844341366, 5392.622516423813, 6348.841278968062, 6356.77751278703, 6358.046293056079, 6360.84097897547, 6368.872622547616, 6128.3503509891225, 6219.222597175353, 6301.936980630135, 6307.211598550181, 6320.873582528416, 5678.858028549319, 5726.627769194989, 6156.692165391623, 6341.207349081365, 6354.4916406686425, 6199.5040396767245, 6208.751649933952, 6213.316535181036, 6215.440610345091, 6233.0338797486465, 6212.409821066992, 6263.78076767311, 6274.780382686584, 6276.905846412216, 6285.057241413824, 4979.377577802775, 5967.46292833647, 6040.063790112539, 6041.69791510414, 6043.244594425697, 6105.308121371012, 6119.045604113885, 6134.773364742599, 6134.773364742599, 6137.5302083125, 5925.792597259076, 5972.731227094878, 5981.611195272293, 5984.521238300838, 6006.369331220334, 5929.229200203946, 6095.451409373178, 6143.938560614515, 6146.354632763496, 6149.077638354103, 5813.76744930198, 5841.269841269841, 5865.178874957594, 5888.087346461305, 5897.64614123154], "value": 5690.985825233705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.5708705078378, 497.5099526965938, 511.2612275262246, 523.4922125538229, 551.8510002299377, 30177.54733678994, 39020.804895975554, 40131.598684013115, 40253.59746402542, 41713.374299385534, 31840.522392164137, 41542.75371738845, 41957.0, 42005.15989680205, 42067.37258901518, 9243.768905777359, 9418.058194180561, 9424.96325404205, 9426.905730942672, 9428.481433521154, 9271.443713377184, 9358.578863951105, 9381.530923453834, 9385.296102792283, 9402.717918462457, 9379.202767764747, 9395.906040939606, 9396.295277854188, 9403.482808445533, 9425.010373910744, 9313.580888859984, 9348.766280842965, 9360.110789475057, 9374.718758437259, 9414.670486532972, 9151.496667683276, 9233.907660923373, 9255.352125351228, 9324.766880827965, 9331.973482916874, 39008.60991390078, 39374.212515749525, 39433.0, 39472.01319966995, 39502.40746388806, 3275.197576593726, 3328.4508056170703, 3370.6292307846115, 3639.3813051781262, 3880.06878349197, 29674.70325296741, 30537.0, 30565.38869222603, 30684.0, 30854.537181942287, 2753.2703833483943, 2973.509370953812, 3115.7195852373397, 3198.1365031441615, 3212.180893872048, 498089.0, 500144.99999999633, 501000.0, 505342.0, 515803.0, 59315.40684593185, 59932.700336498914, 60044.0, 60063.69968150131, 60200.69899650474, 33630.66369336275, 34298.48552271718, 34328.313433731186, 34740.652593473744, 35287.82356088203, 15678.529644110695, 15790.684186316439, 15800.762988555181, 15812.60468488297, 15819.05085694862, 11953.983911367457, 12045.096617753703, 12049.397530123459, 12053.457594408097, 12059.517619295306, 18547.814521854878, 18555.793873398456, 18578.814211857978, 18582.721259181122, 18586.79185852915, 7685.538867667958, 7715.344195743424, 7722.802965540351, 7798.961005194938, 7889.382676551293, 791.9128895821455, 819.0539926385035, 837.8575642140851, 872.0189786490198, 977.3695966101825, 28947.56578651322, 29627.522038196264, 29737.10788676343, 30035.549466758017, 30150.547741783892, 979.4612962870393, 1038.4755698372273, 1053.0, 1085.46812062089, 1103.4648195625116, 12775.552855650008, 14704.75009624194, 14755.631109222355, 15250.389984400721, 15255.084694918118, 670983.6450817714, 675911.0, 677519.6124019348, 678214.0, 679316.0, 55895.882082358126, 56509.0, 56519.71740141273, 56522.0, 56531.0, 1059.1156384419096, 1146.7305183281921, 1155.7457359381092, 1253.9498420063096, 1254.3163975633483, 24391.756082439657, 28510.144695659164, 29296.56055159217, 30063.699363006966, 30606.387872242874, 52494.73752631212, 52898.73550632222, 53097.734511328745, 53169.734151328994, 53265.0, 594644.0, 602479.0, 602873.0, 603463.0, 603571.0, 22558.548829023657, 23114.53770924606, 24797.0, 25435.6184657234, 25734.970601175744, 36072.4589131158, 44410.66767996965, 44959.32561011522, 45957.080858381974, 46493.53506464892, 37338.81330593438, 37647.81176094102, 37695.623043769214, 38778.22443551169, 39400.40899386454, 32311.838440807645, 32369.35261294808, 37818.81090594529, 38468.0, 38632.42051369175, 36102.63897360993, 36874.262514750095, 36928.44607330946, 36930.44604330883, 37416.0, 31488.370232595676, 31952.0, 32277.51583726293, 33904.83047584845, 34190.0, 24245.0, 24460.388490287885, 24636.876815615808, 25179.370515737253, 25271.0], "value": 19141.54831825231, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.74521656591895, 352.54697713438236, 367.53139746822796, 370.6515875077426, 407.2161089901938, 14565.854341456583, 14823.925880370596, 15610.985285956405, 15712.685746285068, 17124.657506849857, 19150.0, 19431.652811833417, 19729.506762330948, 20094.497637559067, 20262.797372026274, 5731.168980497825, 6097.725602347905, 6111.083337499366, 6122.693865306739, 6124.877502449948, 5901.114832775075, 5929.9703501482645, 5957.731902064417, 6018.15745795589, 6089.177960975278, 6036.3360030396625, 6038.69806509675, 6039.1243269725865, 6047.848803779919, 6048.697565121748, 5795.095921232086, 5872.735726892279, 5964.701764911737, 5991.850203744942, 5995.850103747442, 5026.195808670632, 5185.325907632021, 5188.533032027098, 5188.8183913563225, 5195.610329225323, 24488.265352039467, 24982.0, 25001.749982500307, 25352.492950140895, 25375.873120634464, 2248.977510224893, 2322.303309007308, 2386.3198988288427, 2441.011390386896, 2758.434520923206, 12295.508179672803, 15254.923725381414, 15334.923325383414, 15535.844641553553, 15992.12043337616, 1662.2270644150528, 1764.1884733022825, 1818.6544556534216, 1822.5534743987675, 1827.2142978519232, 102424.97575024229, 118566.0, 121061.39469302686, 123347.38326308312, 124971.3751431237, 10125.848112278321, 10329.380237185793, 10843.78312433747, 10847.349159050482, 11155.888441115647, 12218.511259549696, 12479.627241003482, 13466.326683665777, 13487.393067311994, 13498.055136140376, 7027.683754231072, 7283.490155689157, 8219.0, 8250.711225107092, 8399.41204115706, 8257.47236761201, 8317.164917838076, 8356.498610083292, 8371.414001019992, 8495.27790137833, 5403.783848646089, 6439.67801609927, 6538.280789113193, 6549.738010479623, 6644.302348253461, 1623.342546268763, 1767.8762486625812, 1804.8556115510728, 1810.3482746211353, 1813.3925135079896, 761.7486229544237, 843.6035063520259, 871.6252011635058, 937.2876613773445, 986.5856340337076, 20442.95729764174, 21660.783392165875, 21809.56380872374, 21886.274860601712, 21940.81896981176, 932.5523748600709, 939.1594522901964, 948.8766460360109, 1021.8313978193663, 1044.6448207609449, 9780.217582593375, 9786.706398808046, 11476.0, 11589.76820463586, 11611.59359422433, 479612.0, 530547.3890522168, 566094.0, 587431.0, 599155.0, 65017.0, 83769.0, 114488.0, 118434.22348664605, 118855.0, 995.3182070281736, 995.5868314649484, 1013.7364285285879, 1061.5010944855906, 1064.4518073192157, 15018.699626007201, 19668.311609093613, 19931.402057938285, 19994.400167994983, 20010.0, 49432.0, 50280.0, 51065.0, 51916.740416297675, 55231.0, 73463.53072938405, 73622.63188684022, 73835.0, 74359.0, 74669.50660986858, 7845.372370210255, 7848.60756962161, 7912.525248484879, 7999.400044996532, 8017.599120044091, 12906.225626462443, 12954.352282385655, 13146.21122732639, 13169.47322107105, 13245.933770331472, 9369.81260374775, 11079.058280046287, 11193.944030280123, 11357.318560886373, 11428.14288928317, 10843.891561084289, 10943.616973405893, 11081.667549973514, 11296.096312294832, 11400.771984560428, 10371.636992705218, 10750.784984300426, 11122.110231181648, 11279.492422840827, 11352.94323528377, 6101.389861013863, 7779.611019448892, 7821.726239581587, 7835.804104897423, 8063.113057563546, 10682.305650132717, 10779.353238805697, 11088.944555277172, 11093.778124437627, 11148.05241554477], "value": 9456.340619452461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.6202101390597, 1451.5427640293303, 1481.9629509262268, 1632.444968710639, 1816.6003479234564, 6506.902396464056, 7339.963300183498, 7786.221377862211, 8165.265126138646, 8168.673253069885, 8153.470024448421, 8229.67081316748, 8233.259006689412, 8235.752927412172, 8272.751817445485, 2275.294658655818, 2315.0855412112205, 2315.22439982606, 2316.3745788637057, 2319.6056670365992, 2288.0, 2331.0209711920947, 2345.179187284445, 2345.847519911209, 2346.3312955807596, 2276.237460450751, 2280.372897453197, 2307.365474494519, 2311.2257393773107, 2313.699219101523, 2234.765349638289, 2257.6387777955447, 2298.1152256381247, 2301.6547517872455, 2302.976970230293, 2305.5965206088867, 2320.0951628864755, 2324.3491822289784, 2325.546518428907, 2334.8132149428006, 8006.839863202762, 8153.388495862775, 8219.054808697016, 8223.301019413357, 8235.917640823574, 4954.479779623124, 5119.052975199563, 5126.5642420394315, 5132.0505706444055, 5153.845384638467, 3322.4517954537473, 3449.689527942472, 3466.2547552276383, 3531.04661741331, 3532.5054492371087, 1048.6644273832376, 1057.3761480726332, 1059.7615536504302, 1075.8924107589178, 1092.5684354679856, 10579.576816927314, 10624.62813801521, 10720.410377429316, 10721.678349649444, 10742.624008159755, 3425.72594192464, 3508.122969257686, 4207.158568286355, 4291.6137547620865, 4347.760873152007, 8470.449420787629, 8472.66109355619, 8483.660653573788, 8503.574821258911, 8507.914920850711, 4380.255356589388, 4952.430470495867, 4954.603631709455, 4956.702597844069, 5051.494850514992, 4015.558288588253, 4259.531451540328, 4399.186150562156, 4420.491643460979, 4759.119562880878, 3534.4344904815107, 3589.4077477215965, 3637.9818100909324, 3650.8904732858055, 3658.0123366690846, 1129.2377645089532, 1131.1064259235277, 1136.0400461609927, 1141.2125633313153, 1145.5188820695328, 776.7242628866671, 863.8488264553678, 893.5487578772808, 925.2043242811177, 937.3485427627869, 5558.888822223533, 5664.858378540487, 5768.913466298009, 5791.478766910914, 5943.405659434108, 868.5700578213824, 882.9779255518534, 893.4058850864103, 902.444996327254, 919.5723988345318, 3081.245094951751, 3213.550102985584, 3683.1528748388023, 3746.3069332173636, 3777.905552361158, 9397.76505587352, 9922.553485093189, 10113.342632728849, 10118.342307749972, 10147.036031576989, 9586.760330991641, 9902.108810207115, 10056.296059275926, 10084.294099412971, 10088.949555252177, 7543.73596924116, 7673.961630191813, 7873.645685944146, 7875.6062196889925, 7876.960615196887, 4544.931826022678, 5449.373322067854, 5536.480901189869, 5593.944060559343, 5636.436356364331, 9113.863292050757, 9261.907380926104, 9328.860067098864, 9362.765930851783, 9461.053894610484, 8640.740777776677, 9299.395539289924, 9484.0, 9608.375455595364, 9612.615495380107, 6306.810795676137, 6480.481561475165, 6521.347865213441, 6691.59850408977, 6727.0, 7859.724909628136, 7860.371170306247, 7877.527348359117, 7941.126476087741, 7955.5226686399, 5979.820605381671, 6996.125484314461, 7061.364477196871, 7073.893891591527, 7074.68163932614, 6836.418904393182, 6909.516333856582, 6914.377706006484, 6952.930470695228, 6969.407600354027, 6515.869682606227, 6653.5009874260595, 6666.200055993312, 6673.265940746611, 6674.733010679518, 3691.3724666807243, 4222.809973551259, 4736.431628204499, 4818.180909245507, 4882.8759489622125, 4063.8577649782114, 4165.687573431944, 4892.241702536113, 4893.168161412497, 5057.14028615129], "value": 4286.96034447862, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.971106184771, 307.38522954091815, 309.54496889572334, 317.43971889614846, 318.79915653138517, 5219.556337711294, 5258.474152584745, 5270.973645131774, 5296.629235953485, 5309.681419114846, 4192.727472714271, 5043.470435604264, 5197.596648904803, 5233.371995360552, 5237.685738855671, 3812.2947254757887, 3866.4973553438012, 3876.8061596920043, 3957.9208415831667, 3960.485136932209, 3589.402715791474, 3974.682025437958, 3979.86070487533, 4009.0, 4037.454943582623, 3567.6075631680496, 3642.488367327556, 3970.0868800175977, 3972.7616343019513, 3975.741576797499, 3866.2022159695593, 3903.8048097595006, 3938.2698174156535, 3983.5020622422344, 3990.1022269989166, 3441.4513468939076, 3448.930831442236, 3459.68862802349, 3474.9826250868837, 3482.9477557836653, 4356.4772227332605, 5030.4215015272985, 5043.041822053835, 5046.596272298208, 5056.494350564951, 3749.343864823645, 4286.464191976003, 4501.954980450187, 4510.233260345749, 4515.148788996528, 5131.384233891957, 5384.811531596375, 5438.7280635968045, 5458.8263523342275, 5477.917831232535, 3754.7747135171976, 3811.6760075393627, 3811.8094095295123, 3813.5423749150004, 3813.8855834325013, 5087.34172851427, 5154.768035438415, 5722.62802917809, 5748.683822389767, 5755.568332375046, 3477.565304336958, 3574.910627234288, 3811.561670407883, 3838.7696738195796, 3871.3031654302495, 3920.6471417572557, 3921.9803900980314, 3926.293267211929, 3930.587288334741, 3936.271789718854, 3795.066413662283, 4257.083897530201, 4470.351798989128, 4484.910301793946, 4528.864134075917, 5150.510701483353, 5496.258005169331, 5498.285222920995, 5516.172574113834, 5525.364583072998, 1094.9890501095047, 1169.7368092179192, 1257.7736007518733, 1262.7916393795106, 1267.3473161321742, 778.591239599215, 833.8832563441123, 864.9221570058725, 879.5118709116374, 879.9880137841534, 3927.666148377363, 4480.641548676098, 4657.208274593328, 5052.292679024939, 5125.206177837727, 4792.784324705397, 5223.850752834371, 5540.418256083134, 5629.509703983556, 5704.657720536781, 4618.122556714214, 4618.56123668251, 4633.976830115827, 4919.819243381634, 5247.606429517801, 2122.2678176029244, 2371.6205407134776, 2497.700275966896, 2517.5216708825265, 2816.7324104210065, 4788.592969597554, 5413.83758487246, 5437.891242175214, 5465.508104270635, 5503.7066289421955, 5089.007643509554, 5242.217646000378, 5459.454054594588, 5534.280543529396, 5554.77780888768, 4963.851084467472, 5220.634555581149, 5343.5457986071615, 5837.6497410155525, 5838.883222335615, 4561.977190114028, 5042.495750425075, 5367.543758780547, 5520.944790552204, 5740.971295143498, 4475.70907890986, 4754.95682763025, 5460.853220823671, 5604.467575580314, 5656.5757568181725, 5408.671853930831, 5420.566354691694, 5890.4698577128265, 5890.793822216202, 5918.408159184047, 3456.3951308520404, 3770.2836461072307, 3821.9235615288094, 3857.363535016803, 3880.6820168755307, 4104.363823607346, 5503.147012213113, 5678.3186017678145, 5706.857328566819, 5714.599978001666, 4595.37962375075, 5540.667559946416, 5540.924786743396, 5554.0843705186935, 5556.527695145796, 4568.748718820364, 5531.612787104864, 5538.307711536058, 5545.528630066328, 5547.583931205095, 4747.2672474547235, 5024.648274620888, 5216.817411390735, 5381.973090134681, 5399.677079115641, 4549.93076626999, 4789.209780386197, 5320.627556071193, 5337.279467271868, 5472.972635136799, 5021.72380519075, 5288.920666189933, 5331.413544510023, 5357.8392648220615, 5361.758720857492], "value": 3951.81716408012, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.6839188169383, 745.1021519069521, 762.2910693055456, 792.2394501278773, 828.2876726015626, 13992.230427326505, 14013.089149205294, 14557.0, 14585.708285834276, 14764.0, 13071.673208169777, 13212.801807972888, 13244.801327980063, 13251.933740331286, 13268.137571057874, 657.1752450674409, 722.6964674836581, 844.501743971057, 864.6498168241872, 865.273170536749, 850.4642075492432, 851.6508231625035, 852.2287329966359, 854.2098558833086, 856.6915910272328, 902.7066203483861, 903.4353529044347, 906.0531744327194, 906.4017748286133, 906.9138431848963, 898.9595468203946, 900.6082354175954, 901.6078006067349, 904.656230632362, 905.112989270512, 670.6780745242262, 671.5332843673649, 672.4418732452053, 673.6463356737703, 673.9123913891211, 13464.798028029587, 13645.522406715718, 13741.725165496635, 13743.312834358341, 14246.430142794276, 13249.07256492046, 13341.933290333487, 13475.460981560725, 13567.321633918364, 13736.244506552135, 10876.456177191109, 11005.0, 11139.944300278446, 11220.158488113424, 11287.0, 3767.830447629863, 4332.718373305725, 4393.758343291118, 4398.64810815134, 4455.888602784924, 80275.19724802794, 89787.0, 92619.61070583947, 92628.53685731595, 92662.53668731681, 10126.898731012743, 10209.591616335412, 10241.385516868862, 10445.582176712845, 10631.787364252672, 18946.715799263024, 18949.052547372576, 18963.33628323002, 18971.71542426865, 18982.050897455072, 7129.14450265961, 7365.116186057708, 7426.2945020223, 7469.88795168062, 7474.364679002237, 3878.8642397516514, 3999.7800120993625, 4036.777977211223, 4137.54487006429, 4176.206520761046, 3129.85915633797, 3178.698023687746, 3224.5485632011537, 3225.951610725841, 3235.692609202122, 584.8099367705428, 601.1463721515458, 603.4418163199024, 604.114971566657, 619.2723549829022, 559.4712996218534, 593.6734795862259, 604.283923550594, 604.9516038716893, 623.1089541955048, 8123.228293312126, 8436.36727245459, 8515.787105322293, 8549.529775862264, 8730.69442569507, 502.8692539939642, 553.6014069869688, 605.3552966091099, 643.4787821864305, 646.2890820097855, 3307.371599396107, 4200.390943313202, 4249.596288352602, 4307.138572285493, 4379.3430985351815, 89849.0, 98282.5772840224, 102072.9013622781, 108443.0, 108535.0, 61932.69033654803, 62212.0, 62296.06555901665, 90619.0, 91202.0, 57793.71103144541, 75220.24779752242, 81070.78393824097, 84162.0, 85661.71507427518, 9206.907930920874, 9335.393199442015, 9348.691183234216, 9399.20106790903, 9426.07032953896, 46927.53072469368, 48528.0, 53124.20313695375, 53852.0, 54353.0, 66633.00050499344, 67129.0, 71534.0, 72795.0, 76224.0, 12181.451834667285, 12284.877151228373, 12645.241285522898, 12803.35983200855, 12893.48426062947, 13543.119697219649, 14181.220032897876, 14227.573172804832, 14392.20842853653, 14868.256587170381, 12917.677058073623, 13067.803982940073, 13186.0, 13769.518066867611, 13797.586072417844, 12773.297468638943, 13067.607971760863, 13092.410841511964, 13204.933975330447, 13220.867791321964, 12576.937115314731, 12882.098253122567, 13412.597622071353, 13432.731345372842, 13456.327183640584, 10865.343438467733, 11182.496787644413, 11446.656600302003, 11517.942410287895, 11536.884631153582, 9144.3598948073, 10085.344452610558, 10380.844287335847, 11355.318680879174, 11385.259958102697], "value": 7146.3809875544375, "unit": "score"}], "name": "dromaeo_css", "value": 7068.51307566048, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 113.0, 112.0, 112.0, 114.0, 112.0, 112.0, 113.0, 111.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 113.0, 110.0, 149.0, 139.0, 138.0, 137.0, 110.0, 142.0, 113.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 183.0, 186.0, 180.0, 182.0, 183.0, 181.0, 182.0, 186.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 87.0, 63.0, 75.0, 83.0, 82.0, 93.0, 58.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 94.0, 72.0, 70.0, 70.0, 89.0, 68.0, 69.0, 93.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 84.0, 87.0, 83.0, 87.0, 84.0, 86.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 108.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 81.0, 80.0, 85.0, 128.0, 135.0, 83.0, 84.0, 82.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 54.0, 55.0, 53.0, 51.0, 53.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 78.0, 82.0, 71.0, 73.0, 70.0, 70.0, 71.0, 71.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 89.0, 88.0, 90.0, 86.0, 90.0, 86.0, 88.0, 86.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 147.0, 146.0, 152.0, 161.0, 157.0, 187.0, 157.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 178.0, 174.0, 173.0, 171.0, 169.0, 176.0, 173.0, 173.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 78.0, 87.0, 89.0, 71.0, 67.0, 68.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1465.0, "alertThreshold": 2.0}]} 06:43:22 INFO - Return code: 0 06:43:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:43:22 INFO - # TBPL SUCCESS # 06:43:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:43:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:43:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:43:22 INFO - 2016-11-12 06:43:22.725 screenresolution[1678:10489] starting screenresolution argv=screenresolution get 06:43:22 INFO - 2016-11-12 06:43:22.728 screenresolution[1678:10489] Display 0: 1600x1200x32@60 06:43:22 INFO - 2016-11-12 06:43:22.734 screenresolution[1679:10492] starting screenresolution argv=screenresolution list 06:43:22 INFO - Available Modes on Display 0 06:43:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:43:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:43:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:43:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:43:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:43:22 INFO - Intel Iris: 06:43:22 INFO - Chipset Model: Intel Iris 06:43:22 INFO - Type: GPU 06:43:22 INFO - Bus: Built-In 06:43:22 INFO - VRAM (Dynamic, Max): 1536 MB 06:43:22 INFO - Vendor: Intel (0x8086) 06:43:22 INFO - Device ID: 0x0a2e 06:43:22 INFO - Revision ID: 0x0009 06:43:22 INFO - Displays: 06:43:22 INFO - Display: 06:43:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:43:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:43:22 INFO - Display Serial Number: 1600x1200 60 06:43:22 INFO - Main Display: Yes 06:43:22 INFO - Mirror: Off 06:43:22 INFO - Online: Yes 06:43:22 INFO - Rotation: Supported 06:43:22 INFO - Return code: 0 06:43:22 INFO - Running post-action listener: _resource_record_post_action 06:43:22 INFO - [mozharness: 2016-11-12 14:43:22.968739Z] Finished run-tests step (success) 06:43:22 INFO - Running post-run listener: _resource_record_post_run 06:43:23 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 33401856; Write bytes: 700527616; Read time: 311; Write time: 2023 06:43:23 INFO - TinderboxPrint: CPU usage
53.5% 06:43:23 INFO - TinderboxPrint: I/O read bytes / time
33,401,856 / 311 06:43:23 INFO - TinderboxPrint: I/O write bytes / time
700,527,616 / 2,023 06:43:23 INFO - TinderboxPrint: CPU idle
2,257.9 (46.5%) 06:43:23 INFO - TinderboxPrint: CPU system
972.7 (20.0%) 06:43:23 INFO - TinderboxPrint: CPU user
1,627.1 (33.5%) 06:43:23 INFO - TinderboxPrint: Swap in / out
428,642,304 / 0 06:43:23 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 379662848; Write bytes: 373819392; Read time: 28016; Write time: 768 06:43:23 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 32459776; Write bytes: 298978304; Read time: 297; Write time: 1199 06:43:23 INFO - Running post-run listener: _upload_blobber_files 06:43:23 INFO - Blob upload gear active. 06:43:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:43:23 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 06:43:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:43:23 INFO - (blobuploader) - INFO - Open directory for files ... 06:43:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:43:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:43:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:24 INFO - (blobuploader) - INFO - Done attempting. 06:43:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:43:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:43:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:25 INFO - (blobuploader) - INFO - Done attempting. 06:43:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:43:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:43:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:27 INFO - (blobuploader) - INFO - Done attempting. 06:43:27 INFO - (blobuploader) - INFO - Iteration through files over. 06:43:27 INFO - Return code: 0 06:43:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:43:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:43:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73f13dd5eda408ff10f22c8953e54ca54e5f8f0554d9c68bdc1bc8d74c7e60ade7ce7a29f6ca3205ad4982413c9f18c1e1b44d526c427074eea6f342f1aa382d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d55c890bb5e036853ee951906a5817867d6e1ffbe2f52c1a68ca0f603889d4687837da65e9b484dfd58b06e0867a46cd323760defa8247eee7335395b1e57003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d972dde83d7340904ea22e4590cc9e0081fe87b77d16478ff8892c45a373b1bd47e00ac2a567eeb6df0060a3a0e680af6036c1ac72443d861d57924fc76074"} 06:43:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:43:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:43:27 INFO - Contents: 06:43:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73f13dd5eda408ff10f22c8953e54ca54e5f8f0554d9c68bdc1bc8d74c7e60ade7ce7a29f6ca3205ad4982413c9f18c1e1b44d526c427074eea6f342f1aa382d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d55c890bb5e036853ee951906a5817867d6e1ffbe2f52c1a68ca0f603889d4687837da65e9b484dfd58b06e0867a46cd323760defa8247eee7335395b1e57003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d972dde83d7340904ea22e4590cc9e0081fe87b77d16478ff8892c45a373b1bd47e00ac2a567eeb6df0060a3a0e680af6036c1ac72443d861d57924fc76074"} 06:43:27 INFO - Running post-run listener: copy_logs_to_upload_dir 06:43:27 INFO - Copying logs to upload dir... 06:43:27 INFO - mkdir: /builds/slave/test/build/upload/logs 06:43:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.187367 ========= master_lag: 2.36 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-12 06:43:30.330561) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 06:43:30.334343) ========= 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.BlvS2g2h7o/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.WCpR6RubgC/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73f13dd5eda408ff10f22c8953e54ca54e5f8f0554d9c68bdc1bc8d74c7e60ade7ce7a29f6ca3205ad4982413c9f18c1e1b44d526c427074eea6f342f1aa382d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d55c890bb5e036853ee951906a5817867d6e1ffbe2f52c1a68ca0f603889d4687837da65e9b484dfd58b06e0867a46cd323760defa8247eee7335395b1e57003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d972dde83d7340904ea22e4590cc9e0081fe87b77d16478ff8892c45a373b1bd47e00ac2a567eeb6df0060a3a0e680af6036c1ac72443d861d57924fc76074"} build_url:https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011734 build_url: 'https://queue.taskcluster.net/v1/task/ZgXLJT8rQWSbWqtu9GQGsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73f13dd5eda408ff10f22c8953e54ca54e5f8f0554d9c68bdc1bc8d74c7e60ade7ce7a29f6ca3205ad4982413c9f18c1e1b44d526c427074eea6f342f1aa382d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d55c890bb5e036853ee951906a5817867d6e1ffbe2f52c1a68ca0f603889d4687837da65e9b484dfd58b06e0867a46cd323760defa8247eee7335395b1e57003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d972dde83d7340904ea22e4590cc9e0081fe87b77d16478ff8892c45a373b1bd47e00ac2a567eeb6df0060a3a0e680af6036c1ac72443d861d57924fc76074"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 06:43:30.368861) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 06:43:30.369396) ========= 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.BlvS2g2h7o/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.WCpR6RubgC/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.005144 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 06:43:30.417989) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 06:43:30.418321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 06:43:30.418666) ========= ========= Total master_lag: 2.56 =========