builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0154 starttime: 1464436389.57 results: success (0) buildid: 20160528032836 builduid: 21f2e1b848b64280a2fbf75b97eedc1d revision: 7e64e2bf7665ee3ace2a4d2c4097afb8cc72096a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:09.566677) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:09.567179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:09.567457) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:09.711352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:09.711652) ========= 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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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-05-28 04:53:08-- 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% 8.04M=0.001s 2016-05-28 04:53:09 (8.04 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.651065 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:10.397676) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:10.398150) ========= 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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.018779 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:10.453189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 04:53:10.453510) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7e64e2bf7665ee3ace2a4d2c4097afb8cc72096a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7e64e2bf7665ee3ace2a4d2c4097afb8cc72096a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4z3aZKKT8C/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.aQo7LmPmJl/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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-05-28 04:53:09,664 truncating revision to first 12 chars 2016-05-28 04:53:09,664 Setting DEBUG logging. 2016-05-28 04:53:09,664 attempt 1/10 2016-05-28 04:53:09,664 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7e64e2bf7665?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 04:53:10,453 unpacking tar archive at: mozilla-beta-7e64e2bf7665/testing/mozharness/ program finished with exit code 0 elapsedTime=1.051483 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 04:53:11.524758) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:11.525079) ========= script_repo_revision: 7e64e2bf7665ee3ace2a4d2c4097afb8cc72096a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:11.525454) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:11.525720) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 04:53:11.541989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-28 04:53:11.542452) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4z3aZKKT8C/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.aQo7LmPmJl/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:53:10 INFO - MultiFileLogger online at 20160528 04:53:10 in /builds/slave/test 04:53:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:53:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:53:10 INFO - {'append_to_log': False, 04:53:10 INFO - 'base_work_dir': '/builds/slave/test', 04:53:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:53:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:53:10 INFO - 'branch': 'Mozilla-Beta', 04:53:10 INFO - 'buildbot_json_path': 'buildprops.json', 04:53:10 INFO - 'config_files': ('talos/mac_config.py',), 04:53:10 INFO - 'default_actions': ('clobber', 04:53:10 INFO - 'read-buildbot-config', 04:53:10 INFO - 'download-and-extract', 04:53:10 INFO - 'populate-webroot', 04:53:10 INFO - 'create-virtualenv', 04:53:10 INFO - 'install', 04:53:10 INFO - 'run-tests'), 04:53:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:53:10 INFO - 'download_minidump_stackwalk': True, 04:53:10 INFO - 'download_symbols': 'ondemand', 04:53:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:53:10 INFO - 'tooltool.py': '/tools/tooltool.py', 04:53:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:53:10 INFO - '/tools/misc-python/virtualenv.py')}, 04:53:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:53:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:53:10 INFO - 'installer_path': 'installer.exe', 04:53:10 INFO - 'log_level': 'info', 04:53:10 INFO - 'log_name': 'talos', 04:53:10 INFO - 'log_to_console': True, 04:53:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:53:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:53:10 INFO - 'opt_config_files': (), 04:53:10 INFO - 'pip_index': False, 04:53:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:53:10 INFO - 'cmd': ('bash', 04:53:10 INFO - '-c', 04:53:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:53:10 INFO - 'enabled': True, 04:53:10 INFO - 'halt_on_failure': False, 04:53:10 INFO - 'name': 'check_screen_resolution'},), 04:53:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:53:10 INFO - 'cmd': ('bash', 04:53:10 INFO - '-c', 04:53:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:53:10 INFO - 'enabled': True, 04:53:10 INFO - 'halt_on_failure': False, 04:53:10 INFO - 'name': 'check_screen_resolution'},), 04:53:10 INFO - 'run_cmd_checks_enabled': True, 04:53:10 INFO - 'sps_profile': False, 04:53:10 INFO - 'sps_profile_interval': 0, 04:53:10 INFO - 'suite': 'dromaeojs-e10s', 04:53:10 INFO - 'system_bits': '32', 04:53:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:53:10 INFO - 'title': 't-yosemite-r7-0154', 04:53:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:53:10 INFO - 'use_talos_json': True, 04:53:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:53:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:53:10 INFO - 'work_dir': 'build'} 04:53:10 INFO - ##### 04:53:10 INFO - ##### Running clobber step. 04:53:10 INFO - ##### 04:53:10 INFO - Running pre-action listener: _resource_record_pre_action 04:53:10 INFO - Running main action method: clobber 04:53:10 INFO - rmtree: /builds/slave/test/build 04:53:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:53:11 INFO - Running post-action listener: _resource_record_post_action 04:53:11 INFO - ##### 04:53:11 INFO - ##### Running read-buildbot-config step. 04:53:11 INFO - ##### 04:53:11 INFO - Running pre-action listener: _resource_record_pre_action 04:53:11 INFO - Running main action method: read_buildbot_config 04:53:11 INFO - Using buildbot properties: 04:53:11 INFO - { 04:53:11 INFO - "project": "", 04:53:11 INFO - "product": "firefox", 04:53:11 INFO - "script_repo_revision": "production", 04:53:11 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:53:11 INFO - "repository": "", 04:53:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:53:11 INFO - "buildid": "20160528032836", 04:53:11 INFO - "pgo_build": "False", 04:53:11 INFO - "basedir": "/builds/slave/test", 04:53:11 INFO - "buildnumber": 24, 04:53:11 INFO - "slavename": "t-yosemite-r7-0154", 04:53:11 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:53:11 INFO - "platform": "yosemite_r7", 04:53:11 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:53:11 INFO - "branch": "mozilla-beta", 04:53:11 INFO - "repo_path": "releases/mozilla-beta", 04:53:11 INFO - "revision": "7e64e2bf7665ee3ace2a4d2c4097afb8cc72096a", 04:53:11 INFO - "stage_platform": "macosx64", 04:53:11 INFO - "builduid": "21f2e1b848b64280a2fbf75b97eedc1d", 04:53:11 INFO - "slavebuilddir": "test" 04:53:11 INFO - } 04:53:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 04:53:11 INFO - Running post-action listener: _resource_record_post_action 04:53:11 INFO - ##### 04:53:11 INFO - ##### Running download-and-extract step. 04:53:11 INFO - ##### 04:53:11 INFO - Running pre-action listener: _resource_record_pre_action 04:53:11 INFO - Running main action method: download_and_extract 04:53:11 INFO - mkdir: /builds/slave/test/build/tests 04:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:11 INFO - https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:53:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 04:53:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 04:53:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 04:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 04:53:11 INFO - Downloaded 1241 bytes. 04:53:11 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 04:53:11 INFO - Using the following test package requirements: 04:53:11 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 04:53:11 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:53:11 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 04:53:11 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:53:11 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 04:53:11 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:53:11 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:53:11 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 04:53:11 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 04:53:11 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:53:11 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 04:53:11 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:53:11 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 04:53:11 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:53:11 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 04:53:11 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 04:53:11 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:53:11 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 04:53:11 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 04:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:11 INFO - https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:53:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 04:53:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 04:53:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 04:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 04:53:14 INFO - Downloaded 17816900 bytes. 04:53:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:53:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:53:17 INFO - Return code: 0 04:53:17 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:17 INFO - https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:53:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 04:53:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 04:53:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 04:53:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 04:53:19 INFO - Downloaded 17816900 bytes. 04:53:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:53:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:53:23 INFO - Return code: 0 04:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:23 INFO - https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 04:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 04:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 04:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 04:53:25 INFO - Downloaded 10845194 bytes. 04:53:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:53:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:53:25 INFO - Return code: 0 04:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:25 INFO - https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 04:53:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 04:53:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 04:53:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 04:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 04:53:28 INFO - Downloaded 88467658 bytes. 04:53:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 04:53:28 INFO - mkdir: /builds/slave/test/properties 04:53:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:28 INFO - Contents: 04:53:28 INFO - build_url:https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 04:53:30 INFO - Running post-action listener: _resource_record_post_action 04:53:30 INFO - Running post-action listener: set_extra_try_arguments 04:53:30 INFO - ##### 04:53:30 INFO - ##### Running populate-webroot step. 04:53:30 INFO - ##### 04:53:30 INFO - Running pre-action listener: _resource_record_pre_action 04:53:30 INFO - Running main action method: populate_webroot 04:53:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:30 INFO - '--tppagecycles', 04:53:30 INFO - '7'], 04:53:30 INFO - 'tests': ['tsvgm']}}, 04:53:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:53:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:53:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:53:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:53:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:53:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:30 INFO - 'talos_options': ['--e10s'], 04:53:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:30 INFO - 'tests': ['damp', 'tps']}, 04:53:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:30 INFO - 'talos_options': ['--e10s'], 04:53:30 INFO - 'tests': ['damp', 'tps']}, 04:53:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:53:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:30 INFO - 'other': {'tests': ['a11yr', 04:53:30 INFO - 'ts_paint', 04:53:30 INFO - 'tpaint', 04:53:30 INFO - 'sessionrestore', 04:53:30 INFO - 'sessionrestore_no_auto_restore', 04:53:30 INFO - 'tabpaint']}, 04:53:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:53:30 INFO - 'tests': ['a11yr', 04:53:30 INFO - 'ts_paint', 04:53:30 INFO - 'tpaint', 04:53:30 INFO - 'sessionrestore', 04:53:30 INFO - 'sessionrestore_no_auto_restore', 04:53:30 INFO - 'tabpaint']}, 04:53:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:53:30 INFO - 'tests': ['a11yr', 04:53:30 INFO - 'ts_paint', 04:53:30 INFO - 'tpaint', 04:53:30 INFO - 'sessionrestore', 04:53:30 INFO - 'sessionrestore_no_auto_restore', 04:53:30 INFO - 'tabpaint']}, 04:53:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:53:30 INFO - 'tests': ['a11yr', 04:53:30 INFO - 'ts_paint', 04:53:30 INFO - 'tpaint', 04:53:30 INFO - 'sessionrestore', 04:53:30 INFO - 'sessionrestore_no_auto_restore', 04:53:30 INFO - 'tabpaint']}, 04:53:30 INFO - 'other_l64': {'tests': ['a11yr', 04:53:30 INFO - 'ts_paint', 04:53:30 INFO - 'tpaint', 04:53:30 INFO - 'sessionrestore', 04:53:30 INFO - 'sessionrestore_no_auto_restore', 04:53:30 INFO - 'tabpaint']}, 04:53:30 INFO - 'other_nol64': {'tests': ['a11yr', 04:53:30 INFO - 'ts_paint', 04:53:30 INFO - 'tpaint', 04:53:30 INFO - 'sessionrestore', 04:53:30 INFO - 'sessionrestore_no_auto_restore', 04:53:30 INFO - 'tabpaint']}, 04:53:30 INFO - 'svgr': {'tests': ['tsvgx', 04:53:30 INFO - 'tsvgr_opacity', 04:53:30 INFO - 'tart', 04:53:30 INFO - 'tscrollx', 04:53:30 INFO - 'cart']}, 04:53:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:53:30 INFO - 'tests': ['tsvgx', 04:53:30 INFO - 'tsvgr_opacity', 04:53:30 INFO - 'tart', 04:53:30 INFO - 'tscrollx', 04:53:30 INFO - 'cart']}, 04:53:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:30 INFO - 'tests': ['tp5o']}, 04:53:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:30 INFO - 'talos_options': ['--e10s'], 04:53:30 INFO - 'tests': ['tp5o']}, 04:53:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:30 INFO - 'talos_options': ['--xperf_path', 04:53:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:30 INFO - 'tests': ['tp5n']}, 04:53:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:30 INFO - 'talos_options': ['--e10s', 04:53:30 INFO - '--xperf_path', 04:53:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:30 INFO - 'tests': ['tp5n']}}, 04:53:30 INFO - 'talos.zip': {'path': '', 04:53:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:30 INFO - Running post-action listener: _resource_record_post_action 04:53:30 INFO - ##### 04:53:30 INFO - ##### Running create-virtualenv step. 04:53:30 INFO - ##### 04:53:30 INFO - Running pre-action listener: _resource_record_pre_action 04:53:30 INFO - Running main action method: create_virtualenv 04:53:30 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:53:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:30 INFO - Using real prefix '/tools/python27' 04:53:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:30 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:33 INFO - Installing pip.................done. 04:53:33 INFO - Return code: 0 04:53:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc670d44660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd2d30>, '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 0x109a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9b20>, '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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:53:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z3aZKKT8C/Render', 04:53:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:33 INFO - 'HOME': '/Users/cltbld', 04:53:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:33 INFO - 'LOGNAME': 'cltbld', 04:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:33 INFO - 'MOZ_NO_REMOTE': '1', 04:53:33 INFO - 'NO_EM_RESTART': '1', 04:53:33 INFO - 'PAGER': '/bin/cat', 04:53:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:33 INFO - 'PWD': '/builds/slave/test', 04:53:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:33 INFO - 'SHELL': '/bin/bash', 04:53:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQo7LmPmJl/Listeners', 04:53:33 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 04:53:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:33 INFO - 'USER': 'cltbld', 04:53:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:33 INFO - 'XPC_FLAGS': '0x0', 04:53:33 INFO - 'XPC_SERVICE_NAME': '0', 04:53:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:53:34 INFO - Cleaning up... 04:53:34 INFO - Return code: 0 04:53:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:34 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc670d44660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd2d30>, '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 0x109a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9b20>, '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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:34 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>=0.7.1'] in /builds/slave/test/build 04:53:34 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>=0.7.1 04:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z3aZKKT8C/Render', 04:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:34 INFO - 'HOME': '/Users/cltbld', 04:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:34 INFO - 'LOGNAME': 'cltbld', 04:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:34 INFO - 'MOZ_NO_REMOTE': '1', 04:53:34 INFO - 'NO_EM_RESTART': '1', 04:53:34 INFO - 'PAGER': '/bin/cat', 04:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:34 INFO - 'PWD': '/builds/slave/test', 04:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:34 INFO - 'SHELL': '/bin/bash', 04:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQo7LmPmJl/Listeners', 04:53:34 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 04:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:34 INFO - 'USER': 'cltbld', 04:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:34 INFO - 'XPC_FLAGS': '0x0', 04:53:34 INFO - 'XPC_SERVICE_NAME': '0', 04:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:34 INFO - Downloading/unpacking psutil>=0.7.1 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:37 INFO - Installing collected packages: psutil 04:53:37 INFO - Running setup.py install for psutil 04:53:37 INFO - building 'psutil._psutil_osx' extension 04:53:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:53:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:53:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:53:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:53:37 INFO - building 'psutil._psutil_posix' extension 04:53:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:53:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:53:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:53:37 INFO - ^ 04:53:37 INFO - 1 warning generated. 04:53:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:53:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:38 INFO - Successfully installed psutil 04:53:38 INFO - Cleaning up... 04:53:38 INFO - Return code: 0 04:53:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:38 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc670d44660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd2d30>, '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 0x109a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9b20>, '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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:38 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.0.0'] in /builds/slave/test/build 04:53:38 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.0.0 04:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z3aZKKT8C/Render', 04:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:38 INFO - 'HOME': '/Users/cltbld', 04:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:38 INFO - 'LOGNAME': 'cltbld', 04:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:38 INFO - 'MOZ_NO_REMOTE': '1', 04:53:38 INFO - 'NO_EM_RESTART': '1', 04:53:38 INFO - 'PAGER': '/bin/cat', 04:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:38 INFO - 'PWD': '/builds/slave/test', 04:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:38 INFO - 'SHELL': '/bin/bash', 04:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQo7LmPmJl/Listeners', 04:53:38 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 04:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:38 INFO - 'USER': 'cltbld', 04:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:38 INFO - 'XPC_FLAGS': '0x0', 04:53:38 INFO - 'XPC_SERVICE_NAME': '0', 04:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:53:41 INFO - Installing collected packages: mozsystemmonitor 04:53:41 INFO - Running setup.py install for mozsystemmonitor 04:53:41 INFO - Successfully installed mozsystemmonitor 04:53:41 INFO - Cleaning up... 04:53:41 INFO - Return code: 0 04:53:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:41 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 0x109d2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc670d44660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd2d30>, '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 0x109a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9b20>, '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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z3aZKKT8C/Render', 04:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:41 INFO - 'HOME': '/Users/cltbld', 04:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:41 INFO - 'LOGNAME': 'cltbld', 04:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:41 INFO - 'MOZ_NO_REMOTE': '1', 04:53:41 INFO - 'NO_EM_RESTART': '1', 04:53:41 INFO - 'PAGER': '/bin/cat', 04:53:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:41 INFO - 'PWD': '/builds/slave/test', 04:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:41 INFO - 'SHELL': '/bin/bash', 04:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQo7LmPmJl/Listeners', 04:53:41 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 04:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:41 INFO - 'USER': 'cltbld', 04:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:41 INFO - 'XPC_FLAGS': '0x0', 04:53:41 INFO - 'XPC_SERVICE_NAME': '0', 04:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:45 INFO - Downloading docopt-0.6.1.tar.gz 04:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:45 INFO - Running setup.py install for blobuploader 04:53:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:45 INFO - Running setup.py install for requests 04:53:45 INFO - Running setup.py install for docopt 04:53:46 INFO - Successfully installed blobuploader requests docopt 04:53:46 INFO - Cleaning up... 04:53:46 INFO - Return code: 0 04:53:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:46 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 0x109d2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc670d44660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd2d30>, '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 0x109a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9b20>, '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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z3aZKKT8C/Render', 04:53:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:46 INFO - 'HOME': '/Users/cltbld', 04:53:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:46 INFO - 'LOGNAME': 'cltbld', 04:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:46 INFO - 'MOZ_NO_REMOTE': '1', 04:53:46 INFO - 'NO_EM_RESTART': '1', 04:53:46 INFO - 'PAGER': '/bin/cat', 04:53:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:46 INFO - 'PWD': '/builds/slave/test', 04:53:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:46 INFO - 'SHELL': '/bin/bash', 04:53:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQo7LmPmJl/Listeners', 04:53:46 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 04:53:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:46 INFO - 'USER': 'cltbld', 04:53:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:46 INFO - 'XPC_FLAGS': '0x0', 04:53:46 INFO - 'XPC_SERVICE_NAME': '0', 04:53:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:46 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-1XmZbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:46 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-QfErWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:46 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-IHE66Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:46 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-lpfafP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:46 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-EkNPxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:46 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-RQjYzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:47 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-q73dBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:47 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-DRmlVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:47 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-lqXXdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:47 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-Cc6XLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:47 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-zPcczr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:47 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-yf2XVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:47 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-zOguQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:47 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-maRFiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:47 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-7Hu_A5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:47 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-bgKY7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:48 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-9M185Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:48 INFO - Running setup.py install for manifestparser 04:53:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Running setup.py install for mozcrash 04:53:48 INFO - Running setup.py install for mozdebug 04:53:48 INFO - Running setup.py install for mozdevice 04:53:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:48 INFO - Running setup.py install for mozfile 04:53:48 INFO - Running setup.py install for mozhttpd 04:53:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:49 INFO - Running setup.py install for mozinfo 04:53:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:49 INFO - Running setup.py install for mozInstall 04:53:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:49 INFO - Running setup.py install for mozleak 04:53:49 INFO - Running setup.py install for mozlog 04:53:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:49 INFO - Running setup.py install for moznetwork 04:53:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:49 INFO - Running setup.py install for mozprocess 04:53:49 INFO - Running setup.py install for mozprofile 04:53:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:50 INFO - Running setup.py install for mozrunner 04:53:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:50 INFO - Running setup.py install for mozscreenshot 04:53:50 INFO - Running setup.py install for moztest 04:53:50 INFO - Running setup.py install for mozversion 04:53:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:50 INFO - Cleaning up... 04:53:50 INFO - Return code: 0 04:53:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc670d44660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd2d30>, '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 0x109a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9b20>, '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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z3aZKKT8C/Render', 04:53:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:50 INFO - 'HOME': '/Users/cltbld', 04:53:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:50 INFO - 'LOGNAME': 'cltbld', 04:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:50 INFO - 'MOZ_NO_REMOTE': '1', 04:53:50 INFO - 'NO_EM_RESTART': '1', 04:53:50 INFO - 'PAGER': '/bin/cat', 04:53:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:50 INFO - 'PWD': '/builds/slave/test', 04:53:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:50 INFO - 'SHELL': '/bin/bash', 04:53:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQo7LmPmJl/Listeners', 04:53:50 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 04:53:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:50 INFO - 'USER': 'cltbld', 04:53:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:50 INFO - 'XPC_FLAGS': '0x0', 04:53:50 INFO - 'XPC_SERVICE_NAME': '0', 04:53:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:51 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-i9DQL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:51 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-50rHig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:51 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)) 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:51 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-j0KKB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:51 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-YEsfdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:51 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-9kwoKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:51 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-BQC3fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:51 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-WkxEZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:51 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-GC6N0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:51 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-g6WK4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:51 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-ew3SYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-ADtTI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-qN2DGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-DiCBaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-VRZCk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-gczDDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-gSnN1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-EUmNIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:55 INFO - Downloading blessings-1.6.tar.gz 04:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:55 INFO - Installing collected packages: blessings 04:53:55 INFO - Running setup.py install for blessings 04:53:55 INFO - Successfully installed blessings 04:53:55 INFO - Cleaning up... 04:53:55 INFO - Return code: 0 04:53:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:55 INFO - Reading from file tmpfile_stdout 04:53:55 INFO - Current package versions: 04:53:55 INFO - blessings == 1.6 04:53:55 INFO - blobuploader == 1.2.4 04:53:55 INFO - docopt == 0.6.1 04:53:55 INFO - manifestparser == 1.1 04:53:55 INFO - mozInstall == 1.12 04:53:55 INFO - mozcrash == 0.17 04:53:55 INFO - mozdebug == 0.1 04:53:55 INFO - mozdevice == 0.48 04:53:55 INFO - mozfile == 1.2 04:53:55 INFO - mozhttpd == 0.7 04:53:55 INFO - mozinfo == 0.9 04:53:55 INFO - mozleak == 0.1 04:53:55 INFO - mozlog == 3.1 04:53:55 INFO - moznetwork == 0.27 04:53:55 INFO - mozprocess == 0.22 04:53:55 INFO - mozprofile == 0.28 04:53:55 INFO - mozrunner == 6.11 04:53:55 INFO - mozscreenshot == 0.1 04:53:55 INFO - mozsystemmonitor == 0.0 04:53:55 INFO - moztest == 0.7 04:53:55 INFO - mozversion == 1.4 04:53:55 INFO - psutil == 3.1.1 04:53:55 INFO - requests == 1.2.3 04:53:55 INFO - wsgiref == 0.1.2 04:53:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:55 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 0x109d2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc670d44660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd2d30>, '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 0x109a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9b20>, '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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z3aZKKT8C/Render', 04:53:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:55 INFO - 'HOME': '/Users/cltbld', 04:53:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:55 INFO - 'LOGNAME': 'cltbld', 04:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:55 INFO - 'MOZ_NO_REMOTE': '1', 04:53:55 INFO - 'NO_EM_RESTART': '1', 04:53:55 INFO - 'PAGER': '/bin/cat', 04:53:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:55 INFO - 'PWD': '/builds/slave/test', 04:53:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:55 INFO - 'SHELL': '/bin/bash', 04:53:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQo7LmPmJl/Listeners', 04:53:55 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 04:53:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:55 INFO - 'USER': 'cltbld', 04:53:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:55 INFO - 'XPC_FLAGS': '0x0', 04:53:55 INFO - 'XPC_SERVICE_NAME': '0', 04:53:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:53:56 INFO - Cleaning up... 04:53:56 INFO - Return code: 0 04:53:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:56 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 0x109d2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc670d44660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd2d30>, '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 0x109a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9b20>, '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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:53:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z3aZKKT8C/Render', 04:53:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:56 INFO - 'HOME': '/Users/cltbld', 04:53:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:56 INFO - 'LOGNAME': 'cltbld', 04:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:56 INFO - 'MOZ_NO_REMOTE': '1', 04:53:56 INFO - 'NO_EM_RESTART': '1', 04:53:56 INFO - 'PAGER': '/bin/cat', 04:53:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:56 INFO - 'PWD': '/builds/slave/test', 04:53:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:56 INFO - 'SHELL': '/bin/bash', 04:53:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQo7LmPmJl/Listeners', 04:53:56 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 04:53:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:56 INFO - 'USER': 'cltbld', 04:53:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:56 INFO - 'XPC_FLAGS': '0x0', 04:53:56 INFO - 'XPC_SERVICE_NAME': '0', 04:53:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:56 INFO - Downloading/unpacking jsonschema 04:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:58 INFO - Downloading/unpacking functools32 (from jsonschema) 04:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:59 INFO - warning: no files found matching '*.txt' 04:53:59 INFO - no previously-included directories found matching 'build' 04:53:59 INFO - no previously-included directories found matching 'dist' 04:53:59 INFO - no previously-included directories found matching '.git*' 04:53:59 INFO - Installing collected packages: jsonschema, functools32 04:53:59 INFO - Running setup.py install for functools32 04:53:59 INFO - warning: no files found matching '*.txt' 04:53:59 INFO - no previously-included directories found matching 'build' 04:53:59 INFO - no previously-included directories found matching 'dist' 04:53:59 INFO - no previously-included directories found matching '.git*' 04:53:59 INFO - Successfully installed jsonschema functools32 04:53:59 INFO - Cleaning up... 04:53:59 INFO - Return code: 0 04:53:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:59 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc670d44660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd2d30>, '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 0x109a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9b20>, '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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:59 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', 'flake8'] in /builds/slave/test/build 04:53:59 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 flake8 04:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z3aZKKT8C/Render', 04:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:59 INFO - 'HOME': '/Users/cltbld', 04:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:59 INFO - 'LOGNAME': 'cltbld', 04:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:59 INFO - 'MOZ_NO_REMOTE': '1', 04:53:59 INFO - 'NO_EM_RESTART': '1', 04:53:59 INFO - 'PAGER': '/bin/cat', 04:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:59 INFO - 'PWD': '/builds/slave/test', 04:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:59 INFO - 'SHELL': '/bin/bash', 04:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQo7LmPmJl/Listeners', 04:53:59 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 04:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:59 INFO - 'USER': 'cltbld', 04:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:59 INFO - 'XPC_FLAGS': '0x0', 04:53:59 INFO - 'XPC_SERVICE_NAME': '0', 04:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:59 INFO - Downloading/unpacking flake8 04:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:54:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:54:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:03 INFO - no previously-included directories found matching 'docs/_build' 04:54:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:54:03 INFO - Running setup.py install for pep8 04:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:03 INFO - no previously-included directories found matching 'docs/_build' 04:54:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:54:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:54:03 INFO - Cleaning up... 04:54:03 INFO - Return code: 0 04:54:03 INFO - Running post-action listener: _resource_record_post_action 04:54:03 INFO - Running post-action listener: _start_resource_monitoring 04:54:03 INFO - Starting resource monitoring. 04:54:03 INFO - ##### 04:54:03 INFO - ##### Running install step. 04:54:03 INFO - ##### 04:54:03 INFO - Running pre-action listener: _resource_record_pre_action 04:54:03 INFO - Running main action method: install 04:54:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:04 INFO - Reading from file tmpfile_stdout 04:54:04 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:04 INFO - Reading from file tmpfile_stdout 04:54:04 INFO - Output received: 04:54:04 INFO - Usage: mozinstall [options] installer 04:54:04 INFO - Options: 04:54:04 INFO - -h, --help show this help message and exit 04:54:04 INFO - -d DEST, --destination=DEST 04:54:04 INFO - Directory to install application into. [default: 04:54:04 INFO - "/builds/slave/test"] 04:54:04 INFO - --app=APP Application being installed. [default: firefox] 04:54:04 INFO - mkdir: /builds/slave/test/build/application 04:54:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:54:27 INFO - Reading from file tmpfile_stdout 04:54:27 INFO - Output received: 04:54:27 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:54:27 INFO - Running post-action listener: _resource_record_post_action 04:54:27 INFO - ##### 04:54:27 INFO - ##### Running run-tests step. 04:54:27 INFO - ##### 04:54:27 INFO - Running pre-action listener: _resource_record_pre_action 04:54:27 INFO - Running main action method: run_tests 04:54:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:54:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:54:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:54:27 INFO - 2016-05-28 04:54:27.318 screenresolution[2519:21673] starting screenresolution argv=screenresolution get 04:54:27 INFO - 2016-05-28 04:54:27.320 screenresolution[2519:21673] Display 0: 1600x1200x32@60 04:54:27 INFO - 2016-05-28 04:54:27.326 screenresolution[2520:21676] starting screenresolution argv=screenresolution list 04:54:27 INFO - Available Modes on Display 0 04:54:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:54:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:54:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:54:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:54:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:54:27 INFO - Intel Iris: 04:54:27 INFO - Chipset Model: Intel Iris 04:54:27 INFO - Type: GPU 04:54:27 INFO - Bus: Built-In 04:54:27 INFO - VRAM (Dynamic, Max): 1536 MB 04:54:27 INFO - Vendor: Intel (0x8086) 04:54:27 INFO - Device ID: 0x0a2e 04:54:27 INFO - Revision ID: 0x0009 04:54:27 INFO - Displays: 04:54:27 INFO - Display: 04:54:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:54:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:54:27 INFO - Display Serial Number: 1600x1200 60 04:54:27 INFO - Main Display: Yes 04:54:27 INFO - Mirror: Off 04:54:27 INFO - Online: Yes 04:54:27 INFO - Rotation: Supported 04:54:27 INFO - Return code: 0 04:54:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:27 INFO - Python 2.7.3 04:54:27 INFO - Return code: 0 04:54:27 INFO - grabbing minidump binary from tooltool 04:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:27 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd2d30>, '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 0x109a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:54:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:54:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:27 INFO - Return code: 0 04:54:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:54:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:54:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:54:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:54:28 INFO - Return code: 0 04:54:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0154 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:54:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z3aZKKT8C/Render', 04:54:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:28 INFO - 'HOME': '/Users/cltbld', 04:54:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:28 INFO - 'LOGNAME': 'cltbld', 04:54:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:28 INFO - 'MOZ_NO_REMOTE': '1', 04:54:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:28 INFO - 'NO_EM_RESTART': '1', 04:54:28 INFO - 'PAGER': '/bin/cat', 04:54:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:28 INFO - 'PWD': '/builds/slave/test', 04:54:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:28 INFO - 'SHELL': '/bin/bash', 04:54:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQo7LmPmJl/Listeners', 04:54:28 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 04:54:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:28 INFO - 'USER': 'cltbld', 04:54:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:28 INFO - 'XPC_FLAGS': '0x0', 04:54:28 INFO - 'XPC_SERVICE_NAME': '0', 04:54:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:54:29 INFO - mozversion application_buildid: 20160528032836 04:54:29 INFO - mozversion application_changeset: 7e64e2bf7665ee3ace2a4d2c4097afb8cc72096a 04:54:29 INFO - mozversion application_display_name: Firefox 04:54:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:29 INFO - mozversion application_name: Firefox 04:54:29 INFO - mozversion application_remotingname: firefox 04:54:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:54:29 INFO - mozversion application_vendor: Mozilla 04:54:29 INFO - mozversion application_version: 47.0 04:54:29 INFO - mozversion platform_buildid: 20160528032836 04:54:29 INFO - mozversion platform_changeset: 7e64e2bf7665ee3ace2a4d2c4097afb8cc72096a 04:54:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:54:29 INFO - mozversion platform_version: 47.0 04:54:29 INFO - using testdate: 1464436469 04:54:29 INFO - actual date: 1464436469 04:54:29 INFO - starting webserver on 'localhost:52103' 04:54:29 INFO - SUITE-START | Running 2 tests 04:54:29 INFO - TEST-START | dromaeo_css 04:54:29 INFO - operating with platform_type : mac_ 04:54:29 INFO - Initialising browser for dromaeo_css test... 04:54:29 INFO - TEST-INFO | started process 2538 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpamB0Q9/profile http://localhost:52103/getInfo.html) 04:54:31 INFO - PROCESS | 2538 | __metrics Screen width/height:1600/1200 04:54:31 INFO - PROCESS | 2538 | colorDepth:24 04:54:31 INFO - PROCESS | 2538 | Browser inner width/height: 1024/689 04:54:31 INFO - PROCESS | 2538 | __metrics 04:54:31 ERROR - PROCESS | 2538 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 04:54:32 INFO - TEST-INFO | 2538: exit 0 04:54:32 INFO - Browser initialized. 04:54:32 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:32 INFO - TEST-INFO | started process 2542 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpamB0Q9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:44 INFO - PROCESS | 2542 | RSS: Main: 168013824 04:54:44 INFO - PROCESS | 2542 | 04:55:34 INFO - PROCESS | 2542 | 1464436534248 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:57:45 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:52103/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52103/tests/dromaeo/cssquery-ext.html) 04:57:46 INFO - PROCESS | 2542 | RSS: Main: 178720768 04:57:46 INFO - PROCESS | 2542 | 05:00:48 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:52103/tests/dromaeo/cssquery-ext.html (next: http://localhost:52103/tests/dromaeo/cssquery-jquery.html) 05:00:49 INFO - PROCESS | 2542 | RSS: Main: 190275584 05:00:49 INFO - PROCESS | 2542 | 05:03:50 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:52103/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52103/tests/dromaeo/cssquery-mootools.html) 05:03:51 INFO - PROCESS | 2542 | RSS: Main: 192057344 05:03:51 INFO - PROCESS | 2542 | 05:06:53 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:52103/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52103/tests/dromaeo/cssquery-prototype.html) 05:06:53 INFO - PROCESS | 2542 | RSS: Main: 195735552 05:06:53 INFO - PROCESS | 2542 | 05:09:56 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:52103/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52103/tests/dromaeo/cssquery-yui.html) 05:09:56 INFO - PROCESS | 2542 | RSS: Main: 194846720 05:09:56 INFO - PROCESS | 2542 | 05:12:58 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:52103/tests/dromaeo/cssquery-yui.html (next: http://localhost:52103/tests/dromaeo/cssquery-dojo.html) 05:12:59 INFO - PROCESS | 2542 | RSS: Main: 200257536 05:12:59 INFO - PROCESS | 2542 | 05:12:59 INFO - PROCESS | 2542 | __start_tp_report 05:12:59 INFO - PROCESS | 2542 | _x_x_mozilla_page_load 05:12:59 INFO - PROCESS | 2542 | _x_x_mozilla_page_load_details 05:12:59 INFO - PROCESS | 2542 | |i|pagename|runs| 05:12:59 INFO - PROCESS | 2542 | |0;dojo.html;3617.9638203617965;3650.9452358214617;3674.5039419678337;3682.999999999999;3704.722145839061;5719.913216488864;5791.102379131231;5872.471477567018;5873.500752436043;5902.085176797593;5170.767315470804;5919.964006298891;5920.023196172627;5930.940690593093;5950.404959504048;5310.884714210011;5371.650842695231;5385.030694474993;5409.24270602114;5482.424345443731;5323.281357016792;5407.188921661763;5427.891442171154;5440.156775699773;5442.156465747816;5319.308489896308;5407.053765591026;5416.647917885325;5419.943111093338;5436.103042997901;5388.515033646991;5444.50999410051;5457.781688732446;5461.42655021223;5463;5331.786728530854;5369.194620806871;5388.245645609618;5416.91874621881;5464.590155738336;5570.326243403189;5601.551875849922;5652.3217213934595;5701.885962280772;5794.0439827428845;6273.05904114382;6287.2140982377205;6295.527835412362;6304.464120549759;6318.905216421757;6366.745330186787;6382.170317858695;6388.105665206875;6393.136926514908;6538.084668146464;5036.445990940993;5956.55325850563;6085.96538588441;6106.542009349317;6134.263888333428;6270.216222972129;6292.402221788922;6310.905336419957;6312.842178945563;6315.084312774622;6149.262088549313;6172;6205.162303089115;6208.379162083846;6208.9689551551955;6217.720202590895;6298.968505157445;6300.747970081237;6334.398232167937;6342.39747224013;6220.191375121205;6232.937670623326;6257.374262573706;6271.404216599416;6279.560430769802;6141.6007959482495;6203.875922481616;6265.561410701298;6266.028765541258;6271.686415679198;4067.918641627151;5058.797648094109;5068;5079.74601269935;5150.0472412603785;4507.526709695435;4523.5024147343765;4565.452145742533;4571.38286331341;4580.610648094949;5911.822645320562;5966.254218222723;6042.154098426224;6050.152978583002;6088.786892458831;6256.343083976117;6289.96855015722;6306.527010474233;6326.145970293951;6331.271903731038;6011.338752737195;6029.427204415573;6032.3967603239325;6039.698015099315;6063.029915213545;5362.3565172178805;5497.312835895513;5523.834284971457;5554.972225138929;5575.52608028314;6365.586236894587;6452.387023232785;6494.837629059122;6495.6752162391695;6513.381228783258;6195.4424101831055;6272.560920735505;6305.369463053658;6337.176167098248;6359.618422894641;6314.179156709598;6405.871882562229;6427.292997770148;6530.216374035146;6568.901466477911;6229.0967809668255;6273.309935906956;6275.184226050585;6282.183316168869;6307.76998485291;6295.150154729236;6301.243850737941;6304.5271604628915;6309.274433440213;6384.106225128578;6097.176881120992;6124.960759790135;6252.406021427957;6266.811995640138;6284.120223168851;6255.093011513396;6256.499480041494;6275.874482510233;6275.937240627535;6291.370862913672;6077.574569780073;6149.661768602769;6209;6212.316645169119;6228.346023667631;6119.602225855305;6165.907511387243;6216.658083805434;6244.906326405198;6274.372562743689;6154.815355539341;6194.225721784777;6209.782657607143;6224.657643829632;6234.844128896814 05:12:59 INFO - PROCESS | 2542 | |1;ext.html;591.6184061280475;597.5936363272973;616.4975544930878;630.738243628894;665.8002599220234;30831.537526937114;39686.00784980377;39891.800540997254;40024.79987600065;40136.996575085635;28067.719322806766;41092.76721698346;41642.79178604103;41732.58267417325;42012.57987420125;9905.653302134391;9930.255230857696;9941.353812002197;9964.053414925607;9987;9733.951330243373;10069;10117.190624750003;10124.746881327952;10128.987101289886;7998.560079195671;8701.999270083958;9352.25181985443;10057.849132263022;10095.788505379365;9252.398594091395;9595.520223988842;9979.401235925796;9990.100890919815;10102.242331825106;9848.556814943273;9933.403995760278;9991.400515968993;9992.600295988152;10003.39979601219;36067;38094.23811523754;40293.99265018369;40757.59242407568;41297.38053929193;3365.9158521036925;3409.8124603146816;3423.7432192585406;3550.254446566224;3561.7506774525796;28498.145055648365;28934.565981510295;28971.275718107005;28971.71028289711;30148.24629384261;2748.491529067129;2784.9721502784914;2795.692473827877;2818.5208514552573;2826.491231578315;434166;436076;441391;442121.7893910542;442890;47484.7625761869;48353.75823120932;67036.65926681439;70450.64774676094;74703;47288.05423891572;47291;47291.52708472871;47370.76314618405;47407.76296118566;14692.706145877237;17144.828551714574;17389;17806.821931780774;17895.821041789415;11949.581764638197;14117.364718587689;14209.857901420854;14259.857401426061;14302.356393962296;12882.871171288354;15507.224638768017;15713.371465141496;15734.9213253933;15822.52532424029;6449;6546.116274303004;6571.080048793173;6598.670066496656;6598.802035938929;963.4123184857232;1047.9528421221064;1100.0869278498826;1122.5565901468874;1125.178619607691;30920.446910692423;30943;31251.374972500424;31297.8435107823;31651.366972660417;1144.3591588710183;1150.5685367987005;1158.4902642837126;1167.8073117935614;1221.462556475166;12720.300383478812;14583.781243281359;15729.68540629181;15934.884558080823;15997.484640837636;491622;542173;543736;545524;547965;61778;63444.36555634477;63660.36339636637;63829.68085159545;63893.68053159704;1269.4731686350246;1527.5570084675542;1534.77745726869;1551.534539638104;1580.0203873598443;30032.099037028926;30532.236694082825;30735.077947661604;30877;31052.22369440782;54809;55013;55189.89620207493;55469.445305546426;55513.444865550824;495839;499104;504601;507837;509394.4530277325;34445;34507.30985380329;35519.46720799242;35577.82211088928;35640.643593563735;46565.53434465748;46732.53267467282;48754;49221.261681074095;49277.26084108813;39718.41126354913;39801.40297895592;39930.60069399269;40108.39837402383;40683.1863362737;38761.80619096886;39042.80478597589;39051;39632.40551391789;40043;32842;33446;38075.80962095172;38873.416898747106;39733.60266397415;31470.213244669067;32308.676913231506;32331.838340808146;32419.675803241666;33169.83415083006;22190;25808.967641294137;25822.87088564545;25882.611760823227;25941.74058259393 05:12:59 INFO - PROCESS | 2542 | |2;jquery.html;334.5984818218139;373.4472979989617;380.767731683673;387.08068337697966;387.21009141351647;20499.282525111623;20837.374878753642;21267.787322126773;21865.890670546625;21909.342719718436;12200.816987745191;12535.686607834808;22442.55114897701;22820;22832.429189270275;5240.423553409131;5372.274742909716;5406.945930540684;5411.675299482044;5412.91880621791;4183.393407955845;5406.216098665691;5838.678872662002;5991.071383935497;6119.388061193889;5932.762689492415;5965.403459654021;5978.073398623221;6071.4232147946095;6119.143319935212;5324.733763311839;5780.682062486561;5940.940590594104;5954.404559544033;5965.671888046156;5082.4663410341755;5448.692313844688;5594.021046316879;5645.745941432604;5677.977963966485;14417.062890912162;16404.425845095364;23281.53436931269;25711.61432578513;26892.462150756874;1851.5648822526696;1948.6200190962768;2119.7880211978677;2309.145616122029;2322.9651555226687;8284.46151000183;9957.75105622358;10311.865694773569;10434.269601127924;12888.742225155444;1784.857211423083;1793.5874748807717;1801.2884910460295;1804.6751584714746;1813.4287699374786;104285.4785726074;105866;109890;111154.44422777915;113493;9995.150412214898;11621.07031437483;11693.006094482063;11778.469968851423;11782.469788859522;14300;14453.566393008226;14484.275786210648;14590.41638334476;14659.413623455155;7997.640106195236;8933.240674542736;9079.727608171765;9139.131782480654;9179.541022948826;7602.6198690066385;8840.160184782435;9267.44395336282;9289.16397524226;9381.061893810564;4539.364488971547;4604.700694454849;4609;4624.606908412823;4654.720716757005;1822.7448157257995;1858.4145994012113;1887.0941947865101;1922.644310802506;1937.2832052140798;901.6753968571309;958.5015791788231;1018.134585602247;1080.9297395669257;1120.798256313855;18628.72056919147;19816.801831981495;20580.58838823215;20677.896610517153;20823.1670733172;987.5485179298255;1024.8155332040305;1068.8396740488988;1113.6659002299277;1131.7000994736402;10971.780564388828;11507.539698411969;11592.420378981185;11601.18791684574;11639;631951;633918;648752;652728;662653;117447.65104697859;122359;124177;124675;127070.72929270774;1040.2042437535292;1048.7797562511805;1050.4957620342125;1063.5905176506947;1068.2522234435926;18546.81453185451;18802.965836879102;19009.42971710851;19029.333973311423;19155.233790648217;50500.484985450494;51754.96490070102;52760.73619632031;53885;54754;74828;75358.62320688361;76325.61837190778;76613;76647;7079.752208672672;7375.598636259094;8461.492310461392;8469.74590762278;8570;12375.814362784746;13501.189928604315;13501.932490337485;13689.931550342184;13814.861851381358;11610.94194529022;11617.302961822317;11702.648920532398;11709.414529273672;11873.940630296793;11467.139964502529;11484;11501.19491635611;11716.23844450108;11866.466009029788;9712.660056897974;10221.540030698488;11825.231359961575;11926.344051076927;12036.63890083299;8289.626966786389;8330.083690794128;8469.5341756204;8488.490690558587;8543.359248056297;8821.823563528822;11304.434778261219;11648.88351116478;11768.646940591796;11980.58067967617 05:12:59 INFO - PROCESS | 2542 | |3;mootools.html;1465.574983254856;1526.2673916520066;1924.3457224543652;2056.5886822635475;2117.5235571996313;8328.875066873987;9065.138811812883;9091.318151138667;9270.304727145465;9288.164065234128;9056.230220431271;9065;9224.815503689922;9225.861612075823;9236.769080772983;2577.3814284571754;2579.3938424470234;2582.7546383093577;2592.7277635848245;2597.2597809624262;2540.5427023135826;2595.8442493450452;2596.6883973923154;2614.16346769034;2617.50267449185;2581.5740402833508;2592.364870606704;2595.740425957408;2617.8691065446747;2631.4210873607776;2546.3506805764505;2570.5373032854077;2583.2121203033066;2596.9220923372327;2603.2060221632396;2549.6430499730054;2551.693796744384;2610.843349399042;2619.2796980830235;2629.8685065746636;9265.953670231605;9347.906520934772;9406.153446189875;9407.106324899123;9429;5347.572194224453;5770.394108618619;5804.071348584249;5955.374685657986;6028.276606807167;3690.7785532868115;3783.5838057813617;3854.3640299350573;3871.128995975911;3880.9223815523815;1076.8061748885198;1082.4154956323655;1084.0893649334596;1122.4387806096952;1128.328644456547;12180.51277948881;12393;12417.254964702057;12431.067669924701;12482.43829027696;4438.800253988514;5040.218766091261;5075.187969924795;5152.201408781645;5163.277141200235;10517.631882884063;10607.15142788575;10635.468226588795;10655.893441065646;10787.6224332148;5678.346990096192;5697.259356283656;5731.799387021518;5735.225744524436;5808.419158084243;4676.602488788423;5118;5205.947940520547;5211.166213405837;5272.657277277041;3781.6029316921877;3970.630132604247;4111.60939710727;4164.708470407103;4172.979135104305;1251.6870782304425;1287.9567550284112;1357.2399456304502;1362.6797702539895;1381.5717127690448;1137.8293256011664;1296.7276871856827;1324.0863803975226;1340.2293681133388;1465.8460861609378;8578.785530361665;8624.051354351017;8635.654573817103;8647.827043459221;8656.047834738174;538.4346436241931;539.4093467652914;545.6126150433157;549.9092649712833;551.7296524702866;6343.238811342669;6440.806775796734;6459.935400645933;6462.870742585122;6495.837604059936;9250;9677.419354838732;11289.71775705614;11384.601538946263;11450.885491145149;10964.945175274232;11123.555057797597;11125.833112503318;11306.434678266054;11317.377544235145;7678.654460549289;8747.606357713918;8812.603432845537;8859.7342079739;8862.512561809033;6819.147606549182;8145.551994640352;8302.584870756558;8420.578971051546;8464.873026904479;8289.4197406181;9951.800963980824;10087.848682269918;10126.8480972784;10182.592696292066;10247.641332553325;10263.538140783534;10587.735306617396;10592.629257976243;10594.417307047877;7076.25699301566;7660.1956794538;7698.307152356315;7874.0157480314965;7985.920140798517;7552.584607846401;8519.105493923049;8533.402661813861;8560.357973151915;8583.18459746323;6354.745810167727;7620.237976202558;7652.1582625912215;7712.807179820549;7776.222377762178;7417.221191774786;7513.060867391576;7539.2083831199125;7584.938108664681;7618.961905190438;6888.345607167311;7996.04047514302;8073.233042860918;8120.918790812017;8199.549024803693;7299.160596531467;7333.449991250571;7394.704211831467;7413.740519081806;7455.105387353336;7434.59109748969;7447.404207663482;7495.7001719930595;7511.624418779148;7521.360684341892 05:12:59 INFO - PROCESS | 2542 | |4;prototype.html;341.3139589425255;341.38550608903984;342.84057913070416;344.175699200415;344.98918169762595;6176.166217560628;6332.715027823753;6559.344065593438;6962.09492765941;7063.434925205984;6812.727490900371;6984.2317345092;7004.57972521649;7015.158181018272;7058.576485410867;4125.876223713279;4874.854409213832;5006.649534532584;5087.49125087492;5173.689578625275;5062.544371006608;5082.23766435034;5082.745862706868;5088.465711100337;5121.513456221653;4093.488313960755;5007.949920500803;5030.220315851031;5051.166557518023;5052.595792336604;4925.605951523888;5112.463191364909;5120.308758317654;5128.487151284879;5130.076586214499;3856.267309211241;4147.315692910666;4395.362672412514;4408.691391602589;4412.40432541606;6362.427381535684;6597.868042639168;6697.799066028027;6735.831604209934;6746.392824645805;5884.146798714205;5887.293524777011;5936.881262374728;5944.346121926585;5971.701414929236;7404.814879627998;7421.703131874719;7447.739329123455;7453.440991925628;7463.552186868751;3958.386450100239;4764.213904705754;4783.736894470802;4790.185668436374;4796.664233503621;6211.782587609412;7398.11222653285;7878.842423151505;7894.526328420256;7897.8025549361155;4636.907261854744;4738.407699037621;4788.760561971888;4796.736179510091;4798.160321943646;4874.098291816025;4879.902401951941;4888.902221955612;5002.874928126826;5037.974810125999;5931.051031834886;5947.256592925884;5956.374580669054;5960.880782384328;5982.880342393128;5951.018082016419;6459.967700161469;6591.868162636721;6871.453922867415;7421.183669796318;1702.8467437930399;1726.9136543173042;1728.3173146607019;1730.7663465432258;1732.1772158224742;1051.1748277602046;1081.6700906223678;1089.5750657243682;1089.983650245247;1091.8198497247865;6988.720451181997;7041.401480874183;7060;7078.327558881898;7082.681279342442;7651.196624354474;7655.425843061793;7660.923390766133;7665.5017423868385;7675.692972281158;5996.910046349309;6782.423494003065;7042.753503627348;7056.506044576933;7057.329553692391;3942.4677668514955;4030.4760381150263;4070.816813243411;4073.9592604073578;4092.8567500137947;8030.39772017101;8047.557384343917;8050.19498050202;8053;8056.556889371141;7859.214078592209;7902.525848449111;7907.327877130393;7921.920780792118;7926.326262267657;7999.640016199285;8004.879926801103;8019.83960320802;8043.155468675822;8050.355971522265;6139.649277159018;7048.295170482911;7112.359887609933;7451.552906825608;7628.275313845176;7452.292032256927;7476;7508;7518.210587888412;7555.282248186413;7156.284371562802;7492.737754178577;7991.680332786856;8026.277635012877;8037.879431808411;4827.903441931212;4869.366982292279;4884.804607815648;4889.90220195587;4892.290617860319;7462;7524.962375188089;7616.276453736886;7794.649240784065;7802.609869506388;7451.8882216765705;7462.403007759474;7472.775816725507;7513.511621744569;7516.398688105048;7456.067991501062;7467.514611550232;7472.925270747223;7473.77578672619;7507.136679281734;5657.60396772222;5878.353381128158;7209.170945341143;7289.307515785992;7312.012878261579;7434.888476672746;7466.701331946661;7491.737789177353;7504.362129219077;7523.548587084792;7217.927820721936;7304.96347518259;7330.706771729285;7331.826907694744;7356.227596102546 05:12:59 INFO - PROCESS | 2542 | |5;yui.html;634.3497914637493;698.5319835710073;761.3072104385011;765.4144579396759;775.050563060251;15442.073475591473;15492;15558;15606.219689015546;15707.371705131794;14287.642808929782;14491.855081449208;14523.491677791279;14537.92731036346;14551.126932384064;770.7148355108618;820.8891799607036;904.2043002158092;953.7853982853871;958.9472579008152;936.8220038192721;938.8544775559799;953.3183773601874;953.5232383808096;953.7949340891707;885.9457245877418;972.4505654305331;974.5565767575736;975.5902520941222;992.2310209587555;830.8462934357133;998.0269237493459;1000.4397537379091;1000.5247507433947;1001.0990108901974;694.229405360055;695.3845846425899;737.5574655206887;742.3393180069743;750.1785544828405;15153.848461515465;15284.694306113815;15305.1582162981;15573.221338933008;15591.376344946302;11328.263662861887;13430.597082087554;13468.663283417894;13632.250226237553;13723.862761372358;10335.741606459824;10508.737281567946;10513.369197848153;10582.78834423315;10823.621173258976;3608.440691692792;3680.1351682354625;3682.3371793077235;3682.4844521766972;3696.704263658901;79260.41479170442;84397.57801211016;86252.56873715654;87051;88073.99999999936;9891.307608467338;9942.254330925065;9968.950155249177;9975.201983841276;10161.288709790391;22364.776352236593;23302.7669723304;23313;23344.533109337717;23356.532869342518;7580.05249343832;7732.884006739903;7749.7675069748;7816.7264145754625;7952.341506242492;4072.2669919414197;4209.894752631209;4253.574642535722;4276.743395396286;4357.215701173819;3758.9436158457647;3759.135398858223;3809.104860357814;3816.675582575512;3819.923601527954;584.6813486649786;658.2989116590816;675.0448115916022;679.1578442730978;681.9045333653293;504.23859971443386;526.3525863188299;558.5810642018486;566.8724536979147;618.1870839845589;7986.440949133505;8034.357251419872;8060.113387527367;8144.83710325802;8407.53758543286;506.4252073896154;507.7359772918062;522.1233677452611;605.9515238780887;616.6793267500964;3775.565809931838;3819.8854034379015;3997.200559887976;4314.611684948307;4323.567643235651;66616.00075998864;85555.5722221385;86331;98335.50832245793;100679;75957.62021189858;76553;80824;82524.58737706393;83419;63096.68451657804;64270.678646607405;77348;81305.59347203345;81915;8737.082606326498;8748.518831464331;8796.384253102222;8845.071267516818;8894.33292503052;50944.45277736172;50979.49020509747;51224.74387628038;51711.741441294056;52106.739466302424;66590.33409665841;68278.65860670665;68525.65737171282;69667.95498067634;70223.07080986176;11873.821892671443;11903;11972;11975.820362694392;12225.327606981346;9795.412275263221;10069.791625005046;12213.572524961584;12438.626841194779;13446.193228406328;10260.58957641686;11300.547978080785;11848.58529951482;11870.706385356132;11872.643820685393;11746.119041071783;11895.583654572049;11903.76192476163;11998.64004079879;12099.092568057255;9358.15776580111;11518.654440366803;11671.766564668489;11726.58769674366;11803.82294265604;9788.853167202355;9973.401595904268;9983.700488985342;10076.596936122767;10163.881972982817;8627.22354988054;9924;10117.08946194846;10135.239857010607;10272.845907311546 05:12:59 INFO - PROCESS | 2542 | __end_tp_report 05:12:59 INFO - PROCESS | 2542 | __start_cc_report 05:12:59 INFO - PROCESS | 2542 | _x_x_mozilla_cycle_collect,358 05:12:59 INFO - PROCESS | 2542 | __end_cc_report 05:12:59 INFO - PROCESS | 2542 | __startTimestamp1464437579186__endTimestamp 05:12:59 INFO - PROCESS | 2542 | 05:12:59 INFO - PROCESS | 2542 | ------- Summary: start ------- 05:12:59 INFO - PROCESS | 2542 | Number of tests: 6 05:12:59 INFO - PROCESS | 2542 | 05:12:59 INFO - PROCESS | 2542 | [#0] dojo.html Cycles:165 Average:5877.78 Median:6154.82 stddev:620.14 (10.1%) stddev-sans-first:596.17 05:12:59 INFO - PROCESS | 2542 | Values: 3618.0 3650.9 3674.5 3683.0 3704.7 5719.9 5791.1 5872.5 5873.5 5902.1 5170.8 5920.0 5920.0 5930.9 5950.4 5310.9 5371.7 5385.0 5409.2 5482.4 5323.3 5407.2 5427.9 5440.2 5442.2 5319.3 5407.1 5416.6 5419.9 5436.1 5388.5 5444.5 5457.8 5461.4 5463.0 5331.8 5369.2 5388.2 5416.9 5464.6 5570.3 5601.6 5652.3 5701.9 5794.0 6273.1 6287.2 6295.5 6304.5 6318.9 6366.7 6382.2 6388.1 6393.1 6538.1 5036.4 5956.6 6086.0 6106.5 6134.3 6270.2 6292.4 6310.9 6312.8 6315.1 6149.3 6172.0 6205.2 6208.4 6209.0 6217.7 6299.0 6300.7 6334.4 6342.4 6220.2 6232.9 6257.4 6271.4 6279.6 6141.6 6203.9 6265.6 6266.0 6271.7 4067.9 5058.8 5068.0 5079.7 5150.0 4507.5 4523.5 4565.5 4571.4 4580.6 5911.8 5966.3 6042.2 6050.2 6088.8 6256.3 6290.0 6306.5 6326.1 6331.3 6011.3 6029.4 6032.4 6039.7 6063.0 5362.4 5497.3 5523.8 5555.0 5575.5 6365.6 6452.4 6494.8 6495.7 6513.4 6195.4 6272.6 6305.4 6337.2 6359.6 6314.2 6405.9 6427.3 6530.2 6568.9 6229.1 6273.3 6275.2 6282.2 6307.8 6295.2 6301.2 6304.5 6309.3 6384.1 6097.2 6125.0 6252.4 6266.8 6284.1 6255.1 6256.5 6275.9 6275.9 6291.4 6077.6 6149.7 6209.0 6212.3 6228.3 6119.6 6165.9 6216.7 6244.9 6274.4 6154.8 6194.2 6209.8 6224.7 6234.8 05:12:59 INFO - PROCESS | 2542 | 05:12:59 INFO - PROCESS | 2542 | [#1] ext.html Cycles:180 Average:63758.37 Median:38958.11 stddev:131350.59 (337.2%) stddev-sans-first:131633.44 05:12:59 INFO - PROCESS | 2542 | Values: 591.6 597.6 616.5 630.7 665.8 30831.5 39686.0 39891.8 40024.8 40137.0 28067.7 41092.8 41642.8 41732.6 42012.6 9905.7 9930.3 9941.4 9964.1 9987.0 9734.0 10069.0 10117.2 10124.7 10129.0 7998.6 8702.0 9352.3 10057.8 10095.8 9252.4 9595.5 9979.4 9990.1 10102.2 9848.6 9933.4 9991.4 9992.6 10003.4 36067.0 38094.2 40294.0 40757.6 41297.4 3365.9 3409.8 3423.7 3550.3 3561.8 28498.1 28934.6 28971.3 28971.7 30148.2 2748.5 2785.0 2795.7 2818.5 2826.5 434166.0 436076.0 441391.0 442121.8 442890.0 47484.8 48353.8 67036.7 70450.6 74703.0 47288.1 47291.0 47291.5 47370.8 47407.8 14692.7 17144.8 17389.0 17806.8 17895.8 11949.6 14117.4 14209.9 14259.9 14302.4 12882.9 15507.2 15713.4 15734.9 15822.5 6449.0 6546.1 6571.1 6598.7 6598.8 963.4 1048.0 1100.1 1122.6 1125.2 30920.4 30943.0 31251.4 31297.8 31651.4 1144.4 1150.6 1158.5 1167.8 1221.5 12720.3 14583.8 15729.7 15934.9 15997.5 491622.0 542173.0 543736.0 545524.0 547965.0 61778.0 63444.4 63660.4 63829.7 63893.7 1269.5 1527.6 1534.8 1551.5 1580.0 30032.1 30532.2 30735.1 30877.0 31052.2 54809.0 55013.0 55189.9 55469.4 55513.4 495839.0 499104.0 504601.0 507837.0 509394.5 34445.0 34507.3 35519.5 35577.8 35640.6 46565.5 46732.5 48754.0 49221.3 49277.3 39718.4 39801.4 39930.6 40108.4 40683.2 38761.8 39042.8 39051.0 39632.4 40043.0 32842.0 33446.0 38075.8 38873.4 39733.6 31470.2 32308.7 32331.8 32419.7 33169.8 22190.0 25809.0 25822.9 25882.6 25941.7 05:12:59 INFO - PROCESS | 2542 | 05:12:59 INFO - PROCESS | 2542 | [#2] jquery.html Cycles:180 Average:35829.26 Median:11693.79 stddev:107105.23 (915.9%) stddev-sans-first:107372.52 05:12:59 INFO - PROCESS | 2542 | Values: 334.6 373.4 380.8 387.1 387.2 20499.3 20837.4 21267.8 21865.9 21909.3 12200.8 12535.7 22442.6 22820.0 22832.4 5240.4 5372.3 5406.9 5411.7 5412.9 4183.4 5406.2 5838.7 5991.1 6119.4 5932.8 5965.4 5978.1 6071.4 6119.1 5324.7 5780.7 5940.9 5954.4 5965.7 5082.5 5448.7 5594.0 5645.7 5678.0 14417.1 16404.4 23281.5 25711.6 26892.5 1851.6 1948.6 2119.8 2309.1 2323.0 8284.5 9957.8 10311.9 10434.3 12888.7 1784.9 1793.6 1801.3 1804.7 1813.4 104285.5 105866.0 109890.0 111154.4 113493.0 9995.2 11621.1 11693.0 11778.5 11782.5 14300.0 14453.6 14484.3 14590.4 14659.4 7997.6 8933.2 9079.7 9139.1 9179.5 7602.6 8840.2 9267.4 9289.2 9381.1 4539.4 4604.7 4609.0 4624.6 4654.7 1822.7 1858.4 1887.1 1922.6 1937.3 901.7 958.5 1018.1 1080.9 1120.8 18628.7 19816.8 20580.6 20677.9 20823.2 987.5 1024.8 1068.8 1113.7 1131.7 10971.8 11507.5 11592.4 11601.2 11639.0 631951.0 633918.0 648752.0 652728.0 662653.0 117447.7 122359.0 124177.0 124675.0 127070.7 1040.2 1048.8 1050.5 1063.6 1068.3 18546.8 18803.0 19009.4 19029.3 19155.2 50500.5 51755.0 52760.7 53885.0 54754.0 74828.0 75358.6 76325.6 76613.0 76647.0 7079.8 7375.6 8461.5 8469.7 8570.0 12375.8 13501.2 13501.9 13689.9 13814.9 11610.9 11617.3 11702.6 11709.4 11873.9 11467.1 11484.0 11501.2 11716.2 11866.5 9712.7 10221.5 11825.2 11926.3 12036.6 8289.6 8330.1 8469.5 8488.5 8543.4 8821.8 11304.4 11648.9 11768.6 11980.6 05:12:59 INFO - PROCESS | 2542 | 05:12:59 INFO - PROCESS | 2542 | [#3] mootools.html Cycles:180 Average:6288.84 Median:5310.11 stddev:3328.38 (62.7%) stddev-sans-first:3317.96 05:12:59 INFO - PROCESS | 2542 | Values: 1465.6 1526.3 1924.3 2056.6 2117.5 8328.9 9065.1 9091.3 9270.3 9288.2 9056.2 9065.0 9224.8 9225.9 9236.8 2577.4 2579.4 2582.8 2592.7 2597.3 2540.5 2595.8 2596.7 2614.2 2617.5 2581.6 2592.4 2595.7 2617.9 2631.4 2546.4 2570.5 2583.2 2596.9 2603.2 2549.6 2551.7 2610.8 2619.3 2629.9 9266.0 9347.9 9406.2 9407.1 9429.0 5347.6 5770.4 5804.1 5955.4 6028.3 3690.8 3783.6 3854.4 3871.1 3880.9 1076.8 1082.4 1084.1 1122.4 1128.3 12180.5 12393.0 12417.3 12431.1 12482.4 4438.8 5040.2 5075.2 5152.2 5163.3 10517.6 10607.2 10635.5 10655.9 10787.6 5678.3 5697.3 5731.8 5735.2 5808.4 4676.6 5118.0 5205.9 5211.2 5272.7 3781.6 3970.6 4111.6 4164.7 4173.0 1251.7 1288.0 1357.2 1362.7 1381.6 1137.8 1296.7 1324.1 1340.2 1465.8 8578.8 8624.1 8635.7 8647.8 8656.0 538.4 539.4 545.6 549.9 551.7 6343.2 6440.8 6459.9 6462.9 6495.8 9250.0 9677.4 11289.7 11384.6 11450.9 10964.9 11123.6 11125.8 11306.4 11317.4 7678.7 8747.6 8812.6 8859.7 8862.5 6819.1 8145.6 8302.6 8420.6 8464.9 8289.4 9951.8 10087.8 10126.8 10182.6 10247.6 10263.5 10587.7 10592.6 10594.4 7076.3 7660.2 7698.3 7874.0 7985.9 7552.6 8519.1 8533.4 8560.4 8583.2 6354.7 7620.2 7652.2 7712.8 7776.2 7417.2 7513.1 7539.2 7584.9 7619.0 6888.3 7996.0 8073.2 8120.9 8199.5 7299.2 7333.4 7394.7 7413.7 7455.1 7434.6 7447.4 7495.7 7511.6 7521.4 05:12:59 INFO - PROCESS | 2542 | 05:12:59 INFO - PROCESS | 2542 | [#4] prototype.html Cycles:180 Average:5999.87 Median:6764.41 stddev:1939.10 (28.7%) stddev-sans-first:1897.46 05:12:59 INFO - PROCESS | 2542 | Values: 341.3 341.4 342.8 344.2 345.0 6176.2 6332.7 6559.3 6962.1 7063.4 6812.7 6984.2 7004.6 7015.2 7058.6 4125.9 4874.9 5006.6 5087.5 5173.7 5062.5 5082.2 5082.7 5088.5 5121.5 4093.5 5007.9 5030.2 5051.2 5052.6 4925.6 5112.5 5120.3 5128.5 5130.1 3856.3 4147.3 4395.4 4408.7 4412.4 6362.4 6597.9 6697.8 6735.8 6746.4 5884.1 5887.3 5936.9 5944.3 5971.7 7404.8 7421.7 7447.7 7453.4 7463.6 3958.4 4764.2 4783.7 4790.2 4796.7 6211.8 7398.1 7878.8 7894.5 7897.8 4636.9 4738.4 4788.8 4796.7 4798.2 4874.1 4879.9 4888.9 5002.9 5038.0 5931.1 5947.3 5956.4 5960.9 5982.9 5951.0 6460.0 6591.9 6871.5 7421.2 1702.8 1726.9 1728.3 1730.8 1732.2 1051.2 1081.7 1089.6 1090.0 1091.8 6988.7 7041.4 7060.0 7078.3 7082.7 7651.2 7655.4 7660.9 7665.5 7675.7 5996.9 6782.4 7042.8 7056.5 7057.3 3942.5 4030.5 4070.8 4074.0 4092.9 8030.4 8047.6 8050.2 8053.0 8056.6 7859.2 7902.5 7907.3 7921.9 7926.3 7999.6 8004.9 8019.8 8043.2 8050.4 6139.6 7048.3 7112.4 7451.6 7628.3 7452.3 7476.0 7508.0 7518.2 7555.3 7156.3 7492.7 7991.7 8026.3 8037.9 4827.9 4869.4 4884.8 4889.9 4892.3 7462.0 7525.0 7616.3 7794.6 7802.6 7451.9 7462.4 7472.8 7513.5 7516.4 7456.1 7467.5 7472.9 7473.8 7507.1 5657.6 5878.4 7209.2 7289.3 7312.0 7434.9 7466.7 7491.7 7504.4 7523.5 7217.9 7305.0 7330.7 7331.8 7356.2 05:12:59 INFO - PROCESS | 2542 | 05:12:59 INFO - PROCESS | 2542 | [#5] yui.html Cycles:180 Average:18711.05 Median:26314.43 stddev:26116.55 (99.2%) stddev-sans-first:26154.54 05:12:59 INFO - PROCESS | 2542 | Values: 634.3 698.5 761.3 765.4 775.1 15442.1 15492.0 15558.0 15606.2 15707.4 14287.6 14491.9 14523.5 14537.9 14551.1 770.7 820.9 904.2 953.8 958.9 936.8 938.9 953.3 953.5 953.8 885.9 972.5 974.6 975.6 992.2 830.8 998.0 1000.4 1000.5 1001.1 694.2 695.4 737.6 742.3 750.2 15153.8 15284.7 15305.2 15573.2 15591.4 11328.3 13430.6 13468.7 13632.3 13723.9 10335.7 10508.7 10513.4 10582.8 10823.6 3608.4 3680.1 3682.3 3682.5 3696.7 79260.4 84397.6 86252.6 87051.0 88074.0 9891.3 9942.3 9969.0 9975.2 10161.3 22364.8 23302.8 23313.0 23344.5 23356.5 7580.1 7732.9 7749.8 7816.7 7952.3 4072.3 4209.9 4253.6 4276.7 4357.2 3758.9 3759.1 3809.1 3816.7 3819.9 584.7 658.3 675.0 679.2 681.9 504.2 526.4 558.6 566.9 618.2 7986.4 8034.4 8060.1 8144.8 8407.5 506.4 507.7 522.1 606.0 616.7 3775.6 3819.9 3997.2 4314.6 4323.6 66616.0 85555.6 86331.0 98335.5 100679.0 75957.6 76553.0 80824.0 82524.6 83419.0 63096.7 64270.7 77348.0 81305.6 81915.0 8737.1 8748.5 8796.4 8845.1 8894.3 50944.5 50979.5 51224.7 51711.7 52106.7 66590.3 68278.7 68525.7 69668.0 70223.1 11873.8 11903.0 11972.0 11975.8 12225.3 9795.4 10069.8 12213.6 12438.6 13446.2 10260.6 11300.5 11848.6 11870.7 11872.6 11746.1 11895.6 11903.8 11998.6 12099.1 9358.2 11518.7 11671.8 11726.6 11803.8 9788.9 9973.4 9983.7 10076.6 10163.9 8627.2 9924.0 10117.1 10135.2 10272.8 05:12:59 INFO - PROCESS | 2542 | -------- Summary: end -------- 05:12:59 INFO - PROCESS | 2542 | 05:12:59 INFO - TEST-INFO | 2542: exit 0 05:12:59 INFO - TEST-OK | dromaeo_css | took 1110752ms 05:12:59 INFO - TEST-START | kraken 05:12:59 INFO - operating with platform_type : mac_ 05:12:59 INFO - Initialising browser for kraken test... 05:12:59 INFO - TEST-INFO | started process 2548 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpthDoAY/profile http://localhost:52103/getInfo.html) 05:13:02 INFO - PROCESS | 2548 | __metrics Screen width/height:1600/1200 05:13:02 INFO - PROCESS | 2548 | colorDepth:24 05:13:02 INFO - PROCESS | 2548 | Browser inner width/height: 1024/689 05:13:02 INFO - PROCESS | 2548 | __metrics 05:13:02 ERROR - PROCESS | 2548 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 05:13:03 INFO - TEST-INFO | 2548: exit 0 05:13:03 INFO - Browser initialized. 05:13:03 INFO - Running cycle 1/1 for kraken test... 05:13:03 INFO - TEST-INFO | started process 2552 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpthDoAY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:14 INFO - PROCESS | 2552 | RSS: Main: 167718912 05:13:14 INFO - PROCESS | 2552 | 05:13:17 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52103/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:18 INFO - PROCESS | 2552 | RSS: Main: 179896320 05:13:18 INFO - PROCESS | 2552 | 05:13:21 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52103/tests/kraken/driver.html?testName=audio-dft) 05:13:21 INFO - PROCESS | 2552 | RSS: Main: 188952576 05:13:21 INFO - PROCESS | 2552 | 05:13:25 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52103/tests/kraken/driver.html?testName=audio-fft) 05:13:25 INFO - PROCESS | 2552 | RSS: Main: 192438272 05:13:25 INFO - PROCESS | 2552 | 05:13:27 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52103/tests/kraken/driver.html?testName=audio-oscillator) 05:13:28 INFO - PROCESS | 2552 | RSS: Main: 193789952 05:13:28 INFO - PROCESS | 2552 | 05:13:30 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52103/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:31 INFO - PROCESS | 2552 | RSS: Main: 194248704 05:13:31 INFO - PROCESS | 2552 | 05:13:34 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52103/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:34 INFO - PROCESS | 2552 | RSS: Main: 194637824 05:13:34 INFO - PROCESS | 2552 | 05:13:37 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52103/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:38 INFO - PROCESS | 2552 | RSS: Main: 194875392 05:13:38 INFO - PROCESS | 2552 | 05:13:41 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52103/tests/kraken/driver.html?testName=json-parse-financial) 05:13:41 INFO - PROCESS | 2552 | RSS: Main: 194740224 05:13:41 INFO - PROCESS | 2552 | 05:13:43 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52103/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:44 INFO - PROCESS | 2552 | RSS: Main: 194252800 05:13:44 INFO - PROCESS | 2552 | 05:13:46 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52103/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:46 INFO - PROCESS | 2552 | RSS: Main: 194457600 05:13:46 INFO - PROCESS | 2552 | 05:13:48 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52103/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:49 INFO - PROCESS | 2552 | RSS: Main: 194531328 05:13:49 INFO - PROCESS | 2552 | 05:13:52 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:52 INFO - PROCESS | 2552 | RSS: Main: 194416640 05:13:52 INFO - PROCESS | 2552 | 05:13:55 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:55 INFO - PROCESS | 2552 | RSS: Main: 194879488 05:13:55 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | Cycle 1(1): loaded http://localhost:52103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52103/tests/kraken/driver.html?testName=ai-astar) 05:13:57 INFO - PROCESS | 2552 | RSS: Main: 195858432 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | __start_tp_report 05:13:57 INFO - PROCESS | 2552 | _x_x_mozilla_page_load 05:13:57 INFO - PROCESS | 2552 | _x_x_mozilla_page_load_details 05:13:57 INFO - PROCESS | 2552 | |i|pagename|runs| 05:13:57 INFO - PROCESS | 2552 | |0;ai-astar;167;160;142;115;132;189;163;115;115;130 05:13:57 INFO - PROCESS | 2552 | |1;audio-beat-detection;170;143;177;154;118;136;133;186;154;143 05:13:57 INFO - PROCESS | 2552 | |2;audio-dft;221;258;203;198;202;200;202;199;200;195 05:13:57 INFO - PROCESS | 2552 | |3;audio-fft;66;76;72;109;56;57;52;59;153;84 05:13:57 INFO - PROCESS | 2552 | |4;audio-oscillator;99;126;158;120;65;100;154;119;115;123 05:13:57 INFO - PROCESS | 2552 | |5;imaging-gaussian-blur;135;129;92;90;93;102;135;112;92;91 05:13:57 INFO - PROCESS | 2552 | |6;imaging-darkroom;96;99;97;97;124;148;149;97;120;129 05:13:57 INFO - PROCESS | 2552 | |7;imaging-desaturate;76;117;143;146;93;92;119;121;91;93 05:13:57 INFO - PROCESS | 2552 | |8;json-parse-financial;56;59;56;76;88;91;87;79;71;56 05:13:57 INFO - PROCESS | 2552 | |9;json-stringify-tinderbox;64;69;68;71;79;76;72;67;65;68 05:13:57 INFO - PROCESS | 2552 | |10;stanford-crypto-aes;82;84;84;83;82;103;100;110;107;114 05:13:57 INFO - PROCESS | 2552 | |11;stanford-crypto-ccm;133;129;151;133;130;134;113;142;139;132 05:13:57 INFO - PROCESS | 2552 | |12;stanford-crypto-pbkdf2;141;136;152;140;139;125;105;107;167;173 05:13:57 INFO - PROCESS | 2552 | |13;stanford-crypto-sha256-iterative;67;65;69;65;65;69;66;67;67;67 05:13:57 INFO - PROCESS | 2552 | __end_tp_report 05:13:57 INFO - PROCESS | 2552 | __start_cc_report 05:13:57 INFO - PROCESS | 2552 | _x_x_mozilla_cycle_collect,913 05:13:57 INFO - PROCESS | 2552 | __end_cc_report 05:13:57 INFO - PROCESS | 2552 | __startTimestamp1464437637696__endTimestamp 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | ------- Summary: start ------- 05:13:57 INFO - PROCESS | 2552 | Number of tests: 14 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#0] ai-astar Cycles:10 Average:142.80 Median:151.00 stddev:25.87 (17.1%) stddev-sans-first:25.92 05:13:57 INFO - PROCESS | 2552 | Values: 167.0 160.0 142.0 115.0 132.0 189.0 163.0 115.0 115.0 130.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:154.00 stddev:21.20 (13.8%) stddev-sans-first:21.39 05:13:57 INFO - PROCESS | 2552 | Values: 170.0 143.0 177.0 154.0 118.0 136.0 133.0 186.0 154.0 143.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#2] audio-dft Cycles:10 Average:207.80 Median:202.00 stddev:18.98 (9.4%) stddev-sans-first:19.53 05:13:57 INFO - PROCESS | 2552 | Values: 221.0 258.0 203.0 198.0 202.0 200.0 202.0 199.0 200.0 195.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#3] audio-fft Cycles:10 Average:78.40 Median:62.50 stddev:31.21 (49.9%) stddev-sans-first:32.78 05:13:57 INFO - PROCESS | 2552 | Values: 66.0 76.0 72.0 109.0 56.0 57.0 52.0 59.0 153.0 84.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#4] audio-oscillator Cycles:10 Average:117.90 Median:140.00 stddev:26.86 (19.2%) stddev-sans-first:27.60 05:13:57 INFO - PROCESS | 2552 | Values: 99.0 126.0 158.0 120.0 65.0 100.0 154.0 119.0 115.0 123.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#5] imaging-gaussian-blur Cycles:10 Average:107.10 Median:90.50 stddev:19.13 (21.1%) stddev-sans-first:17.42 05:13:57 INFO - PROCESS | 2552 | Values: 135.0 129.0 92.0 90.0 93.0 102.0 135.0 112.0 92.0 91.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#6] imaging-darkroom Cycles:10 Average:115.60 Median:96.50 stddev:21.43 (22.2%) stddev-sans-first:21.52 05:13:57 INFO - PROCESS | 2552 | Values: 96.0 99.0 97.0 97.0 124.0 148.0 149.0 97.0 120.0 129.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#7] imaging-desaturate Cycles:10 Average:109.10 Median:83.50 stddev:23.68 (28.4%) stddev-sans-first:21.88 05:13:57 INFO - PROCESS | 2552 | Values: 76.0 117.0 143.0 146.0 93.0 92.0 119.0 121.0 91.0 93.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#8] json-parse-financial Cycles:10 Average:71.90 Median:77.50 stddev:14.32 (18.5%) stddev-sans-first:13.98 05:13:57 INFO - PROCESS | 2552 | Values: 56.0 59.0 56.0 76.0 88.0 91.0 87.0 79.0 71.0 56.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:4.72 (6.7%) stddev-sans-first:4.50 05:13:57 INFO - PROCESS | 2552 | Values: 64.0 69.0 68.0 71.0 79.0 76.0 72.0 67.0 65.0 68.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#10] stanford-crypto-aes Cycles:10 Average:94.90 Median:82.00 stddev:13.09 (16.0%) stddev-sans-first:13.03 05:13:57 INFO - PROCESS | 2552 | Values: 82.0 84.0 84.0 83.0 82.0 103.0 100.0 110.0 107.0 114.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:133.50 stddev:9.80 (7.3%) stddev-sans-first:10.39 05:13:57 INFO - PROCESS | 2552 | Values: 133.0 129.0 151.0 133.0 130.0 134.0 113.0 142.0 139.0 132.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.50 Median:140.50 stddev:22.35 (15.9%) stddev-sans-first:23.69 05:13:57 INFO - PROCESS | 2552 | Values: 141.0 136.0 152.0 140.0 139.0 125.0 105.0 107.0 167.0 173.0 05:13:57 INFO - PROCESS | 2552 | 05:13:57 INFO - PROCESS | 2552 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.58 05:13:57 INFO - PROCESS | 2552 | Values: 67.0 65.0 69.0 65.0 65.0 69.0 66.0 67.0 67.0 67.0 05:13:57 INFO - PROCESS | 2552 | -------- Summary: end -------- 05:13:57 INFO - PROCESS | 2552 | 05:13:58 INFO - TEST-INFO | 2552: exit 0 05:13:58 INFO - TEST-OK | kraken | took 58673ms 05:13:58 INFO - SUITE-END | took 1169s 05:13:58 INFO - Completed test suite (00:19:29) 05:13:58 INFO - javascript benchmark 05:13:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3617.9638203617965, 3650.9452358214617, 3674.5039419678337, 3682.999999999999, 3704.722145839061, 5719.913216488864, 5791.102379131231, 5872.471477567018, 5873.500752436043, 5902.085176797593, 5170.767315470804, 5919.964006298891, 5920.023196172627, 5930.940690593093, 5950.404959504048, 5310.884714210011, 5371.650842695231, 5385.030694474993, 5409.24270602114, 5482.424345443731, 5323.281357016792, 5407.188921661763, 5427.891442171154, 5440.156775699773, 5442.156465747816, 5319.308489896308, 5407.053765591026, 5416.647917885325, 5419.943111093338, 5436.103042997901, 5388.515033646991, 5444.50999410051, 5457.781688732446, 5461.42655021223, 5463.0, 5331.786728530854, 5369.194620806871, 5388.245645609618, 5416.91874621881, 5464.590155738336, 5570.326243403189, 5601.551875849922, 5652.3217213934595, 5701.885962280772, 5794.0439827428845, 6273.05904114382, 6287.2140982377205, 6295.527835412362, 6304.464120549759, 6318.905216421757, 6366.745330186787, 6382.170317858695, 6388.105665206875, 6393.136926514908, 6538.084668146464, 5036.445990940993, 5956.55325850563, 6085.96538588441, 6106.542009349317, 6134.263888333428, 6270.216222972129, 6292.402221788922, 6310.905336419957, 6312.842178945563, 6315.084312774622, 6149.262088549313, 6172.0, 6205.162303089115, 6208.379162083846, 6208.9689551551955, 6217.720202590895, 6298.968505157445, 6300.747970081237, 6334.398232167937, 6342.39747224013, 6220.191375121205, 6232.937670623326, 6257.374262573706, 6271.404216599416, 6279.560430769802, 6141.6007959482495, 6203.875922481616, 6265.561410701298, 6266.028765541258, 6271.686415679198, 4067.918641627151, 5058.797648094109, 5068.0, 5079.74601269935, 5150.0472412603785, 4507.526709695435, 4523.5024147343765, 4565.452145742533, 4571.38286331341, 4580.610648094949, 5911.822645320562, 5966.254218222723, 6042.154098426224, 6050.152978583002, 6088.786892458831, 6256.343083976117, 6289.96855015722, 6306.527010474233, 6326.145970293951, 6331.271903731038, 6011.338752737195, 6029.427204415573, 6032.3967603239325, 6039.698015099315, 6063.029915213545, 5362.3565172178805, 5497.312835895513, 5523.834284971457, 5554.972225138929, 5575.52608028314, 6365.586236894587, 6452.387023232785, 6494.837629059122, 6495.6752162391695, 6513.381228783258, 6195.4424101831055, 6272.560920735505, 6305.369463053658, 6337.176167098248, 6359.618422894641, 6314.179156709598, 6405.871882562229, 6427.292997770148, 6530.216374035146, 6568.901466477911, 6229.0967809668255, 6273.309935906956, 6275.184226050585, 6282.183316168869, 6307.76998485291, 6295.150154729236, 6301.243850737941, 6304.5271604628915, 6309.274433440213, 6384.106225128578, 6097.176881120992, 6124.960759790135, 6252.406021427957, 6266.811995640138, 6284.120223168851, 6255.093011513396, 6256.499480041494, 6275.874482510233, 6275.937240627535, 6291.370862913672, 6077.574569780073, 6149.661768602769, 6209.0, 6212.316645169119, 6228.346023667631, 6119.602225855305, 6165.907511387243, 6216.658083805434, 6244.906326405198, 6274.372562743689, 6154.815355539341, 6194.225721784777, 6209.782657607143, 6224.657643829632, 6234.844128896814], "unit": "score", "name": "dojo.html", "value": 5841.291050373216}, {"lowerIsBetter": false, "replicates": [591.6184061280475, 597.5936363272973, 616.4975544930878, 630.738243628894, 665.8002599220234, 30831.537526937114, 39686.00784980377, 39891.800540997254, 40024.79987600065, 40136.996575085635, 28067.719322806766, 41092.76721698346, 41642.79178604103, 41732.58267417325, 42012.57987420125, 9905.653302134391, 9930.255230857696, 9941.353812002197, 9964.053414925607, 9987.0, 9733.951330243373, 10069.0, 10117.190624750003, 10124.746881327952, 10128.987101289886, 7998.560079195671, 8701.999270083958, 9352.25181985443, 10057.849132263022, 10095.788505379365, 9252.398594091395, 9595.520223988842, 9979.401235925796, 9990.100890919815, 10102.242331825106, 9848.556814943273, 9933.403995760278, 9991.400515968993, 9992.600295988152, 10003.39979601219, 36067.0, 38094.23811523754, 40293.99265018369, 40757.59242407568, 41297.38053929193, 3365.9158521036925, 3409.8124603146816, 3423.7432192585406, 3550.254446566224, 3561.7506774525796, 28498.145055648365, 28934.565981510295, 28971.275718107005, 28971.71028289711, 30148.24629384261, 2748.491529067129, 2784.9721502784914, 2795.692473827877, 2818.5208514552573, 2826.491231578315, 434166.0, 436076.0, 441391.0, 442121.7893910542, 442890.0, 47484.7625761869, 48353.75823120932, 67036.65926681439, 70450.64774676094, 74703.0, 47288.05423891572, 47291.0, 47291.52708472871, 47370.76314618405, 47407.76296118566, 14692.706145877237, 17144.828551714574, 17389.0, 17806.821931780774, 17895.821041789415, 11949.581764638197, 14117.364718587689, 14209.857901420854, 14259.857401426061, 14302.356393962296, 12882.871171288354, 15507.224638768017, 15713.371465141496, 15734.9213253933, 15822.52532424029, 6449.0, 6546.116274303004, 6571.080048793173, 6598.670066496656, 6598.802035938929, 963.4123184857232, 1047.9528421221064, 1100.0869278498826, 1122.5565901468874, 1125.178619607691, 30920.446910692423, 30943.0, 31251.374972500424, 31297.8435107823, 31651.366972660417, 1144.3591588710183, 1150.5685367987005, 1158.4902642837126, 1167.8073117935614, 1221.462556475166, 12720.300383478812, 14583.781243281359, 15729.68540629181, 15934.884558080823, 15997.484640837636, 491622.0, 542173.0, 543736.0, 545524.0, 547965.0, 61778.0, 63444.36555634477, 63660.36339636637, 63829.68085159545, 63893.68053159704, 1269.4731686350246, 1527.5570084675542, 1534.77745726869, 1551.534539638104, 1580.0203873598443, 30032.099037028926, 30532.236694082825, 30735.077947661604, 30877.0, 31052.22369440782, 54809.0, 55013.0, 55189.89620207493, 55469.445305546426, 55513.444865550824, 495839.0, 499104.0, 504601.0, 507837.0, 509394.4530277325, 34445.0, 34507.30985380329, 35519.46720799242, 35577.82211088928, 35640.643593563735, 46565.53434465748, 46732.53267467282, 48754.0, 49221.261681074095, 49277.26084108813, 39718.41126354913, 39801.40297895592, 39930.60069399269, 40108.39837402383, 40683.1863362737, 38761.80619096886, 39042.80478597589, 39051.0, 39632.40551391789, 40043.0, 32842.0, 33446.0, 38075.80962095172, 38873.416898747106, 39733.60266397415, 31470.213244669067, 32308.676913231506, 32331.838340808146, 32419.675803241666, 33169.83415083006, 22190.0, 25808.967641294137, 25822.87088564545, 25882.611760823227, 25941.74058259393], "unit": "score", "name": "ext.html", "value": 19870.860142607195}, {"lowerIsBetter": false, "replicates": [334.5984818218139, 373.4472979989617, 380.767731683673, 387.08068337697966, 387.21009141351647, 20499.282525111623, 20837.374878753642, 21267.787322126773, 21865.890670546625, 21909.342719718436, 12200.816987745191, 12535.686607834808, 22442.55114897701, 22820.0, 22832.429189270275, 5240.423553409131, 5372.274742909716, 5406.945930540684, 5411.675299482044, 5412.91880621791, 4183.393407955845, 5406.216098665691, 5838.678872662002, 5991.071383935497, 6119.388061193889, 5932.762689492415, 5965.403459654021, 5978.073398623221, 6071.4232147946095, 6119.143319935212, 5324.733763311839, 5780.682062486561, 5940.940590594104, 5954.404559544033, 5965.671888046156, 5082.4663410341755, 5448.692313844688, 5594.021046316879, 5645.745941432604, 5677.977963966485, 14417.062890912162, 16404.425845095364, 23281.53436931269, 25711.61432578513, 26892.462150756874, 1851.5648822526696, 1948.6200190962768, 2119.7880211978677, 2309.145616122029, 2322.9651555226687, 8284.46151000183, 9957.75105622358, 10311.865694773569, 10434.269601127924, 12888.742225155444, 1784.857211423083, 1793.5874748807717, 1801.2884910460295, 1804.6751584714746, 1813.4287699374786, 104285.4785726074, 105866.0, 109890.0, 111154.44422777915, 113493.0, 9995.150412214898, 11621.07031437483, 11693.006094482063, 11778.469968851423, 11782.469788859522, 14300.0, 14453.566393008226, 14484.275786210648, 14590.41638334476, 14659.413623455155, 7997.640106195236, 8933.240674542736, 9079.727608171765, 9139.131782480654, 9179.541022948826, 7602.6198690066385, 8840.160184782435, 9267.44395336282, 9289.16397524226, 9381.061893810564, 4539.364488971547, 4604.700694454849, 4609.0, 4624.606908412823, 4654.720716757005, 1822.7448157257995, 1858.4145994012113, 1887.0941947865101, 1922.644310802506, 1937.2832052140798, 901.6753968571309, 958.5015791788231, 1018.134585602247, 1080.9297395669257, 1120.798256313855, 18628.72056919147, 19816.801831981495, 20580.58838823215, 20677.896610517153, 20823.1670733172, 987.5485179298255, 1024.8155332040305, 1068.8396740488988, 1113.6659002299277, 1131.7000994736402, 10971.780564388828, 11507.539698411969, 11592.420378981185, 11601.18791684574, 11639.0, 631951.0, 633918.0, 648752.0, 652728.0, 662653.0, 117447.65104697859, 122359.0, 124177.0, 124675.0, 127070.72929270774, 1040.2042437535292, 1048.7797562511805, 1050.4957620342125, 1063.5905176506947, 1068.2522234435926, 18546.81453185451, 18802.965836879102, 19009.42971710851, 19029.333973311423, 19155.233790648217, 50500.484985450494, 51754.96490070102, 52760.73619632031, 53885.0, 54754.0, 74828.0, 75358.62320688361, 76325.61837190778, 76613.0, 76647.0, 7079.752208672672, 7375.598636259094, 8461.492310461392, 8469.74590762278, 8570.0, 12375.814362784746, 13501.189928604315, 13501.932490337485, 13689.931550342184, 13814.861851381358, 11610.94194529022, 11617.302961822317, 11702.648920532398, 11709.414529273672, 11873.940630296793, 11467.139964502529, 11484.0, 11501.19491635611, 11716.23844450108, 11866.466009029788, 9712.660056897974, 10221.540030698488, 11825.231359961575, 11926.344051076927, 12036.63890083299, 8289.626966786389, 8330.083690794128, 8469.5341756204, 8488.490690558587, 8543.359248056297, 8821.823563528822, 11304.434778261219, 11648.88351116478, 11768.646940591796, 11980.58067967617], "unit": "score", "name": "jquery.html", "value": 9572.424214160139}, {"lowerIsBetter": false, "replicates": [1465.574983254856, 1526.2673916520066, 1924.3457224543652, 2056.5886822635475, 2117.5235571996313, 8328.875066873987, 9065.138811812883, 9091.318151138667, 9270.304727145465, 9288.164065234128, 9056.230220431271, 9065.0, 9224.815503689922, 9225.861612075823, 9236.769080772983, 2577.3814284571754, 2579.3938424470234, 2582.7546383093577, 2592.7277635848245, 2597.2597809624262, 2540.5427023135826, 2595.8442493450452, 2596.6883973923154, 2614.16346769034, 2617.50267449185, 2581.5740402833508, 2592.364870606704, 2595.740425957408, 2617.8691065446747, 2631.4210873607776, 2546.3506805764505, 2570.5373032854077, 2583.2121203033066, 2596.9220923372327, 2603.2060221632396, 2549.6430499730054, 2551.693796744384, 2610.843349399042, 2619.2796980830235, 2629.8685065746636, 9265.953670231605, 9347.906520934772, 9406.153446189875, 9407.106324899123, 9429.0, 5347.572194224453, 5770.394108618619, 5804.071348584249, 5955.374685657986, 6028.276606807167, 3690.7785532868115, 3783.5838057813617, 3854.3640299350573, 3871.128995975911, 3880.9223815523815, 1076.8061748885198, 1082.4154956323655, 1084.0893649334596, 1122.4387806096952, 1128.328644456547, 12180.51277948881, 12393.0, 12417.254964702057, 12431.067669924701, 12482.43829027696, 4438.800253988514, 5040.218766091261, 5075.187969924795, 5152.201408781645, 5163.277141200235, 10517.631882884063, 10607.15142788575, 10635.468226588795, 10655.893441065646, 10787.6224332148, 5678.346990096192, 5697.259356283656, 5731.799387021518, 5735.225744524436, 5808.419158084243, 4676.602488788423, 5118.0, 5205.947940520547, 5211.166213405837, 5272.657277277041, 3781.6029316921877, 3970.630132604247, 4111.60939710727, 4164.708470407103, 4172.979135104305, 1251.6870782304425, 1287.9567550284112, 1357.2399456304502, 1362.6797702539895, 1381.5717127690448, 1137.8293256011664, 1296.7276871856827, 1324.0863803975226, 1340.2293681133388, 1465.8460861609378, 8578.785530361665, 8624.051354351017, 8635.654573817103, 8647.827043459221, 8656.047834738174, 538.4346436241931, 539.4093467652914, 545.6126150433157, 549.9092649712833, 551.7296524702866, 6343.238811342669, 6440.806775796734, 6459.935400645933, 6462.870742585122, 6495.837604059936, 9250.0, 9677.419354838732, 11289.71775705614, 11384.601538946263, 11450.885491145149, 10964.945175274232, 11123.555057797597, 11125.833112503318, 11306.434678266054, 11317.377544235145, 7678.654460549289, 8747.606357713918, 8812.603432845537, 8859.7342079739, 8862.512561809033, 6819.147606549182, 8145.551994640352, 8302.584870756558, 8420.578971051546, 8464.873026904479, 8289.4197406181, 9951.800963980824, 10087.848682269918, 10126.8480972784, 10182.592696292066, 10247.641332553325, 10263.538140783534, 10587.735306617396, 10592.629257976243, 10594.417307047877, 7076.25699301566, 7660.1956794538, 7698.307152356315, 7874.0157480314965, 7985.920140798517, 7552.584607846401, 8519.105493923049, 8533.402661813861, 8560.357973151915, 8583.18459746323, 6354.745810167727, 7620.237976202558, 7652.1582625912215, 7712.807179820549, 7776.222377762178, 7417.221191774786, 7513.060867391576, 7539.2083831199125, 7584.938108664681, 7618.961905190438, 6888.345607167311, 7996.04047514302, 8073.233042860918, 8120.918790812017, 8199.549024803693, 7299.160596531467, 7333.449991250571, 7394.704211831467, 7413.740519081806, 7455.105387353336, 7434.59109748969, 7447.404207663482, 7495.7001719930595, 7511.624418779148, 7521.360684341892], "unit": "score", "name": "mootools.html", "value": 5051.48868696026}, {"lowerIsBetter": false, "replicates": [341.3139589425255, 341.38550608903984, 342.84057913070416, 344.175699200415, 344.98918169762595, 6176.166217560628, 6332.715027823753, 6559.344065593438, 6962.09492765941, 7063.434925205984, 6812.727490900371, 6984.2317345092, 7004.57972521649, 7015.158181018272, 7058.576485410867, 4125.876223713279, 4874.854409213832, 5006.649534532584, 5087.49125087492, 5173.689578625275, 5062.544371006608, 5082.23766435034, 5082.745862706868, 5088.465711100337, 5121.513456221653, 4093.488313960755, 5007.949920500803, 5030.220315851031, 5051.166557518023, 5052.595792336604, 4925.605951523888, 5112.463191364909, 5120.308758317654, 5128.487151284879, 5130.076586214499, 3856.267309211241, 4147.315692910666, 4395.362672412514, 4408.691391602589, 4412.40432541606, 6362.427381535684, 6597.868042639168, 6697.799066028027, 6735.831604209934, 6746.392824645805, 5884.146798714205, 5887.293524777011, 5936.881262374728, 5944.346121926585, 5971.701414929236, 7404.814879627998, 7421.703131874719, 7447.739329123455, 7453.440991925628, 7463.552186868751, 3958.386450100239, 4764.213904705754, 4783.736894470802, 4790.185668436374, 4796.664233503621, 6211.782587609412, 7398.11222653285, 7878.842423151505, 7894.526328420256, 7897.8025549361155, 4636.907261854744, 4738.407699037621, 4788.760561971888, 4796.736179510091, 4798.160321943646, 4874.098291816025, 4879.902401951941, 4888.902221955612, 5002.874928126826, 5037.974810125999, 5931.051031834886, 5947.256592925884, 5956.374580669054, 5960.880782384328, 5982.880342393128, 5951.018082016419, 6459.967700161469, 6591.868162636721, 6871.453922867415, 7421.183669796318, 1702.8467437930399, 1726.9136543173042, 1728.3173146607019, 1730.7663465432258, 1732.1772158224742, 1051.1748277602046, 1081.6700906223678, 1089.5750657243682, 1089.983650245247, 1091.8198497247865, 6988.720451181997, 7041.401480874183, 7060.0, 7078.327558881898, 7082.681279342442, 7651.196624354474, 7655.425843061793, 7660.923390766133, 7665.5017423868385, 7675.692972281158, 5996.910046349309, 6782.423494003065, 7042.753503627348, 7056.506044576933, 7057.329553692391, 3942.4677668514955, 4030.4760381150263, 4070.816813243411, 4073.9592604073578, 4092.8567500137947, 8030.39772017101, 8047.557384343917, 8050.19498050202, 8053.0, 8056.556889371141, 7859.214078592209, 7902.525848449111, 7907.327877130393, 7921.920780792118, 7926.326262267657, 7999.640016199285, 8004.879926801103, 8019.83960320802, 8043.155468675822, 8050.355971522265, 6139.649277159018, 7048.295170482911, 7112.359887609933, 7451.552906825608, 7628.275313845176, 7452.292032256927, 7476.0, 7508.0, 7518.210587888412, 7555.282248186413, 7156.284371562802, 7492.737754178577, 7991.680332786856, 8026.277635012877, 8037.879431808411, 4827.903441931212, 4869.366982292279, 4884.804607815648, 4889.90220195587, 4892.290617860319, 7462.0, 7524.962375188089, 7616.276453736886, 7794.649240784065, 7802.609869506388, 7451.8882216765705, 7462.403007759474, 7472.775816725507, 7513.511621744569, 7516.398688105048, 7456.067991501062, 7467.514611550232, 7472.925270747223, 7473.77578672619, 7507.136679281734, 5657.60396772222, 5878.353381128158, 7209.170945341143, 7289.307515785992, 7312.012878261579, 7434.888476672746, 7466.701331946661, 7491.737789177353, 7504.362129219077, 7523.548587084792, 7217.927820721936, 7304.96347518259, 7330.706771729285, 7331.826907694744, 7356.227596102546], "unit": "score", "name": "prototype.html", "value": 5352.321572555291}, {"lowerIsBetter": false, "replicates": [634.3497914637493, 698.5319835710073, 761.3072104385011, 765.4144579396759, 775.050563060251, 15442.073475591473, 15492.0, 15558.0, 15606.219689015546, 15707.371705131794, 14287.642808929782, 14491.855081449208, 14523.491677791279, 14537.92731036346, 14551.126932384064, 770.7148355108618, 820.8891799607036, 904.2043002158092, 953.7853982853871, 958.9472579008152, 936.8220038192721, 938.8544775559799, 953.3183773601874, 953.5232383808096, 953.7949340891707, 885.9457245877418, 972.4505654305331, 974.5565767575736, 975.5902520941222, 992.2310209587555, 830.8462934357133, 998.0269237493459, 1000.4397537379091, 1000.5247507433947, 1001.0990108901974, 694.229405360055, 695.3845846425899, 737.5574655206887, 742.3393180069743, 750.1785544828405, 15153.848461515465, 15284.694306113815, 15305.1582162981, 15573.221338933008, 15591.376344946302, 11328.263662861887, 13430.597082087554, 13468.663283417894, 13632.250226237553, 13723.862761372358, 10335.741606459824, 10508.737281567946, 10513.369197848153, 10582.78834423315, 10823.621173258976, 3608.440691692792, 3680.1351682354625, 3682.3371793077235, 3682.4844521766972, 3696.704263658901, 79260.41479170442, 84397.57801211016, 86252.56873715654, 87051.0, 88073.99999999936, 9891.307608467338, 9942.254330925065, 9968.950155249177, 9975.201983841276, 10161.288709790391, 22364.776352236593, 23302.7669723304, 23313.0, 23344.533109337717, 23356.532869342518, 7580.05249343832, 7732.884006739903, 7749.7675069748, 7816.7264145754625, 7952.341506242492, 4072.2669919414197, 4209.894752631209, 4253.574642535722, 4276.743395396286, 4357.215701173819, 3758.9436158457647, 3759.135398858223, 3809.104860357814, 3816.675582575512, 3819.923601527954, 584.6813486649786, 658.2989116590816, 675.0448115916022, 679.1578442730978, 681.9045333653293, 504.23859971443386, 526.3525863188299, 558.5810642018486, 566.8724536979147, 618.1870839845589, 7986.440949133505, 8034.357251419872, 8060.113387527367, 8144.83710325802, 8407.53758543286, 506.4252073896154, 507.7359772918062, 522.1233677452611, 605.9515238780887, 616.6793267500964, 3775.565809931838, 3819.8854034379015, 3997.200559887976, 4314.611684948307, 4323.567643235651, 66616.00075998864, 85555.5722221385, 86331.0, 98335.50832245793, 100679.0, 75957.62021189858, 76553.0, 80824.0, 82524.58737706393, 83419.0, 63096.68451657804, 64270.678646607405, 77348.0, 81305.59347203345, 81915.0, 8737.082606326498, 8748.518831464331, 8796.384253102222, 8845.071267516818, 8894.33292503052, 50944.45277736172, 50979.49020509747, 51224.74387628038, 51711.741441294056, 52106.739466302424, 66590.33409665841, 68278.65860670665, 68525.65737171282, 69667.95498067634, 70223.07080986176, 11873.821892671443, 11903.0, 11972.0, 11975.820362694392, 12225.327606981346, 9795.412275263221, 10069.791625005046, 12213.572524961584, 12438.626841194779, 13446.193228406328, 10260.58957641686, 11300.547978080785, 11848.58529951482, 11870.706385356132, 11872.643820685393, 11746.119041071783, 11895.583654572049, 11903.76192476163, 11998.64004079879, 12099.092568057255, 9358.15776580111, 11518.654440366803, 11671.766564668489, 11726.58769674366, 11803.82294265604, 9788.853167202355, 9973.401595904268, 9983.700488985342, 10076.596936122767, 10163.881972982817, 8627.22354988054, 9924.0, 10117.08946194846, 10135.239857010607, 10272.845907311546], "unit": "score", "name": "yui.html", "value": 7075.71895728752}], "name": "dromaeo_css", "value": 7725.360019784777}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [167.0, 160.0, 142.0, 115.0, 132.0, 189.0, 163.0, 115.0, 115.0, 130.0], "unit": "score", "name": "ai-astar", "value": 142.8}, {"lowerIsBetter": true, "replicates": [170.0, 143.0, 177.0, 154.0, 118.0, 136.0, 133.0, 186.0, 154.0, 143.0], "unit": "score", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [221.0, 258.0, 203.0, 198.0, 202.0, 200.0, 202.0, 199.0, 200.0, 195.0], "unit": "score", "name": "audio-dft", "value": 207.8}, {"lowerIsBetter": true, "replicates": [66.0, 76.0, 72.0, 109.0, 56.0, 57.0, 52.0, 59.0, 153.0, 84.0], "unit": "score", "name": "audio-fft", "value": 78.4}, {"lowerIsBetter": true, "replicates": [99.0, 126.0, 158.0, 120.0, 65.0, 100.0, 154.0, 119.0, 115.0, 123.0], "unit": "score", "name": "audio-oscillator", "value": 117.9}, {"lowerIsBetter": true, "replicates": [135.0, 129.0, 92.0, 90.0, 93.0, 102.0, 135.0, 112.0, 92.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 107.1}, {"lowerIsBetter": true, "replicates": [96.0, 99.0, 97.0, 97.0, 124.0, 148.0, 149.0, 97.0, 120.0, 129.0], "unit": "score", "name": "imaging-darkroom", "value": 115.6}, {"lowerIsBetter": true, "replicates": [76.0, 117.0, 143.0, 146.0, 93.0, 92.0, 119.0, 121.0, 91.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 109.1}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 56.0, 76.0, 88.0, 91.0, 87.0, 79.0, 71.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [64.0, 69.0, 68.0, 71.0, 79.0, 76.0, 72.0, 67.0, 65.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 84.0, 83.0, 82.0, 103.0, 100.0, 110.0, 107.0, 114.0], "unit": "score", "name": "stanford-crypto-aes", "value": 94.9}, {"lowerIsBetter": true, "replicates": [133.0, 129.0, 151.0, 133.0, 130.0, 134.0, 113.0, 142.0, 139.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.6}, {"lowerIsBetter": true, "replicates": [141.0, 136.0, 152.0, 140.0, 139.0, 125.0, 105.0, 107.0, 167.0, 173.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.5}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 69.0, 65.0, 65.0, 69.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1605.6000000000004}]} 05:13:58 INFO - Return code: 0 05:13:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:13:58 ERROR - # TBPL SUCCESS # 05:13:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:13:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:13:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:13:59 INFO - 2016-05-28 05:13:59.001 screenresolution[2557:24285] starting screenresolution argv=screenresolution get 05:13:59 INFO - 2016-05-28 05:13:59.004 screenresolution[2557:24285] Display 0: 1600x1200x32@60 05:13:59 INFO - 2016-05-28 05:13:59.010 screenresolution[2558:24288] starting screenresolution argv=screenresolution list 05:13:59 INFO - Available Modes on Display 0 05:13:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:13:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:13:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:13:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:13:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:13:59 INFO - Intel Iris: 05:13:59 INFO - Chipset Model: Intel Iris 05:13:59 INFO - Type: GPU 05:13:59 INFO - Bus: Built-In 05:13:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:13:59 INFO - Vendor: Intel (0x8086) 05:13:59 INFO - Device ID: 0x0a2e 05:13:59 INFO - Revision ID: 0x0009 05:13:59 INFO - Displays: 05:13:59 INFO - Display: 05:13:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:13:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:13:59 INFO - Display Serial Number: 1600x1200 60 05:13:59 INFO - Main Display: Yes 05:13:59 INFO - Mirror: Off 05:13:59 INFO - Online: Yes 05:13:59 INFO - Rotation: Supported 05:13:59 INFO - Return code: 0 05:13:59 INFO - Running post-action listener: _resource_record_post_action 05:13:59 INFO - Running post-run listener: _resource_record_post_run 05:14:00 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 331776; Write bytes: 510873600; Read time: 7; Write time: 1870 05:14:00 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 200557056; Write bytes: 198211584; Read time: 18937; Write time: 362 05:14:00 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 331776; Write bytes: 301864960; Read time: 7; Write time: 1474 05:14:00 INFO - Running post-run listener: _upload_blobber_files 05:14:00 INFO - Blob upload gear active. 05:14:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:14:00 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 05:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:14:00 INFO - (blobuploader) - INFO - Open directory for files ... 05:14:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:14:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:14:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:02 INFO - (blobuploader) - INFO - Done attempting. 05:14:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:14:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:14:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:03 INFO - (blobuploader) - INFO - Done attempting. 05:14:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:03 INFO - Return code: 0 05:14:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:14:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/22d741a90bb7cd223d35ba20e8382b8da006fc8a75d16818da60c37c6bb3ea4256a9e2491dd579f969d62ebc7d7ef8f7d21b4395a1d7240b2b741105073e92b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/177081e57510983a40ad833dc19582160da29228230512462dfb4789b2b2ad3534ea2c9d9bc253106c4f481844585b26dc9144156c2771988a7785032a83a5fa"} 05:14:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:14:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:14:03 INFO - Contents: 05:14:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/22d741a90bb7cd223d35ba20e8382b8da006fc8a75d16818da60c37c6bb3ea4256a9e2491dd579f969d62ebc7d7ef8f7d21b4395a1d7240b2b741105073e92b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/177081e57510983a40ad833dc19582160da29228230512462dfb4789b2b2ad3534ea2c9d9bc253106c4f481844585b26dc9144156c2771988a7785032a83a5fa"} 05:14:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:14:03 INFO - Copying logs to upload dir... 05:14:03 INFO - mkdir: /builds/slave/test/build/upload/logs 05:14:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.743930 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-28 05:14:04.345887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-05-28 05:14:04.349189) ========= 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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/22d741a90bb7cd223d35ba20e8382b8da006fc8a75d16818da60c37c6bb3ea4256a9e2491dd579f969d62ebc7d7ef8f7d21b4395a1d7240b2b741105073e92b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/177081e57510983a40ad833dc19582160da29228230512462dfb4789b2b2ad3534ea2c9d9bc253106c4f481844585b26dc9144156c2771988a7785032a83a5fa"} build_url:https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011630 build_url: 'https://queue.taskcluster.net/v1/task/VBsoyUieRpCYE7cC_0T6sg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/22d741a90bb7cd223d35ba20e8382b8da006fc8a75d16818da60c37c6bb3ea4256a9e2491dd579f969d62ebc7d7ef8f7d21b4395a1d7240b2b741105073e92b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/177081e57510983a40ad833dc19582160da29228230512462dfb4789b2b2ad3534ea2c9d9bc253106c4f481844585b26dc9144156c2771988a7785032a83a5fa"}' ========= master_lag: 2.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-05-28 05:14:06.431520) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:14:06.431870) ========= 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.4z3aZKKT8C/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.aQo7LmPmJl/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.005451 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:14:06.465438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 05:14:06.465701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 05:14:06.466042) ========= ========= Total master_lag: 2.25 =========