builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0226 starttime: 1469124279.14 results: success (0) buildid: 20160721085121 builduid: 0b0ea61ef9fd4eb8a52d89742345b9ff revision: 4b83d342c9f79da4ec067392a1d5ed97e0edd683 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:39.144940) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:39.145458) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:39.145747) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:39.254834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:39.255182) ========= 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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-07-21 11:04:39-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.01M=0.001s 2016-07-21 11:04:39 (9.01 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086976 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:39.367413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:39.367695) ========= 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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.020538 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:39.417212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 11:04:39.417523) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4b83d342c9f79da4ec067392a1d5ed97e0edd683 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4b83d342c9f79da4ec067392a1d5ed97e0edd683 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yYXUvKwIdL/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.lvYkRdpyFS/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-07-21 11:04:39,496 truncating revision to first 12 chars 2016-07-21 11:04:39,497 Setting DEBUG logging. 2016-07-21 11:04:39,497 attempt 1/10 2016-07-21 11:04:39,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4b83d342c9f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 11:04:40,219 unpacking tar archive at: fx-team-4b83d342c9f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.006491 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 11:04:40.446218) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:40.446531) ========= script_repo_revision: 4b83d342c9f79da4ec067392a1d5ed97e0edd683 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:40.446910) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:40.447171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 11:04:40.465463) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-07-21 11:04:40.465808) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yYXUvKwIdL/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.lvYkRdpyFS/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 11:04:40 INFO - MultiFileLogger online at 20160721 11:04:40 in /builds/slave/test 11:04:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:04:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:04:40 INFO - {'append_to_log': False, 11:04:40 INFO - 'base_work_dir': '/builds/slave/test', 11:04:40 INFO - 'blob_upload_branch': 'Fx-Team', 11:04:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:04:40 INFO - 'branch': 'Fx-Team', 11:04:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:04:40 INFO - 'config_files': ('talos/mac_config.py',), 11:04:40 INFO - 'default_actions': ('clobber', 11:04:40 INFO - 'read-buildbot-config', 11:04:40 INFO - 'download-and-extract', 11:04:40 INFO - 'populate-webroot', 11:04:40 INFO - 'create-virtualenv', 11:04:40 INFO - 'install', 11:04:40 INFO - 'run-tests'), 11:04:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:04:40 INFO - 'download_minidump_stackwalk': True, 11:04:40 INFO - 'download_symbols': 'ondemand', 11:04:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:04:40 INFO - 'tooltool.py': '/tools/tooltool.py', 11:04:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:04:40 INFO - '/tools/misc-python/virtualenv.py')}, 11:04:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:04:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:04:40 INFO - 'installer_path': 'installer.exe', 11:04:40 INFO - 'log_level': 'info', 11:04:40 INFO - 'log_name': 'talos', 11:04:40 INFO - 'log_to_console': True, 11:04:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:04:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:04:40 INFO - 'opt_config_files': (), 11:04:40 INFO - 'pip_index': False, 11:04:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:04:40 INFO - 'cmd': ('bash', 11:04:40 INFO - '-c', 11:04:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:04:40 INFO - 'enabled': True, 11:04:40 INFO - 'halt_on_failure': False, 11:04:40 INFO - 'name': 'check_screen_resolution'},), 11:04:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:04:40 INFO - 'cmd': ('bash', 11:04:40 INFO - '-c', 11:04:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:04:40 INFO - 'enabled': True, 11:04:40 INFO - 'halt_on_failure': False, 11:04:40 INFO - 'name': 'check_screen_resolution'},), 11:04:40 INFO - 'run_cmd_checks_enabled': True, 11:04:40 INFO - 'sps_profile': False, 11:04:40 INFO - 'sps_profile_interval': 0, 11:04:40 INFO - 'suite': 'dromaeojs-e10s', 11:04:40 INFO - 'system_bits': '32', 11:04:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:04:40 INFO - 'title': 't-yosemite-r7-0226', 11:04:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:04:40 INFO - 'use_talos_json': True, 11:04:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:04:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:04:40 INFO - 'work_dir': 'build'} 11:04:40 INFO - [mozharness: 2016-07-21 18:04:40.656435Z] Running clobber step. 11:04:40 INFO - Running pre-action listener: _resource_record_pre_action 11:04:40 INFO - Running main action method: clobber 11:04:40 INFO - rmtree: /builds/slave/test/build 11:04:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:04:42 INFO - Running post-action listener: _resource_record_post_action 11:04:42 INFO - [mozharness: 2016-07-21 18:04:42.092795Z] Finished clobber step (success) 11:04:42 INFO - [mozharness: 2016-07-21 18:04:42.092934Z] Running read-buildbot-config step. 11:04:42 INFO - Running pre-action listener: _resource_record_pre_action 11:04:42 INFO - Running main action method: read_buildbot_config 11:04:42 INFO - Using buildbot properties: 11:04:42 INFO - { 11:04:42 INFO - "project": "", 11:04:42 INFO - "product": "firefox", 11:04:42 INFO - "script_repo_revision": "production", 11:04:42 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:04:42 INFO - "repository": "", 11:04:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:04:42 INFO - "buildid": "20160721085121", 11:04:42 INFO - "pgo_build": "False", 11:04:42 INFO - "basedir": "/builds/slave/test", 11:04:42 INFO - "buildnumber": 60, 11:04:42 INFO - "slavename": "t-yosemite-r7-0226", 11:04:42 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:04:42 INFO - "platform": "yosemite_r7", 11:04:42 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:04:42 INFO - "branch": "fx-team", 11:04:42 INFO - "repo_path": "integration/fx-team", 11:04:42 INFO - "revision": "4b83d342c9f79da4ec067392a1d5ed97e0edd683", 11:04:42 INFO - "stage_platform": "macosx64", 11:04:42 INFO - "builduid": "0b0ea61ef9fd4eb8a52d89742345b9ff", 11:04:42 INFO - "slavebuilddir": "test" 11:04:42 INFO - } 11:04:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 11:04:42 INFO - Running post-action listener: _resource_record_post_action 11:04:42 INFO - [mozharness: 2016-07-21 18:04:42.096346Z] Finished read-buildbot-config step (success) 11:04:42 INFO - [mozharness: 2016-07-21 18:04:42.096449Z] Running download-and-extract step. 11:04:42 INFO - Running pre-action listener: _resource_record_pre_action 11:04:42 INFO - Running main action method: download_and_extract 11:04:42 INFO - mkdir: /builds/slave/test/build/tests 11:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:42 INFO - https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:04:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 11:04:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 11:04:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 11:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 11:04:49 INFO - Downloaded 1199 bytes. 11:04:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 11:04:49 INFO - Using the following test package requirements: 11:04:49 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 11:04:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:04:49 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 11:04:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:04:49 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 11:04:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:04:49 INFO - u'jsshell-mac.zip'], 11:04:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:04:49 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 11:04:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 11:04:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:04:49 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 11:04:49 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:04:49 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 11:04:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:04:49 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 11:04:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:04:49 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 11:04:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:49 INFO - https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:04:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:04:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:04:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:04:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:04:54 INFO - Downloaded 18806570 bytes. 11:04:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:04:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:04:57 INFO - Return code: 0 11:04:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:57 INFO - https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:04:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:04:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:04:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:04:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:04:58 INFO - Downloaded 18806570 bytes. 11:04:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:04:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:05:02 INFO - Return code: 0 11:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:02 INFO - https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:05:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:05:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:05:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:05:03 INFO - Downloaded 14403317 bytes. 11:05:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:05:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:05:04 INFO - Return code: 0 11:05:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:04 INFO - https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:05:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:05:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:05:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 11:05:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 11:05:08 INFO - Downloaded 112771815 bytes. 11:05:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:05:08 INFO - mkdir: /builds/slave/test/properties 11:05:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:05:08 INFO - Writing to file /builds/slave/test/properties/build_url 11:05:08 INFO - Contents: 11:05:08 INFO - build_url:https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:05:09 INFO - Running post-action listener: _resource_record_post_action 11:05:09 INFO - Running post-action listener: set_extra_try_arguments 11:05:09 INFO - [mozharness: 2016-07-21 18:05:09.885967Z] Finished download-and-extract step (success) 11:05:09 INFO - [mozharness: 2016-07-21 18:05:09.886145Z] Running populate-webroot step. 11:05:09 INFO - Running pre-action listener: _resource_record_pre_action 11:05:09 INFO - Running main action method: populate_webroot 11:05:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:05:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:05:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:05:09 INFO - '--tppagecycles', 11:05:09 INFO - '7'], 11:05:09 INFO - 'tests': ['tsvgm']}}, 11:05:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:05:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:05:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:05:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:05:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:05:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:05:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:09 INFO - 'talos_options': ['--disable-e10s'], 11:05:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:09 INFO - 'talos_options': ['--disable-e10s'], 11:05:09 INFO - 'tests': ['damp', 'tps']}, 11:05:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:09 INFO - 'tests': ['damp', 'tps']}, 11:05:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:05:09 INFO - 'tests': ['dromaeo_dom']}, 11:05:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:05:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:05:09 INFO - 'tests': ['basic_compositor_video']}, 11:05:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:05:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:05:09 INFO - 'tests': ['a11yr', 11:05:09 INFO - 'ts_paint', 11:05:09 INFO - 'tpaint', 11:05:09 INFO - 'sessionrestore', 11:05:09 INFO - 'sessionrestore_no_auto_restore', 11:05:09 INFO - 'tabpaint']}, 11:05:09 INFO - 'other-e10s': {'tests': ['a11yr', 11:05:09 INFO - 'ts_paint', 11:05:09 INFO - 'tpaint', 11:05:09 INFO - 'sessionrestore', 11:05:09 INFO - 'sessionrestore_no_auto_restore', 11:05:09 INFO - 'tabpaint']}, 11:05:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:05:09 INFO - 'ts_paint', 11:05:09 INFO - 'tpaint', 11:05:09 INFO - 'sessionrestore', 11:05:09 INFO - 'sessionrestore_no_auto_restore', 11:05:09 INFO - 'tabpaint']}, 11:05:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:05:09 INFO - 'ts_paint', 11:05:09 INFO - 'tpaint', 11:05:09 INFO - 'sessionrestore', 11:05:09 INFO - 'sessionrestore_no_auto_restore', 11:05:09 INFO - 'tabpaint']}, 11:05:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:05:09 INFO - 'tests': ['a11yr', 11:05:09 INFO - 'ts_paint', 11:05:09 INFO - 'tpaint', 11:05:09 INFO - 'sessionrestore', 11:05:09 INFO - 'sessionrestore_no_auto_restore', 11:05:09 INFO - 'tabpaint']}, 11:05:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:05:09 INFO - 'tests': ['a11yr', 11:05:09 INFO - 'ts_paint', 11:05:09 INFO - 'tpaint', 11:05:09 INFO - 'sessionrestore', 11:05:09 INFO - 'sessionrestore_no_auto_restore', 11:05:09 INFO - 'tabpaint']}, 11:05:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:05:09 INFO - 'tests': ['tsvgx', 11:05:09 INFO - 'tsvgr_opacity', 11:05:09 INFO - 'tart', 11:05:09 INFO - 'tscrollx', 11:05:09 INFO - 'cart']}, 11:05:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:05:09 INFO - 'tsvgr_opacity', 11:05:09 INFO - 'tart', 11:05:09 INFO - 'tscrollx', 11:05:09 INFO - 'cart']}, 11:05:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:09 INFO - 'talos_options': ['--disable-e10s'], 11:05:09 INFO - 'tests': ['tp5o']}, 11:05:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:09 INFO - 'tests': ['tp5o']}, 11:05:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:09 INFO - 'talos_options': ['--disable-e10s', 11:05:09 INFO - '--xperf_path', 11:05:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:09 INFO - 'tests': ['tp5n']}, 11:05:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:09 INFO - 'talos_options': ['--xperf_path', 11:05:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:09 INFO - 'tests': ['tp5n']}}, 11:05:09 INFO - 'talos.zip': {'path': '', 11:05:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:05:09 INFO - Running post-action listener: _resource_record_post_action 11:05:09 INFO - [mozharness: 2016-07-21 18:05:09.905034Z] Finished populate-webroot step (success) 11:05:09 INFO - [mozharness: 2016-07-21 18:05:09.905173Z] Running create-virtualenv step. 11:05:09 INFO - Running pre-action listener: _resource_record_pre_action 11:05:09 INFO - Running main action method: create_virtualenv 11:05:09 INFO - Creating virtualenv /builds/slave/test/build/venv 11:05:09 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 11:05:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:05:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:05:10 INFO - Using real prefix '/tools/python27' 11:05:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:05:10 INFO - Installing distribute.............................................................................................................................................................................................done. 11:05:13 INFO - Installing pip.................done. 11:05:13 INFO - Return code: 0 11:05:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:05:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:13 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 0x109d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9578d76df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9cd30>, '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 0x109a01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c94b20>, '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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 11:05:13 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 11:05:13 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 11:05:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yYXUvKwIdL/Render', 11:05:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:13 INFO - 'HOME': '/Users/cltbld', 11:05:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:13 INFO - 'LOGNAME': 'cltbld', 11:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:13 INFO - 'MOZ_NO_REMOTE': '1', 11:05:13 INFO - 'NO_EM_RESTART': '1', 11:05:13 INFO - 'PAGER': '/bin/cat', 11:05:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:13 INFO - 'PWD': '/builds/slave/test', 11:05:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:13 INFO - 'SHELL': '/bin/bash', 11:05:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvYkRdpyFS/Listeners', 11:05:13 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 11:05:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:13 INFO - 'USER': 'cltbld', 11:05:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:13 INFO - 'XPC_FLAGS': '0x0', 11:05:13 INFO - 'XPC_SERVICE_NAME': '0', 11:05:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:13 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 11:05:13 INFO - Cleaning up... 11:05:13 INFO - Return code: 0 11:05:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:05:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:13 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 0x109d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9578d76df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9cd30>, '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 0x109a01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c94b20>, '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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 11:05:13 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 11:05:13 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 11:05:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yYXUvKwIdL/Render', 11:05:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:13 INFO - 'HOME': '/Users/cltbld', 11:05:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:13 INFO - 'LOGNAME': 'cltbld', 11:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:13 INFO - 'MOZ_NO_REMOTE': '1', 11:05:13 INFO - 'NO_EM_RESTART': '1', 11:05:13 INFO - 'PAGER': '/bin/cat', 11:05:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:13 INFO - 'PWD': '/builds/slave/test', 11:05:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:13 INFO - 'SHELL': '/bin/bash', 11:05:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvYkRdpyFS/Listeners', 11:05:13 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 11:05:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:13 INFO - 'USER': 'cltbld', 11:05:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:13 INFO - 'XPC_FLAGS': '0x0', 11:05:13 INFO - 'XPC_SERVICE_NAME': '0', 11:05:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:14 INFO - Downloading/unpacking psutil>=3.1.1 11:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:05:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:17 INFO - Installing collected packages: psutil 11:05:17 INFO - Running setup.py install for psutil 11:05:17 INFO - building 'psutil._psutil_osx' extension 11:05:17 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 11:05:17 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 11:05:17 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 11:05:17 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 11:05:17 INFO - building 'psutil._psutil_posix' extension 11:05:17 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 11:05:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:05:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:05:17 INFO - ^ 11:05:17 INFO - 1 warning generated. 11:05:17 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 11:05:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:17 INFO - Successfully installed psutil 11:05:17 INFO - Cleaning up... 11:05:18 INFO - Return code: 0 11:05:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:05:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:18 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 0x109d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9578d76df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9cd30>, '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 0x109a01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c94b20>, '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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 11:05:18 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 11:05:18 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 11:05:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yYXUvKwIdL/Render', 11:05:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:18 INFO - 'HOME': '/Users/cltbld', 11:05:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:18 INFO - 'LOGNAME': 'cltbld', 11:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:18 INFO - 'MOZ_NO_REMOTE': '1', 11:05:18 INFO - 'NO_EM_RESTART': '1', 11:05:18 INFO - 'PAGER': '/bin/cat', 11:05:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:18 INFO - 'PWD': '/builds/slave/test', 11:05:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:18 INFO - 'SHELL': '/bin/bash', 11:05:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvYkRdpyFS/Listeners', 11:05:18 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 11:05:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:18 INFO - 'USER': 'cltbld', 11:05:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:18 INFO - 'XPC_FLAGS': '0x0', 11:05:18 INFO - 'XPC_SERVICE_NAME': '0', 11:05:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:05:20 INFO - Installing collected packages: mozsystemmonitor 11:05:20 INFO - Running setup.py install for mozsystemmonitor 11:05:20 INFO - Successfully installed mozsystemmonitor 11:05:20 INFO - Cleaning up... 11:05:21 INFO - Return code: 0 11:05:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9578d76df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9cd30>, '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 0x109a01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c94b20>, '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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 11:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:05:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yYXUvKwIdL/Render', 11:05:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:21 INFO - 'HOME': '/Users/cltbld', 11:05:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:21 INFO - 'LOGNAME': 'cltbld', 11:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:21 INFO - 'MOZ_NO_REMOTE': '1', 11:05:21 INFO - 'NO_EM_RESTART': '1', 11:05:21 INFO - 'PAGER': '/bin/cat', 11:05:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:21 INFO - 'PWD': '/builds/slave/test', 11:05:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:21 INFO - 'SHELL': '/bin/bash', 11:05:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvYkRdpyFS/Listeners', 11:05:21 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 11:05:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:21 INFO - 'USER': 'cltbld', 11:05:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:21 INFO - 'XPC_FLAGS': '0x0', 11:05:21 INFO - 'XPC_SERVICE_NAME': '0', 11:05:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:21 INFO - Downloading/unpacking jsonschema==2.5.1 11:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:05:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:05:23 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 11:05:23 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 11:05:23 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 11:05:23 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 11:05:23 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 11:05:23 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 11:05:24 INFO - Downloading functools32-3.2.3-2.tar.gz 11:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:05:24 INFO - warning: no files found matching '*.txt' 11:05:24 INFO - no previously-included directories found matching 'build' 11:05:24 INFO - no previously-included directories found matching 'dist' 11:05:24 INFO - no previously-included directories found matching '.git*' 11:05:24 INFO - Installing collected packages: jsonschema, functools32 11:05:24 INFO - Running setup.py install for functools32 11:05:24 INFO - warning: no files found matching '*.txt' 11:05:24 INFO - no previously-included directories found matching 'build' 11:05:24 INFO - no previously-included directories found matching 'dist' 11:05:24 INFO - no previously-included directories found matching '.git*' 11:05:24 INFO - Successfully installed jsonschema functools32 11:05:24 INFO - Cleaning up... 11:05:24 INFO - Return code: 0 11:05:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:05:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:24 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 0x109d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9578d76df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9cd30>, '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 0x109a01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c94b20>, '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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 11:05:24 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 11:05:24 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 11:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yYXUvKwIdL/Render', 11:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:24 INFO - 'HOME': '/Users/cltbld', 11:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:24 INFO - 'LOGNAME': 'cltbld', 11:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:24 INFO - 'MOZ_NO_REMOTE': '1', 11:05:24 INFO - 'NO_EM_RESTART': '1', 11:05:24 INFO - 'PAGER': '/bin/cat', 11:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:24 INFO - 'PWD': '/builds/slave/test', 11:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:24 INFO - 'SHELL': '/bin/bash', 11:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvYkRdpyFS/Listeners', 11:05:24 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 11:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:24 INFO - 'USER': 'cltbld', 11:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:24 INFO - 'XPC_FLAGS': '0x0', 11:05:24 INFO - 'XPC_SERVICE_NAME': '0', 11:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:24 INFO - Downloading/unpacking blobuploader==1.2.4 11:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:27 INFO - Downloading blobuploader-1.2.4.tar.gz 11:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:05:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:05:27 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 11:05:27 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 11:05:27 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 11:05:27 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 11:05:27 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 11:05:27 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 11:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:05:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:05:27 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 11:05:28 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 11:05:28 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 11:05:28 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 11:05:28 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 11:05:28 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 11:05:28 INFO - Downloading docopt-0.6.1.tar.gz 11:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:05:28 INFO - Installing collected packages: blobuploader, requests, docopt 11:05:28 INFO - Running setup.py install for blobuploader 11:05:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:05:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:05:28 INFO - Running setup.py install for requests 11:05:29 INFO - Running setup.py install for docopt 11:05:29 INFO - Successfully installed blobuploader requests docopt 11:05:29 INFO - Cleaning up... 11:05:29 INFO - Return code: 0 11:05:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:29 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 0x109d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9578d76df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9cd30>, '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 0x109a01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c94b20>, '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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 11:05:29 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 11:05:29 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 11:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yYXUvKwIdL/Render', 11:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:29 INFO - 'HOME': '/Users/cltbld', 11:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:29 INFO - 'LOGNAME': 'cltbld', 11:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:29 INFO - 'MOZ_NO_REMOTE': '1', 11:05:29 INFO - 'NO_EM_RESTART': '1', 11:05:29 INFO - 'PAGER': '/bin/cat', 11:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:29 INFO - 'PWD': '/builds/slave/test', 11:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:29 INFO - 'SHELL': '/bin/bash', 11:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvYkRdpyFS/Listeners', 11:05:29 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 11:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:29 INFO - 'USER': 'cltbld', 11:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:29 INFO - 'XPC_FLAGS': '0x0', 11:05:29 INFO - 'XPC_SERVICE_NAME': '0', 11:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:29 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-3zNJCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:29 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-ZIbJO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:29 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-3vxgFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:29 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-TFGE4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-4LY8_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-rj1R8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-bfG_G8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Wt_rYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-jy1G43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-9Zloe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-h4OITb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-ZH9ruZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-AndpJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-dmqcAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-dvKrxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-BP32hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-WTFDoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:31 INFO - Running setup.py install for manifestparser 11:05:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:05:31 INFO - Running setup.py install for mozcrash 11:05:31 INFO - Running setup.py install for mozdebug 11:05:31 INFO - Running setup.py install for mozdevice 11:05:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:05:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:05:32 INFO - Running setup.py install for mozfile 11:05:32 INFO - Running setup.py install for mozhttpd 11:05:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:05:32 INFO - Running setup.py install for mozinfo 11:05:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:05:32 INFO - Running setup.py install for mozInstall 11:05:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:05:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:05:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:05:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:05:32 INFO - Running setup.py install for mozleak 11:05:32 INFO - Running setup.py install for mozlog 11:05:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:05:32 INFO - Running setup.py install for moznetwork 11:05:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:05:33 INFO - Running setup.py install for mozprocess 11:05:33 INFO - Running setup.py install for mozprofile 11:05:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:05:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:05:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:05:33 INFO - Running setup.py install for mozrunner 11:05:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:05:33 INFO - Running setup.py install for mozscreenshot 11:05:33 INFO - Running setup.py install for moztest 11:05:33 INFO - Running setup.py install for mozversion 11:05:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:05:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:05:33 INFO - Cleaning up... 11:05:34 INFO - Return code: 0 11:05:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:34 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 0x109d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9578d76df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9cd30>, '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 0x109a01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c94b20>, '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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 11:05:34 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 11:05:34 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 11:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yYXUvKwIdL/Render', 11:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:34 INFO - 'HOME': '/Users/cltbld', 11:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:34 INFO - 'LOGNAME': 'cltbld', 11:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:34 INFO - 'MOZ_NO_REMOTE': '1', 11:05:34 INFO - 'NO_EM_RESTART': '1', 11:05:34 INFO - 'PAGER': '/bin/cat', 11:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:34 INFO - 'PWD': '/builds/slave/test', 11:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:34 INFO - 'SHELL': '/bin/bash', 11:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvYkRdpyFS/Listeners', 11:05:34 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 11:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:34 INFO - 'USER': 'cltbld', 11:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:34 INFO - 'XPC_FLAGS': '0x0', 11:05:34 INFO - 'XPC_SERVICE_NAME': '0', 11:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-8UzoOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:34 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)) 11:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-YkZldX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 11:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-nizcHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:35 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)) 11:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-ScRqV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:35 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)) 11:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-eVJw_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:35 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)) 11:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-nwjoMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:35 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)) 11:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-eTkI3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:35 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)) 11:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-k5OhV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:35 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)) 11:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-CmYkmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:35 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)) 11:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Dyuyoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-kxPc8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:35 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)) 11:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-SqonyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:36 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)) 11:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-P6TIr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:36 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)) 11:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-MqAGTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-bONyGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:36 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)) 11:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-0zsMNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:36 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)) 11:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-XqRKvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:36 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)) 11:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:05:36 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)) 11:05:36 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)) 11:05:36 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)) 11:05:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:36 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 11:05:36 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 11:05:36 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 11:05:36 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 11:05:36 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 11:05:36 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 11:05:39 INFO - Downloading blessings-1.6.tar.gz 11:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:05:39 INFO - Installing collected packages: blessings 11:05:39 INFO - Running setup.py install for blessings 11:05:39 INFO - Successfully installed blessings 11:05:39 INFO - Cleaning up... 11:05:39 INFO - Return code: 0 11:05:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:40 INFO - Reading from file tmpfile_stdout 11:05:40 INFO - Current package versions: 11:05:40 INFO - blessings == 1.6 11:05:40 INFO - blobuploader == 1.2.4 11:05:40 INFO - docopt == 0.6.1 11:05:40 INFO - functools32 == 3.2.3-2 11:05:40 INFO - jsonschema == 2.5.1 11:05:40 INFO - manifestparser == 1.1 11:05:40 INFO - mozInstall == 1.12 11:05:40 INFO - mozcrash == 0.17 11:05:40 INFO - mozdebug == 0.1 11:05:40 INFO - mozdevice == 0.48 11:05:40 INFO - mozfile == 1.2 11:05:40 INFO - mozhttpd == 0.7 11:05:40 INFO - mozinfo == 0.9 11:05:40 INFO - mozleak == 0.1 11:05:40 INFO - mozlog == 3.3 11:05:40 INFO - moznetwork == 0.27 11:05:40 INFO - mozprocess == 0.23 11:05:40 INFO - mozprofile == 0.28 11:05:40 INFO - mozrunner == 6.12 11:05:40 INFO - mozscreenshot == 0.1 11:05:40 INFO - mozsystemmonitor == 0.3 11:05:40 INFO - moztest == 0.7 11:05:40 INFO - mozversion == 1.4 11:05:40 INFO - psutil == 3.1.1 11:05:40 INFO - requests == 1.2.3 11:05:40 INFO - wsgiref == 0.1.2 11:05:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:40 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 0x109d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9578d76df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9cd30>, '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 0x109a01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c94b20>, '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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 11:05:40 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 11:05:40 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 11:05:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yYXUvKwIdL/Render', 11:05:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:40 INFO - 'HOME': '/Users/cltbld', 11:05:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:40 INFO - 'LOGNAME': 'cltbld', 11:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:40 INFO - 'MOZ_NO_REMOTE': '1', 11:05:40 INFO - 'NO_EM_RESTART': '1', 11:05:40 INFO - 'PAGER': '/bin/cat', 11:05:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:40 INFO - 'PWD': '/builds/slave/test', 11:05:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:40 INFO - 'SHELL': '/bin/bash', 11:05:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvYkRdpyFS/Listeners', 11:05:40 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 11:05:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:40 INFO - 'USER': 'cltbld', 11:05:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:40 INFO - 'XPC_FLAGS': '0x0', 11:05:40 INFO - 'XPC_SERVICE_NAME': '0', 11:05:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:40 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)) 11:05:40 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)) 11:05:40 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)) 11:05:40 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)) 11:05:40 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)) 11:05:40 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)) 11:05:40 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)) 11:05:40 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)) 11:05:40 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)) 11:05:40 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)) 11:05:40 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)) 11:05:40 INFO - Cleaning up... 11:05:40 INFO - Return code: 0 11:05:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9578d76df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9cd30>, '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 0x109a01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c94b20>, '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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 11:05: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', 'jsonschema'] in /builds/slave/test/build 11:05: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 jsonschema 11:05:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yYXUvKwIdL/Render', 11:05:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:40 INFO - 'HOME': '/Users/cltbld', 11:05:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:40 INFO - 'LOGNAME': 'cltbld', 11:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:40 INFO - 'MOZ_NO_REMOTE': '1', 11:05:40 INFO - 'NO_EM_RESTART': '1', 11:05:40 INFO - 'PAGER': '/bin/cat', 11:05:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:40 INFO - 'PWD': '/builds/slave/test', 11:05:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:40 INFO - 'SHELL': '/bin/bash', 11:05:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvYkRdpyFS/Listeners', 11:05:40 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 11:05:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:40 INFO - 'USER': 'cltbld', 11:05:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:40 INFO - 'XPC_FLAGS': '0x0', 11:05:40 INFO - 'XPC_SERVICE_NAME': '0', 11:05:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:05:40 INFO - Cleaning up... 11:05:40 INFO - Return code: 0 11:05:40 INFO - Running post-action listener: _resource_record_post_action 11:05:40 INFO - Running post-action listener: _start_resource_monitoring 11:05:40 INFO - Starting resource monitoring. 11:05:40 INFO - [mozharness: 2016-07-21 18:05:40.608924Z] Finished create-virtualenv step (success) 11:05:40 INFO - [mozharness: 2016-07-21 18:05:40.609872Z] Running install step. 11:05:40 INFO - Running pre-action listener: _resource_record_pre_action 11:05:40 INFO - Running main action method: install 11:05:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:40 INFO - Reading from file tmpfile_stdout 11:05:40 INFO - Detecting whether we're running mozinstall >=1.0... 11:05:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:05:40 INFO - Reading from file tmpfile_stdout 11:05:40 INFO - Output received: 11:05:40 INFO - Usage: mozinstall [options] installer 11:05:40 INFO - Options: 11:05:40 INFO - -h, --help show this help message and exit 11:05:40 INFO - -d DEST, --destination=DEST 11:05:40 INFO - Directory to install application into. [default: 11:05:40 INFO - "/builds/slave/test"] 11:05:40 INFO - --app=APP Application being installed. [default: firefox] 11:05:40 INFO - mkdir: /builds/slave/test/build/application 11:05:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:06:16 INFO - Reading from file tmpfile_stdout 11:06:16 INFO - Output received: 11:06:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:06:16 INFO - Running post-action listener: _resource_record_post_action 11:06:16 INFO - [mozharness: 2016-07-21 18:06:16.096164Z] Finished install step (success) 11:06:16 INFO - [mozharness: 2016-07-21 18:06:16.096301Z] Running run-tests step. 11:06:16 INFO - Running pre-action listener: _resource_record_pre_action 11:06:16 INFO - Running main action method: run_tests 11:06:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:06:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:06:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:06:16 INFO - 2016-07-21 11:06:16.110 screenresolution[1918:9650] starting screenresolution argv=screenresolution get 11:06:16 INFO - 2016-07-21 11:06:16.113 screenresolution[1918:9650] Display 0: 1600x1200x32@60 11:06:16 INFO - 2016-07-21 11:06:16.119 screenresolution[1919:9652] starting screenresolution argv=screenresolution list 11:06:16 INFO - Available Modes on Display 0 11:06:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:06:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:06:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:06:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:06:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:06:16 INFO - Intel Iris: 11:06:16 INFO - Chipset Model: Intel Iris 11:06:16 INFO - Type: GPU 11:06:16 INFO - Bus: Built-In 11:06:16 INFO - VRAM (Dynamic, Max): 1536 MB 11:06:16 INFO - Vendor: Intel (0x8086) 11:06:16 INFO - Device ID: 0x0a2e 11:06:16 INFO - Revision ID: 0x0009 11:06:16 INFO - Displays: 11:06:16 INFO - Display: 11:06:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:06:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:06:16 INFO - Display Serial Number: 1600x1200 60 11:06:16 INFO - Main Display: Yes 11:06:16 INFO - Mirror: Off 11:06:16 INFO - Online: Yes 11:06:16 INFO - Rotation: Supported 11:06:16 INFO - Return code: 0 11:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:06:16 INFO - Python 2.7.3 11:06:16 INFO - Return code: 0 11:06:16 INFO - grabbing minidump binary from tooltool 11:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:16 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 0x109c9cd30>, '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 0x109a01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c94b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:06:16 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 11:06:16 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 11:06:16 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 11:06:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:16 INFO - Return code: 0 11:06:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:06:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:06:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:06:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:06:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0226 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:06:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yYXUvKwIdL/Render', 11:06:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:16 INFO - 'HOME': '/Users/cltbld', 11:06:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:16 INFO - 'LOGNAME': 'cltbld', 11:06:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:06:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:16 INFO - 'MOZ_NO_REMOTE': '1', 11:06:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:06:16 INFO - 'NO_EM_RESTART': '1', 11:06:16 INFO - 'PAGER': '/bin/cat', 11:06:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:16 INFO - 'PWD': '/builds/slave/test', 11:06:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:06:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:16 INFO - 'SHELL': '/bin/bash', 11:06:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvYkRdpyFS/Listeners', 11:06:16 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 11:06:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:16 INFO - 'USER': 'cltbld', 11:06:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:16 INFO - 'XPC_FLAGS': '0x0', 11:06:16 INFO - 'XPC_SERVICE_NAME': '0', 11:06:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:06:16 INFO - mozversion application_buildid: 20160721085121 11:06:16 INFO - mozversion application_changeset: 4b83d342c9f79da4ec067392a1d5ed97e0edd683 11:06:16 INFO - mozversion application_display_name: Nightly 11:06:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:16 INFO - mozversion application_name: Firefox 11:06:16 INFO - mozversion application_remotingname: firefox 11:06:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:06:16 INFO - mozversion application_vendor: Mozilla 11:06:16 INFO - mozversion application_version: 50.0a1 11:06:16 INFO - mozversion platform_buildid: 20160721085121 11:06:16 INFO - mozversion platform_changeset: 4b83d342c9f79da4ec067392a1d5ed97e0edd683 11:06:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:06:16 INFO - mozversion platform_version: 50.0a1 11:06:16 INFO - using testdate: 1469124376 11:06:16 INFO - actual date: 1469124376 11:06:16 INFO - starting webserver on 'localhost:49688' 11:06:16 INFO - SUITE-START | Running 2 tests 11:06:16 INFO - TEST-START | dromaeo_css 11:06:16 INFO - operating with platform_type : mac_ 11:06:16 INFO - Initialising browser for dromaeo_css test... 11:06:16 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpXuZ8wd/profile http://localhost:49688/getInfo.html) 11:06:18 INFO - PROCESS | 1929 | JavaScript error: , line 0: uncaught exception: undefined 11:06:19 INFO - PROCESS | 1929 | __metrics Screen width/height:1600/1200 11:06:19 INFO - PROCESS | 1929 | colorDepth:24 11:06:19 INFO - PROCESS | 1929 | Browser inner width/height: 1024/689 11:06:19 INFO - PROCESS | 1929 | __metrics 11:06:19 ERROR - PROCESS | 1929 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:06:20 INFO - TEST-INFO | 1929: exit 0 11:06:20 INFO - Browser initialized. 11:06:20 INFO - Running cycle 1/1 for dromaeo_css test... 11:06:20 INFO - TEST-INFO | started process 1932 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpXuZ8wd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:32 INFO - PROCESS | 1932 | RSS: Main: 256106496 11:06:32 INFO - PROCESS | 1932 | 11:07:22 INFO - PROCESS | 1932 | 1469124442483 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] 11:09:34 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49688/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49688/tests/dromaeo/cssquery-ext.html) 11:09:35 INFO - PROCESS | 1932 | RSS: Main: 268804096 11:09:35 INFO - PROCESS | 1932 | 11:12:37 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49688/tests/dromaeo/cssquery-ext.html (next: http://localhost:49688/tests/dromaeo/cssquery-jquery.html) 11:12:38 INFO - PROCESS | 1932 | RSS: Main: 281513984 11:12:38 INFO - PROCESS | 1932 | 11:15:40 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49688/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49688/tests/dromaeo/cssquery-mootools.html) 11:15:41 INFO - PROCESS | 1932 | RSS: Main: 289112064 11:15:41 INFO - PROCESS | 1932 | 11:18:42 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49688/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49688/tests/dromaeo/cssquery-prototype.html) 11:18:43 INFO - PROCESS | 1932 | RSS: Main: 288976896 11:18:43 INFO - PROCESS | 1932 | 11:21:46 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49688/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49688/tests/dromaeo/cssquery-yui.html) 11:21:46 INFO - PROCESS | 1932 | RSS: Main: 293453824 11:21:46 INFO - PROCESS | 1932 | 11:24:49 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:49688/tests/dromaeo/cssquery-yui.html (next: http://localhost:49688/tests/dromaeo/cssquery-dojo.html) 11:24:49 INFO - PROCESS | 1932 | RSS: Main: 293662720 11:24:49 INFO - PROCESS | 1932 | 11:24:49 INFO - PROCESS | 1932 | __start_tp_report 11:24:49 INFO - PROCESS | 1932 | _x_x_mozilla_page_load 11:24:49 INFO - PROCESS | 1932 | _x_x_mozilla_page_load_details 11:24:49 INFO - PROCESS | 1932 | |i|pagename|runs| 11:24:49 INFO - PROCESS | 1932 | |0;dojo.html;3360.5127256547803;3388.88138915138;3425.640307767686;3430.571178602674;3444.689977901989;4511.954880451194;4566.474855391631;5147.202183661534;5857.326407463138;5996.610220335675;5785.936322767026;5913.2017177681;5919.49684276837;5985.970070149643;5998.7600495980105;5294.894102117965;5301;5311.760970756306;5385.272988146608;5448.019356515825;5464.535514481274;5531.446855314477;5540.63985840919;5542.334919809608;5577.470140336662;4881.341018962448;5295.31160949078;5302.867428314285;5423.674579525202;5467.398586155519;5281.155015197588;5293.311869456946;5302.0721373759825;5319.069162896478;5388.0570900092325;5320.494553017457;5343.599230057723;5352.812651557177;5362.43694412085;5444.373897001856;5891.734871930774;5910.645361278337;5992.981193197167;6034.275886893557;6045.395460453963;6214.378562143795;6231.065340199007;6237.6257424554215;6243.125962365272;6244.594101383395;6335.968320158416;6339.397757213057;6361;6371.426571608531;6381.936180638227;5906.557008224358;5955.40445955401;6048.243969503812;6050.909236361458;6081.543884208702;5463.808766693147;6457.903131453032;6462.159919210567;6464.709088091047;6476.6114033158165;6164.383561643889;6178.845528861724;6183.81448556544;6207.6275423474735;6221.9377806221355;6147.323794382614;6204;6213.596116252429;6237.532185086136;6279.466245369194;6123.801220575414;6134.662593557308;6137.263528376623;6167.599106058092;6175.62946223219;6117.663528505886;6177.938220617736;6213.409726076106;6221.9377806222265;6244.313125556185;5017.799288028511;5080.339555857715;5130.256112863613;5138.717370544656;5152.922706159336;4534.909301813946;4538.841140560065;4583.495815460296;4611.354410382549;4654.348391225231;5972.223610930551;6018.518518518508;6069.2716873975405;6081.8479538011015;6086.786962456293;6144.648177400964;6213.03697926822;6322.873542529215;6340.112384266206;6346.587471814318;6046.304674962347;6098.054801505774;6107.4197951194565;6108.251008765869;6120.296165940885;4787.898783279865;4809.302651115569;5017.1721665924715;5611.2144299798065;5612.017896868032;4968.27959945813;5561;5701.916635839178;6425.1968503937005;6479.967600161969;6210.31686514474;6279.340669229665;6296.0555916612875;6318.304986451395;6325.77859774924;6513.478921686348;6520.804375868732;6535.57518761279;6552.967235163794;6605.768798092044;6099.420555047263;6154.076888466766;6240.375962403723;6253.218347706536;6257.4681152102585;6216;6281.654509002049;6337.207849018872;6343.270523889812;6354.015127655221;6150.10823430609;6162.815115546541;6170.228721409824;6181.752729890754;6184.350643182401;6108.645631960618;6141.1924606744105;6162.445379915829;6167.013277875519;6171.6297022178815;4951.331570237971;6080.3615620361;6113.449789518964;6144.709610981744;6193.4425901669065;6169.938300616936;6194.783182588588;6198.256209254918;6198.380161983766;6206.844828879314;6011.879762404815;6060.121282414113;6183.721732522137;6201.162843016135;6208.658523781055 11:24:49 INFO - PROCESS | 1932 | |1;ext.html;482.761033288522;492.76347353270427;496.5630245384061;500.8021831376604;504.3972452918761;37165.814170929145;42153.57846421535;42178.57821421785;42374.36438453418;42425.151496970044;43114.92212694684;43394.78302608491;43553.34669979953;43582.7820860896;43585.78207108968;8462.915370846275;9530.80938381232;9749.122578967892;9772.755681107958;9788.36375635585;9646.228301735879;9743.220542356594;9749.512524373788;9774.5601447935;9786.902130978706;9742.561584728668;9784.706458806248;9791.951040244789;9815.50922453878;9827.722396088498;9708.514574271294;9756.951215243878;9771.853422198708;9773.609055637766;9776.071273229032;9665.081817227352;9695.90304096957;9716.61133554664;9726.9513652432;9732.367396119229;40047.59952400497;40391.39412908809;40467.39298910519;40473.79763101195;40708.389374159415;3228.257500774835;3508.0878971467346;3563.55455568054;3569.928601427983;3583.086312990197;29695.70304296951;31045.844770776002;31866.362672746647;31879.36241275185;31879.52180717291;3093.3658599986948;3101.9689803101905;3122.2194451387154;3136.8949329768093;3207.550942868;160969;161815.1909240458;162247;162673;162984.9999999988;33721;33778.831105844314;33826.154346141055;33831.49252761211;33953.15117122042;27985.44029119447;28255.71744282531;28488.85755571209;28621.284467888054;34380.48429273563;17066.91466542684;17240.913795431192;17242.224099915533;17265.56836079083;17270.309187632607;12700.301483418501;12883.806742898863;13007.219566826021;13010.414531346112;13018.28399438021;15470.607645311977;18911.716324255147;19018;19115.61768764645;19186.904065479583;7574.166841647414;7610.657520411595;7624.560140754905;7630.847383052308;7656.425768067417;719.3705507680779;816.4529765057425;852.8976522817178;998.9450580218157;1036.896310368957;24439.26682199537;29759.553606695918;30042.54936175959;30387.392252154834;30390.240243994078;940.9764755881021;976.8912284557078;1152.2913408253864;1169.7543515861594;1170.9707257318635;13766.380512876945;16089.954152980254;16101.758473622906;16306.103164326076;16633.417830375878;181692.91535423175;183355.16644833647;183529;183659;184083;61840.381596184365;62509.68745156245;62510.68744656248;62668.373316266254;62927;1397.9790303145462;1405.971880562383;1447.117258472352;1450.6953539756769;1454.861788130147;30266.54600181043;30611.928582499506;30655.386892262475;31146.53280200844;31310.843445782626;52355.73822130865;52496.21255681091;52523;52805.5676381034;53047.73476132595;590702;591182;591774;592470;592610;27173.59239611368;27476.313092172855;27553.86223068872;27682.446351073268;27701.168964931083;47747.04505909932;48421;49137.262941055196;49320.50679493159;49607.503924960285;33804;37816.676416325296;40174.79475615736;40577.985550360296;40914.590854091075;35528.64471355357;40314.798426007685;40543.594564055165;41556;41687.374689379074;38959;39759.40360894531;39799.2040159201;40154.39768403418;40296.194076118896;30249.790008399417;33697.83151084229;35990.82004590065;36397;36468.27063458663;26208.106195748765;26334.473310534064;26507.734922650525;26716.7328326722;26931.730682692923 11:24:49 INFO - PROCESS | 1932 | |2;jquery.html;318.5890201639885;366.44849501500255;377.7676728811781;380.2148563216955;383.63937898375525;20130;21243;22058.007389667444;22087.33737987859;22315;18798.718019229724;19477.805221947776;20541;21509.247176348832;22091.447713807163;4760.2383618621025;5343.866403339909;5569.74680696844;5952.58331916766;6127.448529632332;6112.6638034908065;6154.815355539341;6156.815295541141;6162.7534898604;6169.537284703642;5632.295963004624;5986.730597123118;6030.819075427744;6063.363346848583;6140.508759299268;5442.476106690133;5806.245188125559;5949.048152295655;6009.248843894513;6087.3303936566945;5646.971765141189;5869.647821130703;5871.530277577784;5875.236219291465;5941.821745347604;13276.336183190899;13449.66375840602;13685.657858553517;13739.96950228737;13743.862561374359;2379.845310054841;2406.4585468269674;2470.888810003536;2662.267876334004;2748.395353022332;9994;10081;10296.073353398155;10316.484175791256;10420.531076101593;1783;1858.7026075827803;1892.5836316010455;1900.0309841980688;1952.19959816476;102289.97710022879;108890;112595;124750;131883.6811631881;9042.547872606343;9586.808263834684;11400.600978965862;11792.115591330685;11899.107566932515;14496.420143194155;14791.186484743443;14794.260286985607;14833;14851.108933464027;8401.495910245405;8675.696350627697;8722.86915696265;8813.2949364052;8876;6969.721211151497;8431.662733490715;8502;8660.783480412914;8696.260817830555;4514.277715565494;4530.161920044802;4590.357349971006;4668.183067963093;4684.992726563805;1929.5562020735028;1956.745623068992;1969.556849708804;1981;1985.3448362040492;907.6233363154349;910.4309806371018;980.4803454169302;1019.6635110413546;1062.6865074802952;21078.262260820797;21365.25221617236;21372.251971180933;21468.463288417915;21627.35117946464;932.8740620016347;984.3847595252967;988.8368419210893;991.3308516751164;1017.1455976979373;10946.343219406703;11567.88432115668;11581.536738530533;11591.826122608167;11603.825942610867;506683;606125;606187;612880;618022;122335.38832305782;124215.37892310662;124549.37725311497;125668;129914;987.3976874106789;1002.5638847101534;1019.9694009179736;1021.836506159011;1026.9024442677933;18451.892886426856;18858.717119243498;19198.232070717015;19347.129379177688;19359.93520356394;41365.37951930663;52777;53405.732971334895;53936.73031634817;54625.72687136539;79693.20306796858;80499.59750201445;81685.7144282411;82667.5866620663;82969;7254.347108760237;8077.596120193849;8465.746027619181;8491.74524764258;8627;9826.65606703762;12969.35153242353;13561.932190338985;13718.588442346745;14327;11615.128865334964;11730.882691173321;11881.405929703653;12117.515299387926;12150.635480935585;9914.107730304308;10296.970302969943;11459.854014598473;11755;11888.762224755283;11718.414079296172;11901.226420282654;12031.45858436355;12050.578229761917;12197.634070977885;6318.715657795318;7153.964230178815;7528.849423011399;7691.192424795539;8563.785905352415;9378.906210938076;10818.134549235885;11288.604898828502;11941.343226122646;11943.880561194277 11:24:49 INFO - PROCESS | 1932 | |3;mootools.html;1557.9999999999995;1603.1984007996004;1848.6395152945172;1909.5035290824383;1916.27181670965;8163.306118979894;8739.956300218506;8833.425827321227;9326.580303886325;9356.578953947072;8825.955870220656;9002.054784247657;9004.68483603074;9012.549372531364;9013;2357.045396614374;2389.3190440724397;2393.796527295182;2397.4725560376687;2399.3881560202126;1806.304572739498;2335.696359473266;2350.1421980976993;2359.772918082596;2367.242482405631;2364.4561750797325;2366.92899213023;2377.7503362146986;2378.7859092681656;2383.6305372667266;2341.227394959668;2341.438054866837;2359.1153317506023;2367.6922000140044;2368.171140100968;2345.953080938372;2352.823538234622;2354.3525530479083;2355.057976809273;2361.6929799126174;9040.728778136667;9043.728688139367;9094.590743416562;9101.226395756368;9142.268618510503;5332.413434522199;5348.144296912515;5366.6779993200535;5384.515393614593;5402.91895621566;3419.6834218825684;3500.8949731508096;3572.624874388178;3577.3918433866047;3636.8363423646;899.4423457456419;1048.3290693955873;1067.2422579968154;1076.590895459728;1088.0425225801323;11613.825792613117;11775.528978840835;11810.173287869853;11919.761604767857;11928.940355298342;4763.166445872028;4784.732046007811;4816.710997340171;4914.508549145057;4942.2092465206115;10147.391156530484;10152.39085654863;10153.39079655223;10172.440515771556;10186.694399168036;5431.5926305526455;5435.945640543623;5445.891082178414;5448;5464.1257398816;4420.690551661417;4803.879903002383;4929.9014019720125;4951.405831300267;4958.528939750718;3687.2625474905126;3736.2714270717493;4017.9196416071513;4023.3160362738404;4054.432379466877;1288.806678998139;1293.5795866343476;1298.1886321049344;1298.2405292903757;1300.959232613905;700.6881937537848;949.3734135470556;975.4342481360794;975.878015248094;992.4690290694443;5614.129809879475;5733.942660573424;6137.539684523678;6157;6160.691965401712;400.3154605624415;421.2838175102338;447.9820807167742;451.3140027158766;452.25152372822373;3921.4117882317883;4037.0916543777416;4052.756834589934;4151.066010147692;4174.415581818548;8583.957080214559;9826.508674566243;9898.208143348515;10257.435841028815;11100.555977760961;10539.683809485728;10774.461276936121;10821.67534973952;11082.944585277022;11083.889161108447;7230.891536626955;7944.960275198587;8265.338772898274;8350.62422191003;8491;5021.748912554431;6093.634381937098;6256.530760192913;6300.716467759054;6341.778037768656;10170.135538479311;10370.014848589371;10384.42885641297;10388.584456621651;10427.635032773816;9950.850737239092;10404.167666586807;10423.739406514898;10518.737031574272;10610.045095941094;7163.820904477429;7619.1999840016;7750.10873749526;7753.806154845948;7928.127905930459;8689.826203476021;8726.520041397784;8784.692535761218;8799.780005499913;8805.16350946659;7601.847963040597;7754.651040703069;7785.766427007199;7825.843483130419;7881.330086942674;7365;7431.29402706742;7438.888416673863;7441.479096463196;7614.695412183451;6879.965600171967;6986.895196571953;7005.439564834903;7008.264132266243;7021.648917554204;5014.473480284518;5031.295618613471;5172.586193104617;5179.22311653255;5274;5106.10643137442;5112.335396398593;5176.637635365489;5264.921026184534;5348.090824559912 11:24:49 INFO - PROCESS | 1932 | |4;prototype.html;300.32576864938204;313.28570858442754;320.35128864050296;320.6745153669025;325.9429599820034;5239.423663397033;5688.800891968782;5792.522906658806;5809.302883653962;5820.9126863097035;4967.473094103182;5358.936809328407;5675.318961724599;5690.430956904307;5755.568332375078;4086.794395653282;4123.463949686537;4213.452251207339;4276.776076440249;4309.612134907858;3859.4982652255308;4252.893677658068;4261.955820823902;4264.104538047014;4322.222000039991;3515.34966031285;3715.866660668495;3983.362661974085;4223.598758117989;4238.385434112052;3503.5095086687884;4123.422720819088;4218.978905105486;4237.660987121023;4269.829206831723;3673.246984368198;3674.1549443627846;3688.7417880748358;3690.19180601506;3696.741228114033;4320.617402431223;5577.358603760538;5581.074529287389;5582.944170558324;5620.185073164409;4679.27471241958;4764.8332308369045;4918.508149185089;4947.257911313296;4952.845512202203;5927.7925272615685;5934.881302373971;5945.483901605106;5955.285365756094;6020.638761674313;4097.405876147972;4098.405731168994;4100.851761506753;4108.876733697994;4113.8971525711795;5463.562914966793;5874.9118763218585;6232.320102355985;6289.87420251597;6304.810855674337;3999.8800035998966;4009.51885773709;4024.1146947671464;4037.959620403817;4041.656459201001;3716.3682174030478;3743.550773907094;4104.8768536943935;4122.464079669624;4125.319322311845;3846.673032792244;4363.716358436692;4594.747288899142;4837.992233223173;4856.611471082305;5240.790368385222;5459.317585301837;5832.1834943108;6011.579189456784;6013.789517366871;1257.1891130221138;1376.078027721429;1400.1948879394388;1403.4386245501678;1406.1492796857958;752.7929819299736;755.0674916478146;857.6998050682336;863.4862256957226;868.843608150539;4374.300111982131;5350.822818979818;5387;5561.972190139104;5630.577706672016;5634.140733557916;5666.376698563155;5949.881002380015;6209.59637623553;6244.2819075806865;4922.956972856225;5113.744312784346;5574.554035677136;5622.746976386073;5661.3206415229615;3189.2824114574037;3220.6940340667597;3226.274088330154;3227.967720322814;3231.6768323167494;5458.863528411742;5987.072003839412;6079.513638908877;6210.968945155245;6404.967975160094;5267.446918073624;5449.986012868171;6065.5450841187085;6198.163247961557;6385.233771947396;6149.86227547905;6424.618706978023;6439.64581947988;6439.751602443993;6451.000094985285;5795.673444050923;6074.691617185441;6119.204503414528;6166.290876549075;6172.537059720449;5094.617903657167;5124.744437612809;6051;6100.267967843887;6124.908126378197;5683.9715801420725;6127.816165515042;6368.617882927039;6407.519436042408;6436.259830119596;3944.1322908959983;3979.343408337708;4004.1991601680365;4007.3988901664984;4037.4347591337823;6172.660503672341;6219.973704338733;6221.631241126945;6225.128482012431;6237.725194273043;4899.853004409873;5633.662030257397;5920.141579470866;5923.555733319932;6004.87990240184;4588.311753236908;5835.591508594358;5962.853372785707;5994.250718660168;6004.489618382487;4887.020756593585;5055.545000949932;5139.460356662496;5848.912266315923;5890;5125.7693403796175;5937.901488224519;5969.313528944227;5984.940150598438;5985;4991.301217829434;5541.778328866801;5874.678197405549;5916.171735957056;5941.435563621449 11:24:49 INFO - PROCESS | 1932 | |5;yui.html;727.5489196698046;728.2280782370684;775.0931410250007;822;838.1827717974974;15744.606384840385;16055.59861003474;16061.83938160618;16063.95584287022;16085.919570402146;14730.779038314407;14807.33366998485;14821.629459263524;14830.555083347517;14890.478833240839;710.9751158709446;895.726803324984;897.9371443998923;921.8018126102886;925.3846192282124;918.3020904112856;918.5407296351824;918.7565295196778;918.9982918618704;920.9677661281856;980.1766516126453;980.3382716666257;981.7447463659464;982.9164521015687;983.6852207293668;972.6060945317158;977.6529332087077;978.3738407419257;979.1432496565506;979.2851218610418;707.7699747582056;724.322758221065;727.5816405566767;728.0426239495047;728.6174758251907;15320.693586128327;15407.768883466757;15454.845451545452;15460.768088478682;15468.994515356466;13471.595852124452;13582.456701731919;13772.724545509034;13859.584212473643;13937.917532244312;13180.86819131806;13229.801552976713;13360.131591446525;13491.865081349159;13789.931050344683;4651.348811166439;4688.109259240733;4803.711777293373;4854.320395144682;4873.147199240118;93664;111671;114385.4280728591;116996.41501792436;118380.40809795982;11073.944630276797;11074.335539867634;11144.929994910619;11192.10463162945;11347.943260283646;21239.256626018323;21368.786312136992;21437.571248574943;21488.24791132303;21584.78415215859;6884.829578971587;7898.526088434713;7960.562169080757;8099;8174.836503269901;4312.676549258818;4404.383386325917;4416.447944006999;4475.530069342737;4551.749653769009;3392.6607339265875;3486.0413386318965;3493.8427770750377;3507.5264839246374;3517.4547945068557;640.1517988665038;646.8479907221799;650.222983534681;659.0674196012588;659.9835004124935;493.79013919084247;516.7209706758308;561.9185218143347;635.5487603801353;642.1421943001181;7286.744963926237;9133.086691330815;9479.76300592477;9489.90510094904;10239.436830974219;640.9647469389229;661.424560632253;662.6156829039146;686.2074304178682;686.2142846440897;4229;4302.419173411549;4352.173087113501;4820.807167713252;4932.778024988884;153026.23486882716;154073;158057.41942580658;159980;162390.18804906137;134147;137764.93352599718;138982;139559;141006;76551.46897062028;76593;76609.616951916;77799;81151;7797.688092476237;8874.29005679557;8880.911190888008;8889.377743557889;8898.42160259581;49039.50960490349;58857.11714324374;61141.38858611357;63498.682506587174;63631;90578.18843623223;97082;99592;100432.49783751034;102692.48653756683;11983.580574679845;11998.880011199777;12182.147249692436;12391.814122787984;12795.232286062866;13653.249071301174;13723.382447790073;13782.7722811697;13910.37403316833;14494.34775435129;12875.163114397534;13080.476780928657;13488.988325875795;13516.864831351953;13590.048696591144;13059.673508161992;13107.213567186;13261.07172497916;13488.190708557519;13500;11655.242409243372;12552.49790008426;12628;12653.620391388273;12722.745545089232;10249.026342497451;10317.9484102579;10605.416702081151;10618.469076546296;10806.729831753955;9323.953380233055;10682.83975740349;10690.62582809598;10706.357618542912;10851.565937362733 11:24:49 INFO - PROCESS | 1932 | __end_tp_report 11:24:49 INFO - PROCESS | 1932 | __start_cc_report 11:24:49 INFO - PROCESS | 1932 | _x_x_mozilla_cycle_collect,455 11:24:49 INFO - PROCESS | 1932 | __end_cc_report 11:24:49 INFO - PROCESS | 1932 | __startTimestamp1469125489940__endTimestamp 11:24:49 INFO - PROCESS | 1932 | 11:24:49 INFO - PROCESS | 1932 | ------- Summary: start ------- 11:24:49 INFO - PROCESS | 1932 | Number of tests: 6 11:24:49 INFO - PROCESS | 1932 | 11:24:49 INFO - PROCESS | 1932 | [#0] dojo.html Cycles:165 Average:5816.79 Median:6108.25 stddev:658.94 (10.8%) stddev-sans-first:632.16 11:24:49 INFO - PROCESS | 1932 | Values: 3360.5 3388.9 3425.6 3430.6 3444.7 4512.0 4566.5 5147.2 5857.3 5996.6 5785.9 5913.2 5919.5 5986.0 5998.8 5294.9 5301.0 5311.8 5385.3 5448.0 5464.5 5531.4 5540.6 5542.3 5577.5 4881.3 5295.3 5302.9 5423.7 5467.4 5281.2 5293.3 5302.1 5319.1 5388.1 5320.5 5343.6 5352.8 5362.4 5444.4 5891.7 5910.6 5993.0 6034.3 6045.4 6214.4 6231.1 6237.6 6243.1 6244.6 6336.0 6339.4 6361.0 6371.4 6381.9 5906.6 5955.4 6048.2 6050.9 6081.5 5463.8 6457.9 6462.2 6464.7 6476.6 6164.4 6178.8 6183.8 6207.6 6221.9 6147.3 6204.0 6213.6 6237.5 6279.5 6123.8 6134.7 6137.3 6167.6 6175.6 6117.7 6177.9 6213.4 6221.9 6244.3 5017.8 5080.3 5130.3 5138.7 5152.9 4534.9 4538.8 4583.5 4611.4 4654.3 5972.2 6018.5 6069.3 6081.8 6086.8 6144.6 6213.0 6322.9 6340.1 6346.6 6046.3 6098.1 6107.4 6108.3 6120.3 4787.9 4809.3 5017.2 5611.2 5612.0 4968.3 5561.0 5701.9 6425.2 6480.0 6210.3 6279.3 6296.1 6318.3 6325.8 6513.5 6520.8 6535.6 6553.0 6605.8 6099.4 6154.1 6240.4 6253.2 6257.5 6216.0 6281.7 6337.2 6343.3 6354.0 6150.1 6162.8 6170.2 6181.8 6184.4 6108.6 6141.2 6162.4 6167.0 6171.6 4951.3 6080.4 6113.4 6144.7 6193.4 6169.9 6194.8 6198.3 6198.4 6206.8 6011.9 6060.1 6183.7 6201.2 6208.7 11:24:49 INFO - PROCESS | 1932 | 11:24:49 INFO - PROCESS | 1932 | [#1] ext.html Cycles:180 Average:47737.53 Median:36817.04 stddev:99726.20 (270.9%) stddev-sans-first:99942.84 11:24:49 INFO - PROCESS | 1932 | Values: 482.8 492.8 496.6 500.8 504.4 37165.8 42153.6 42178.6 42374.4 42425.2 43114.9 43394.8 43553.3 43582.8 43585.8 8462.9 9530.8 9749.1 9772.8 9788.4 9646.2 9743.2 9749.5 9774.6 9786.9 9742.6 9784.7 9792.0 9815.5 9827.7 9708.5 9757.0 9771.9 9773.6 9776.1 9665.1 9695.9 9716.6 9727.0 9732.4 40047.6 40391.4 40467.4 40473.8 40708.4 3228.3 3508.1 3563.6 3569.9 3583.1 29695.7 31045.8 31866.4 31879.4 31879.5 3093.4 3102.0 3122.2 3136.9 3207.6 160969.0 161815.2 162247.0 162673.0 162985.0 33721.0 33778.8 33826.2 33831.5 33953.2 27985.4 28255.7 28488.9 28621.3 34380.5 17066.9 17240.9 17242.2 17265.6 17270.3 12700.3 12883.8 13007.2 13010.4 13018.3 15470.6 18911.7 19018.0 19115.6 19186.9 7574.2 7610.7 7624.6 7630.8 7656.4 719.4 816.5 852.9 998.9 1036.9 24439.3 29759.6 30042.5 30387.4 30390.2 941.0 976.9 1152.3 1169.8 1171.0 13766.4 16090.0 16101.8 16306.1 16633.4 181692.9 183355.2 183529.0 183659.0 184083.0 61840.4 62509.7 62510.7 62668.4 62927.0 1398.0 1406.0 1447.1 1450.7 1454.9 30266.5 30611.9 30655.4 31146.5 31310.8 52355.7 52496.2 52523.0 52805.6 53047.7 590702.0 591182.0 591774.0 592470.0 592610.0 27173.6 27476.3 27553.9 27682.4 27701.2 47747.0 48421.0 49137.3 49320.5 49607.5 33804.0 37816.7 40174.8 40578.0 40914.6 35528.6 40314.8 40543.6 41556.0 41687.4 38959.0 39759.4 39799.2 40154.4 40296.2 30249.8 33697.8 35990.8 36397.0 36468.3 26208.1 26334.5 26507.7 26716.7 26931.7 11:24:49 INFO - PROCESS | 1932 | 11:24:49 INFO - PROCESS | 1932 | [#2] jquery.html Cycles:180 Average:34514.39 Median:12347.42 stddev:98761.17 (799.9%) stddev-sans-first:99004.84 11:24:49 INFO - PROCESS | 1932 | Values: 318.6 366.4 377.8 380.2 383.6 20130.0 21243.0 22058.0 22087.3 22315.0 18798.7 19477.8 20541.0 21509.2 22091.4 4760.2 5343.9 5569.7 5952.6 6127.4 6112.7 6154.8 6156.8 6162.8 6169.5 5632.3 5986.7 6030.8 6063.4 6140.5 5442.5 5806.2 5949.0 6009.2 6087.3 5647.0 5869.6 5871.5 5875.2 5941.8 13276.3 13449.7 13685.7 13740.0 13743.9 2379.8 2406.5 2470.9 2662.3 2748.4 9994.0 10081.0 10296.1 10316.5 10420.5 1783.0 1858.7 1892.6 1900.0 1952.2 102290.0 108890.0 112595.0 124750.0 131883.7 9042.5 9586.8 11400.6 11792.1 11899.1 14496.4 14791.2 14794.3 14833.0 14851.1 8401.5 8675.7 8722.9 8813.3 8876.0 6969.7 8431.7 8502.0 8660.8 8696.3 4514.3 4530.2 4590.4 4668.2 4685.0 1929.6 1956.7 1969.6 1981.0 1985.3 907.6 910.4 980.5 1019.7 1062.7 21078.3 21365.3 21372.3 21468.5 21627.4 932.9 984.4 988.8 991.3 1017.1 10946.3 11567.9 11581.5 11591.8 11603.8 506683.0 606125.0 606187.0 612880.0 618022.0 122335.4 124215.4 124549.4 125668.0 129914.0 987.4 1002.6 1020.0 1021.8 1026.9 18451.9 18858.7 19198.2 19347.1 19359.9 41365.4 52777.0 53405.7 53936.7 54625.7 79693.2 80499.6 81685.7 82667.6 82969.0 7254.3 8077.6 8465.7 8491.7 8627.0 9826.7 12969.4 13561.9 13718.6 14327.0 11615.1 11730.9 11881.4 12117.5 12150.6 9914.1 10297.0 11459.9 11755.0 11888.8 11718.4 11901.2 12031.5 12050.6 12197.6 6318.7 7154.0 7528.8 7691.2 8563.8 9378.9 10818.1 11288.6 11941.3 11943.9 11:24:49 INFO - PROCESS | 1932 | 11:24:49 INFO - PROCESS | 1932 | [#3] mootools.html Cycles:180 Average:5793.17 Median:4922.20 stddev:3272.16 (66.5%) stddev-sans-first:3265.87 11:24:49 INFO - PROCESS | 1932 | Values: 1558.0 1603.2 1848.6 1909.5 1916.3 8163.3 8740.0 8833.4 9326.6 9356.6 8826.0 9002.1 9004.7 9012.5 9013.0 2357.0 2389.3 2393.8 2397.5 2399.4 1806.3 2335.7 2350.1 2359.8 2367.2 2364.5 2366.9 2377.8 2378.8 2383.6 2341.2 2341.4 2359.1 2367.7 2368.2 2346.0 2352.8 2354.4 2355.1 2361.7 9040.7 9043.7 9094.6 9101.2 9142.3 5332.4 5348.1 5366.7 5384.5 5402.9 3419.7 3500.9 3572.6 3577.4 3636.8 899.4 1048.3 1067.2 1076.6 1088.0 11613.8 11775.5 11810.2 11919.8 11928.9 4763.2 4784.7 4816.7 4914.5 4942.2 10147.4 10152.4 10153.4 10172.4 10186.7 5431.6 5435.9 5445.9 5448.0 5464.1 4420.7 4803.9 4929.9 4951.4 4958.5 3687.3 3736.3 4017.9 4023.3 4054.4 1288.8 1293.6 1298.2 1298.2 1301.0 700.7 949.4 975.4 975.9 992.5 5614.1 5733.9 6137.5 6157.0 6160.7 400.3 421.3 448.0 451.3 452.3 3921.4 4037.1 4052.8 4151.1 4174.4 8584.0 9826.5 9898.2 10257.4 11100.6 10539.7 10774.5 10821.7 11082.9 11083.9 7230.9 7945.0 8265.3 8350.6 8491.0 5021.7 6093.6 6256.5 6300.7 6341.8 10170.1 10370.0 10384.4 10388.6 10427.6 9950.9 10404.2 10423.7 10518.7 10610.0 7163.8 7619.2 7750.1 7753.8 7928.1 8689.8 8726.5 8784.7 8799.8 8805.2 7601.8 7754.7 7785.8 7825.8 7881.3 7365.0 7431.3 7438.9 7441.5 7614.7 6880.0 6986.9 7005.4 7008.3 7021.6 5014.5 5031.3 5172.6 5179.2 5274.0 5106.1 5112.3 5176.6 5264.9 5348.1 11:24:49 INFO - PROCESS | 1932 | 11:24:49 INFO - PROCESS | 1932 | [#4] prototype.html Cycles:180 Average:4796.16 Median:5454.42 stddev:1504.90 (27.6%) stddev-sans-first:1470.80 11:24:49 INFO - PROCESS | 1932 | Values: 300.3 313.3 320.4 320.7 325.9 5239.4 5688.8 5792.5 5809.3 5820.9 4967.5 5358.9 5675.3 5690.4 5755.6 4086.8 4123.5 4213.5 4276.8 4309.6 3859.5 4252.9 4262.0 4264.1 4322.2 3515.3 3715.9 3983.4 4223.6 4238.4 3503.5 4123.4 4219.0 4237.7 4269.8 3673.2 3674.2 3688.7 3690.2 3696.7 4320.6 5577.4 5581.1 5582.9 5620.2 4679.3 4764.8 4918.5 4947.3 4952.8 5927.8 5934.9 5945.5 5955.3 6020.6 4097.4 4098.4 4100.9 4108.9 4113.9 5463.6 5874.9 6232.3 6289.9 6304.8 3999.9 4009.5 4024.1 4038.0 4041.7 3716.4 3743.6 4104.9 4122.5 4125.3 3846.7 4363.7 4594.7 4838.0 4856.6 5240.8 5459.3 5832.2 6011.6 6013.8 1257.2 1376.1 1400.2 1403.4 1406.1 752.8 755.1 857.7 863.5 868.8 4374.3 5350.8 5387.0 5562.0 5630.6 5634.1 5666.4 5949.9 6209.6 6244.3 4923.0 5113.7 5574.6 5622.7 5661.3 3189.3 3220.7 3226.3 3228.0 3231.7 5458.9 5987.1 6079.5 6211.0 6405.0 5267.4 5450.0 6065.5 6198.2 6385.2 6149.9 6424.6 6439.6 6439.8 6451.0 5795.7 6074.7 6119.2 6166.3 6172.5 5094.6 5124.7 6051.0 6100.3 6124.9 5684.0 6127.8 6368.6 6407.5 6436.3 3944.1 3979.3 4004.2 4007.4 4037.4 6172.7 6220.0 6221.6 6225.1 6237.7 4899.9 5633.7 5920.1 5923.6 6004.9 4588.3 5835.6 5962.9 5994.3 6004.5 4887.0 5055.5 5139.5 5848.9 5890.0 5125.8 5937.9 5969.3 5984.9 5985.0 4991.3 5541.8 5874.7 5916.2 5941.4 11:24:49 INFO - PROCESS | 1932 | 11:24:49 INFO - PROCESS | 1932 | [#5] yui.html Cycles:180 Average:24554.79 Median:3873.23 stddev:39871.09 (1029.4%) stddev-sans-first:39942.80 11:24:49 INFO - PROCESS | 1932 | Values: 727.5 728.2 775.1 822.0 838.2 15744.6 16055.6 16061.8 16064.0 16085.9 14730.8 14807.3 14821.6 14830.6 14890.5 711.0 895.7 897.9 921.8 925.4 918.3 918.5 918.8 919.0 921.0 980.2 980.3 981.7 982.9 983.7 972.6 977.7 978.4 979.1 979.3 707.8 724.3 727.6 728.0 728.6 15320.7 15407.8 15454.8 15460.8 15469.0 13471.6 13582.5 13772.7 13859.6 13937.9 13180.9 13229.8 13360.1 13491.9 13789.9 4651.3 4688.1 4803.7 4854.3 4873.1 93664.0 111671.0 114385.4 116996.4 118380.4 11073.9 11074.3 11144.9 11192.1 11347.9 21239.3 21368.8 21437.6 21488.2 21584.8 6884.8 7898.5 7960.6 8099.0 8174.8 4312.7 4404.4 4416.4 4475.5 4551.7 3392.7 3486.0 3493.8 3507.5 3517.5 640.2 646.8 650.2 659.1 660.0 493.8 516.7 561.9 635.5 642.1 7286.7 9133.1 9479.8 9489.9 10239.4 641.0 661.4 662.6 686.2 686.2 4229.0 4302.4 4352.2 4820.8 4932.8 153026.2 154073.0 158057.4 159980.0 162390.2 134147.0 137764.9 138982.0 139559.0 141006.0 76551.5 76593.0 76609.6 77799.0 81151.0 7797.7 8874.3 8880.9 8889.4 8898.4 49039.5 58857.1 61141.4 63498.7 63631.0 90578.2 97082.0 99592.0 100432.5 102692.5 11983.6 11998.9 12182.1 12391.8 12795.2 13653.2 13723.4 13782.8 13910.4 14494.3 12875.2 13080.5 13489.0 13516.9 13590.0 13059.7 13107.2 13261.1 13488.2 13500.0 11655.2 12552.5 12628.0 12653.6 12722.7 10249.0 10317.9 10605.4 10618.5 10806.7 9324.0 10682.8 10690.6 10706.4 10851.6 11:24:49 INFO - PROCESS | 1932 | -------- Summary: end -------- 11:24:49 INFO - PROCESS | 1932 | 11:24:50 INFO - TEST-INFO | 1932: exit 0 11:24:50 INFO - TEST-OK | dromaeo_css | took 1113966ms 11:24:50 INFO - TEST-START | kraken 11:24:50 INFO - operating with platform_type : mac_ 11:24:50 INFO - Initialising browser for kraken test... 11:24:50 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmphKsG8j/profile http://localhost:49688/getInfo.html) 11:24:52 INFO - PROCESS | 1938 | JavaScript error: , line 0: uncaught exception: undefined 11:24:53 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 11:24:53 INFO - PROCESS | 1938 | colorDepth:24 11:24:53 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 11:24:53 INFO - PROCESS | 1938 | __metrics 11:24:53 ERROR - PROCESS | 1938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:24:54 INFO - TEST-INFO | 1938: exit 0 11:24:54 INFO - Browser initialized. 11:24:54 INFO - Running cycle 1/1 for kraken test... 11:24:54 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmphKsG8j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:06 INFO - PROCESS | 1940 | RSS: Main: 256364544 11:25:06 INFO - PROCESS | 1940 | 11:25:08 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49688/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:09 INFO - PROCESS | 1940 | RSS: Main: 269422592 11:25:09 INFO - PROCESS | 1940 | 11:25:12 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49688/tests/kraken/driver.html?testName=audio-dft) 11:25:13 INFO - PROCESS | 1940 | RSS: Main: 277168128 11:25:13 INFO - PROCESS | 1940 | 11:25:16 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49688/tests/kraken/driver.html?testName=audio-fft) 11:25:17 INFO - PROCESS | 1940 | RSS: Main: 280686592 11:25:17 INFO - PROCESS | 1940 | 11:25:19 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49688/tests/kraken/driver.html?testName=audio-oscillator) 11:25:19 INFO - PROCESS | 1940 | RSS: Main: 282046464 11:25:19 INFO - PROCESS | 1940 | 11:25:21 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49688/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:25:22 INFO - PROCESS | 1940 | RSS: Main: 282796032 11:25:22 INFO - PROCESS | 1940 | 11:25:25 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49688/tests/kraken/driver.html?testName=imaging-darkroom) 11:25:26 INFO - PROCESS | 1940 | RSS: Main: 284807168 11:25:26 INFO - PROCESS | 1940 | 11:25:29 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49688/tests/kraken/driver.html?testName=imaging-desaturate) 11:25:29 INFO - PROCESS | 1940 | RSS: Main: 285073408 11:25:29 INFO - PROCESS | 1940 | 11:25:32 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49688/tests/kraken/driver.html?testName=json-parse-financial) 11:25:33 INFO - PROCESS | 1940 | RSS: Main: 285007872 11:25:33 INFO - PROCESS | 1940 | 11:25:35 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49688/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:25:35 INFO - PROCESS | 1940 | RSS: Main: 284766208 11:25:35 INFO - PROCESS | 1940 | 11:25:37 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49688/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:25:38 INFO - PROCESS | 1940 | RSS: Main: 284512256 11:25:38 INFO - PROCESS | 1940 | 11:25:40 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49688/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:25:41 INFO - PROCESS | 1940 | RSS: Main: 284782592 11:25:41 INFO - PROCESS | 1940 | 11:25:44 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:25:44 INFO - PROCESS | 1940 | RSS: Main: 284966912 11:25:44 INFO - PROCESS | 1940 | 11:25:47 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:25:48 INFO - PROCESS | 1940 | RSS: Main: 284889088 11:25:48 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49688/tests/kraken/driver.html?testName=ai-astar) 11:25:50 INFO - PROCESS | 1940 | RSS: Main: 285769728 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | __start_tp_report 11:25:50 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 11:25:50 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 11:25:50 INFO - PROCESS | 1940 | |i|pagename|runs| 11:25:50 INFO - PROCESS | 1940 | |0;ai-astar;102;116;107;116;118;117;114;116;116;116 11:25:50 INFO - PROCESS | 1940 | |1;audio-beat-detection;142;109;131;165;112;129;128;109;161;122 11:25:50 INFO - PROCESS | 1940 | |2;audio-dft;201;184;196;204;215;256;234;219;223;195 11:25:50 INFO - PROCESS | 1940 | |3;audio-fft;69;80;72;113;58;59;59;64;135;58 11:25:50 INFO - PROCESS | 1940 | |4;audio-oscillator;77;104;143;70;72;86;106;92;100;151 11:25:50 INFO - PROCESS | 1940 | |5;imaging-gaussian-blur;120;73;127;130;116;87;92;88;89;88 11:25:50 INFO - PROCESS | 1940 | |6;imaging-darkroom;130;147;96;122;149;114;96;98;105;96 11:25:50 INFO - PROCESS | 1940 | |7;imaging-desaturate;142;134;90;91;88;87;92;91;90;89 11:25:50 INFO - PROCESS | 1940 | |8;json-parse-financial;55;56;57;56;54;57;57;55;55;57 11:25:50 INFO - PROCESS | 1940 | |9;json-stringify-tinderbox;82;84;76;70;81;92;74;74;61;99 11:25:50 INFO - PROCESS | 1940 | |10;stanford-crypto-aes;95;68;94;75;105;103;105;104;81;84 11:25:50 INFO - PROCESS | 1940 | |11;stanford-crypto-ccm;149;153;157;148;137;150;137;140;185;129 11:25:50 INFO - PROCESS | 1940 | |12;stanford-crypto-pbkdf2;168;170;164;168;168;168;235;168;219;155 11:25:50 INFO - PROCESS | 1940 | |13;stanford-crypto-sha256-iterative;68;66;71;67;70;66;67;65;64;88 11:25:50 INFO - PROCESS | 1940 | __end_tp_report 11:25:50 INFO - PROCESS | 1940 | __start_cc_report 11:25:50 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,1146 11:25:50 INFO - PROCESS | 1940 | __end_cc_report 11:25:50 INFO - PROCESS | 1940 | __startTimestamp1469125550427__endTimestamp 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | ------- Summary: start ------- 11:25:50 INFO - PROCESS | 1940 | Number of tests: 14 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#0] ai-astar Cycles:10 Average:113.80 Median:116.00 stddev:5.14 (4.4%) stddev-sans-first:3.22 11:25:50 INFO - PROCESS | 1940 | Values: 102.0 116.0 107.0 116.0 118.0 117.0 114.0 116.0 116.0 116.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:130.00 stddev:20.00 (15.4%) stddev-sans-first:20.80 11:25:50 INFO - PROCESS | 1940 | Values: 142.0 109.0 131.0 165.0 112.0 129.0 128.0 109.0 161.0 122.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#2] audio-dft Cycles:10 Average:212.70 Median:217.00 stddev:21.36 (9.8%) stddev-sans-first:22.24 11:25:50 INFO - PROCESS | 1940 | Values: 201.0 184.0 196.0 204.0 215.0 256.0 234.0 219.0 223.0 195.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#3] audio-fft Cycles:10 Average:76.70 Median:61.50 stddev:26.45 (43.0%) stddev-sans-first:27.91 11:25:50 INFO - PROCESS | 1940 | Values: 69.0 80.0 72.0 113.0 58.0 59.0 59.0 64.0 135.0 58.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#4] audio-oscillator Cycles:10 Average:100.10 Median:71.00 stddev:27.84 (39.2%) stddev-sans-first:28.24 11:25:50 INFO - PROCESS | 1940 | Values: 77.0 104.0 143.0 70.0 72.0 86.0 106.0 92.0 100.0 151.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#5] imaging-gaussian-blur Cycles:10 Average:101.00 Median:87.50 stddev:20.13 (23.0%) stddev-sans-first:20.14 11:25:50 INFO - PROCESS | 1940 | Values: 120.0 73.0 127.0 130.0 116.0 87.0 92.0 88.0 89.0 88.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#6] imaging-darkroom Cycles:10 Average:115.30 Median:122.50 stddev:20.89 (17.0%) stddev-sans-first:21.47 11:25:50 INFO - PROCESS | 1940 | Values: 130.0 147.0 96.0 122.0 149.0 114.0 96.0 98.0 105.0 96.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#7] imaging-desaturate Cycles:10 Average:99.40 Median:90.00 stddev:20.48 (22.8%) stddev-sans-first:14.83 11:25:50 INFO - PROCESS | 1940 | Values: 142.0 134.0 90.0 91.0 88.0 87.0 92.0 91.0 90.0 89.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.50 stddev:1.10 (1.9%) stddev-sans-first:1.12 11:25:50 INFO - PROCESS | 1940 | Values: 55.0 56.0 57.0 56.0 54.0 57.0 57.0 55.0 55.0 57.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#9] json-stringify-tinderbox Cycles:10 Average:79.30 Median:81.50 stddev:10.90 (13.4%) stddev-sans-first:11.52 11:25:50 INFO - PROCESS | 1940 | Values: 82.0 84.0 76.0 70.0 81.0 92.0 74.0 74.0 61.0 99.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:78.00 stddev:13.59 (17.4%) stddev-sans-first:14.35 11:25:50 INFO - PROCESS | 1940 | Values: 95.0 68.0 94.0 75.0 105.0 103.0 105.0 104.0 81.0 84.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:149.50 stddev:15.44 (10.3%) stddev-sans-first:16.37 11:25:50 INFO - PROCESS | 1940 | Values: 149.0 153.0 157.0 148.0 137.0 150.0 137.0 140.0 185.0 129.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:168.00 stddev:26.28 (15.6%) stddev-sans-first:27.61 11:25:50 INFO - PROCESS | 1940 | Values: 168.0 170.0 164.0 168.0 168.0 168.0 235.0 168.0 219.0 155.0 11:25:50 INFO - PROCESS | 1940 | 11:25:50 INFO - PROCESS | 1940 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:67.50 stddev:6.94 (10.3%) stddev-sans-first:7.35 11:25:50 INFO - PROCESS | 1940 | Values: 68.0 66.0 71.0 67.0 70.0 66.0 67.0 65.0 64.0 88.0 11:25:50 INFO - PROCESS | 1940 | -------- Summary: end -------- 11:25:50 INFO - PROCESS | 1940 | 11:25:51 INFO - TEST-INFO | 1940: exit 0 11:25:51 INFO - TEST-OK | kraken | took 60605ms 11:25:51 INFO - SUITE-END | took 1174s 11:25:51 INFO - Completed test suite (00:19:34) 11:25:51 INFO - javascript benchmark 11:25:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7329.85165792038, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.5127256547803, 3388.88138915138, 3425.640307767686, 3430.571178602674, 3444.689977901989, 4511.954880451194, 4566.474855391631, 5147.202183661534, 5857.326407463138, 5996.610220335675, 5785.936322767026, 5913.2017177681, 5919.49684276837, 5985.970070149643, 5998.7600495980105, 5294.894102117965, 5301.0, 5311.760970756306, 5385.272988146608, 5448.019356515825, 5464.535514481274, 5531.446855314477, 5540.63985840919, 5542.334919809608, 5577.470140336662, 4881.341018962448, 5295.31160949078, 5302.867428314285, 5423.674579525202, 5467.398586155519, 5281.155015197588, 5293.311869456946, 5302.0721373759825, 5319.069162896478, 5388.0570900092325, 5320.494553017457, 5343.599230057723, 5352.812651557177, 5362.43694412085, 5444.373897001856, 5891.734871930774, 5910.645361278337, 5992.981193197167, 6034.275886893557, 6045.395460453963, 6214.378562143795, 6231.065340199007, 6237.6257424554215, 6243.125962365272, 6244.594101383395, 6335.968320158416, 6339.397757213057, 6361.0, 6371.426571608531, 6381.936180638227, 5906.557008224358, 5955.40445955401, 6048.243969503812, 6050.909236361458, 6081.543884208702, 5463.808766693147, 6457.903131453032, 6462.159919210567, 6464.709088091047, 6476.6114033158165, 6164.383561643889, 6178.845528861724, 6183.81448556544, 6207.6275423474735, 6221.9377806221355, 6147.323794382614, 6204.0, 6213.596116252429, 6237.532185086136, 6279.466245369194, 6123.801220575414, 6134.662593557308, 6137.263528376623, 6167.599106058092, 6175.62946223219, 6117.663528505886, 6177.938220617736, 6213.409726076106, 6221.9377806222265, 6244.313125556185, 5017.799288028511, 5080.339555857715, 5130.256112863613, 5138.717370544656, 5152.922706159336, 4534.909301813946, 4538.841140560065, 4583.495815460296, 4611.354410382549, 4654.348391225231, 5972.223610930551, 6018.518518518508, 6069.2716873975405, 6081.8479538011015, 6086.786962456293, 6144.648177400964, 6213.03697926822, 6322.873542529215, 6340.112384266206, 6346.587471814318, 6046.304674962347, 6098.054801505774, 6107.4197951194565, 6108.251008765869, 6120.296165940885, 4787.898783279865, 4809.302651115569, 5017.1721665924715, 5611.2144299798065, 5612.017896868032, 4968.27959945813, 5561.0, 5701.916635839178, 6425.1968503937005, 6479.967600161969, 6210.31686514474, 6279.340669229665, 6296.0555916612875, 6318.304986451395, 6325.77859774924, 6513.478921686348, 6520.804375868732, 6535.57518761279, 6552.967235163794, 6605.768798092044, 6099.420555047263, 6154.076888466766, 6240.375962403723, 6253.218347706536, 6257.4681152102585, 6216.0, 6281.654509002049, 6337.207849018872, 6343.270523889812, 6354.015127655221, 6150.10823430609, 6162.815115546541, 6170.228721409824, 6181.752729890754, 6184.350643182401, 6108.645631960618, 6141.1924606744105, 6162.445379915829, 6167.013277875519, 6171.6297022178815, 4951.331570237971, 6080.3615620361, 6113.449789518964, 6144.709610981744, 6193.4425901669065, 6169.938300616936, 6194.783182588588, 6198.256209254918, 6198.380161983766, 6206.844828879314, 6011.879762404815, 6060.121282414113, 6183.721732522137, 6201.162843016135, 6208.658523781055], "value": 5776.524892018793, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.761033288522, 492.76347353270427, 496.5630245384061, 500.8021831376604, 504.3972452918761, 37165.814170929145, 42153.57846421535, 42178.57821421785, 42374.36438453418, 42425.151496970044, 43114.92212694684, 43394.78302608491, 43553.34669979953, 43582.7820860896, 43585.78207108968, 8462.915370846275, 9530.80938381232, 9749.122578967892, 9772.755681107958, 9788.36375635585, 9646.228301735879, 9743.220542356594, 9749.512524373788, 9774.5601447935, 9786.902130978706, 9742.561584728668, 9784.706458806248, 9791.951040244789, 9815.50922453878, 9827.722396088498, 9708.514574271294, 9756.951215243878, 9771.853422198708, 9773.609055637766, 9776.071273229032, 9665.081817227352, 9695.90304096957, 9716.61133554664, 9726.9513652432, 9732.367396119229, 40047.59952400497, 40391.39412908809, 40467.39298910519, 40473.79763101195, 40708.389374159415, 3228.257500774835, 3508.0878971467346, 3563.55455568054, 3569.928601427983, 3583.086312990197, 29695.70304296951, 31045.844770776002, 31866.362672746647, 31879.36241275185, 31879.52180717291, 3093.3658599986948, 3101.9689803101905, 3122.2194451387154, 3136.8949329768093, 3207.550942868, 160969.0, 161815.1909240458, 162247.0, 162673.0, 162984.9999999988, 33721.0, 33778.831105844314, 33826.154346141055, 33831.49252761211, 33953.15117122042, 27985.44029119447, 28255.71744282531, 28488.85755571209, 28621.284467888054, 34380.48429273563, 17066.91466542684, 17240.913795431192, 17242.224099915533, 17265.56836079083, 17270.309187632607, 12700.301483418501, 12883.806742898863, 13007.219566826021, 13010.414531346112, 13018.28399438021, 15470.607645311977, 18911.716324255147, 19018.0, 19115.61768764645, 19186.904065479583, 7574.166841647414, 7610.657520411595, 7624.560140754905, 7630.847383052308, 7656.425768067417, 719.3705507680779, 816.4529765057425, 852.8976522817178, 998.9450580218157, 1036.896310368957, 24439.26682199537, 29759.553606695918, 30042.54936175959, 30387.392252154834, 30390.240243994078, 940.9764755881021, 976.8912284557078, 1152.2913408253864, 1169.7543515861594, 1170.9707257318635, 13766.380512876945, 16089.954152980254, 16101.758473622906, 16306.103164326076, 16633.417830375878, 181692.91535423175, 183355.16644833647, 183529.0, 183659.0, 184083.0, 61840.381596184365, 62509.68745156245, 62510.68744656248, 62668.373316266254, 62927.0, 1397.9790303145462, 1405.971880562383, 1447.117258472352, 1450.6953539756769, 1454.861788130147, 30266.54600181043, 30611.928582499506, 30655.386892262475, 31146.53280200844, 31310.843445782626, 52355.73822130865, 52496.21255681091, 52523.0, 52805.5676381034, 53047.73476132595, 590702.0, 591182.0, 591774.0, 592470.0, 592610.0, 27173.59239611368, 27476.313092172855, 27553.86223068872, 27682.446351073268, 27701.168964931083, 47747.04505909932, 48421.0, 49137.262941055196, 49320.50679493159, 49607.503924960285, 33804.0, 37816.676416325296, 40174.79475615736, 40577.985550360296, 40914.590854091075, 35528.64471355357, 40314.798426007685, 40543.594564055165, 41556.0, 41687.374689379074, 38959.0, 39759.40360894531, 39799.2040159201, 40154.39768403418, 40296.194076118896, 30249.790008399417, 33697.83151084229, 35990.82004590065, 36397.0, 36468.27063458663, 26208.106195748765, 26334.473310534064, 26507.734922650525, 26716.7328326722, 26931.730682692923], "value": 18293.654932428108, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.5890201639885, 366.44849501500255, 377.7676728811781, 380.2148563216955, 383.63937898375525, 20130.0, 21243.0, 22058.007389667444, 22087.33737987859, 22315.0, 18798.718019229724, 19477.805221947776, 20541.0, 21509.247176348832, 22091.447713807163, 4760.2383618621025, 5343.866403339909, 5569.74680696844, 5952.58331916766, 6127.448529632332, 6112.6638034908065, 6154.815355539341, 6156.815295541141, 6162.7534898604, 6169.537284703642, 5632.295963004624, 5986.730597123118, 6030.819075427744, 6063.363346848583, 6140.508759299268, 5442.476106690133, 5806.245188125559, 5949.048152295655, 6009.248843894513, 6087.3303936566945, 5646.971765141189, 5869.647821130703, 5871.530277577784, 5875.236219291465, 5941.821745347604, 13276.336183190899, 13449.66375840602, 13685.657858553517, 13739.96950228737, 13743.862561374359, 2379.845310054841, 2406.4585468269674, 2470.888810003536, 2662.267876334004, 2748.395353022332, 9994.0, 10081.0, 10296.073353398155, 10316.484175791256, 10420.531076101593, 1783.0, 1858.7026075827803, 1892.5836316010455, 1900.0309841980688, 1952.19959816476, 102289.97710022879, 108890.0, 112595.0, 124750.0, 131883.6811631881, 9042.547872606343, 9586.808263834684, 11400.600978965862, 11792.115591330685, 11899.107566932515, 14496.420143194155, 14791.186484743443, 14794.260286985607, 14833.0, 14851.108933464027, 8401.495910245405, 8675.696350627697, 8722.86915696265, 8813.2949364052, 8876.0, 6969.721211151497, 8431.662733490715, 8502.0, 8660.783480412914, 8696.260817830555, 4514.277715565494, 4530.161920044802, 4590.357349971006, 4668.183067963093, 4684.992726563805, 1929.5562020735028, 1956.745623068992, 1969.556849708804, 1981.0, 1985.3448362040492, 907.6233363154349, 910.4309806371018, 980.4803454169302, 1019.6635110413546, 1062.6865074802952, 21078.262260820797, 21365.25221617236, 21372.251971180933, 21468.463288417915, 21627.35117946464, 932.8740620016347, 984.3847595252967, 988.8368419210893, 991.3308516751164, 1017.1455976979373, 10946.343219406703, 11567.88432115668, 11581.536738530533, 11591.826122608167, 11603.825942610867, 506683.0, 606125.0, 606187.0, 612880.0, 618022.0, 122335.38832305782, 124215.37892310662, 124549.37725311497, 125668.0, 129914.0, 987.3976874106789, 1002.5638847101534, 1019.9694009179736, 1021.836506159011, 1026.9024442677933, 18451.892886426856, 18858.717119243498, 19198.232070717015, 19347.129379177688, 19359.93520356394, 41365.37951930663, 52777.0, 53405.732971334895, 53936.73031634817, 54625.72687136539, 79693.20306796858, 80499.59750201445, 81685.7144282411, 82667.5866620663, 82969.0, 7254.347108760237, 8077.596120193849, 8465.746027619181, 8491.74524764258, 8627.0, 9826.65606703762, 12969.35153242353, 13561.932190338985, 13718.588442346745, 14327.0, 11615.128865334964, 11730.882691173321, 11881.405929703653, 12117.515299387926, 12150.635480935585, 9914.107730304308, 10296.970302969943, 11459.854014598473, 11755.0, 11888.762224755283, 11718.414079296172, 11901.226420282654, 12031.45858436355, 12050.578229761917, 12197.634070977885, 6318.715657795318, 7153.964230178815, 7528.849423011399, 7691.192424795539, 8563.785905352415, 9378.906210938076, 10818.134549235885, 11288.604898828502, 11941.343226122646, 11943.880561194277], "value": 9521.391828430247, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.9999999999995, 1603.1984007996004, 1848.6395152945172, 1909.5035290824383, 1916.27181670965, 8163.306118979894, 8739.956300218506, 8833.425827321227, 9326.580303886325, 9356.578953947072, 8825.955870220656, 9002.054784247657, 9004.68483603074, 9012.549372531364, 9013.0, 2357.045396614374, 2389.3190440724397, 2393.796527295182, 2397.4725560376687, 2399.3881560202126, 1806.304572739498, 2335.696359473266, 2350.1421980976993, 2359.772918082596, 2367.242482405631, 2364.4561750797325, 2366.92899213023, 2377.7503362146986, 2378.7859092681656, 2383.6305372667266, 2341.227394959668, 2341.438054866837, 2359.1153317506023, 2367.6922000140044, 2368.171140100968, 2345.953080938372, 2352.823538234622, 2354.3525530479083, 2355.057976809273, 2361.6929799126174, 9040.728778136667, 9043.728688139367, 9094.590743416562, 9101.226395756368, 9142.268618510503, 5332.413434522199, 5348.144296912515, 5366.6779993200535, 5384.515393614593, 5402.91895621566, 3419.6834218825684, 3500.8949731508096, 3572.624874388178, 3577.3918433866047, 3636.8363423646, 899.4423457456419, 1048.3290693955873, 1067.2422579968154, 1076.590895459728, 1088.0425225801323, 11613.825792613117, 11775.528978840835, 11810.173287869853, 11919.761604767857, 11928.940355298342, 4763.166445872028, 4784.732046007811, 4816.710997340171, 4914.508549145057, 4942.2092465206115, 10147.391156530484, 10152.39085654863, 10153.39079655223, 10172.440515771556, 10186.694399168036, 5431.5926305526455, 5435.945640543623, 5445.891082178414, 5448.0, 5464.1257398816, 4420.690551661417, 4803.879903002383, 4929.9014019720125, 4951.405831300267, 4958.528939750718, 3687.2625474905126, 3736.2714270717493, 4017.9196416071513, 4023.3160362738404, 4054.432379466877, 1288.806678998139, 1293.5795866343476, 1298.1886321049344, 1298.2405292903757, 1300.959232613905, 700.6881937537848, 949.3734135470556, 975.4342481360794, 975.878015248094, 992.4690290694443, 5614.129809879475, 5733.942660573424, 6137.539684523678, 6157.0, 6160.691965401712, 400.3154605624415, 421.2838175102338, 447.9820807167742, 451.3140027158766, 452.25152372822373, 3921.4117882317883, 4037.0916543777416, 4052.756834589934, 4151.066010147692, 4174.415581818548, 8583.957080214559, 9826.508674566243, 9898.208143348515, 10257.435841028815, 11100.555977760961, 10539.683809485728, 10774.461276936121, 10821.67534973952, 11082.944585277022, 11083.889161108447, 7230.891536626955, 7944.960275198587, 8265.338772898274, 8350.62422191003, 8491.0, 5021.748912554431, 6093.634381937098, 6256.530760192913, 6300.716467759054, 6341.778037768656, 10170.135538479311, 10370.014848589371, 10384.42885641297, 10388.584456621651, 10427.635032773816, 9950.850737239092, 10404.167666586807, 10423.739406514898, 10518.737031574272, 10610.045095941094, 7163.820904477429, 7619.1999840016, 7750.10873749526, 7753.806154845948, 7928.127905930459, 8689.826203476021, 8726.520041397784, 8784.692535761218, 8799.780005499913, 8805.16350946659, 7601.847963040597, 7754.651040703069, 7785.766427007199, 7825.843483130419, 7881.330086942674, 7365.0, 7431.29402706742, 7438.888416673863, 7441.479096463196, 7614.695412183451, 6879.965600171967, 6986.895196571953, 7005.439564834903, 7008.264132266243, 7021.648917554204, 5014.473480284518, 5031.295618613471, 5172.586193104617, 5179.22311653255, 5274.0, 5106.10643137442, 5112.335396398593, 5176.637635365489, 5264.921026184534, 5348.090824559912], "value": 4562.755931625054, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.32576864938204, 313.28570858442754, 320.35128864050296, 320.6745153669025, 325.9429599820034, 5239.423663397033, 5688.800891968782, 5792.522906658806, 5809.302883653962, 5820.9126863097035, 4967.473094103182, 5358.936809328407, 5675.318961724599, 5690.430956904307, 5755.568332375078, 4086.794395653282, 4123.463949686537, 4213.452251207339, 4276.776076440249, 4309.612134907858, 3859.4982652255308, 4252.893677658068, 4261.955820823902, 4264.104538047014, 4322.222000039991, 3515.34966031285, 3715.866660668495, 3983.362661974085, 4223.598758117989, 4238.385434112052, 3503.5095086687884, 4123.422720819088, 4218.978905105486, 4237.660987121023, 4269.829206831723, 3673.246984368198, 3674.1549443627846, 3688.7417880748358, 3690.19180601506, 3696.741228114033, 4320.617402431223, 5577.358603760538, 5581.074529287389, 5582.944170558324, 5620.185073164409, 4679.27471241958, 4764.8332308369045, 4918.508149185089, 4947.257911313296, 4952.845512202203, 5927.7925272615685, 5934.881302373971, 5945.483901605106, 5955.285365756094, 6020.638761674313, 4097.405876147972, 4098.405731168994, 4100.851761506753, 4108.876733697994, 4113.8971525711795, 5463.562914966793, 5874.9118763218585, 6232.320102355985, 6289.87420251597, 6304.810855674337, 3999.8800035998966, 4009.51885773709, 4024.1146947671464, 4037.959620403817, 4041.656459201001, 3716.3682174030478, 3743.550773907094, 4104.8768536943935, 4122.464079669624, 4125.319322311845, 3846.673032792244, 4363.716358436692, 4594.747288899142, 4837.992233223173, 4856.611471082305, 5240.790368385222, 5459.317585301837, 5832.1834943108, 6011.579189456784, 6013.789517366871, 1257.1891130221138, 1376.078027721429, 1400.1948879394388, 1403.4386245501678, 1406.1492796857958, 752.7929819299736, 755.0674916478146, 857.6998050682336, 863.4862256957226, 868.843608150539, 4374.300111982131, 5350.822818979818, 5387.0, 5561.972190139104, 5630.577706672016, 5634.140733557916, 5666.376698563155, 5949.881002380015, 6209.59637623553, 6244.2819075806865, 4922.956972856225, 5113.744312784346, 5574.554035677136, 5622.746976386073, 5661.3206415229615, 3189.2824114574037, 3220.6940340667597, 3226.274088330154, 3227.967720322814, 3231.6768323167494, 5458.863528411742, 5987.072003839412, 6079.513638908877, 6210.968945155245, 6404.967975160094, 5267.446918073624, 5449.986012868171, 6065.5450841187085, 6198.163247961557, 6385.233771947396, 6149.86227547905, 6424.618706978023, 6439.64581947988, 6439.751602443993, 6451.000094985285, 5795.673444050923, 6074.691617185441, 6119.204503414528, 6166.290876549075, 6172.537059720449, 5094.617903657167, 5124.744437612809, 6051.0, 6100.267967843887, 6124.908126378197, 5683.9715801420725, 6127.816165515042, 6368.617882927039, 6407.519436042408, 6436.259830119596, 3944.1322908959983, 3979.343408337708, 4004.1991601680365, 4007.3988901664984, 4037.4347591337823, 6172.660503672341, 6219.973704338733, 6221.631241126945, 6225.128482012431, 6237.725194273043, 4899.853004409873, 5633.662030257397, 5920.141579470866, 5923.555733319932, 6004.87990240184, 4588.311753236908, 5835.591508594358, 5962.853372785707, 5994.250718660168, 6004.489618382487, 4887.020756593585, 5055.545000949932, 5139.460356662496, 5848.912266315923, 5890.0, 5125.7693403796175, 5937.901488224519, 5969.313528944227, 5984.940150598438, 5985.0, 4991.301217829434, 5541.778328866801, 5874.678197405549, 5916.171735957056, 5941.435563621449], "value": 4304.933784780475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.5489196698046, 728.2280782370684, 775.0931410250007, 822.0, 838.1827717974974, 15744.606384840385, 16055.59861003474, 16061.83938160618, 16063.95584287022, 16085.919570402146, 14730.779038314407, 14807.33366998485, 14821.629459263524, 14830.555083347517, 14890.478833240839, 710.9751158709446, 895.726803324984, 897.9371443998923, 921.8018126102886, 925.3846192282124, 918.3020904112856, 918.5407296351824, 918.7565295196778, 918.9982918618704, 920.9677661281856, 980.1766516126453, 980.3382716666257, 981.7447463659464, 982.9164521015687, 983.6852207293668, 972.6060945317158, 977.6529332087077, 978.3738407419257, 979.1432496565506, 979.2851218610418, 707.7699747582056, 724.322758221065, 727.5816405566767, 728.0426239495047, 728.6174758251907, 15320.693586128327, 15407.768883466757, 15454.845451545452, 15460.768088478682, 15468.994515356466, 13471.595852124452, 13582.456701731919, 13772.724545509034, 13859.584212473643, 13937.917532244312, 13180.86819131806, 13229.801552976713, 13360.131591446525, 13491.865081349159, 13789.931050344683, 4651.348811166439, 4688.109259240733, 4803.711777293373, 4854.320395144682, 4873.147199240118, 93664.0, 111671.0, 114385.4280728591, 116996.41501792436, 118380.40809795982, 11073.944630276797, 11074.335539867634, 11144.929994910619, 11192.10463162945, 11347.943260283646, 21239.256626018323, 21368.786312136992, 21437.571248574943, 21488.24791132303, 21584.78415215859, 6884.829578971587, 7898.526088434713, 7960.562169080757, 8099.0, 8174.836503269901, 4312.676549258818, 4404.383386325917, 4416.447944006999, 4475.530069342737, 4551.749653769009, 3392.6607339265875, 3486.0413386318965, 3493.8427770750377, 3507.5264839246374, 3517.4547945068557, 640.1517988665038, 646.8479907221799, 650.222983534681, 659.0674196012588, 659.9835004124935, 493.79013919084247, 516.7209706758308, 561.9185218143347, 635.5487603801353, 642.1421943001181, 7286.744963926237, 9133.086691330815, 9479.76300592477, 9489.90510094904, 10239.436830974219, 640.9647469389229, 661.424560632253, 662.6156829039146, 686.2074304178682, 686.2142846440897, 4229.0, 4302.419173411549, 4352.173087113501, 4820.807167713252, 4932.778024988884, 153026.23486882716, 154073.0, 158057.41942580658, 159980.0, 162390.18804906137, 134147.0, 137764.93352599718, 138982.0, 139559.0, 141006.0, 76551.46897062028, 76593.0, 76609.616951916, 77799.0, 81151.0, 7797.688092476237, 8874.29005679557, 8880.911190888008, 8889.377743557889, 8898.42160259581, 49039.50960490349, 58857.11714324374, 61141.38858611357, 63498.682506587174, 63631.0, 90578.18843623223, 97082.0, 99592.0, 100432.49783751034, 102692.48653756683, 11983.580574679845, 11998.880011199777, 12182.147249692436, 12391.814122787984, 12795.232286062866, 13653.249071301174, 13723.382447790073, 13782.7722811697, 13910.37403316833, 14494.34775435129, 12875.163114397534, 13080.476780928657, 13488.988325875795, 13516.864831351953, 13590.048696591144, 13059.673508161992, 13107.213567186, 13261.07172497916, 13488.190708557519, 13500.0, 11655.242409243372, 12552.49790008426, 12628.0, 12653.620391388273, 12722.745545089232, 10249.026342497451, 10317.9484102579, 10605.416702081151, 10618.469076546296, 10806.729831753955, 9323.953380233055, 10682.83975740349, 10690.62582809598, 10706.357618542912, 10851.565937362733], "value": 7846.380951519029, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 107.0, 116.0, 118.0, 117.0, 114.0, 116.0, 116.0, 116.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 131.0, 165.0, 112.0, 129.0, 128.0, 109.0, 161.0, 122.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 184.0, 196.0, 204.0, 215.0, 256.0, 234.0, 219.0, 223.0, 195.0], "value": 212.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 80.0, 72.0, 113.0, 58.0, 59.0, 59.0, 64.0, 135.0, 58.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 104.0, 143.0, 70.0, 72.0, 86.0, 106.0, 92.0, 100.0, 151.0], "value": 100.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 73.0, 127.0, 130.0, 116.0, 87.0, 92.0, 88.0, 89.0, 88.0], "value": 101.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 147.0, 96.0, 122.0, 149.0, 114.0, 96.0, 98.0, 105.0, 96.0], "value": 115.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 90.0, 91.0, 88.0, 87.0, 92.0, 91.0, 90.0, 89.0], "value": 99.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 56.0, 54.0, 57.0, 57.0, 55.0, 55.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 76.0, 70.0, 81.0, 92.0, 74.0, 74.0, 61.0, 99.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 68.0, 94.0, 75.0, 105.0, 103.0, 105.0, 104.0, 81.0, 84.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 153.0, 157.0, 148.0, 137.0, 150.0, 137.0, 140.0, 185.0, 129.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 164.0, 168.0, 168.0, 168.0, 235.0, 168.0, 219.0, 155.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 71.0, 67.0, 70.0, 66.0, 67.0, 65.0, 64.0, 88.0], "value": 69.2, "unit": "score"}]}]} 11:25:51 INFO - Return code: 0 11:25:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:25:51 ERROR - # TBPL SUCCESS # 11:25:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:25:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:25:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:25:51 INFO - 2016-07-21 11:25:51.714 screenresolution[1945:12467] starting screenresolution argv=screenresolution get 11:25:51 INFO - 2016-07-21 11:25:51.717 screenresolution[1945:12467] Display 0: 1600x1200x32@60 11:25:51 INFO - 2016-07-21 11:25:51.723 screenresolution[1946:12470] starting screenresolution argv=screenresolution list 11:25:51 INFO - Available Modes on Display 0 11:25:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:25:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:25:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:25:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:25:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:25:51 INFO - Intel Iris: 11:25:51 INFO - Chipset Model: Intel Iris 11:25:51 INFO - Type: GPU 11:25:51 INFO - Bus: Built-In 11:25:51 INFO - VRAM (Dynamic, Max): 1536 MB 11:25:51 INFO - Vendor: Intel (0x8086) 11:25:51 INFO - Device ID: 0x0a2e 11:25:51 INFO - Revision ID: 0x0009 11:25:51 INFO - Displays: 11:25:51 INFO - Display: 11:25:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:25:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:25:51 INFO - Display Serial Number: 1600x1200 60 11:25:51 INFO - Main Display: Yes 11:25:51 INFO - Mirror: Off 11:25:51 INFO - Online: Yes 11:25:51 INFO - Rotation: Supported 11:25:51 INFO - Return code: 0 11:25:51 INFO - Running post-action listener: _resource_record_post_action 11:25:51 INFO - [mozharness: 2016-07-21 18:25:51.955835Z] Finished run-tests step (success) 11:25:51 INFO - Running post-run listener: _resource_record_post_run 11:25:52 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1155072; Write bytes: 703743488; Read time: 10; Write time: 2047 11:25:52 INFO - TinderboxPrint: CPU usage
54.3% 11:25:52 INFO - TinderboxPrint: I/O read bytes / time
1,155,072 / 10 11:25:52 INFO - TinderboxPrint: I/O write bytes / time
703,743,488 / 2,047 11:25:52 INFO - TinderboxPrint: CPU idle
2,212.5 (45.7%) 11:25:52 INFO - TinderboxPrint: CPU system
981.3 (20.3%) 11:25:52 INFO - TinderboxPrint: CPU user
1,647.8 (34.0%) 11:25:52 INFO - TinderboxPrint: Swap in / out
408,485,888 / 0 11:25:52 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 401254912; Write bytes: 394786304; Read time: 30207; Write time: 884 11:25:52 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1155072; Write bytes: 293400576; Read time: 10; Write time: 1120 11:25:52 INFO - Running post-run listener: _upload_blobber_files 11:25:52 INFO - Blob upload gear active. 11:25:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:25:52 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 11:25:52 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:25:52 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:25:52 INFO - (blobuploader) - INFO - Open directory for files ... 11:25:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:25:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:25:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:54 INFO - (blobuploader) - INFO - Done attempting. 11:25:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:25:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:25:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:55 INFO - (blobuploader) - INFO - Done attempting. 11:25:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:25:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:59 INFO - (blobuploader) - INFO - Done attempting. 11:25:59 INFO - (blobuploader) - INFO - Iteration through files over. 11:25:59 INFO - Return code: 0 11:25:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:25:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:25:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a83059de62cda3464af76149096a73ed38ae7f39c7f98eadb08d661cbded434a29b7d63da7b7632d69f026e22ea82aa5cd2caa26737fa6daa50199593c9a0f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83bd3dd3058ecbe979624c26ea4e6cdbea00ce11748fc37b8f86a7daebba6a967ae09e4faf5f55469492ef74d1f79b2d1991ecc465028e84680e9f800420a4a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c17862f50ce1c8496ac600907f4b1935b7507b6b675204becf13161f53537dbb0ed164b9f1603acb762b754ffc01967d861e1689d69f8937d72843f556af261c"} 11:25:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:25:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:25:59 INFO - Contents: 11:25:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a83059de62cda3464af76149096a73ed38ae7f39c7f98eadb08d661cbded434a29b7d63da7b7632d69f026e22ea82aa5cd2caa26737fa6daa50199593c9a0f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83bd3dd3058ecbe979624c26ea4e6cdbea00ce11748fc37b8f86a7daebba6a967ae09e4faf5f55469492ef74d1f79b2d1991ecc465028e84680e9f800420a4a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c17862f50ce1c8496ac600907f4b1935b7507b6b675204becf13161f53537dbb0ed164b9f1603acb762b754ffc01967d861e1689d69f8937d72843f556af261c"} 11:25:59 INFO - Running post-run listener: copy_logs_to_upload_dir 11:25:59 INFO - Copying logs to upload dir... 11:25:59 INFO - mkdir: /builds/slave/test/build/upload/logs 11:25:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.755053 ========= master_lag: 2.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-07-21 11:26:01.662704) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-07-21 11:26:01.668516) ========= 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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a83059de62cda3464af76149096a73ed38ae7f39c7f98eadb08d661cbded434a29b7d63da7b7632d69f026e22ea82aa5cd2caa26737fa6daa50199593c9a0f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83bd3dd3058ecbe979624c26ea4e6cdbea00ce11748fc37b8f86a7daebba6a967ae09e4faf5f55469492ef74d1f79b2d1991ecc465028e84680e9f800420a4a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c17862f50ce1c8496ac600907f4b1935b7507b6b675204becf13161f53537dbb0ed164b9f1603acb762b754ffc01967d861e1689d69f8937d72843f556af261c"} build_url:https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011029 build_url: 'https://queue.taskcluster.net/v1/task/GfVJ9Ht-T4-k6YXfMXdHBw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a83059de62cda3464af76149096a73ed38ae7f39c7f98eadb08d661cbded434a29b7d63da7b7632d69f026e22ea82aa5cd2caa26737fa6daa50199593c9a0f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83bd3dd3058ecbe979624c26ea4e6cdbea00ce11748fc37b8f86a7daebba6a967ae09e4faf5f55469492ef74d1f79b2d1991ecc465028e84680e9f800420a4a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c17862f50ce1c8496ac600907f4b1935b7507b6b675204becf13161f53537dbb0ed164b9f1603acb762b754ffc01967d861e1689d69f8937d72843f556af261c"}' ========= master_lag: 2.88 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-07-21 11:26:04.555330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-07-21 11:26:04.555690) ========= 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.yYXUvKwIdL/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.lvYkRdpyFS/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.004984 ========= master_lag: 4.72 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-07-21 11:26:09.276389) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 11:26:09.276762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 11:26:09.418817) ========= ========= Total master_lag: 10.11 =========