builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0362 starttime: 1472554249.36 results: success (0) buildid: 20160830003521 builduid: df247d14b4da4e56822cf71e79aa1cd2 revision: 2c763524c0b6e92987fb18fc6e6cdd05fa9ae6f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:49.363334) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:49.363769) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:49.364174) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:49.389902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:49.390293) ========= 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.NdMNM0rzYX/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.IViecQALW6/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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-08-30 03:50:49-- 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% 125M=0s 2016-08-30 03:50:49 (125 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.597657 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:50.015231) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:50.015801) ========= 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.NdMNM0rzYX/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.IViecQALW6/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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.025599 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:50.064787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 03:50:50.065112) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2c763524c0b6e92987fb18fc6e6cdd05fa9ae6f0 --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 2c763524c0b6e92987fb18fc6e6cdd05fa9ae6f0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NdMNM0rzYX/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.IViecQALW6/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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-08-30 03:50:50,155 truncating revision to first 12 chars 2016-08-30 03:50:50,155 Setting DEBUG logging. 2016-08-30 03:50:50,155 attempt 1/10 2016-08-30 03:50:50,155 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2c763524c0b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 03:50:51,858 unpacking tar archive at: fx-team-2c763524c0b6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.959338 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 03:50:52.046904) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:52.047218) ========= script_repo_revision: 2c763524c0b6e92987fb18fc6e6cdd05fa9ae6f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:52.048788) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:52.049070) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 03:50:52.069224) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-30 03:50:52.069619) ========= /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.NdMNM0rzYX/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.IViecQALW6/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:50:52 INFO - MultiFileLogger online at 20160830 03:50:52 in /builds/slave/test 03:50:52 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 03:50:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:50:52 INFO - {'append_to_log': False, 03:50:52 INFO - 'base_work_dir': '/builds/slave/test', 03:50:52 INFO - 'blob_upload_branch': 'Fx-Team', 03:50:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:50:52 INFO - 'branch': 'Fx-Team', 03:50:52 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:52 INFO - 'config_files': ('talos/mac_config.py',), 03:50:52 INFO - 'default_actions': ('clobber', 03:50:52 INFO - 'read-buildbot-config', 03:50:52 INFO - 'download-and-extract', 03:50:52 INFO - 'populate-webroot', 03:50:52 INFO - 'create-virtualenv', 03:50:52 INFO - 'install', 03:50:52 INFO - 'run-tests'), 03:50:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:52 INFO - 'download_minidump_stackwalk': True, 03:50:52 INFO - 'download_symbols': 'ondemand', 03:50:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:50:52 INFO - 'tooltool.py': '/tools/tooltool.py', 03:50:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:50:52 INFO - '/tools/misc-python/virtualenv.py')}, 03:50:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:52 INFO - 'installer_path': 'installer.exe', 03:50:52 INFO - 'log_level': 'info', 03:50:52 INFO - 'log_name': 'talos', 03:50:52 INFO - 'log_to_console': True, 03:50:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:50:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:50:52 INFO - 'opt_config_files': (), 03:50:52 INFO - 'pip_index': False, 03:50:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:50:52 INFO - 'cmd': ('bash', 03:50:52 INFO - '-c', 03:50:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:50:52 INFO - 'enabled': True, 03:50:52 INFO - 'halt_on_failure': False, 03:50:52 INFO - 'name': 'check_screen_resolution'},), 03:50:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:50:52 INFO - 'cmd': ('bash', 03:50:52 INFO - '-c', 03:50:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:50:52 INFO - 'enabled': True, 03:50:52 INFO - 'halt_on_failure': False, 03:50:52 INFO - 'name': 'check_screen_resolution'},), 03:50:52 INFO - 'run_cmd_checks_enabled': True, 03:50:52 INFO - 'sps_profile': False, 03:50:52 INFO - 'sps_profile_interval': 0, 03:50:52 INFO - 'suite': 'dromaeojs-e10s', 03:50:52 INFO - 'system_bits': '32', 03:50:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:52 INFO - 'title': 't-yosemite-r7-0362', 03:50:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:52 INFO - 'use_talos_json': True, 03:50:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:50:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:52 INFO - 'work_dir': 'build'} 03:50:52 INFO - [mozharness: 2016-08-30 10:50:52.269557Z] Running clobber step. 03:50:52 INFO - Running pre-action listener: _resource_record_pre_action 03:50:52 INFO - Running main action method: clobber 03:50:52 INFO - rmtree: /builds/slave/test/build 03:50:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:50:54 INFO - Running post-action listener: _resource_record_post_action 03:50:54 INFO - [mozharness: 2016-08-30 10:50:54.353485Z] Finished clobber step (success) 03:50:54 INFO - [mozharness: 2016-08-30 10:50:54.353811Z] Running read-buildbot-config step. 03:50:54 INFO - Running pre-action listener: _resource_record_pre_action 03:50:54 INFO - Running main action method: read_buildbot_config 03:50:54 INFO - Using buildbot properties: 03:50:54 INFO - { 03:50:54 INFO - "project": "", 03:50:54 INFO - "product": "firefox", 03:50:54 INFO - "script_repo_revision": "production", 03:50:54 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:50:54 INFO - "repository": "", 03:50:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:50:54 INFO - "buildid": "20160830003521", 03:50:54 INFO - "pgo_build": "False", 03:50:54 INFO - "basedir": "/builds/slave/test", 03:50:54 INFO - "buildnumber": 81, 03:50:54 INFO - "slavename": "t-yosemite-r7-0362", 03:50:54 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:50:54 INFO - "platform": "yosemite_r7", 03:50:54 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 03:50:54 INFO - "branch": "fx-team", 03:50:54 INFO - "repo_path": "integration/fx-team", 03:50:54 INFO - "revision": "2c763524c0b6e92987fb18fc6e6cdd05fa9ae6f0", 03:50:54 INFO - "stage_platform": "macosx64", 03:50:54 INFO - "builduid": "df247d14b4da4e56822cf71e79aa1cd2", 03:50:54 INFO - "slavebuilddir": "test" 03:50:54 INFO - } 03:50:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 03:50:54 INFO - Running post-action listener: _resource_record_post_action 03:50:54 INFO - [mozharness: 2016-08-30 10:50:54.359748Z] Finished read-buildbot-config step (success) 03:50:54 INFO - [mozharness: 2016-08-30 10:50:54.359975Z] Running download-and-extract step. 03:50:54 INFO - Running pre-action listener: _resource_record_pre_action 03:50:54 INFO - Running main action method: download_and_extract 03:50:54 INFO - mkdir: /builds/slave/test/build/tests 03:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:54 INFO - trying https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 03:50:54 INFO - Downloading https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 03:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 03:50:55 INFO - Downloaded 1199 bytes. 03:50:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 03:50:55 INFO - Using the following test package requirements: 03:50:55 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 03:50:55 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:50:55 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 03:50:55 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:50:55 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 03:50:55 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:50:55 INFO - u'jsshell-mac.zip'], 03:50:55 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:50:55 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 03:50:55 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 03:50:55 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:50:55 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 03:50:55 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:50:55 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 03:50:55 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:50:55 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 03:50:55 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:50:55 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 03:50:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:55 INFO - trying https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:50:55 INFO - Downloading https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:50:56 INFO - Downloaded 16380536 bytes. 03:50:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 03:51:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:03 INFO - trying https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:51:03 INFO - Downloading https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:51:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:51:04 INFO - Downloaded 16380536 bytes. 03:51:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 03:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:10 INFO - trying https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 03:51:10 INFO - Downloading https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 03:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:51:11 INFO - Downloaded 14413998 bytes. 03:51:11 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 03:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:12 INFO - trying https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:51:12 INFO - Downloading https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 03:51:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 03:51:15 INFO - Downloaded 111554458 bytes. 03:51:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:51:15 INFO - mkdir: /builds/slave/test/properties 03:51:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:51:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:51:15 INFO - Contents: 03:51:15 INFO - build_url:https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:51:15 INFO - Running post-action listener: _resource_record_post_action 03:51:15 INFO - Running post-action listener: set_extra_try_arguments 03:51:15 INFO - [mozharness: 2016-08-30 10:51:15.778986Z] Finished download-and-extract step (success) 03:51:15 INFO - [mozharness: 2016-08-30 10:51:15.779099Z] Running populate-webroot step. 03:51:15 INFO - Running pre-action listener: _resource_record_pre_action 03:51:15 INFO - Running main action method: populate_webroot 03:51:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:51:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:51:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:51:15 INFO - '--tppagecycles', 03:51:15 INFO - '7'], 03:51:15 INFO - 'tests': ['tsvgm']}}, 03:51:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:51:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:51:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:51:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:51:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:51:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:51:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:15 INFO - 'talos_options': ['--disable-e10s'], 03:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:15 INFO - 'talos_options': ['--disable-e10s'], 03:51:15 INFO - 'tests': ['damp', 'tps']}, 03:51:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:15 INFO - 'tests': ['damp', 'tps']}, 03:51:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:51:15 INFO - 'tests': ['dromaeo_dom']}, 03:51:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:51:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:51:15 INFO - 'tests': ['basic_compositor_video']}, 03:51:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:51:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:51:15 INFO - 'tests': ['a11yr', 03:51:15 INFO - 'ts_paint', 03:51:15 INFO - 'tpaint', 03:51:15 INFO - 'sessionrestore', 03:51:15 INFO - 'sessionrestore_no_auto_restore', 03:51:15 INFO - 'tabpaint']}, 03:51:15 INFO - 'other-e10s': {'tests': ['a11yr', 03:51:15 INFO - 'ts_paint', 03:51:15 INFO - 'tpaint', 03:51:15 INFO - 'sessionrestore', 03:51:15 INFO - 'sessionrestore_no_auto_restore', 03:51:15 INFO - 'tabpaint']}, 03:51:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:51:15 INFO - 'ts_paint', 03:51:15 INFO - 'tpaint', 03:51:15 INFO - 'sessionrestore', 03:51:15 INFO - 'sessionrestore_no_auto_restore', 03:51:15 INFO - 'tabpaint']}, 03:51:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:51:15 INFO - 'ts_paint', 03:51:15 INFO - 'tpaint', 03:51:15 INFO - 'sessionrestore', 03:51:15 INFO - 'sessionrestore_no_auto_restore', 03:51:15 INFO - 'tabpaint']}, 03:51:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:51:15 INFO - 'tests': ['a11yr', 03:51:15 INFO - 'ts_paint', 03:51:15 INFO - 'tpaint', 03:51:15 INFO - 'sessionrestore', 03:51:15 INFO - 'sessionrestore_no_auto_restore', 03:51:15 INFO - 'tabpaint']}, 03:51:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:51:15 INFO - 'tests': ['a11yr', 03:51:15 INFO - 'ts_paint', 03:51:15 INFO - 'tpaint', 03:51:15 INFO - 'sessionrestore', 03:51:15 INFO - 'sessionrestore_no_auto_restore', 03:51:15 INFO - 'tabpaint']}, 03:51:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:51:15 INFO - 'tests': ['tsvgx', 03:51:15 INFO - 'tsvgr_opacity', 03:51:15 INFO - 'tart', 03:51:15 INFO - 'tscrollx', 03:51:15 INFO - 'cart']}, 03:51:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:51:15 INFO - 'tsvgr_opacity', 03:51:15 INFO - 'tart', 03:51:15 INFO - 'tscrollx', 03:51:15 INFO - 'cart']}, 03:51:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:15 INFO - 'talos_options': ['--disable-e10s'], 03:51:15 INFO - 'tests': ['tp5o']}, 03:51:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:15 INFO - 'tests': ['tp5o']}, 03:51:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:15 INFO - 'talos_options': ['--disable-e10s', 03:51:15 INFO - '--xperf_path', 03:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:15 INFO - 'tests': ['tp5n']}, 03:51:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:15 INFO - 'talos_options': ['--xperf_path', 03:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:15 INFO - 'tests': ['tp5n']}}, 03:51:15 INFO - 'talos.zip': {'path': '', 03:51:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:51:15 INFO - Running post-action listener: _resource_record_post_action 03:51:15 INFO - [mozharness: 2016-08-30 10:51:15.798183Z] Finished populate-webroot step (success) 03:51:15 INFO - [mozharness: 2016-08-30 10:51:15.798294Z] Running create-virtualenv step. 03:51:15 INFO - Running pre-action listener: _resource_record_pre_action 03:51:15 INFO - Running main action method: create_virtualenv 03:51:15 INFO - Creating virtualenv /builds/slave/test/build/venv 03:51:15 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 03:51:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:51:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:51:15 INFO - Using real prefix '/tools/python27' 03:51:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:51:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:51:19 INFO - Installing pip.................done. 03:51:19 INFO - Return code: 0 03:51:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:19 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 0x1086caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a14a1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10862ed30>, '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 0x108393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626b20>, '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.NdMNM0rzYX/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.IViecQALW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:51:19 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 03:51:19 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 03:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NdMNM0rzYX/Render', 03:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:19 INFO - 'HOME': '/Users/cltbld', 03:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:19 INFO - 'LOGNAME': 'cltbld', 03:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:19 INFO - 'MOZ_NO_REMOTE': '1', 03:51:19 INFO - 'NO_EM_RESTART': '1', 03:51:19 INFO - 'PAGER': '/bin/cat', 03:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:19 INFO - 'PWD': '/builds/slave/test', 03:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:19 INFO - 'SHELL': '/bin/bash', 03:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IViecQALW6/Listeners', 03:51:19 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:19 INFO - 'USER': 'cltbld', 03:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:19 INFO - 'XPC_FLAGS': '0x0', 03:51:19 INFO - 'XPC_SERVICE_NAME': '0', 03:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:19 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 03:51:19 INFO - Cleaning up... 03:51:19 INFO - Return code: 0 03:51:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:19 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 0x1086caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a14a1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10862ed30>, '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 0x108393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626b20>, '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.NdMNM0rzYX/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.IViecQALW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:51:19 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 03:51:19 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 03:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NdMNM0rzYX/Render', 03:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:19 INFO - 'HOME': '/Users/cltbld', 03:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:19 INFO - 'LOGNAME': 'cltbld', 03:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:19 INFO - 'MOZ_NO_REMOTE': '1', 03:51:19 INFO - 'NO_EM_RESTART': '1', 03:51:19 INFO - 'PAGER': '/bin/cat', 03:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:19 INFO - 'PWD': '/builds/slave/test', 03:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:19 INFO - 'SHELL': '/bin/bash', 03:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IViecQALW6/Listeners', 03:51:19 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:19 INFO - 'USER': 'cltbld', 03:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:19 INFO - 'XPC_FLAGS': '0x0', 03:51:19 INFO - 'XPC_SERVICE_NAME': '0', 03:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:20 INFO - Downloading/unpacking psutil>=3.1.1 03:51:20 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 03:51:20 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 03:51:20 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 03:51:20 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 03:51:20 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 03:51:20 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 03:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:51:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:23 INFO - Installing collected packages: psutil 03:51:23 INFO - Running setup.py install for psutil 03:51:23 INFO - building 'psutil._psutil_osx' extension 03:51:23 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 03:51:24 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 03:51:24 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 03:51:24 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 03:51:24 INFO - building 'psutil._psutil_posix' extension 03:51:24 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 03:51:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:51:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:51:24 INFO - ^ 03:51:24 INFO - 1 warning generated. 03:51:24 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 03:51:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:25 INFO - Successfully installed psutil 03:51:25 INFO - Cleaning up... 03:51:25 INFO - Return code: 0 03:51:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:25 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 0x1086caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a14a1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10862ed30>, '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 0x108393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626b20>, '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.NdMNM0rzYX/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.IViecQALW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:51:25 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 03:51:25 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 03:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NdMNM0rzYX/Render', 03:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:25 INFO - 'HOME': '/Users/cltbld', 03:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:25 INFO - 'LOGNAME': 'cltbld', 03:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:25 INFO - 'MOZ_NO_REMOTE': '1', 03:51:25 INFO - 'NO_EM_RESTART': '1', 03:51:25 INFO - 'PAGER': '/bin/cat', 03:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:25 INFO - 'PWD': '/builds/slave/test', 03:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:25 INFO - 'SHELL': '/bin/bash', 03:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IViecQALW6/Listeners', 03:51:25 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:25 INFO - 'USER': 'cltbld', 03:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:25 INFO - 'XPC_FLAGS': '0x0', 03:51:25 INFO - 'XPC_SERVICE_NAME': '0', 03:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:51:27 INFO - Installing collected packages: mozsystemmonitor 03:51:27 INFO - Running setup.py install for mozsystemmonitor 03:51:28 INFO - Successfully installed mozsystemmonitor 03:51:28 INFO - Cleaning up... 03:51:28 INFO - Return code: 0 03:51:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1086caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a14a1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10862ed30>, '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 0x108393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626b20>, '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.NdMNM0rzYX/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.IViecQALW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NdMNM0rzYX/Render', 03:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:28 INFO - 'HOME': '/Users/cltbld', 03:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:28 INFO - 'LOGNAME': 'cltbld', 03:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:28 INFO - 'MOZ_NO_REMOTE': '1', 03:51:28 INFO - 'NO_EM_RESTART': '1', 03:51:28 INFO - 'PAGER': '/bin/cat', 03:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:28 INFO - 'PWD': '/builds/slave/test', 03:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:28 INFO - 'SHELL': '/bin/bash', 03:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IViecQALW6/Listeners', 03:51:28 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:28 INFO - 'USER': 'cltbld', 03:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:28 INFO - 'XPC_FLAGS': '0x0', 03:51:28 INFO - 'XPC_SERVICE_NAME': '0', 03:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:51:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:51:30 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 03:51:30 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 03:51:30 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 03:51:30 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 03:51:30 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 03:51:30 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 03:51:31 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:31 INFO - warning: no files found matching '*.txt' 03:51:31 INFO - no previously-included directories found matching 'build' 03:51:31 INFO - no previously-included directories found matching 'dist' 03:51:31 INFO - no previously-included directories found matching '.git*' 03:51:31 INFO - Installing collected packages: jsonschema, functools32 03:51:31 INFO - Running setup.py install for functools32 03:51:31 INFO - warning: no files found matching '*.txt' 03:51:31 INFO - no previously-included directories found matching 'build' 03:51:31 INFO - no previously-included directories found matching 'dist' 03:51:31 INFO - no previously-included directories found matching '.git*' 03:51:31 INFO - Successfully installed jsonschema functools32 03:51:31 INFO - Cleaning up... 03:51:31 INFO - Return code: 0 03:51:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a14a1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10862ed30>, '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 0x108393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626b20>, '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.NdMNM0rzYX/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.IViecQALW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:51:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:51:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NdMNM0rzYX/Render', 03:51:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:31 INFO - 'HOME': '/Users/cltbld', 03:51:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:31 INFO - 'LOGNAME': 'cltbld', 03:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:31 INFO - 'MOZ_NO_REMOTE': '1', 03:51:31 INFO - 'NO_EM_RESTART': '1', 03:51:31 INFO - 'PAGER': '/bin/cat', 03:51:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:31 INFO - 'PWD': '/builds/slave/test', 03:51:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:31 INFO - 'SHELL': '/bin/bash', 03:51:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IViecQALW6/Listeners', 03:51:31 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:51:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:31 INFO - 'USER': 'cltbld', 03:51:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:31 INFO - 'XPC_FLAGS': '0x0', 03:51:31 INFO - 'XPC_SERVICE_NAME': '0', 03:51:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:51:31 INFO - Cleaning up... 03:51:32 INFO - Return code: 0 03:51:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:32 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 0x1086caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a14a1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10862ed30>, '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 0x108393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626b20>, '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.NdMNM0rzYX/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.IViecQALW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:51:32 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 03:51:32 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 03:51:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NdMNM0rzYX/Render', 03:51:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:32 INFO - 'HOME': '/Users/cltbld', 03:51:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:32 INFO - 'LOGNAME': 'cltbld', 03:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:32 INFO - 'MOZ_NO_REMOTE': '1', 03:51:32 INFO - 'NO_EM_RESTART': '1', 03:51:32 INFO - 'PAGER': '/bin/cat', 03:51:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:32 INFO - 'PWD': '/builds/slave/test', 03:51:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:32 INFO - 'SHELL': '/bin/bash', 03:51:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IViecQALW6/Listeners', 03:51:32 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:51:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:32 INFO - 'USER': 'cltbld', 03:51:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:32 INFO - 'XPC_FLAGS': '0x0', 03:51:32 INFO - 'XPC_SERVICE_NAME': '0', 03:51:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:32 INFO - Downloading/unpacking blobuploader==1.2.4 03:51:32 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 03:51:32 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 03:51:32 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 03:51:32 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 03:51:32 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 03:51:32 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 03:51:34 INFO - Downloading blobuploader-1.2.4.tar.gz 03:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:51:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:51:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:51:35 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 03:51:35 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 03:51:35 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 03:51:35 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 03:51:35 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 03:51:35 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 03:51:35 INFO - Downloading docopt-0.6.1.tar.gz 03:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:51:35 INFO - Installing collected packages: blobuploader, requests, docopt 03:51:35 INFO - Running setup.py install for blobuploader 03:51:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:51:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:51:36 INFO - Running setup.py install for requests 03:51:36 INFO - Running setup.py install for docopt 03:51:36 INFO - Successfully installed blobuploader requests docopt 03:51:36 INFO - Cleaning up... 03:51:36 INFO - Return code: 0 03:51:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:36 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 0x1086caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a14a1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10862ed30>, '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 0x108393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626b20>, '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.NdMNM0rzYX/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.IViecQALW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:51:36 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 03:51:36 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 03:51:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NdMNM0rzYX/Render', 03:51:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:36 INFO - 'HOME': '/Users/cltbld', 03:51:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:36 INFO - 'LOGNAME': 'cltbld', 03:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:36 INFO - 'MOZ_NO_REMOTE': '1', 03:51:36 INFO - 'NO_EM_RESTART': '1', 03:51:36 INFO - 'PAGER': '/bin/cat', 03:51:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:36 INFO - 'PWD': '/builds/slave/test', 03:51:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:36 INFO - 'SHELL': '/bin/bash', 03:51:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IViecQALW6/Listeners', 03:51:36 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:51:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:36 INFO - 'USER': 'cltbld', 03:51:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:36 INFO - 'XPC_FLAGS': '0x0', 03:51:36 INFO - 'XPC_SERVICE_NAME': '0', 03:51:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:37 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-QZkJkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:37 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-zzBbPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:37 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-Xlk0sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:37 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-6VRFJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:37 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-4p0r7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:37 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-TP0jia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:37 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-fDtA2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:37 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-MbGDVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:37 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-Ir2ZVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:38 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-DoLc17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:38 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-qijB7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:38 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-3FJu5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:38 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-UJGJgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:38 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-i6TTUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:38 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-PoT3lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:38 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-RVHSK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:38 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-dG8RcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:51:38 INFO - Running setup.py install for manifestparser 03:51:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:51:39 INFO - Running setup.py install for mozcrash 03:51:39 INFO - Running setup.py install for mozdebug 03:51:39 INFO - Running setup.py install for mozdevice 03:51:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:51:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:51:39 INFO - Running setup.py install for mozfile 03:51:39 INFO - Running setup.py install for mozhttpd 03:51:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:51:39 INFO - Running setup.py install for mozinfo 03:51:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:51:39 INFO - Running setup.py install for mozInstall 03:51:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:51:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:51:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:51:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:51:40 INFO - Running setup.py install for mozleak 03:51:40 INFO - Running setup.py install for mozlog 03:51:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:51:40 INFO - Running setup.py install for moznetwork 03:51:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:51:40 INFO - Running setup.py install for mozprocess 03:51:40 INFO - Running setup.py install for mozprofile 03:51:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:51:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:51:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:51:40 INFO - Running setup.py install for mozrunner 03:51:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:51:41 INFO - Running setup.py install for mozscreenshot 03:51:41 INFO - Running setup.py install for moztest 03:51:41 INFO - Running setup.py install for mozversion 03:51:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:51:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:51:41 INFO - Cleaning up... 03:51:41 INFO - Return code: 0 03:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:41 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 0x1086caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a14a1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10862ed30>, '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 0x108393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626b20>, '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.NdMNM0rzYX/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.IViecQALW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:51:41 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 03:51:41 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 03:51:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NdMNM0rzYX/Render', 03:51:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:41 INFO - 'HOME': '/Users/cltbld', 03:51:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:41 INFO - 'LOGNAME': 'cltbld', 03:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:41 INFO - 'MOZ_NO_REMOTE': '1', 03:51:41 INFO - 'NO_EM_RESTART': '1', 03:51:41 INFO - 'PAGER': '/bin/cat', 03:51:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:41 INFO - 'PWD': '/builds/slave/test', 03:51:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:41 INFO - 'SHELL': '/bin/bash', 03:51:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IViecQALW6/Listeners', 03:51:41 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:51:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:41 INFO - 'USER': 'cltbld', 03:51:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:41 INFO - 'XPC_FLAGS': '0x0', 03:51:41 INFO - 'XPC_SERVICE_NAME': '0', 03:51:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:41 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-BVYd7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:41 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)) 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:41 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-yrD6HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:41 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)) 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:41 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-QLB2b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:42 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)) 03:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:42 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-MkoRZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:42 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)) 03:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:42 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-YSB9Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:42 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)) 03:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:42 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-9cxi_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:42 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)) 03:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:42 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-MROR_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:42 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)) 03:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:42 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-akeBtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:42 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)) 03:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:42 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-YkTlG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:42 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)) 03:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:42 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-UCREp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:42 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)) 03:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:42 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-Az6AKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:42 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)) 03:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:42 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-GbZpXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:43 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)) 03:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:43 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-dLBOLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:43 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)) 03:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:43 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-K2sWhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:43 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)) 03:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:43 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-qeCfDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:43 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)) 03:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:43 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-Bq9nJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:43 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)) 03:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:43 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-tGLxcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:43 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)) 03:51:43 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)) 03:51:43 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)) 03:51:43 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)) 03:51:43 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)) 03:51:43 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)) 03:51:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:45 INFO - Downloading blessings-1.6.tar.gz 03:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:51:46 INFO - Installing collected packages: blessings 03:51:46 INFO - Running setup.py install for blessings 03:51:46 INFO - Successfully installed blessings 03:51:46 INFO - Cleaning up... 03:51:46 INFO - Return code: 0 03:51:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:46 INFO - Reading from file tmpfile_stdout 03:51:46 INFO - Current package versions: 03:51:46 INFO - blessings == 1.6 03:51:46 INFO - blobuploader == 1.2.4 03:51:46 INFO - docopt == 0.6.1 03:51:46 INFO - functools32 == 3.2.3-2 03:51:46 INFO - jsonschema == 2.5.1 03:51:46 INFO - manifestparser == 1.1 03:51:46 INFO - mozInstall == 1.12 03:51:46 INFO - mozcrash == 0.17 03:51:46 INFO - mozdebug == 0.1 03:51:46 INFO - mozdevice == 0.48 03:51:46 INFO - mozfile == 1.2 03:51:46 INFO - mozhttpd == 0.7 03:51:46 INFO - mozinfo == 0.9 03:51:46 INFO - mozleak == 0.1 03:51:46 INFO - mozlog == 3.3 03:51:46 INFO - moznetwork == 0.27 03:51:46 INFO - mozprocess == 0.23 03:51:46 INFO - mozprofile == 0.28 03:51:46 INFO - mozrunner == 6.12 03:51:46 INFO - mozscreenshot == 0.1 03:51:46 INFO - mozsystemmonitor == 0.3 03:51:46 INFO - moztest == 0.7 03:51:46 INFO - mozversion == 1.4 03:51:46 INFO - psutil == 3.1.1 03:51:46 INFO - requests == 1.2.3 03:51:46 INFO - wsgiref == 0.1.2 03:51:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:46 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 0x1086caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a14a1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10862ed30>, '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 0x108393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626b20>, '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.NdMNM0rzYX/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.IViecQALW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:51:46 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 03:51:46 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 03:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NdMNM0rzYX/Render', 03:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:46 INFO - 'HOME': '/Users/cltbld', 03:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:46 INFO - 'LOGNAME': 'cltbld', 03:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:46 INFO - 'MOZ_NO_REMOTE': '1', 03:51:46 INFO - 'NO_EM_RESTART': '1', 03:51:46 INFO - 'PAGER': '/bin/cat', 03:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:46 INFO - 'PWD': '/builds/slave/test', 03:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:46 INFO - 'SHELL': '/bin/bash', 03:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IViecQALW6/Listeners', 03:51:46 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:46 INFO - 'USER': 'cltbld', 03:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:46 INFO - 'XPC_FLAGS': '0x0', 03:51:46 INFO - 'XPC_SERVICE_NAME': '0', 03:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:46 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)) 03:51:46 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)) 03:51:46 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)) 03:51:46 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)) 03:51:46 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)) 03:51:46 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)) 03:51:46 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)) 03:51:46 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)) 03:51:46 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)) 03:51:46 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)) 03:51:46 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)) 03:51:46 INFO - Cleaning up... 03:51:46 INFO - Return code: 0 03:51:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a14a1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10862ed30>, '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 0x108393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626b20>, '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.NdMNM0rzYX/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.IViecQALW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NdMNM0rzYX/Render', 03:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:46 INFO - 'HOME': '/Users/cltbld', 03:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:46 INFO - 'LOGNAME': 'cltbld', 03:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:46 INFO - 'MOZ_NO_REMOTE': '1', 03:51:46 INFO - 'NO_EM_RESTART': '1', 03:51:46 INFO - 'PAGER': '/bin/cat', 03:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:46 INFO - 'PWD': '/builds/slave/test', 03:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:46 INFO - 'SHELL': '/bin/bash', 03:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IViecQALW6/Listeners', 03:51:46 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:46 INFO - 'USER': 'cltbld', 03:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:46 INFO - 'XPC_FLAGS': '0x0', 03:51:46 INFO - 'XPC_SERVICE_NAME': '0', 03:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:51:47 INFO - Cleaning up... 03:51:47 INFO - Return code: 0 03:51:47 INFO - Running post-action listener: _resource_record_post_action 03:51:47 INFO - Running post-action listener: _start_resource_monitoring 03:51:47 INFO - Starting resource monitoring. 03:51:47 INFO - [mozharness: 2016-08-30 10:51:47.246398Z] Finished create-virtualenv step (success) 03:51:47 INFO - [mozharness: 2016-08-30 10:51:47.247451Z] Running install step. 03:51:47 INFO - Running pre-action listener: _resource_record_pre_action 03:51:47 INFO - Running main action method: install 03:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:47 INFO - Reading from file tmpfile_stdout 03:51:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:51:47 INFO - Reading from file tmpfile_stdout 03:51:47 INFO - Output received: 03:51:47 INFO - Usage: mozinstall [options] installer 03:51:47 INFO - Options: 03:51:47 INFO - -h, --help show this help message and exit 03:51:47 INFO - -d DEST, --destination=DEST 03:51:47 INFO - Directory to install application into. [default: 03:51:47 INFO - "/builds/slave/test"] 03:51:47 INFO - --app=APP Application being installed. [default: firefox] 03:51:47 INFO - mkdir: /builds/slave/test/build/application 03:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:52:22 INFO - Reading from file tmpfile_stdout 03:52:22 INFO - Output received: 03:52:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:52:22 INFO - Running post-action listener: _resource_record_post_action 03:52:22 INFO - [mozharness: 2016-08-30 10:52:22.131374Z] Finished install step (success) 03:52:22 INFO - [mozharness: 2016-08-30 10:52:22.131510Z] Running run-tests step. 03:52:22 INFO - Running pre-action listener: _resource_record_pre_action 03:52:22 INFO - Running main action method: run_tests 03:52:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:52:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:52:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:52:22 INFO - 2016-08-30 03:52:22.145 screenresolution[1656:8148] starting screenresolution argv=screenresolution get 03:52:22 INFO - 2016-08-30 03:52:22.148 screenresolution[1656:8148] Display 0: 1600x1200x32@60 03:52:22 INFO - 2016-08-30 03:52:22.154 screenresolution[1657:8150] starting screenresolution argv=screenresolution list 03:52:22 INFO - Available Modes on Display 0 03:52:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:52:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:52:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:52:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:52:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:52:22 INFO - Intel Iris: 03:52:22 INFO - Chipset Model: Intel Iris 03:52:22 INFO - Type: GPU 03:52:22 INFO - Bus: Built-In 03:52:22 INFO - VRAM (Dynamic, Max): 1536 MB 03:52:22 INFO - Vendor: Intel (0x8086) 03:52:22 INFO - Device ID: 0x0a2e 03:52:22 INFO - Revision ID: 0x0009 03:52:22 INFO - Displays: 03:52:22 INFO - Display: 03:52:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:52:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:52:22 INFO - Display Serial Number: 1600x1200 60 03:52:22 INFO - Main Display: Yes 03:52:22 INFO - Mirror: Off 03:52:22 INFO - Online: Yes 03:52:22 INFO - Rotation: Supported 03:52:22 INFO - Return code: 0 03:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:52:22 INFO - Python 2.7.3 03:52:22 INFO - Return code: 0 03:52:22 INFO - grabbing minidump binary from tooltool 03:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:22 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 0x10862ed30>, '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 0x108393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:52:22 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 03:52:22 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 03:52:22 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 03:52:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:52:22 INFO - Return code: 0 03:52:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:52:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:52:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:52:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:52:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:52:22 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/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0362', '--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 03:52:22 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/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0362 --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 03:52:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NdMNM0rzYX/Render', 03:52:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:22 INFO - 'HOME': '/Users/cltbld', 03:52:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:22 INFO - 'LOGNAME': 'cltbld', 03:52:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:52:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:22 INFO - 'MOZ_NO_REMOTE': '1', 03:52:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:52:22 INFO - 'NO_EM_RESTART': '1', 03:52:22 INFO - 'PAGER': '/bin/cat', 03:52:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:22 INFO - 'PWD': '/builds/slave/test', 03:52:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:52:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:22 INFO - 'SHELL': '/bin/bash', 03:52:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IViecQALW6/Listeners', 03:52:22 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:52:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:22 INFO - 'USER': 'cltbld', 03:52:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:22 INFO - 'XPC_FLAGS': '0x0', 03:52:22 INFO - 'XPC_SERVICE_NAME': '0', 03:52:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:22 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/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0362', '--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 03:52:22 INFO - mozversion application_buildid: 20160830003521 03:52:22 INFO - mozversion application_changeset: 2c763524c0b6e92987fb18fc6e6cdd05fa9ae6f0 03:52:22 INFO - mozversion application_display_name: Nightly 03:52:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:52:22 INFO - mozversion application_name: Firefox 03:52:22 INFO - mozversion application_remotingname: firefox 03:52:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:52:22 INFO - mozversion application_vendor: Mozilla 03:52:22 INFO - mozversion application_version: 51.0a1 03:52:22 INFO - mozversion platform_buildid: 20160830003521 03:52:22 INFO - mozversion platform_changeset: 2c763524c0b6e92987fb18fc6e6cdd05fa9ae6f0 03:52:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:52:22 INFO - mozversion platform_version: 51.0a1 03:52:22 INFO - using testdate: 1472554342 03:52:22 INFO - actual date: 1472554342 03:52:22 INFO - starting webserver on 'localhost:49267' 03:52:22 INFO - SUITE-START | Running 2 tests 03:52:22 INFO - TEST-START | dromaeo_css 03:52:22 INFO - operating with platform_type : mac_ 03:52:22 INFO - Initialising browser for dromaeo_css test... 03:52:22 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmpeFBcob/profile http://localhost:49267/getInfo.html) 03:52:25 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 03:52:25 INFO - PROCESS | 1667 | colorDepth:24 03:52:25 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 03:52:25 INFO - PROCESS | 1667 | __metrics 03:52:25 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 03:52:26 INFO - TEST-INFO | 1667: exit 0 03:52:26 INFO - Browser initialized. 03:52:26 INFO - Running cycle 1/1 for dromaeo_css test... 03:52:26 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmpeFBcob/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:38 INFO - PROCESS | 1670 | RSS: Main: 244011008 03:52:38 INFO - PROCESS | 1670 | 03:53:27 INFO - PROCESS | 1670 | 1472554407702 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] 03:55:39 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 03:55:40 INFO - PROCESS | 1670 | RSS: Main: 268435456 03:55:40 INFO - PROCESS | 1670 | 03:58:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 03:58:43 INFO - PROCESS | 1670 | RSS: Main: 274321408 03:58:43 INFO - PROCESS | 1670 | 04:01:45 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 04:01:46 INFO - PROCESS | 1670 | RSS: Main: 274620416 04:01:46 INFO - PROCESS | 1670 | 04:04:48 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 04:04:48 INFO - PROCESS | 1670 | RSS: Main: 269762560 04:04:48 INFO - PROCESS | 1670 | 04:07:51 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 04:07:52 INFO - PROCESS | 1670 | RSS: Main: 276140032 04:07:52 INFO - PROCESS | 1670 | 04:10:55 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 04:10:55 INFO - PROCESS | 1670 | RSS: Main: 279920640 04:10:55 INFO - PROCESS | 1670 | 04:10:55 INFO - PROCESS | 1670 | __start_tp_report 04:10:55 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 04:10:55 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 04:10:55 INFO - PROCESS | 1670 | |i|pagename|runs| 04:10:55 INFO - PROCESS | 1670 | |0;dojo.html;3087.7375423089024;3223.9355212895744;3297.835108244589;3331.2005118771503;3396.405629014922;4550.408446901906;5585.52523035542;5632.633878797876;5650.180723795047;5862.589618726696;5440.972795136028;5595.776168953237;5612.438756124386;5684.289463817023;5730.512906402951;5069.163588007974;5132.769025393866;5233.65981211222;5240.266362709223;5246.186841039645;5044.924326135111;5319.973400132994;5331.6534425262425;5335.919961200585;5353.00969320675;5072.746362681888;5098.388193416777;5193.688378697271;5204.089284375219;5238.371395432553;5119.104156772587;5122.795088196468;5133.717645529495;5155.561777248939;5214.165733482625;5139.203423469368;5141.331626888481;5157.6647517911215;5179.14544100223;5193.221016847503;5562.7774889004395;5615.634983726045;5685.374608793029;5695.5443564514735;5721.456461636138;5068.214426763858;5533.280673512418;6012.098185272201;6088;6160.44555989963;6185.969070154621;6213.627182369027;6235.407636274546;6240.157578726859;6245.188125543696;5604.887902241932;5643.125315576092;5681.034224181816;5693.459121383462;5739.626924249952;6229.065640154013;6233.3143354231;6262.906056409158;6280.466160376328;6307.905381419282;6003.0695242237525;6020.608660437058;6021.488173505301;6023.066424704178;6056.576039677268;6069.484093852072;6115.778948468095;6139.263288405331;6153.800008998202;6175.59858609189;5971.611845230046;6102.755889764359;6123.374132580074;6134.130457564626;6142.867137759686;6079.8480037998515;6122.510199184055;6153.569250152446;6194.566380353332;6200.658963756947;4828.61371090319;4890.266460031024;4918.458969513351;4926.014797040534;4934.580560652313;4404.779761011937;4407.867763967086;4409.162259170747;4505.909881802411;4516.3902873112365;4668.4631267404;5663.461971112738;5668.971655141698;5684.715764211773;5757.280339957505;6078.1186727924205;6129.049997250433;6227.844303892349;6234.0337247726675;6247.562670613104;5580.441955804387;5597.720113994284;5608.69152196625;5664.8867022659315;5675.31896172462;5329.333833270841;5329.507737833413;5333.919991200135;5335.67985920846;5343.65266257692;6158.507319414526;6174.876502469836;6221.440070393686;6251.812445626639;6254.781082662085;5110.48895110486;6149.538784591084;6239.188905442264;6270.968645156745;6288.402601752826;6197.163382943245;6229;6260.68696565179;6261.311255761953;6264.530160238091;5941.346451890375;6046.153538504701;6097.847553811191;6132.78535251264;6143.447089761943;5107.310513080686;6164.938350616616;6236.220472440945;6241.968790156202;6254.874902501833;5960.701964901824;5974.253218347707;6035.879282414239;6039;6049.727762250797;5831.4168583141345;5984.311804142405;6043.728032238648;6043.939560604338;6055;5785.479306862402;5805.593608447537;5841.620294681002;5862.560307976833;5957.642541447353;4370.344448332648;4746.264329029006;4817.373741413734;5042.873928151679;6095.299040610386;5683.147527870852;5834.212381328636;5895.380984996514;5950.137230101697;5965.164876917322 04:10:55 INFO - PROCESS | 1670 | |1;ext.html;453.9500654927957;471.4884350479729;515.5875299760191;516.7211152397816;548.700957977902;37321;39852.800735996316;39858.003549911264;39976.40035399464;40046.59953400469;40268.79865600668;40821.387679184765;40878.79560602193;40989.180216395725;41007.17985640285;8408.159184081604;9200.263978881674;9645.22838172948;9661.855072173923;9686.46724430156;7938.6427610757655;9393.483358415284;9537.093976072261;9558;9575.138237558618;9537.856932146024;9545.284103692216;9553.283503737248;9555.901071376777;9570.808583828319;9453.33826632136;9486.193673537757;9489.14597686208;9491.335606507548;9526.333156679035;9526.85709714355;9595.23238140947;9615.471149086798;9624.37441566296;9628.759281017961;34688.653113469045;39029;39090.80454597737;39195.804020979995;39393.40909886354;3356.516178028266;3387.4241378965635;3523.9647603523895;3681.9263614727556;3975;24424.63363049556;29286.414271714446;29559.97408680923;29583;29736.95920642767;3183.2041989502623;3234.3692979868933;3234.3692979868933;3272.4061017050662;3321.4187517184396;432087;467789;471515;473565.264347359;473625.15937101503;57751.401186946685;57980.71009644925;58013.709931450074;58079;58169.4183058164;28353.007644732334;29098;29672.258193545335;30502.847485762428;60101.398986010456;16454.670906581803;16652.666946661;16657.083860387796;16659.583510412092;16668.916655416888;11536.019438347666;12223;12763.361831908553;12832.29422381778;12864.421101050475;18822.153003114618;18911.90544047271;18919.527011824815;18923.905380473287;18955.62088758245;6163.952128138228;6540.836479087966;6890.725215835087;7559;7731.961340193263;712.7932899459099;788.8185717285056;807.9859775981106;888.8577827547562;932.7668082979255;28901.56647650287;29223;29806.25484362908;29930.802767889476;30184.005133638486;838.3628442383832;978.9559469823876;982.916452101565;1094.0143639294654;1121.097516499226;15263.313150908236;15298.311575979107;15388.769168462482;15416.306266218047;15844.76232856508;635677;641313;646094;649291;652515;49266;54782.726086369315;54925.45074549203;55701.72149139229;55748.44251557432;1285.9614211573669;1287.4077924154806;1323.285425870058;1324.3775425549977;1330.5808670268834;23957.687616229246;24480.755192447847;28350.44072576028;29880.551791722708;29967;48902.75548622234;49013.628228331516;49119.50880491149;49186.01627967349;49202.753986229836;558962;559180;559863;560513;561670;25689.743102568737;26186.476270474104;26236.475270494866;26295.868520657274;26300.8684956574;44159.33760993652;44643.10713785771;46342.30486542772;46638.53361466342;47084;37523.37006245285;38204;38297.61702383052;39080.41379379368;39669.60330396774;37490.437643435915;37634.8118259407;38772.80613596914;39064.60935390723;39619.2076158481;31177.37645247128;36465.63534364622;36564.81717591395;37912;38096.04759880914;26110.216693499224;27635.723642763314;33719.662803371655;33986;34146.14634634154;20011.899940500203;25252;25320.620190696787;25634.359141021625;25692.871535642204 04:10:55 INFO - PROCESS | 1670 | |2;jquery.html;371.7026378896883;373.3857803912565;374.63098847635075;383.18381846666597;396.8610986154846;19524.804751952495;20343.49141271469;21687.99999999998;21757.782422175773;21826.563468730637;12021.398930053507;12241.449134788934;14421.495247666333;16396.83603163968;20128.396148115542;5436.537894278991;5639.774409023634;5655.236543066695;5678.148277758328;5690.544756419497;4274;6204.78283260086;6260.937390626081;6275.807596556662;6279.591826531261;6252.3122456529745;6255.468285195764;6266.937330626703;6275.843103922392;6360.968195159017;5889.793857214999;6838.794836154899;6930.826729331757;6936.965315173392;6954.130733658293;5827.426594819417;6058.485028772559;6065.423784740443;6092.329843717188;6109.938900611026;25106.995720171355;25501.362465938313;25597;25694.614580781305;26069.869650651814;2105.9157633694635;2325.7557956414503;2390.71311442628;2581.651477050593;2628.9605655915175;9946.90053099467;10054.145397641209;10247.82150052746;10488.68533943983;10495.842562361571;1869.598036422162;1900.4108726294892;1915.1573307744547;1930.2624462230967;1986.5530255692497;97348.51325743397;117072.41463792711;121249;122507;123189;9649.372790768577;11326.490307936163;11516.424178791027;11573.826392604118;11620.53517859293;14461.349239284258;14514.346854391577;14532.709345813024;14540.49108281205;14547.927260363842;8345.624446899783;8654.78363040929;8709.12908709124;8747.693830715894;8830.823383532294;8575.528345941033;8582.699605513777;8591.527465989306;8684.088170741981;8744.994325652631;3797.867074652374;4433.844815431509;4519.81920723174;4521.344405061313;4601.723896566216;1717.1671739206474;1906.6949288114113;1914.7798003229527;1934.5067007912892;1938.5541325495215;814.5031530766228;882.6292956958093;906.2930913887178;941.110650435332;964.4406244378243;19709.70435443441;21003.369898903056;21031.05360258792;21267.93660316978;21359.359219223446;923.2660035271975;934.076877116115;961.0869673809908;965.8744363232735;995.5121990224737;10519.053285204216;11193.776124477628;11298.830517542243;11346.773064538664;11378;552401;556103.4389656133;563245;564100;564907;112063.87936120697;124312;131271;135498;135821;980.8087422952456;1006.0543089495997;1023.6212601337404;1026.7484466305802;1027.9897201027893;14008.859911401163;16131.919340403692;18270;19230.326938557642;19256.807431926063;38355.424668629435;52277.47722522878;53597.464025359244;54614;57196;84769.57615211884;84925.57537212274;85404.57297713471;86198.56900715457;87338;6907.585544867324;7208.531445456028;7274;7591.202923692933;8098.420807942631;11571.884281157418;12884.677883052998;12989.28558929268;13231.139975901535;13319.800202997156;11071.446427678422;11168.21822472419;11594.246373985665;11701.707457313294;11704.765904681688;10991.890081099087;11077.501512431798;11313.264637798517;11337.773244535229;11603.303801771921;11161.051310638686;11409.54361825551;11708.473118709508;11791.410429478321;11839.58561450345;5713.571482138939;5924.644521328734;6200.472959798468;6348.016057511093;7493.400527957641;11045.337279762918;11097.112231021338;11224.382658953837;11445.370504622326;11565.421728913689 04:10:55 INFO - PROCESS | 1670 | |3;mootools.html;1469.5297504798466;1503.2333509909945;1662.7505874118888;1678.2951160512584;1829.6066345735655;7964.641591128398;8508.829823403536;8667;9052.1853033227;9080.27357811375;8015.078265999412;8639.39524233304;8858.822823543525;8859.778505537348;8870.201681848648;1847.2426305214865;2102.054075665949;2334.1130370459246;2367.3134790910617;2382.773636504538;2337.392278007722;2373.5134297468976;2389.104085967762;2389.163792672568;2403.987980060106;2360.303710405426;2374.7862692357685;2381.8213633977434;2382.8451150675237;2388.0447820871705;2027.472857057161;2339.356676913845;2344.296710986706;2352.1414683640432;2355.2698663414394;2008.9397318080335;2302.5164715409783;2311.722593288799;2355.2698663414394;2359.5045040541336;8872.600732967032;8913.420627659181;8923.687670931551;8924.33067519932;8952;5203.9219411708855;5355.143177091647;5355.437679043684;5380.865478363033;5406.648567843077;3570.7500474966764;3643.453481977698;3769.321522126016;3777.7166712496673;3790;1067.9733006674817;1089.9019088282014;1111.2832223216062;1128.700894263021;1131.8641762988493;11897.167198296123;11983.88016119845;12048.518059277618;12081.395930203455;12086.033117350591;4543.727756228195;4651.348811166439;4805.783739731721;4853.199222128309;4868.707877527359;8689.782755431164;9552.61789528425;9768.267379946532;9864.457454839909;9959.15347195482;5285.101532739443;5325.4940780625775;5326.6005049621435;5329.387120481194;5343.091674415358;4393.143337049309;4737;4875.19559272716;4898.24077268024;4913.680610760289;3656.323580137683;3707.5180226570374;3896.2597106549665;3941.467901833216;3954.3475326570792;1266.1263728027816;1273.980890286628;1276.3618190904547;1277.431542963391;1279.7888348422591;803.2650125135435;824.9092599814015;840.7309660908451;856.259335674637;885;5565.359983601857;5590.608657393944;5777.855553611109;6009.699515024231;6169.180091872819;783.3576467296762;925.2181906289175;939.6617217801722;1008.6116845014575;1016.8423894296396;3672.485851980725;3707.7589956652732;4053.1285773558825;4120.979395103005;4126.814293356806;10409.271351005356;10845.891541084646;10861.076808471369;10886.346819190874;10912.127029837595;10566.894331056745;10679.519421626046;10762.946185269024;10871.239013269153;10928.344299342065;7134.750283740044;7613.238676132342;7675.884861727079;8116.675332986614;8339.12439193876;5114.488551144856;5839.328477225004;5912.852178695567;5925.200097986716;5957.463828255478;8060;8712.738617841474;10048.799024019625;10178.745531361776;10194.490275486047;8679.132086791271;8827.382083254368;9569.425834449956;9644.469554174308;10290.742731431774;5393.6763794172475;6467.3209313023335;6973.267806880204;7051.400630946427;7175.712971481083;7157.141143062866;8261.215184557457;8464.153584641486;8557.44376615518;8562.100979397323;7415.555066696015;7466.664000120117;7510.511816731895;7525.661345239587;7620.466567340233;7357.153927298429;7387.889181662172;7422.257774222535;7556.546607203365;7559.924400755922;6916.619585922621;7023.438124950094;7088.610126443095;7096.929030709627;7097.219305876452;4971.751412429292;4991.875203119951;5079.5428411443145;5147.485251474973;5151.995360904588;5055.620828437808;5055.848324550269;5174.7930082796265;5212.635115542027;5251.369835619597 04:10:55 INFO - PROCESS | 1670 | |4;prototype.html;270.51307646236774;297.73650319467276;311.270071681906;312.43605292447154;313.140429520965;5339.55365527162;5496.972515137429;5554.361248456429;5594.377630487159;5613.389773755203;5481;5570.805021824227;5597.776088956447;5648.4633959773855;5671.943280567193;3436.7422443316727;4269.423627810253;4312.3531470279395;4319.352097185416;4327.350897365404;3525.3301872644242;3954.545227298854;4323.805428755713;4350.889114283287;4377.511646040346;4220.3036498977635;4244.320908654616;4265.488141423034;4269.765162916038;4277.508086570037;3419.9658003420022;4251;4268.9573104268875;4274.658027357804;4295.5824577889225;3548.27260411615;3688.8524459021605;3711;3723.087843478338;3731.0299322176156;4831.541003604687;4921.630877684188;5371.677699338053;5431.565474762009;5480.80817171401;4829.661923665345;4860.379017631852;4873.074115917964;4885.487023862479;4914.729689867056;4712.434507859045;5488.341399032101;5851;5981.043033114681;5982.461578457916;3923.431102490123;3933.5476420211758;3942.743721658083;3944.349182384903;3969.503812023497;5281.498257665554;6006.519478441714;6158.9692051539905;6215.595986260879;6291.307956124822;3847.499825022785;3949.6445319921345;3986.362182050858;3999.1601763629383;4011.277969965376;3952.1622445562953;4016.136530645925;4021.4369988201674;4023.5372932112596;4048.1701251243426;4742.383490146259;4767.4994125617;4787.234042553175;4826.831060912851;4834.589059929875;5145.147746811145;5811.854703632443;6016.766562854605;6030.803674052759;6044.549308166009;1379.0553470872485;1380.1994842991041;1382.3710211853584;1384.5846246126123;1385.217352196006;751.9585374256694;805.697863301262;823.2919689067397;841.2428814067389;848.3849209323315;4162.253971425681;4287.142571485715;4447.3329000650165;4612.561806628365;4646.6747327686735;5075.8984820303385;5078.187490001582;5136.332276803992;5167.17628954571;5169.948300517022;3678.5769636492146;4668.439787225487;4672.7290896372;4682.601978831837;4733.183755665374;2348.3072493614427;2641.960370594443;2709.6858023858413;2722.523558377276;2732.562789953598;4456.710313829655;4547.044071657679;4982.882275033169;5128.846009647799;5148.995945790535;4360.781960902005;4557.521460246627;4571.954280457219;4844.4186697596515;5198.948010519846;4115;5009.321877171043;5210.238573556021;5221.817236396708;5287.043793796243;4148.647364974011;4171.8097998551;4216.683748718797;4478.977605112084;5016.5168241720585;4513.2327504325;4642.37327960721;4652.673338562944;4765.1892280933025;5030.2957585937265;4540.06928579647;5186.507281808223;5235.905637744932;5271.182966640177;5328.786848526015;3132.9373412532077;3529.023746701855;3570.2155714942246;3770.924581508409;3906.5898080701118;5461.863453413696;5593.993081245252;5597.013060363675;5869.530437564899;5952.642841429528;5078.263651770399;5323.520883120537;5870.471657550841;5880.676562789087;5917.609361799888;5031.4213865405945;5250.401051479542;5563.5271001963665;5807.912881306868;5838.182654428469;5705.543556515386;5739.942600573941;5758.79607886237;5777.7977770777825;5805.129230615442;5055;5325.733713314241;5900.409959004065;5919.763209471573;5920.082387229986;5450.345958485007;5752.827415177384;5762.683052432157;5786.929418057673;5808.846674627662 04:10:55 INFO - PROCESS | 1670 | |5;yui.html;693.8855088910329;711.3384552366298;754.1892465599481;770.6223950264372;787.4409169489662;15054.84945150548;15793.447229346975;16187.109708966016;16191.595210119753;16243.918780406082;12055.939720301409;14512.927435362808;14675.853241467583;14700.926495367536;14709.338079786408;657.4871600151889;812.5327936436543;819.1358117186351;834.0950069174952;842.9452085614415;836.4688422851502;845;845.733593917917;846.4455781463151;850.3409857360564;798.4331124901298;818.3289702443998;878.1876763993313;900.3967341880956;901.4951627088818;892.1479986612769;892.3485855325583;894.2577660541767;894.8120894612139;896.5382827843666;618.2148671187612;638.3233772201435;655.7540922154192;660.2671035151027;662.0797092042066;15203.467878624306;15237.466688665954;15248.847511524853;15263.618409539851;15294.235288235655;11476.827847582294;12211.877881221251;14444.638884027878;14653.194074325907;14674.413023479048;11804.704882377924;11999.400029998465;12011.39943002855;12076.577319793852;12084.758304833855;3405.267867408494;3749.550053993511;3808.1812410331636;3822.6559609635265;3824.7513911595934;96835.51582242044;118853.81146188514;124131.75868241383;124522;126784.36607816994;10822;11140.888591114148;11180.664580062612;11398.031167350868;11671.474783634756;21724.23965161212;21817.781822181892;21831.890840546013;21862.453438663844;21887.562248754937;8067.193280671886;8101.068377136587;8169;8280.337572994145;8374.162583741578;4456.799444025027;4485.842995495142;4548.226801443762;4551.795169217393;4643.8374656886845;3124.4844600641095;3520.8767693130617;3644.6355364463343;3671.3024525340634;3681.318955993096;523.6256076905031;648.9059086432441;654.0908137688616;666.5800545656302;678.8302924268933;486.42358804816405;579.3742757821627;608.1364462463313;644.6518879804946;676.4182802789597;8206.507609543447;9096.772580685403;9574.712758617252;9698.224142068617;9904.55429505674;484.22282237009796;594.7918228619949;600.6816387314731;622.2812651387654;658.0974819321375;4142.606452387018;4526.411566496335;4609;4614.1694494991225;4711.646626503026;110795;145443;148082;149470;151166;122342;128410;129095;129918;131128;104083.32417939071;110445.44777276223;111027.44486277517;112404.87595124108;113190.86809131803;8817.911820881965;8927.821443571222;8937.642494300155;9032.32257580671;9134.497602631918;55530.61173470695;60553.48616284452;61478.46303842261;61533;62786.116416507575;89881;91940.54029729808;94376.52811735898;95681;97797.51101244448;11668.416579170838;11818.349990750246;11947.10396720232;12168.817467737814;12181.512739490676;12892.41984110736;13094;13386.129901556367;13854.445822167403;13890.236037018061;11966.940165299118;12204.633860984184;12300.507979680713;12425.005999519835;12722.300273485047;11964;12333.260004399765;12341.876581234073;12439;12724.427400766803;11854.288742675468;12093.516259349528;12157.817632735692;12439.689007774878;12535.623931282076;10323.845142323022;10470.633527826489;10630.946845265724;10693.249206317476;10881.18391120685;8614.78463038429;10237.539310731185;10288.639897603547;10550.155987521133;10565.049145576935 04:10:55 INFO - PROCESS | 1670 | __end_tp_report 04:10:55 INFO - PROCESS | 1670 | __start_cc_report 04:10:55 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,388 04:10:55 INFO - PROCESS | 1670 | __end_cc_report 04:10:55 INFO - PROCESS | 1670 | __startTimestamp1472555455886__endTimestamp 04:10:55 INFO - PROCESS | 1670 | 04:10:55 INFO - PROCESS | 1670 | ------- Summary: start ------- 04:10:55 INFO - PROCESS | 1670 | Number of tests: 6 04:10:55 INFO - PROCESS | 1670 | 04:10:55 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5621.62 Median:5757.28 stddev:652.58 (11.3%) stddev-sans-first:623.58 04:10:55 INFO - PROCESS | 1670 | Values: 3087.7 3223.9 3297.8 3331.2 3396.4 4550.4 5585.5 5632.6 5650.2 5862.6 5441.0 5595.8 5612.4 5684.3 5730.5 5069.2 5132.8 5233.7 5240.3 5246.2 5044.9 5320.0 5331.7 5335.9 5353.0 5072.7 5098.4 5193.7 5204.1 5238.4 5119.1 5122.8 5133.7 5155.6 5214.2 5139.2 5141.3 5157.7 5179.1 5193.2 5562.8 5615.6 5685.4 5695.5 5721.5 5068.2 5533.3 6012.1 6088.0 6160.4 6186.0 6213.6 6235.4 6240.2 6245.2 5604.9 5643.1 5681.0 5693.5 5739.6 6229.1 6233.3 6262.9 6280.5 6307.9 6003.1 6020.6 6021.5 6023.1 6056.6 6069.5 6115.8 6139.3 6153.8 6175.6 5971.6 6102.8 6123.4 6134.1 6142.9 6079.8 6122.5 6153.6 6194.6 6200.7 4828.6 4890.3 4918.5 4926.0 4934.6 4404.8 4407.9 4409.2 4505.9 4516.4 4668.5 5663.5 5669.0 5684.7 5757.3 6078.1 6129.0 6227.8 6234.0 6247.6 5580.4 5597.7 5608.7 5664.9 5675.3 5329.3 5329.5 5333.9 5335.7 5343.7 6158.5 6174.9 6221.4 6251.8 6254.8 5110.5 6149.5 6239.2 6271.0 6288.4 6197.2 6229.0 6260.7 6261.3 6264.5 5941.3 6046.2 6097.8 6132.8 6143.4 5107.3 6164.9 6236.2 6242.0 6254.9 5960.7 5974.3 6035.9 6039.0 6049.7 5831.4 5984.3 6043.7 6043.9 6055.0 5785.5 5805.6 5841.6 5862.6 5957.6 4370.3 4746.3 4817.4 5042.9 6095.3 5683.1 5834.2 5895.4 5950.1 5965.2 04:10:55 INFO - PROCESS | 1670 | 04:10:55 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:67720.57 Median:21822.30 stddev:150167.83 (688.1%) stddev-sans-first:150504.16 04:10:55 INFO - PROCESS | 1670 | Values: 454.0 471.5 515.6 516.7 548.7 37321.0 39852.8 39858.0 39976.4 40046.6 40268.8 40821.4 40878.8 40989.2 41007.2 8408.2 9200.3 9645.2 9661.9 9686.5 7938.6 9393.5 9537.1 9558.0 9575.1 9537.9 9545.3 9553.3 9555.9 9570.8 9453.3 9486.2 9489.1 9491.3 9526.3 9526.9 9595.2 9615.5 9624.4 9628.8 34688.7 39029.0 39090.8 39195.8 39393.4 3356.5 3387.4 3524.0 3681.9 3975.0 24424.6 29286.4 29560.0 29583.0 29737.0 3183.2 3234.4 3234.4 3272.4 3321.4 432087.0 467789.0 471515.0 473565.3 473625.2 57751.4 57980.7 58013.7 58079.0 58169.4 28353.0 29098.0 29672.3 30502.8 60101.4 16454.7 16652.7 16657.1 16659.6 16668.9 11536.0 12223.0 12763.4 12832.3 12864.4 18822.2 18911.9 18919.5 18923.9 18955.6 6164.0 6540.8 6890.7 7559.0 7732.0 712.8 788.8 808.0 888.9 932.8 28901.6 29223.0 29806.3 29930.8 30184.0 838.4 979.0 982.9 1094.0 1121.1 15263.3 15298.3 15388.8 15416.3 15844.8 635677.0 641313.0 646094.0 649291.0 652515.0 49266.0 54782.7 54925.5 55701.7 55748.4 1286.0 1287.4 1323.3 1324.4 1330.6 23957.7 24480.8 28350.4 29880.6 29967.0 48902.8 49013.6 49119.5 49186.0 49202.8 558962.0 559180.0 559863.0 560513.0 561670.0 25689.7 26186.5 26236.5 26295.9 26300.9 44159.3 44643.1 46342.3 46638.5 47084.0 37523.4 38204.0 38297.6 39080.4 39669.6 37490.4 37634.8 38772.8 39064.6 39619.2 31177.4 36465.6 36564.8 37912.0 38096.0 26110.2 27635.7 33719.7 33986.0 34146.1 20011.9 25252.0 25320.6 25634.4 25692.9 04:10:55 INFO - PROCESS | 1670 | 04:10:55 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:33940.94 Median:25549.18 stddev:93974.17 (367.8%) stddev-sans-first:94203.99 04:10:55 INFO - PROCESS | 1670 | Values: 371.7 373.4 374.6 383.2 396.9 19524.8 20343.5 21688.0 21757.8 21826.6 12021.4 12241.4 14421.5 16396.8 20128.4 5436.5 5639.8 5655.2 5678.1 5690.5 4274.0 6204.8 6260.9 6275.8 6279.6 6252.3 6255.5 6266.9 6275.8 6361.0 5889.8 6838.8 6930.8 6937.0 6954.1 5827.4 6058.5 6065.4 6092.3 6109.9 25107.0 25501.4 25597.0 25694.6 26069.9 2105.9 2325.8 2390.7 2581.7 2629.0 9946.9 10054.1 10247.8 10488.7 10495.8 1869.6 1900.4 1915.2 1930.3 1986.6 97348.5 117072.4 121249.0 122507.0 123189.0 9649.4 11326.5 11516.4 11573.8 11620.5 14461.3 14514.3 14532.7 14540.5 14547.9 8345.6 8654.8 8709.1 8747.7 8830.8 8575.5 8582.7 8591.5 8684.1 8745.0 3797.9 4433.8 4519.8 4521.3 4601.7 1717.2 1906.7 1914.8 1934.5 1938.6 814.5 882.6 906.3 941.1 964.4 19709.7 21003.4 21031.1 21267.9 21359.4 923.3 934.1 961.1 965.9 995.5 10519.1 11193.8 11298.8 11346.8 11378.0 552401.0 556103.4 563245.0 564100.0 564907.0 112063.9 124312.0 131271.0 135498.0 135821.0 980.8 1006.1 1023.6 1026.7 1028.0 14008.9 16131.9 18270.0 19230.3 19256.8 38355.4 52277.5 53597.5 54614.0 57196.0 84769.6 84925.6 85404.6 86198.6 87338.0 6907.6 7208.5 7274.0 7591.2 8098.4 11571.9 12884.7 12989.3 13231.1 13319.8 11071.4 11168.2 11594.2 11701.7 11704.8 10991.9 11077.5 11313.3 11337.8 11603.3 11161.1 11409.5 11708.5 11791.4 11839.6 5713.6 5924.6 6200.5 6348.0 7493.4 11045.3 11097.1 11224.4 11445.4 11565.4 04:10:55 INFO - PROCESS | 1670 | 04:10:55 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5653.60 Median:5097.02 stddev:3166.26 (62.1%) stddev-sans-first:3159.52 04:10:55 INFO - PROCESS | 1670 | Values: 1469.5 1503.2 1662.8 1678.3 1829.6 7964.6 8508.8 8667.0 9052.2 9080.3 8015.1 8639.4 8858.8 8859.8 8870.2 1847.2 2102.1 2334.1 2367.3 2382.8 2337.4 2373.5 2389.1 2389.2 2404.0 2360.3 2374.8 2381.8 2382.8 2388.0 2027.5 2339.4 2344.3 2352.1 2355.3 2008.9 2302.5 2311.7 2355.3 2359.5 8872.6 8913.4 8923.7 8924.3 8952.0 5203.9 5355.1 5355.4 5380.9 5406.6 3570.8 3643.5 3769.3 3777.7 3790.0 1068.0 1089.9 1111.3 1128.7 1131.9 11897.2 11983.9 12048.5 12081.4 12086.0 4543.7 4651.3 4805.8 4853.2 4868.7 8689.8 9552.6 9768.3 9864.5 9959.2 5285.1 5325.5 5326.6 5329.4 5343.1 4393.1 4737.0 4875.2 4898.2 4913.7 3656.3 3707.5 3896.3 3941.5 3954.3 1266.1 1274.0 1276.4 1277.4 1279.8 803.3 824.9 840.7 856.3 885.0 5565.4 5590.6 5777.9 6009.7 6169.2 783.4 925.2 939.7 1008.6 1016.8 3672.5 3707.8 4053.1 4121.0 4126.8 10409.3 10845.9 10861.1 10886.3 10912.1 10566.9 10679.5 10762.9 10871.2 10928.3 7134.8 7613.2 7675.9 8116.7 8339.1 5114.5 5839.3 5912.9 5925.2 5957.5 8060.0 8712.7 10048.8 10178.7 10194.5 8679.1 8827.4 9569.4 9644.5 10290.7 5393.7 6467.3 6973.3 7051.4 7175.7 7157.1 8261.2 8464.2 8557.4 8562.1 7415.6 7466.7 7510.5 7525.7 7620.5 7357.2 7387.9 7422.3 7556.5 7559.9 6916.6 7023.4 7088.6 7096.9 7097.2 4971.8 4991.9 5079.5 5147.5 5152.0 5055.6 5055.8 5174.8 5212.6 5251.4 04:10:55 INFO - PROCESS | 1670 | 04:10:55 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:4472.33 Median:4830.60 stddev:1365.87 (28.3%) stddev-sans-first:1332.79 04:10:55 INFO - PROCESS | 1670 | Values: 270.5 297.7 311.3 312.4 313.1 5339.6 5497.0 5554.4 5594.4 5613.4 5481.0 5570.8 5597.8 5648.5 5671.9 3436.7 4269.4 4312.4 4319.4 4327.4 3525.3 3954.5 4323.8 4350.9 4377.5 4220.3 4244.3 4265.5 4269.8 4277.5 3420.0 4251.0 4269.0 4274.7 4295.6 3548.3 3688.9 3711.0 3723.1 3731.0 4831.5 4921.6 5371.7 5431.6 5480.8 4829.7 4860.4 4873.1 4885.5 4914.7 4712.4 5488.3 5851.0 5981.0 5982.5 3923.4 3933.5 3942.7 3944.3 3969.5 5281.5 6006.5 6159.0 6215.6 6291.3 3847.5 3949.6 3986.4 3999.2 4011.3 3952.2 4016.1 4021.4 4023.5 4048.2 4742.4 4767.5 4787.2 4826.8 4834.6 5145.1 5811.9 6016.8 6030.8 6044.5 1379.1 1380.2 1382.4 1384.6 1385.2 752.0 805.7 823.3 841.2 848.4 4162.3 4287.1 4447.3 4612.6 4646.7 5075.9 5078.2 5136.3 5167.2 5169.9 3678.6 4668.4 4672.7 4682.6 4733.2 2348.3 2642.0 2709.7 2722.5 2732.6 4456.7 4547.0 4982.9 5128.8 5149.0 4360.8 4557.5 4572.0 4844.4 5198.9 4115.0 5009.3 5210.2 5221.8 5287.0 4148.6 4171.8 4216.7 4479.0 5016.5 4513.2 4642.4 4652.7 4765.2 5030.3 4540.1 5186.5 5235.9 5271.2 5328.8 3132.9 3529.0 3570.2 3770.9 3906.6 5461.9 5594.0 5597.0 5869.5 5952.6 5078.3 5323.5 5870.5 5880.7 5917.6 5031.4 5250.4 5563.5 5807.9 5838.2 5705.5 5739.9 5758.8 5777.8 5805.1 5055.0 5325.7 5900.4 5919.8 5920.1 5450.3 5752.8 5762.7 5786.9 5808.8 04:10:55 INFO - PROCESS | 1670 | 04:10:55 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:24668.88 Median:3582.76 stddev:39655.98 (1106.9%) stddev-sans-first:39726.37 04:10:55 INFO - PROCESS | 1670 | Values: 693.9 711.3 754.2 770.6 787.4 15054.8 15793.4 16187.1 16191.6 16243.9 12055.9 14512.9 14675.9 14700.9 14709.3 657.5 812.5 819.1 834.1 842.9 836.5 845.0 845.7 846.4 850.3 798.4 818.3 878.2 900.4 901.5 892.1 892.3 894.3 894.8 896.5 618.2 638.3 655.8 660.3 662.1 15203.5 15237.5 15248.8 15263.6 15294.2 11476.8 12211.9 14444.6 14653.2 14674.4 11804.7 11999.4 12011.4 12076.6 12084.8 3405.3 3749.6 3808.2 3822.7 3824.8 96835.5 118853.8 124131.8 124522.0 126784.4 10822.0 11140.9 11180.7 11398.0 11671.5 21724.2 21817.8 21831.9 21862.5 21887.6 8067.2 8101.1 8169.0 8280.3 8374.2 4456.8 4485.8 4548.2 4551.8 4643.8 3124.5 3520.9 3644.6 3671.3 3681.3 523.6 648.9 654.1 666.6 678.8 486.4 579.4 608.1 644.7 676.4 8206.5 9096.8 9574.7 9698.2 9904.6 484.2 594.8 600.7 622.3 658.1 4142.6 4526.4 4609.0 4614.2 4711.6 110795.0 145443.0 148082.0 149470.0 151166.0 122342.0 128410.0 129095.0 129918.0 131128.0 104083.3 110445.4 111027.4 112404.9 113190.9 8817.9 8927.8 8937.6 9032.3 9134.5 55530.6 60553.5 61478.5 61533.0 62786.1 89881.0 91940.5 94376.5 95681.0 97797.5 11668.4 11818.3 11947.1 12168.8 12181.5 12892.4 13094.0 13386.1 13854.4 13890.2 11966.9 12204.6 12300.5 12425.0 12722.3 11964.0 12333.3 12341.9 12439.0 12724.4 11854.3 12093.5 12157.8 12439.7 12535.6 10323.8 10470.6 10630.9 10693.2 10881.2 8614.8 10237.5 10288.6 10550.2 10565.0 04:10:55 INFO - PROCESS | 1670 | -------- Summary: end -------- 04:10:55 INFO - PROCESS | 1670 | 04:10:56 INFO - TEST-INFO | 1670: exit 0 04:10:56 INFO - TEST-OK | dromaeo_css | took 1113805ms 04:10:56 INFO - TEST-START | kraken 04:10:56 INFO - operating with platform_type : mac_ 04:10:56 INFO - Initialising browser for kraken test... 04:10:56 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmpYFhwYK/profile http://localhost:49267/getInfo.html) 04:10:59 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 04:10:59 INFO - PROCESS | 1677 | colorDepth:24 04:10:59 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 04:10:59 INFO - PROCESS | 1677 | __metrics 04:10:59 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 04:10:59 INFO - TEST-INFO | 1677: exit 0 04:10:59 INFO - Browser initialized. 04:10:59 INFO - Running cycle 1/1 for kraken test... 04:10:59 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmpYFhwYK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:12 INFO - PROCESS | 1679 | RSS: Main: 244297728 04:11:12 INFO - PROCESS | 1679 | 04:11:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 04:11:15 INFO - PROCESS | 1679 | RSS: Main: 257138688 04:11:15 INFO - PROCESS | 1679 | 04:11:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 04:11:18 INFO - PROCESS | 1679 | RSS: Main: 265809920 04:11:18 INFO - PROCESS | 1679 | 04:11:22 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 04:11:23 INFO - PROCESS | 1679 | RSS: Main: 261443584 04:11:23 INFO - PROCESS | 1679 | 04:11:25 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 04:11:25 INFO - PROCESS | 1679 | RSS: Main: 262901760 04:11:25 INFO - PROCESS | 1679 | 04:11:27 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:11:28 INFO - PROCESS | 1679 | RSS: Main: 263237632 04:11:28 INFO - PROCESS | 1679 | 04:11:31 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 04:11:31 INFO - PROCESS | 1679 | RSS: Main: 265129984 04:11:31 INFO - PROCESS | 1679 | 04:11:34 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 04:11:35 INFO - PROCESS | 1679 | RSS: Main: 265191424 04:11:35 INFO - PROCESS | 1679 | 04:11:38 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 04:11:39 INFO - PROCESS | 1679 | RSS: Main: 265519104 04:11:39 INFO - PROCESS | 1679 | 04:11:40 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:11:41 INFO - PROCESS | 1679 | RSS: Main: 265072640 04:11:41 INFO - PROCESS | 1679 | 04:11:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:11:43 INFO - PROCESS | 1679 | RSS: Main: 264790016 04:11:43 INFO - PROCESS | 1679 | 04:11:46 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:11:46 INFO - PROCESS | 1679 | RSS: Main: 265056256 04:11:46 INFO - PROCESS | 1679 | 04:11:49 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:11:50 INFO - PROCESS | 1679 | RSS: Main: 265158656 04:11:50 INFO - PROCESS | 1679 | 04:11:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:11:54 INFO - PROCESS | 1679 | RSS: Main: 265457664 04:11:54 INFO - PROCESS | 1679 | 04:11:55 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 04:11:56 INFO - PROCESS | 1679 | RSS: Main: 267456512 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | __start_tp_report 04:11:56 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 04:11:56 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 04:11:56 INFO - PROCESS | 1679 | |i|pagename|runs| 04:11:56 INFO - PROCESS | 1679 | |0;ai-astar;119;112;118;118;112;101;116;116;117;116 04:11:56 INFO - PROCESS | 1679 | |1;audio-beat-detection;144;110;136;161;112;133;130;112;180;142 04:11:56 INFO - PROCESS | 1679 | |2;audio-dft;206;200;209;275;187;286;255;202;201;220 04:11:56 INFO - PROCESS | 1679 | |3;audio-fft;68;105;77;144;59;60;59;67;136;59 04:11:56 INFO - PROCESS | 1679 | |4;audio-oscillator;69;74;141;73;70;81;107;68;73;108 04:11:56 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;90;87;90;87;81;130;135;87;89;88 04:11:56 INFO - PROCESS | 1679 | |6;imaging-darkroom;97;99;98;100;99;105;98;153;133;98 04:11:56 INFO - PROCESS | 1679 | |7;imaging-desaturate;92;96;110;90;145;131;154;150;113;94 04:11:56 INFO - PROCESS | 1679 | |8;json-parse-financial;57;61;58;57;60;57;59;59;60;59 04:11:56 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;64;70;76;72;80;79;71;73;73;73 04:11:56 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;82;87;86;87;88;89;92;88;91;86 04:11:56 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;136;154;165;136;128;156;146;164;172;128 04:11:56 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;165;241;247;228;173;175;217;176;232;172 04:11:56 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;68;71;67;68;71;70;70;70;71;72 04:11:56 INFO - PROCESS | 1679 | __end_tp_report 04:11:56 INFO - PROCESS | 1679 | __start_cc_report 04:11:56 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,966 04:11:56 INFO - PROCESS | 1679 | __end_cc_report 04:11:56 INFO - PROCESS | 1679 | __startTimestamp1472555516154__endTimestamp 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | ------- Summary: start ------- 04:11:56 INFO - PROCESS | 1679 | Number of tests: 14 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:114.50 Median:116.50 stddev:5.30 (4.5%) stddev-sans-first:5.36 04:11:56 INFO - PROCESS | 1679 | Values: 119.0 112.0 118.0 118.0 112.0 101.0 116.0 116.0 117.0 116.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:139.00 stddev:22.44 (16.1%) stddev-sans-first:23.62 04:11:56 INFO - PROCESS | 1679 | Values: 144.0 110.0 136.0 161.0 112.0 133.0 130.0 112.0 180.0 142.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:224.10 Median:214.50 stddev:34.85 (16.2%) stddev-sans-first:36.34 04:11:56 INFO - PROCESS | 1679 | Values: 206.0 200.0 209.0 275.0 187.0 286.0 255.0 202.0 201.0 220.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:83.40 Median:59.50 stddev:32.98 (55.4%) stddev-sans-first:34.50 04:11:56 INFO - PROCESS | 1679 | Values: 68.0 105.0 77.0 144.0 59.0 60.0 59.0 67.0 136.0 59.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:71.50 stddev:24.32 (34.0%) stddev-sans-first:24.97 04:11:56 INFO - PROCESS | 1679 | Values: 69.0 74.0 141.0 73.0 70.0 81.0 107.0 68.0 73.0 108.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:87.50 stddev:19.23 (22.0%) stddev-sans-first:20.26 04:11:56 INFO - PROCESS | 1679 | Values: 90.0 87.0 90.0 87.0 81.0 130.0 135.0 87.0 89.0 88.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:108.00 Median:98.00 stddev:19.17 (19.6%) stddev-sans-first:19.91 04:11:56 INFO - PROCESS | 1679 | Values: 97.0 99.0 98.0 100.0 99.0 105.0 98.0 153.0 133.0 98.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:117.50 Median:122.00 stddev:25.44 (20.9%) stddev-sans-first:25.25 04:11:56 INFO - PROCESS | 1679 | Values: 92.0 96.0 110.0 90.0 145.0 131.0 154.0 150.0 113.0 94.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:59.00 stddev:1.42 (2.4%) stddev-sans-first:1.36 04:11:56 INFO - PROCESS | 1679 | Values: 57.0 61.0 58.0 57.0 60.0 57.0 59.0 59.0 60.0 59.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:73.00 stddev:4.58 (6.3%) stddev-sans-first:3.48 04:11:56 INFO - PROCESS | 1679 | Values: 64.0 70.0 76.0 72.0 80.0 79.0 71.0 73.0 73.0 73.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.00 stddev:2.80 (3.2%) stddev-sans-first:2.11 04:11:56 INFO - PROCESS | 1679 | Values: 82.0 87.0 86.0 87.0 88.0 89.0 92.0 88.0 91.0 86.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:155.00 stddev:16.02 (10.3%) stddev-sans-first:16.34 04:11:56 INFO - PROCESS | 1679 | Values: 136.0 154.0 165.0 136.0 128.0 156.0 146.0 164.0 172.0 128.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.60 Median:222.50 stddev:33.10 (14.9%) stddev-sans-first:32.19 04:11:56 INFO - PROCESS | 1679 | Values: 165.0 241.0 247.0 228.0 173.0 175.0 217.0 176.0 232.0 172.0 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.50 stddev:1.62 (2.3%) stddev-sans-first:1.58 04:11:56 INFO - PROCESS | 1679 | Values: 68.0 71.0 67.0 68.0 71.0 70.0 70.0 70.0 71.0 72.0 04:11:56 INFO - PROCESS | 1679 | -------- Summary: end -------- 04:11:56 INFO - PROCESS | 1679 | 04:11:56 INFO - TEST-INFO | 1679: exit 0 04:11:56 INFO - TEST-OK | kraken | took 60403ms 04:11:56 INFO - SUITE-END | took 1174s 04:11:57 INFO - Completed test suite (00:19:34) 04:11:57 INFO - javascript benchmark 04:11:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7221.144151447914, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.7375423089024, 3223.9355212895744, 3297.835108244589, 3331.2005118771503, 3396.405629014922, 4550.408446901906, 5585.52523035542, 5632.633878797876, 5650.180723795047, 5862.589618726696, 5440.972795136028, 5595.776168953237, 5612.438756124386, 5684.289463817023, 5730.512906402951, 5069.163588007974, 5132.769025393866, 5233.65981211222, 5240.266362709223, 5246.186841039645, 5044.924326135111, 5319.973400132994, 5331.6534425262425, 5335.919961200585, 5353.00969320675, 5072.746362681888, 5098.388193416777, 5193.688378697271, 5204.089284375219, 5238.371395432553, 5119.104156772587, 5122.795088196468, 5133.717645529495, 5155.561777248939, 5214.165733482625, 5139.203423469368, 5141.331626888481, 5157.6647517911215, 5179.14544100223, 5193.221016847503, 5562.7774889004395, 5615.634983726045, 5685.374608793029, 5695.5443564514735, 5721.456461636138, 5068.214426763858, 5533.280673512418, 6012.098185272201, 6088.0, 6160.44555989963, 6185.969070154621, 6213.627182369027, 6235.407636274546, 6240.157578726859, 6245.188125543696, 5604.887902241932, 5643.125315576092, 5681.034224181816, 5693.459121383462, 5739.626924249952, 6229.065640154013, 6233.3143354231, 6262.906056409158, 6280.466160376328, 6307.905381419282, 6003.0695242237525, 6020.608660437058, 6021.488173505301, 6023.066424704178, 6056.576039677268, 6069.484093852072, 6115.778948468095, 6139.263288405331, 6153.800008998202, 6175.59858609189, 5971.611845230046, 6102.755889764359, 6123.374132580074, 6134.130457564626, 6142.867137759686, 6079.8480037998515, 6122.510199184055, 6153.569250152446, 6194.566380353332, 6200.658963756947, 4828.61371090319, 4890.266460031024, 4918.458969513351, 4926.014797040534, 4934.580560652313, 4404.779761011937, 4407.867763967086, 4409.162259170747, 4505.909881802411, 4516.3902873112365, 4668.4631267404, 5663.461971112738, 5668.971655141698, 5684.715764211773, 5757.280339957505, 6078.1186727924205, 6129.049997250433, 6227.844303892349, 6234.0337247726675, 6247.562670613104, 5580.441955804387, 5597.720113994284, 5608.69152196625, 5664.8867022659315, 5675.31896172462, 5329.333833270841, 5329.507737833413, 5333.919991200135, 5335.67985920846, 5343.65266257692, 6158.507319414526, 6174.876502469836, 6221.440070393686, 6251.812445626639, 6254.781082662085, 5110.48895110486, 6149.538784591084, 6239.188905442264, 6270.968645156745, 6288.402601752826, 6197.163382943245, 6229.0, 6260.68696565179, 6261.311255761953, 6264.530160238091, 5941.346451890375, 6046.153538504701, 6097.847553811191, 6132.78535251264, 6143.447089761943, 5107.310513080686, 6164.938350616616, 6236.220472440945, 6241.968790156202, 6254.874902501833, 5960.701964901824, 5974.253218347707, 6035.879282414239, 6039.0, 6049.727762250797, 5831.4168583141345, 5984.311804142405, 6043.728032238648, 6043.939560604338, 6055.0, 5785.479306862402, 5805.593608447537, 5841.620294681002, 5862.560307976833, 5957.642541447353, 4370.344448332648, 4746.264329029006, 4817.373741413734, 5042.873928151679, 6095.299040610386, 5683.147527870852, 5834.212381328636, 5895.380984996514, 5950.137230101697, 5965.164876917322], "value": 5581.335947444195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.9500654927957, 471.4884350479729, 515.5875299760191, 516.7211152397816, 548.700957977902, 37321.0, 39852.800735996316, 39858.003549911264, 39976.40035399464, 40046.59953400469, 40268.79865600668, 40821.387679184765, 40878.79560602193, 40989.180216395725, 41007.17985640285, 8408.159184081604, 9200.263978881674, 9645.22838172948, 9661.855072173923, 9686.46724430156, 7938.6427610757655, 9393.483358415284, 9537.093976072261, 9558.0, 9575.138237558618, 9537.856932146024, 9545.284103692216, 9553.283503737248, 9555.901071376777, 9570.808583828319, 9453.33826632136, 9486.193673537757, 9489.14597686208, 9491.335606507548, 9526.333156679035, 9526.85709714355, 9595.23238140947, 9615.471149086798, 9624.37441566296, 9628.759281017961, 34688.653113469045, 39029.0, 39090.80454597737, 39195.804020979995, 39393.40909886354, 3356.516178028266, 3387.4241378965635, 3523.9647603523895, 3681.9263614727556, 3975.0, 24424.63363049556, 29286.414271714446, 29559.97408680923, 29583.0, 29736.95920642767, 3183.2041989502623, 3234.3692979868933, 3234.3692979868933, 3272.4061017050662, 3321.4187517184396, 432087.0, 467789.0, 471515.0, 473565.264347359, 473625.15937101503, 57751.401186946685, 57980.71009644925, 58013.709931450074, 58079.0, 58169.4183058164, 28353.007644732334, 29098.0, 29672.258193545335, 30502.847485762428, 60101.398986010456, 16454.670906581803, 16652.666946661, 16657.083860387796, 16659.583510412092, 16668.916655416888, 11536.019438347666, 12223.0, 12763.361831908553, 12832.29422381778, 12864.421101050475, 18822.153003114618, 18911.90544047271, 18919.527011824815, 18923.905380473287, 18955.62088758245, 6163.952128138228, 6540.836479087966, 6890.725215835087, 7559.0, 7731.961340193263, 712.7932899459099, 788.8185717285056, 807.9859775981106, 888.8577827547562, 932.7668082979255, 28901.56647650287, 29223.0, 29806.25484362908, 29930.802767889476, 30184.005133638486, 838.3628442383832, 978.9559469823876, 982.916452101565, 1094.0143639294654, 1121.097516499226, 15263.313150908236, 15298.311575979107, 15388.769168462482, 15416.306266218047, 15844.76232856508, 635677.0, 641313.0, 646094.0, 649291.0, 652515.0, 49266.0, 54782.726086369315, 54925.45074549203, 55701.72149139229, 55748.44251557432, 1285.9614211573669, 1287.4077924154806, 1323.285425870058, 1324.3775425549977, 1330.5808670268834, 23957.687616229246, 24480.755192447847, 28350.44072576028, 29880.551791722708, 29967.0, 48902.75548622234, 49013.628228331516, 49119.50880491149, 49186.01627967349, 49202.753986229836, 558962.0, 559180.0, 559863.0, 560513.0, 561670.0, 25689.743102568737, 26186.476270474104, 26236.475270494866, 26295.868520657274, 26300.8684956574, 44159.33760993652, 44643.10713785771, 46342.30486542772, 46638.53361466342, 47084.0, 37523.37006245285, 38204.0, 38297.61702383052, 39080.41379379368, 39669.60330396774, 37490.437643435915, 37634.8118259407, 38772.80613596914, 39064.60935390723, 39619.2076158481, 31177.37645247128, 36465.63534364622, 36564.81717591395, 37912.0, 38096.04759880914, 26110.216693499224, 27635.723642763314, 33719.662803371655, 33986.0, 34146.14634634154, 20011.899940500203, 25252.0, 25320.620190696787, 25634.359141021625, 25692.871535642204], "value": 19082.51232984204, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.7026378896883, 373.3857803912565, 374.63098847635075, 383.18381846666597, 396.8610986154846, 19524.804751952495, 20343.49141271469, 21687.99999999998, 21757.782422175773, 21826.563468730637, 12021.398930053507, 12241.449134788934, 14421.495247666333, 16396.83603163968, 20128.396148115542, 5436.537894278991, 5639.774409023634, 5655.236543066695, 5678.148277758328, 5690.544756419497, 4274.0, 6204.78283260086, 6260.937390626081, 6275.807596556662, 6279.591826531261, 6252.3122456529745, 6255.468285195764, 6266.937330626703, 6275.843103922392, 6360.968195159017, 5889.793857214999, 6838.794836154899, 6930.826729331757, 6936.965315173392, 6954.130733658293, 5827.426594819417, 6058.485028772559, 6065.423784740443, 6092.329843717188, 6109.938900611026, 25106.995720171355, 25501.362465938313, 25597.0, 25694.614580781305, 26069.869650651814, 2105.9157633694635, 2325.7557956414503, 2390.71311442628, 2581.651477050593, 2628.9605655915175, 9946.90053099467, 10054.145397641209, 10247.82150052746, 10488.68533943983, 10495.842562361571, 1869.598036422162, 1900.4108726294892, 1915.1573307744547, 1930.2624462230967, 1986.5530255692497, 97348.51325743397, 117072.41463792711, 121249.0, 122507.0, 123189.0, 9649.372790768577, 11326.490307936163, 11516.424178791027, 11573.826392604118, 11620.53517859293, 14461.349239284258, 14514.346854391577, 14532.709345813024, 14540.49108281205, 14547.927260363842, 8345.624446899783, 8654.78363040929, 8709.12908709124, 8747.693830715894, 8830.823383532294, 8575.528345941033, 8582.699605513777, 8591.527465989306, 8684.088170741981, 8744.994325652631, 3797.867074652374, 4433.844815431509, 4519.81920723174, 4521.344405061313, 4601.723896566216, 1717.1671739206474, 1906.6949288114113, 1914.7798003229527, 1934.5067007912892, 1938.5541325495215, 814.5031530766228, 882.6292956958093, 906.2930913887178, 941.110650435332, 964.4406244378243, 19709.70435443441, 21003.369898903056, 21031.05360258792, 21267.93660316978, 21359.359219223446, 923.2660035271975, 934.076877116115, 961.0869673809908, 965.8744363232735, 995.5121990224737, 10519.053285204216, 11193.776124477628, 11298.830517542243, 11346.773064538664, 11378.0, 552401.0, 556103.4389656133, 563245.0, 564100.0, 564907.0, 112063.87936120697, 124312.0, 131271.0, 135498.0, 135821.0, 980.8087422952456, 1006.0543089495997, 1023.6212601337404, 1026.7484466305802, 1027.9897201027893, 14008.859911401163, 16131.919340403692, 18270.0, 19230.326938557642, 19256.807431926063, 38355.424668629435, 52277.47722522878, 53597.464025359244, 54614.0, 57196.0, 84769.57615211884, 84925.57537212274, 85404.57297713471, 86198.56900715457, 87338.0, 6907.585544867324, 7208.531445456028, 7274.0, 7591.202923692933, 8098.420807942631, 11571.884281157418, 12884.677883052998, 12989.28558929268, 13231.139975901535, 13319.800202997156, 11071.446427678422, 11168.21822472419, 11594.246373985665, 11701.707457313294, 11704.765904681688, 10991.890081099087, 11077.501512431798, 11313.264637798517, 11337.773244535229, 11603.303801771921, 11161.051310638686, 11409.54361825551, 11708.473118709508, 11791.410429478321, 11839.58561450345, 5713.571482138939, 5924.644521328734, 6200.472959798468, 6348.016057511093, 7493.400527957641, 11045.337279762918, 11097.112231021338, 11224.382658953837, 11445.370504622326, 11565.421728913689], "value": 9503.113881714178, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.5297504798466, 1503.2333509909945, 1662.7505874118888, 1678.2951160512584, 1829.6066345735655, 7964.641591128398, 8508.829823403536, 8667.0, 9052.1853033227, 9080.27357811375, 8015.078265999412, 8639.39524233304, 8858.822823543525, 8859.778505537348, 8870.201681848648, 1847.2426305214865, 2102.054075665949, 2334.1130370459246, 2367.3134790910617, 2382.773636504538, 2337.392278007722, 2373.5134297468976, 2389.104085967762, 2389.163792672568, 2403.987980060106, 2360.303710405426, 2374.7862692357685, 2381.8213633977434, 2382.8451150675237, 2388.0447820871705, 2027.472857057161, 2339.356676913845, 2344.296710986706, 2352.1414683640432, 2355.2698663414394, 2008.9397318080335, 2302.5164715409783, 2311.722593288799, 2355.2698663414394, 2359.5045040541336, 8872.600732967032, 8913.420627659181, 8923.687670931551, 8924.33067519932, 8952.0, 5203.9219411708855, 5355.143177091647, 5355.437679043684, 5380.865478363033, 5406.648567843077, 3570.7500474966764, 3643.453481977698, 3769.321522126016, 3777.7166712496673, 3790.0, 1067.9733006674817, 1089.9019088282014, 1111.2832223216062, 1128.700894263021, 1131.8641762988493, 11897.167198296123, 11983.88016119845, 12048.518059277618, 12081.395930203455, 12086.033117350591, 4543.727756228195, 4651.348811166439, 4805.783739731721, 4853.199222128309, 4868.707877527359, 8689.782755431164, 9552.61789528425, 9768.267379946532, 9864.457454839909, 9959.15347195482, 5285.101532739443, 5325.4940780625775, 5326.6005049621435, 5329.387120481194, 5343.091674415358, 4393.143337049309, 4737.0, 4875.19559272716, 4898.24077268024, 4913.680610760289, 3656.323580137683, 3707.5180226570374, 3896.2597106549665, 3941.467901833216, 3954.3475326570792, 1266.1263728027816, 1273.980890286628, 1276.3618190904547, 1277.431542963391, 1279.7888348422591, 803.2650125135435, 824.9092599814015, 840.7309660908451, 856.259335674637, 885.0, 5565.359983601857, 5590.608657393944, 5777.855553611109, 6009.699515024231, 6169.180091872819, 783.3576467296762, 925.2181906289175, 939.6617217801722, 1008.6116845014575, 1016.8423894296396, 3672.485851980725, 3707.7589956652732, 4053.1285773558825, 4120.979395103005, 4126.814293356806, 10409.271351005356, 10845.891541084646, 10861.076808471369, 10886.346819190874, 10912.127029837595, 10566.894331056745, 10679.519421626046, 10762.946185269024, 10871.239013269153, 10928.344299342065, 7134.750283740044, 7613.238676132342, 7675.884861727079, 8116.675332986614, 8339.12439193876, 5114.488551144856, 5839.328477225004, 5912.852178695567, 5925.200097986716, 5957.463828255478, 8060.0, 8712.738617841474, 10048.799024019625, 10178.745531361776, 10194.490275486047, 8679.132086791271, 8827.382083254368, 9569.425834449956, 9644.469554174308, 10290.742731431774, 5393.6763794172475, 6467.3209313023335, 6973.267806880204, 7051.400630946427, 7175.712971481083, 7157.141143062866, 8261.215184557457, 8464.153584641486, 8557.44376615518, 8562.100979397323, 7415.555066696015, 7466.664000120117, 7510.511816731895, 7525.661345239587, 7620.466567340233, 7357.153927298429, 7387.889181662172, 7422.257774222535, 7556.546607203365, 7559.924400755922, 6916.619585922621, 7023.438124950094, 7088.610126443095, 7096.929030709627, 7097.219305876452, 4971.751412429292, 4991.875203119951, 5079.5428411443145, 5147.485251474973, 5151.995360904588, 5055.620828437808, 5055.848324550269, 5174.7930082796265, 5212.635115542027, 5251.369835619597], "value": 4548.837031752064, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.51307646236774, 297.73650319467276, 311.270071681906, 312.43605292447154, 313.140429520965, 5339.55365527162, 5496.972515137429, 5554.361248456429, 5594.377630487159, 5613.389773755203, 5481.0, 5570.805021824227, 5597.776088956447, 5648.4633959773855, 5671.943280567193, 3436.7422443316727, 4269.423627810253, 4312.3531470279395, 4319.352097185416, 4327.350897365404, 3525.3301872644242, 3954.545227298854, 4323.805428755713, 4350.889114283287, 4377.511646040346, 4220.3036498977635, 4244.320908654616, 4265.488141423034, 4269.765162916038, 4277.508086570037, 3419.9658003420022, 4251.0, 4268.9573104268875, 4274.658027357804, 4295.5824577889225, 3548.27260411615, 3688.8524459021605, 3711.0, 3723.087843478338, 3731.0299322176156, 4831.541003604687, 4921.630877684188, 5371.677699338053, 5431.565474762009, 5480.80817171401, 4829.661923665345, 4860.379017631852, 4873.074115917964, 4885.487023862479, 4914.729689867056, 4712.434507859045, 5488.341399032101, 5851.0, 5981.043033114681, 5982.461578457916, 3923.431102490123, 3933.5476420211758, 3942.743721658083, 3944.349182384903, 3969.503812023497, 5281.498257665554, 6006.519478441714, 6158.9692051539905, 6215.595986260879, 6291.307956124822, 3847.499825022785, 3949.6445319921345, 3986.362182050858, 3999.1601763629383, 4011.277969965376, 3952.1622445562953, 4016.136530645925, 4021.4369988201674, 4023.5372932112596, 4048.1701251243426, 4742.383490146259, 4767.4994125617, 4787.234042553175, 4826.831060912851, 4834.589059929875, 5145.147746811145, 5811.854703632443, 6016.766562854605, 6030.803674052759, 6044.549308166009, 1379.0553470872485, 1380.1994842991041, 1382.3710211853584, 1384.5846246126123, 1385.217352196006, 751.9585374256694, 805.697863301262, 823.2919689067397, 841.2428814067389, 848.3849209323315, 4162.253971425681, 4287.142571485715, 4447.3329000650165, 4612.561806628365, 4646.6747327686735, 5075.8984820303385, 5078.187490001582, 5136.332276803992, 5167.17628954571, 5169.948300517022, 3678.5769636492146, 4668.439787225487, 4672.7290896372, 4682.601978831837, 4733.183755665374, 2348.3072493614427, 2641.960370594443, 2709.6858023858413, 2722.523558377276, 2732.562789953598, 4456.710313829655, 4547.044071657679, 4982.882275033169, 5128.846009647799, 5148.995945790535, 4360.781960902005, 4557.521460246627, 4571.954280457219, 4844.4186697596515, 5198.948010519846, 4115.0, 5009.321877171043, 5210.238573556021, 5221.817236396708, 5287.043793796243, 4148.647364974011, 4171.8097998551, 4216.683748718797, 4478.977605112084, 5016.5168241720585, 4513.2327504325, 4642.37327960721, 4652.673338562944, 4765.1892280933025, 5030.2957585937265, 4540.06928579647, 5186.507281808223, 5235.905637744932, 5271.182966640177, 5328.786848526015, 3132.9373412532077, 3529.023746701855, 3570.2155714942246, 3770.924581508409, 3906.5898080701118, 5461.863453413696, 5593.993081245252, 5597.013060363675, 5869.530437564899, 5952.642841429528, 5078.263651770399, 5323.520883120537, 5870.471657550841, 5880.676562789087, 5917.609361799888, 5031.4213865405945, 5250.401051479542, 5563.5271001963665, 5807.912881306868, 5838.182654428469, 5705.543556515386, 5739.942600573941, 5758.79607886237, 5777.7977770777825, 5805.129230615442, 5055.0, 5325.733713314241, 5900.409959004065, 5919.763209471573, 5920.082387229986, 5450.345958485007, 5752.827415177384, 5762.683052432157, 5786.929418057673, 5808.846674627662], "value": 4034.019170559552, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.8855088910329, 711.3384552366298, 754.1892465599481, 770.6223950264372, 787.4409169489662, 15054.84945150548, 15793.447229346975, 16187.109708966016, 16191.595210119753, 16243.918780406082, 12055.939720301409, 14512.927435362808, 14675.853241467583, 14700.926495367536, 14709.338079786408, 657.4871600151889, 812.5327936436543, 819.1358117186351, 834.0950069174952, 842.9452085614415, 836.4688422851502, 845.0, 845.733593917917, 846.4455781463151, 850.3409857360564, 798.4331124901298, 818.3289702443998, 878.1876763993313, 900.3967341880956, 901.4951627088818, 892.1479986612769, 892.3485855325583, 894.2577660541767, 894.8120894612139, 896.5382827843666, 618.2148671187612, 638.3233772201435, 655.7540922154192, 660.2671035151027, 662.0797092042066, 15203.467878624306, 15237.466688665954, 15248.847511524853, 15263.618409539851, 15294.235288235655, 11476.827847582294, 12211.877881221251, 14444.638884027878, 14653.194074325907, 14674.413023479048, 11804.704882377924, 11999.400029998465, 12011.39943002855, 12076.577319793852, 12084.758304833855, 3405.267867408494, 3749.550053993511, 3808.1812410331636, 3822.6559609635265, 3824.7513911595934, 96835.51582242044, 118853.81146188514, 124131.75868241383, 124522.0, 126784.36607816994, 10822.0, 11140.888591114148, 11180.664580062612, 11398.031167350868, 11671.474783634756, 21724.23965161212, 21817.781822181892, 21831.890840546013, 21862.453438663844, 21887.562248754937, 8067.193280671886, 8101.068377136587, 8169.0, 8280.337572994145, 8374.162583741578, 4456.799444025027, 4485.842995495142, 4548.226801443762, 4551.795169217393, 4643.8374656886845, 3124.4844600641095, 3520.8767693130617, 3644.6355364463343, 3671.3024525340634, 3681.318955993096, 523.6256076905031, 648.9059086432441, 654.0908137688616, 666.5800545656302, 678.8302924268933, 486.42358804816405, 579.3742757821627, 608.1364462463313, 644.6518879804946, 676.4182802789597, 8206.507609543447, 9096.772580685403, 9574.712758617252, 9698.224142068617, 9904.55429505674, 484.22282237009796, 594.7918228619949, 600.6816387314731, 622.2812651387654, 658.0974819321375, 4142.606452387018, 4526.411566496335, 4609.0, 4614.1694494991225, 4711.646626503026, 110795.0, 145443.0, 148082.0, 149470.0, 151166.0, 122342.0, 128410.0, 129095.0, 129918.0, 131128.0, 104083.32417939071, 110445.44777276223, 111027.44486277517, 112404.87595124108, 113190.86809131803, 8817.911820881965, 8927.821443571222, 8937.642494300155, 9032.32257580671, 9134.497602631918, 55530.61173470695, 60553.48616284452, 61478.46303842261, 61533.0, 62786.116416507575, 89881.0, 91940.54029729808, 94376.52811735898, 95681.0, 97797.51101244448, 11668.416579170838, 11818.349990750246, 11947.10396720232, 12168.817467737814, 12181.512739490676, 12892.41984110736, 13094.0, 13386.129901556367, 13854.445822167403, 13890.236037018061, 11966.940165299118, 12204.633860984184, 12300.507979680713, 12425.005999519835, 12722.300273485047, 11964.0, 12333.260004399765, 12341.876581234073, 12439.0, 12724.427400766803, 11854.288742675468, 12093.516259349528, 12157.817632735692, 12439.689007774878, 12535.623931282076, 10323.845142323022, 10470.633527826489, 10630.946845265724, 10693.249206317476, 10881.18391120685, 8614.78463038429, 10237.539310731185, 10288.639897603547, 10550.155987521133, 10565.049145576935], "value": 7633.305962438546, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1606.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 112.0, 118.0, 118.0, 112.0, 101.0, 116.0, 116.0, 117.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 136.0, 161.0, 112.0, 133.0, 130.0, 112.0, 180.0, 142.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 200.0, 209.0, 275.0, 187.0, 286.0, 255.0, 202.0, 201.0, 220.0], "value": 224.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 105.0, 77.0, 144.0, 59.0, 60.0, 59.0, 67.0, 136.0, 59.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 141.0, 73.0, 70.0, 81.0, 107.0, 68.0, 73.0, 108.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 81.0, 130.0, 135.0, 87.0, 89.0, 88.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 99.0, 98.0, 100.0, 99.0, 105.0, 98.0, 153.0, 133.0, 98.0], "value": 108.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 110.0, 90.0, 145.0, 131.0, 154.0, 150.0, 113.0, 94.0], "value": 117.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 58.0, 57.0, 60.0, 57.0, 59.0, 59.0, 60.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 76.0, 72.0, 80.0, 79.0, 71.0, 73.0, 73.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 86.0, 87.0, 88.0, 89.0, 92.0, 88.0, 91.0, 86.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 154.0, 165.0, 136.0, 128.0, 156.0, 146.0, 164.0, 172.0, 128.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 241.0, 247.0, 228.0, 173.0, 175.0, 217.0, 176.0, 232.0, 172.0], "value": 202.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 68.0, 71.0, 70.0, 70.0, 70.0, 71.0, 72.0], "value": 69.8, "unit": "score"}]}]} 04:11:57 INFO - Return code: 0 04:11:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:11:57 ERROR - # TBPL SUCCESS # 04:11:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:11:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:11:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:11:57 INFO - 2016-08-30 04:11:57.475 screenresolution[1685:10913] starting screenresolution argv=screenresolution get 04:11:57 INFO - 2016-08-30 04:11:57.478 screenresolution[1685:10913] Display 0: 1600x1200x32@60 04:11:57 INFO - 2016-08-30 04:11:57.484 screenresolution[1686:10916] starting screenresolution argv=screenresolution list 04:11:57 INFO - Available Modes on Display 0 04:11:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:11:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:11:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:11:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:11:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:11:57 INFO - Intel Iris: 04:11:57 INFO - Chipset Model: Intel Iris 04:11:57 INFO - Type: GPU 04:11:57 INFO - Bus: Built-In 04:11:57 INFO - VRAM (Dynamic, Max): 1536 MB 04:11:57 INFO - Vendor: Intel (0x8086) 04:11:57 INFO - Device ID: 0x0a2e 04:11:57 INFO - Revision ID: 0x0009 04:11:57 INFO - Displays: 04:11:57 INFO - Display: 04:11:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:11:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:11:57 INFO - Display Serial Number: 1600x1200 60 04:11:57 INFO - Main Display: Yes 04:11:57 INFO - Mirror: Off 04:11:57 INFO - Online: Yes 04:11:57 INFO - Rotation: Supported 04:11:57 INFO - Return code: 0 04:11:57 INFO - Running post-action listener: _resource_record_post_action 04:11:57 INFO - [mozharness: 2016-08-30 11:11:57.723061Z] Finished run-tests step (success) 04:11:57 INFO - Running post-run listener: _resource_record_post_run 04:11:57 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 32054272; Write bytes: 708263936; Read time: 198; Write time: 2065 04:11:57 INFO - TinderboxPrint: CPU usage
54.5% 04:11:57 INFO - TinderboxPrint: I/O read bytes / time
32,054,272 / 198 04:11:57 INFO - TinderboxPrint: I/O write bytes / time
708,263,936 / 2,065 04:11:57 INFO - TinderboxPrint: CPU idle
2,200.9 (45.5%) 04:11:57 INFO - TinderboxPrint: CPU system
974.7 (20.1%) 04:11:57 INFO - TinderboxPrint: CPU user
1,662.2 (34.4%) 04:11:57 INFO - TinderboxPrint: Swap in / out
434,335,744 / 0 04:11:57 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388424192; Write bytes: 384308736; Read time: 29625; Write time: 835 04:11:57 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 30931968; Write bytes: 297736704; Read time: 183; Write time: 1171 04:11:58 INFO - Running post-run listener: _upload_blobber_files 04:11:58 INFO - Blob upload gear active. 04:11:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:11:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:11:58 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'] 04:11:58 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 04:11:58 INFO - (blobuploader) - INFO - Open directory for files ... 04:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:11:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:59 INFO - (blobuploader) - INFO - Done attempting. 04:11:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:11:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:12:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:00 INFO - (blobuploader) - INFO - Done attempting. 04:12:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:12:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:12:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:03 INFO - (blobuploader) - INFO - Done attempting. 04:12:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:03 INFO - Return code: 0 04:12:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23a567a276838fc9153603e59fd614f3e6635a64139c8d4688319443e664d75eafdbe12139f74590d961e85fab59cccf5410203a85fc3902886c22a2bae3e22e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a270a91824c239988efc9a27121b230d1d7d14f7fdd53a4360db926dd430204e565a470bc45f97a0016637ab340e3a663fe142c46cb369a4e08fcb005b25911c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d163d03f54d6545f5efb51a728a3e2ff8ed222bc54816f3144826ffa93411ca95f305f0024725ffb25ae32d3e91b430cdb8f7592333ca4555ad2c6f5eb1c8ad"} 04:12:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:03 INFO - Contents: 04:12:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23a567a276838fc9153603e59fd614f3e6635a64139c8d4688319443e664d75eafdbe12139f74590d961e85fab59cccf5410203a85fc3902886c22a2bae3e22e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a270a91824c239988efc9a27121b230d1d7d14f7fdd53a4360db926dd430204e565a470bc45f97a0016637ab340e3a663fe142c46cb369a4e08fcb005b25911c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d163d03f54d6545f5efb51a728a3e2ff8ed222bc54816f3144826ffa93411ca95f305f0024725ffb25ae32d3e91b430cdb8f7592333ca4555ad2c6f5eb1c8ad"} 04:12:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:03 INFO - Copying logs to upload dir... 04:12:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.337162 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-30 04:12:03.444962) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 04:12:03.448899) ========= 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.NdMNM0rzYX/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.IViecQALW6/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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/23a567a276838fc9153603e59fd614f3e6635a64139c8d4688319443e664d75eafdbe12139f74590d961e85fab59cccf5410203a85fc3902886c22a2bae3e22e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a270a91824c239988efc9a27121b230d1d7d14f7fdd53a4360db926dd430204e565a470bc45f97a0016637ab340e3a663fe142c46cb369a4e08fcb005b25911c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d163d03f54d6545f5efb51a728a3e2ff8ed222bc54816f3144826ffa93411ca95f305f0024725ffb25ae32d3e91b430cdb8f7592333ca4555ad2c6f5eb1c8ad"} build_url:https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011057 build_url: 'https://queue.taskcluster.net/v1/task/bMNpYUanScyQrR-tWrYACg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23a567a276838fc9153603e59fd614f3e6635a64139c8d4688319443e664d75eafdbe12139f74590d961e85fab59cccf5410203a85fc3902886c22a2bae3e22e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a270a91824c239988efc9a27121b230d1d7d14f7fdd53a4360db926dd430204e565a470bc45f97a0016637ab340e3a663fe142c46cb369a4e08fcb005b25911c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d163d03f54d6545f5efb51a728a3e2ff8ed222bc54816f3144826ffa93411ca95f305f0024725ffb25ae32d3e91b430cdb8f7592333ca4555ad2c6f5eb1c8ad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 04:12:03.482754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 04:12:03.483086) ========= 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.NdMNM0rzYX/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.IViecQALW6/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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.005086 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 04:12:03.532089) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 04:12:03.532417) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 04:12:03.532720) ========= ========= Total master_lag: 0.18 =========