builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0116 starttime: 1461585264.01 results: success (0) buildid: 20160422035709 builduid: 3af33a9a7de54ba3986a82f34ab86caa revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:24.009130) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:24.009649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:24.009989) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:24.030957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:24.031538) ========= 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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-04-25 04:54:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|: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.43M=0.001s 2016-04-25 04:54:24 (8.43 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111995 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:24.163472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:24.163845) ========= 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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.026653 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:24.212794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 04:54:24.213173) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80598be5d80e695727ff74e712faa623b02f3c70 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 80598be5d80e695727ff74e712faa623b02f3c70 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dc0fckrg8L/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.e3uq3r7dNL/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-04-25 04:54:24,292 truncating revision to first 12 chars 2016-04-25 04:54:24,292 Setting DEBUG logging. 2016-04-25 04:54:24,292 attempt 1/10 2016-04-25 04:54:24,292 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80598be5d80e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 04:54:25,388 unpacking tar archive at: fx-team-80598be5d80e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.345805 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 04:54:25.575934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:25.576285) ========= script_repo_revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:25.576735) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:25.577081) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:54:25.590737) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-25 04:54:25.591087) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dc0fckrg8L/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.e3uq3r7dNL/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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:54:25 INFO - MultiFileLogger online at 20160425 04:54:25 in /builds/slave/test 04:54:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:54:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:54:25 INFO - {'append_to_log': False, 04:54:25 INFO - 'base_work_dir': '/builds/slave/test', 04:54:25 INFO - 'blob_upload_branch': 'Fx-Team', 04:54:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:54:25 INFO - 'branch': 'Fx-Team', 04:54:25 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:25 INFO - 'config_files': ('talos/mac_config.py',), 04:54:25 INFO - 'default_actions': ('clobber', 04:54:25 INFO - 'read-buildbot-config', 04:54:25 INFO - 'download-and-extract', 04:54:25 INFO - 'populate-webroot', 04:54:25 INFO - 'create-virtualenv', 04:54:25 INFO - 'install', 04:54:25 INFO - 'run-tests'), 04:54:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:25 INFO - 'download_minidump_stackwalk': True, 04:54:25 INFO - 'download_symbols': 'ondemand', 04:54:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:25 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:25 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:25 INFO - 'installer_path': 'installer.exe', 04:54:25 INFO - 'log_level': 'info', 04:54:25 INFO - 'log_name': 'talos', 04:54:25 INFO - 'log_to_console': True, 04:54:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:54:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:54:25 INFO - 'opt_config_files': (), 04:54:25 INFO - 'pip_index': False, 04:54:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:25 INFO - 'cmd': ('bash', 04:54:25 INFO - '-c', 04:54:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:25 INFO - 'enabled': True, 04:54:25 INFO - 'halt_on_failure': False, 04:54:25 INFO - 'name': 'check_screen_resolution'},), 04:54:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:25 INFO - 'cmd': ('bash', 04:54:25 INFO - '-c', 04:54:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:25 INFO - 'enabled': True, 04:54:25 INFO - 'halt_on_failure': False, 04:54:25 INFO - 'name': 'check_screen_resolution'},), 04:54:25 INFO - 'run_cmd_checks_enabled': True, 04:54:25 INFO - 'sps_profile': False, 04:54:25 INFO - 'sps_profile_interval': 0, 04:54:25 INFO - 'suite': 'dromaeojs-e10s', 04:54:25 INFO - 'system_bits': '32', 04:54:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:25 INFO - 'title': 't-yosemite-r7-0116', 04:54:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:25 INFO - 'use_talos_json': True, 04:54:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:54:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:25 INFO - 'work_dir': 'build'} 04:54:25 INFO - ##### 04:54:25 INFO - ##### Running clobber step. 04:54:25 INFO - ##### 04:54:25 INFO - Running pre-action listener: _resource_record_pre_action 04:54:25 INFO - Running main action method: clobber 04:54:25 INFO - rmtree: /builds/slave/test/build 04:54:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:54:27 INFO - Running post-action listener: _resource_record_post_action 04:54:27 INFO - ##### 04:54:27 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 04:54:27 INFO - Using buildbot properties: 04:54:27 INFO - { 04:54:27 INFO - "project": "", 04:54:27 INFO - "product": "firefox", 04:54:27 INFO - "script_repo_revision": "production", 04:54:27 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:54:27 INFO - "repository": "", 04:54:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:54:27 INFO - "buildid": "20160422035709", 04:54:27 INFO - "pgo_build": "False", 04:54:27 INFO - "basedir": "/builds/slave/test", 04:54:27 INFO - "buildnumber": 632, 04:54:27 INFO - "slavename": "t-yosemite-r7-0116", 04:54:27 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:54:27 INFO - "platform": "yosemite_r7", 04:54:27 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 04:54:27 INFO - "branch": "fx-team", 04:54:27 INFO - "repo_path": "integration/fx-team", 04:54:27 INFO - "revision": "80598be5d80e695727ff74e712faa623b02f3c70", 04:54:27 INFO - "stage_platform": "macosx64", 04:54:27 INFO - "builduid": "3af33a9a7de54ba3986a82f34ab86caa", 04:54:27 INFO - "slavebuilddir": "test" 04:54:27 INFO - } 04:54:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:54:27 INFO - Running post-action listener: _resource_record_post_action 04:54:27 INFO - ##### 04:54:27 INFO - ##### Running download-and-extract 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: download_and_extract 04:54:27 INFO - mkdir: /builds/slave/test/build/tests 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 - https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:54:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:54:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:54:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 04:54:28 INFO - Downloaded 1199 bytes. 04:54:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:54:28 INFO - Using the following test package requirements: 04:54:28 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:54:28 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:54:28 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:54:28 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:54:28 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:54:28 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:54:28 INFO - u'jsshell-mac.zip'], 04:54:28 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:54:28 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:54:28 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:54:28 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:54:28 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:54:28 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:54:28 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:54:28 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:54:28 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:54:28 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:54:28 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:54:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28 INFO - https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:54:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:54:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:54:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:54:30 INFO - Downloaded 18105796 bytes. 04:54:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:54:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:54:33 INFO - Return code: 0 04:54:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:54: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:54:33 INFO - https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:54:35 INFO - Downloaded 18105796 bytes. 04:54:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:54:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:54:39 INFO - Return code: 0 04:54:39 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:39 INFO - https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:54:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:54:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:54:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:54:40 INFO - Downloaded 10845952 bytes. 04:54:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:54:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:54:40 INFO - Return code: 0 04:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:40 INFO - https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 04:54:43 INFO - Downloaded 110034607 bytes. 04:54:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:54:43 INFO - mkdir: /builds/slave/test/properties 04:54:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:54:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:54:43 INFO - Contents: 04:54:43 INFO - build_url:https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:54:44 INFO - Running post-action listener: _resource_record_post_action 04:54:44 INFO - Running post-action listener: set_extra_try_arguments 04:54:44 INFO - ##### 04:54:44 INFO - ##### Running populate-webroot step. 04:54:44 INFO - ##### 04:54:44 INFO - Running pre-action listener: _resource_record_pre_action 04:54:44 INFO - Running main action method: populate_webroot 04:54:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:44 INFO - '--tppagecycles', 04:54:44 INFO - '7'], 04:54:44 INFO - 'tests': ['tsvgm']}}, 04:54:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:54:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:54:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:54:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:54:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:54:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:44 INFO - 'talos_options': ['--disable-e10s'], 04:54:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:44 INFO - 'talos_options': ['--disable-e10s'], 04:54:44 INFO - 'tests': ['damp', 'tps']}, 04:54:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:44 INFO - 'tests': ['damp', 'tps']}, 04:54:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:54:44 INFO - 'tests': ['dromaeo_dom']}, 04:54:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:54:44 INFO - 'tests': ['a11yr', 04:54:44 INFO - 'ts_paint', 04:54:44 INFO - 'tpaint', 04:54:44 INFO - 'sessionrestore', 04:54:44 INFO - 'sessionrestore_no_auto_restore', 04:54:44 INFO - 'tabpaint']}, 04:54:44 INFO - 'other-e10s': {'tests': ['a11yr', 04:54:44 INFO - 'ts_paint', 04:54:44 INFO - 'tpaint', 04:54:44 INFO - 'sessionrestore', 04:54:44 INFO - 'sessionrestore_no_auto_restore', 04:54:44 INFO - 'tabpaint']}, 04:54:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:54:44 INFO - 'ts_paint', 04:54:44 INFO - 'tpaint', 04:54:44 INFO - 'sessionrestore', 04:54:44 INFO - 'sessionrestore_no_auto_restore', 04:54:44 INFO - 'tabpaint']}, 04:54:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:54:44 INFO - 'ts_paint', 04:54:44 INFO - 'tpaint', 04:54:44 INFO - 'sessionrestore', 04:54:44 INFO - 'sessionrestore_no_auto_restore', 04:54:44 INFO - 'tabpaint']}, 04:54:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:54:44 INFO - 'tests': ['a11yr', 04:54:44 INFO - 'ts_paint', 04:54:44 INFO - 'tpaint', 04:54:44 INFO - 'sessionrestore', 04:54:44 INFO - 'sessionrestore_no_auto_restore', 04:54:44 INFO - 'tabpaint']}, 04:54:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:54:44 INFO - 'tests': ['a11yr', 04:54:44 INFO - 'ts_paint', 04:54:44 INFO - 'tpaint', 04:54:44 INFO - 'sessionrestore', 04:54:44 INFO - 'sessionrestore_no_auto_restore', 04:54:44 INFO - 'tabpaint']}, 04:54:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:54:44 INFO - 'tests': ['tsvgx', 04:54:44 INFO - 'tsvgr_opacity', 04:54:44 INFO - 'tart', 04:54:44 INFO - 'tscrollx', 04:54:44 INFO - 'cart']}, 04:54:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:54:44 INFO - 'tsvgr_opacity', 04:54:44 INFO - 'tart', 04:54:44 INFO - 'tscrollx', 04:54:44 INFO - 'cart']}, 04:54:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:44 INFO - 'talos_options': ['--disable-e10s'], 04:54:44 INFO - 'tests': ['tp5o']}, 04:54:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:44 INFO - 'tests': ['tp5o']}, 04:54:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:44 INFO - 'talos_options': ['--disable-e10s', 04:54:44 INFO - '--xperf_path', 04:54:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:44 INFO - 'tests': ['tp5n']}, 04:54:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:44 INFO - 'talos_options': ['--xperf_path', 04:54:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:44 INFO - 'tests': ['tp5n']}}, 04:54:44 INFO - 'talos.zip': {'path': '', 04:54:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:44 INFO - Running post-action listener: _resource_record_post_action 04:54:44 INFO - ##### 04:54:44 INFO - ##### Running create-virtualenv step. 04:54:44 INFO - ##### 04:54:44 INFO - Running pre-action listener: _resource_record_pre_action 04:54:44 INFO - Running main action method: create_virtualenv 04:54:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:54:44 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:54:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:54:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:44 INFO - Using real prefix '/tools/python27' 04:54:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:54:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:48 INFO - Installing pip.................done. 04:54:48 INFO - Return code: 0 04:54:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108296a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ffa488f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108135e00>, '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 0x107f9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108130b20>, '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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:54:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dc0fckrg8L/Render', 04:54:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:48 INFO - 'HOME': '/Users/cltbld', 04:54:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:48 INFO - 'LOGNAME': 'cltbld', 04:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:48 INFO - 'MOZ_NO_REMOTE': '1', 04:54:48 INFO - 'NO_EM_RESTART': '1', 04:54:48 INFO - 'PAGER': '/bin/cat', 04:54:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:48 INFO - 'PWD': '/builds/slave/test', 04:54:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:48 INFO - 'SHELL': '/bin/bash', 04:54:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e3uq3r7dNL/Listeners', 04:54:48 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:54:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:48 INFO - 'USER': 'cltbld', 04:54:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:48 INFO - 'XPC_FLAGS': '0x0', 04:54:48 INFO - 'XPC_SERVICE_NAME': '0', 04:54:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:48 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:54:48 INFO - Cleaning up... 04:54:48 INFO - Return code: 0 04:54:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108296a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ffa488f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108135e00>, '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 0x107f9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108130b20>, '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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:54:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dc0fckrg8L/Render', 04:54:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:48 INFO - 'HOME': '/Users/cltbld', 04:54:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:48 INFO - 'LOGNAME': 'cltbld', 04:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:48 INFO - 'MOZ_NO_REMOTE': '1', 04:54:48 INFO - 'NO_EM_RESTART': '1', 04:54:48 INFO - 'PAGER': '/bin/cat', 04:54:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:48 INFO - 'PWD': '/builds/slave/test', 04:54:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:48 INFO - 'SHELL': '/bin/bash', 04:54:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e3uq3r7dNL/Listeners', 04:54:48 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:54:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:48 INFO - 'USER': 'cltbld', 04:54:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:48 INFO - 'XPC_FLAGS': '0x0', 04:54:48 INFO - 'XPC_SERVICE_NAME': '0', 04:54:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:49 INFO - Downloading/unpacking psutil>=0.7.1 04:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:52 INFO - Installing collected packages: psutil 04:54:52 INFO - Running setup.py install for psutil 04:54:52 INFO - building 'psutil._psutil_osx' extension 04:54:52 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:54:52 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:54:52 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:54:52 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:54:52 INFO - building 'psutil._psutil_posix' extension 04:54:52 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:54:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:54:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:54:53 INFO - ^ 04:54:53 INFO - 1 warning generated. 04:54:53 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:54:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:53 INFO - Successfully installed psutil 04:54:53 INFO - Cleaning up... 04:54:53 INFO - Return code: 0 04:54:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108296a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ffa488f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108135e00>, '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 0x107f9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108130b20>, '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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:54:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dc0fckrg8L/Render', 04:54:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:53 INFO - 'HOME': '/Users/cltbld', 04:54:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:53 INFO - 'LOGNAME': 'cltbld', 04:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:53 INFO - 'MOZ_NO_REMOTE': '1', 04:54:53 INFO - 'NO_EM_RESTART': '1', 04:54:53 INFO - 'PAGER': '/bin/cat', 04:54:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:53 INFO - 'PWD': '/builds/slave/test', 04:54:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:53 INFO - 'SHELL': '/bin/bash', 04:54:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e3uq3r7dNL/Listeners', 04:54:53 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:54:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:53 INFO - 'USER': 'cltbld', 04:54:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:53 INFO - 'XPC_FLAGS': '0x0', 04:54:53 INFO - 'XPC_SERVICE_NAME': '0', 04:54:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54:56 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:54:56 INFO - Installing collected packages: mozsystemmonitor 04:54:56 INFO - Running setup.py install for mozsystemmonitor 04:54:56 INFO - Successfully installed mozsystemmonitor 04:54:56 INFO - Cleaning up... 04:54:56 INFO - Return code: 0 04:54:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:54: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:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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', '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 0x108296a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ffa488f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108135e00>, '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 0x107f9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108130b20>, '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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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:54: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:54: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 blobuploader==1.2.4 04:54:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dc0fckrg8L/Render', 04:54:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:56 INFO - 'HOME': '/Users/cltbld', 04:54:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:56 INFO - 'LOGNAME': 'cltbld', 04:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:56 INFO - 'MOZ_NO_REMOTE': '1', 04:54:56 INFO - 'NO_EM_RESTART': '1', 04:54:56 INFO - 'PAGER': '/bin/cat', 04:54:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:56 INFO - 'PWD': '/builds/slave/test', 04:54:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:56 INFO - 'SHELL': '/bin/bash', 04:54:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e3uq3r7dNL/Listeners', 04:54:56 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:54:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:56 INFO - 'USER': 'cltbld', 04:54:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:56 INFO - 'XPC_FLAGS': '0x0', 04:54:56 INFO - 'XPC_SERVICE_NAME': '0', 04:54:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:56 INFO - Downloading/unpacking blobuploader==1.2.4 04:54: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:54: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:54: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:54: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:54: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:54: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:54:58 INFO - Downloading blobuploader-1.2.4.tar.gz 04:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:54:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:54: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:54: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:54: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:54: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:54: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:54: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:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:54:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:54: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:54: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: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:54: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:54: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:54: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:59 INFO - Downloading docopt-0.6.1.tar.gz 04:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:55:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:55:00 INFO - Running setup.py install for blobuploader 04:55:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:55:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:55:00 INFO - Running setup.py install for requests 04:55:00 INFO - Running setup.py install for docopt 04:55:00 INFO - Successfully installed blobuploader requests docopt 04:55:00 INFO - Cleaning up... 04:55:01 INFO - Return code: 0 04:55:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:01 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:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:01 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:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:01 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 0x108296a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ffa488f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108135e00>, '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 0x107f9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108130b20>, '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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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:55:01 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:55:01 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:55:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dc0fckrg8L/Render', 04:55:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:01 INFO - 'HOME': '/Users/cltbld', 04:55:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:01 INFO - 'LOGNAME': 'cltbld', 04:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:01 INFO - 'MOZ_NO_REMOTE': '1', 04:55:01 INFO - 'NO_EM_RESTART': '1', 04:55:01 INFO - 'PAGER': '/bin/cat', 04:55:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:01 INFO - 'PWD': '/builds/slave/test', 04:55:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:01 INFO - 'SHELL': '/bin/bash', 04:55:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e3uq3r7dNL/Listeners', 04:55:01 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:55:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:01 INFO - 'USER': 'cltbld', 04:55:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:01 INFO - 'XPC_FLAGS': '0x0', 04:55:01 INFO - 'XPC_SERVICE_NAME': '0', 04:55:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:01 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-nAuqse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:01 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-XUbXEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:55:01 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-EXfxoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:55:01 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-SOuZW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:55:01 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-YJkRus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:55:01 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-aFDKtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:55:01 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-LQP7qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:55:02 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-sCHKEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:55:02 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-KLk4qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:55:02 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-kTNqfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:55:02 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-dF1_KO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:55:02 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-6uHWBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:55:02 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-MglelI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:55:02 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-En8Eyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:02 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-LrnpaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:55:02 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-vPzDms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:55:02 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-0WGghL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:55:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:55:03 INFO - Running setup.py install for manifestparser 04:55:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:55:03 INFO - Running setup.py install for mozcrash 04:55:03 INFO - Running setup.py install for mozdebug 04:55:03 INFO - Running setup.py install for mozdevice 04:55:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:55:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:55:03 INFO - Running setup.py install for mozfile 04:55:03 INFO - Running setup.py install for mozhttpd 04:55:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:55:03 INFO - Running setup.py install for mozinfo 04:55:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:55:04 INFO - Running setup.py install for mozInstall 04:55:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:55:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:55:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:55:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:55:04 INFO - Running setup.py install for mozleak 04:55:04 INFO - Running setup.py install for mozlog 04:55:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:55:04 INFO - Running setup.py install for moznetwork 04:55:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:55:04 INFO - Running setup.py install for mozprocess 04:55:04 INFO - Running setup.py install for mozprofile 04:55:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:55:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:55:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:55:04 INFO - Running setup.py install for mozrunner 04:55:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:55:05 INFO - Running setup.py install for mozscreenshot 04:55:05 INFO - Running setup.py install for moztest 04:55:05 INFO - Running setup.py install for mozversion 04:55:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:55:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:55:05 INFO - Cleaning up... 04:55:05 INFO - Return code: 0 04:55:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:05 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:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:05 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:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:05 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 0x108296a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ffa488f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108135e00>, '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 0x107f9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108130b20>, '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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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:55:05 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:55:05 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:55:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dc0fckrg8L/Render', 04:55:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:05 INFO - 'HOME': '/Users/cltbld', 04:55:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:05 INFO - 'LOGNAME': 'cltbld', 04:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:05 INFO - 'MOZ_NO_REMOTE': '1', 04:55:05 INFO - 'NO_EM_RESTART': '1', 04:55:05 INFO - 'PAGER': '/bin/cat', 04:55:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:05 INFO - 'PWD': '/builds/slave/test', 04:55:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:05 INFO - 'SHELL': '/bin/bash', 04:55:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e3uq3r7dNL/Listeners', 04:55:05 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:55:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:05 INFO - 'USER': 'cltbld', 04:55:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:05 INFO - 'XPC_FLAGS': '0x0', 04:55:05 INFO - 'XPC_SERVICE_NAME': '0', 04:55:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:05 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-MuGYmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:06 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:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:06 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-i_i6dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:55:06 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:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:55:06 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-HZl3_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:55:06 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:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:55:06 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-lQYNPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:55:06 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:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:55:06 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-cVTNCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:55:06 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:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:55:06 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-V5ph9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:55:06 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:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:55:06 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-WfPdse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:55:06 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:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:55:06 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-BUNMLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:55:06 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:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:55:06 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-WrKudd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:55:06 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:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:55:06 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-L4eko6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:55:06 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:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:55:06 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-uEdwHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:55:07 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:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:55:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-eMDKom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:55:07 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:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:55:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-OWZ52m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:55:07 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:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:55:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-OScwXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:55:07 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:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-w3qpAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:07 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:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:55:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-823ah2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:55:07 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:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:55:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-iNySht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:55:07 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:55:07 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:55:07 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:55:07 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:55:07 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:55:07 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:55:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:55:07 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:55:07 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:55:07 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:55:07 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:55:07 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:55:07 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:55:10 INFO - Downloading blessings-1.6.tar.gz 04:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:55:10 INFO - Installing collected packages: blessings 04:55:10 INFO - Running setup.py install for blessings 04:55:10 INFO - Successfully installed blessings 04:55:10 INFO - Cleaning up... 04:55:10 INFO - Return code: 0 04:55:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:55:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:55:10 INFO - Reading from file tmpfile_stdout 04:55:10 INFO - Current package versions: 04:55:10 INFO - blessings == 1.6 04:55:10 INFO - blobuploader == 1.2.4 04:55:10 INFO - docopt == 0.6.1 04:55:10 INFO - manifestparser == 1.1 04:55:10 INFO - mozInstall == 1.12 04:55:10 INFO - mozcrash == 0.17 04:55:10 INFO - mozdebug == 0.1 04:55:10 INFO - mozdevice == 0.48 04:55:10 INFO - mozfile == 1.2 04:55:10 INFO - mozhttpd == 0.7 04:55:10 INFO - mozinfo == 0.9 04:55:10 INFO - mozleak == 0.1 04:55:10 INFO - mozlog == 3.1 04:55:10 INFO - moznetwork == 0.27 04:55:10 INFO - mozprocess == 0.22 04:55:10 INFO - mozprofile == 0.28 04:55:10 INFO - mozrunner == 6.11 04:55:10 INFO - mozscreenshot == 0.1 04:55:10 INFO - mozsystemmonitor == 0.0 04:55:10 INFO - moztest == 0.7 04:55:10 INFO - mozversion == 1.4 04:55:10 INFO - psutil == 3.1.1 04:55:10 INFO - requests == 1.2.3 04:55:10 INFO - wsgiref == 0.1.2 04:55:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:10 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 0x108296a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ffa488f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108135e00>, '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 0x107f9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108130b20>, '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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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:55:10 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:55:10 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:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dc0fckrg8L/Render', 04:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:10 INFO - 'HOME': '/Users/cltbld', 04:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:10 INFO - 'LOGNAME': 'cltbld', 04:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:10 INFO - 'MOZ_NO_REMOTE': '1', 04:55:10 INFO - 'NO_EM_RESTART': '1', 04:55:10 INFO - 'PAGER': '/bin/cat', 04:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:10 INFO - 'PWD': '/builds/slave/test', 04:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:10 INFO - 'SHELL': '/bin/bash', 04:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e3uq3r7dNL/Listeners', 04:55:10 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:10 INFO - 'USER': 'cltbld', 04:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:10 INFO - 'XPC_FLAGS': '0x0', 04:55:10 INFO - 'XPC_SERVICE_NAME': '0', 04:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 INFO - Cleaning up... 04:55:10 INFO - Return code: 0 04:55:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:10 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 0x108296a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ffa488f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108135e00>, '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 0x107f9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108130b20>, '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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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:55:10 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:55:10 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:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dc0fckrg8L/Render', 04:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:10 INFO - 'HOME': '/Users/cltbld', 04:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:10 INFO - 'LOGNAME': 'cltbld', 04:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:10 INFO - 'MOZ_NO_REMOTE': '1', 04:55:10 INFO - 'NO_EM_RESTART': '1', 04:55:10 INFO - 'PAGER': '/bin/cat', 04:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:10 INFO - 'PWD': '/builds/slave/test', 04:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:10 INFO - 'SHELL': '/bin/bash', 04:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e3uq3r7dNL/Listeners', 04:55:10 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:10 INFO - 'USER': 'cltbld', 04:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:10 INFO - 'XPC_FLAGS': '0x0', 04:55:10 INFO - 'XPC_SERVICE_NAME': '0', 04:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:11 INFO - Downloading/unpacking jsonschema 04:55:11 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:55:11 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:55:11 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:55:11 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:55:11 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:55:11 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:55:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:55:13 INFO - Downloading/unpacking functools32 (from jsonschema) 04:55:13 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:55:13 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:55:13 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:55:13 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:55:13 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:55:13 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:55:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:55:14 INFO - warning: no files found matching '*.txt' 04:55:14 INFO - no previously-included directories found matching 'build' 04:55:14 INFO - no previously-included directories found matching 'dist' 04:55:14 INFO - no previously-included directories found matching '.git*' 04:55:14 INFO - Installing collected packages: jsonschema, functools32 04:55:14 INFO - Running setup.py install for functools32 04:55:14 INFO - warning: no files found matching '*.txt' 04:55:14 INFO - no previously-included directories found matching 'build' 04:55:14 INFO - no previously-included directories found matching 'dist' 04:55:14 INFO - no previously-included directories found matching '.git*' 04:55:14 INFO - Successfully installed jsonschema functools32 04:55:14 INFO - Cleaning up... 04:55:14 INFO - Return code: 0 04:55:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:55:14 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:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:14 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:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:14 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 0x108296a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ffa488f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108135e00>, '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 0x107f9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108130b20>, '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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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:55:14 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:55:14 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:55:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dc0fckrg8L/Render', 04:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:14 INFO - 'HOME': '/Users/cltbld', 04:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:14 INFO - 'LOGNAME': 'cltbld', 04:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:14 INFO - 'MOZ_NO_REMOTE': '1', 04:55:14 INFO - 'NO_EM_RESTART': '1', 04:55:14 INFO - 'PAGER': '/bin/cat', 04:55:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:14 INFO - 'PWD': '/builds/slave/test', 04:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:14 INFO - 'SHELL': '/bin/bash', 04:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e3uq3r7dNL/Listeners', 04:55:14 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:14 INFO - 'USER': 'cltbld', 04:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:14 INFO - 'XPC_FLAGS': '0x0', 04:55:14 INFO - 'XPC_SERVICE_NAME': '0', 04:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:14 INFO - Downloading/unpacking flake8 04:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:55:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:55:17 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:55:17 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:55:17 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:55:17 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:55:17 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:55:17 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:55:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:55:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:55:17 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:55:17 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:55:17 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:55:17 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:55:17 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:55:17 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:55:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:55:17 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:55:17 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:55:17 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:55:17 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:55:17 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:55:17 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:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:18 INFO - no previously-included directories found matching 'docs/_build' 04:55:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:55:18 INFO - Running setup.py install for pep8 04:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:18 INFO - no previously-included directories found matching 'docs/_build' 04:55:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:55:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:55:18 INFO - Cleaning up... 04:55:18 INFO - Return code: 0 04:55:18 INFO - Running post-action listener: _resource_record_post_action 04:55:18 INFO - Running post-action listener: _start_resource_monitoring 04:55:18 INFO - Starting resource monitoring. 04:55:18 INFO - ##### 04:55:18 INFO - ##### Running install step. 04:55:18 INFO - ##### 04:55:18 INFO - Running pre-action listener: _resource_record_pre_action 04:55:18 INFO - Running main action method: install 04:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:55:19 INFO - Reading from file tmpfile_stdout 04:55:19 INFO - Detecting whether we're running mozinstall >=1.0... 04:55:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:55:19 INFO - Reading from file tmpfile_stdout 04:55:19 INFO - Output received: 04:55:19 INFO - Usage: mozinstall [options] installer 04:55:19 INFO - Options: 04:55:19 INFO - -h, --help show this help message and exit 04:55:19 INFO - -d DEST, --destination=DEST 04:55:19 INFO - Directory to install application into. [default: 04:55:19 INFO - "/builds/slave/test"] 04:55:19 INFO - --app=APP Application being installed. [default: firefox] 04:55:19 INFO - mkdir: /builds/slave/test/build/application 04:55:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:55:52 INFO - Reading from file tmpfile_stdout 04:55:52 INFO - Output received: 04:55:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:55:52 INFO - Running post-action listener: _resource_record_post_action 04:55:52 INFO - ##### 04:55:52 INFO - ##### Running run-tests step. 04:55:52 INFO - ##### 04:55:52 INFO - Running pre-action listener: _resource_record_pre_action 04:55:52 INFO - Running main action method: run_tests 04:55:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:52 INFO - 2016-04-25 04:55:52.686 screenresolution[1638:7646] starting screenresolution argv=screenresolution get 04:55:52 INFO - 2016-04-25 04:55:52.689 screenresolution[1638:7646] Display 0: 1600x1200x32@60 04:55:52 INFO - 2016-04-25 04:55:52.695 screenresolution[1639:7648] starting screenresolution argv=screenresolution list 04:55:52 INFO - Available Modes on Display 0 04:55:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:52 INFO - Intel Iris: 04:55:52 INFO - Chipset Model: Intel Iris 04:55:52 INFO - Type: GPU 04:55:52 INFO - Bus: Built-In 04:55:52 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:52 INFO - Vendor: Intel (0x8086) 04:55:52 INFO - Device ID: 0x0a2e 04:55:52 INFO - Revision ID: 0x0009 04:55:52 INFO - Displays: 04:55:52 INFO - Display: 04:55:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:52 INFO - Display Serial Number: 1600x1200 60 04:55:52 INFO - Main Display: Yes 04:55:52 INFO - Mirror: Off 04:55:52 INFO - Online: Yes 04:55:52 INFO - Rotation: Supported 04:55:52 INFO - Return code: 0 04:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:55:52 INFO - Python 2.7.3 04:55:52 INFO - Return code: 0 04:55:52 INFO - grabbing minidump binary from tooltool 04:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:55:52 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 0x108135e00>, '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 0x107f9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108130b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:55:52 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:55:52 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:55:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:55:53 INFO - Return code: 0 04:55:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:55:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:55:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:55:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:55:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:55:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:55:54 INFO - Return code: 0 04:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0116 --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:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dc0fckrg8L/Render', 04:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:54 INFO - 'HOME': '/Users/cltbld', 04:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:54 INFO - 'LOGNAME': 'cltbld', 04:55:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:55:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:54 INFO - 'MOZ_NO_REMOTE': '1', 04:55:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:55:54 INFO - 'NO_EM_RESTART': '1', 04:55:54 INFO - 'PAGER': '/bin/cat', 04:55:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:54 INFO - 'PWD': '/builds/slave/test', 04:55:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:54 INFO - 'SHELL': '/bin/bash', 04:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e3uq3r7dNL/Listeners', 04:55:54 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:54 INFO - 'USER': 'cltbld', 04:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:54 INFO - 'XPC_FLAGS': '0x0', 04:55:54 INFO - 'XPC_SERVICE_NAME': '0', 04:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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:55:54 INFO - mozversion application_buildid: 20160422035709 04:55:54 INFO - mozversion application_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:55:54 INFO - mozversion application_display_name: Nightly 04:55:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:55:54 INFO - mozversion application_name: Firefox 04:55:54 INFO - mozversion application_remotingname: firefox 04:55:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:55:54 INFO - mozversion application_vendor: Mozilla 04:55:54 INFO - mozversion application_version: 48.0a1 04:55:54 INFO - mozversion platform_buildid: 20160422035709 04:55:54 INFO - mozversion platform_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:55:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:55:54 INFO - mozversion platform_version: 48.0a1 04:55:54 INFO - using testdate: 1461585354 04:55:54 INFO - actual date: 1461585354 04:55:54 INFO - starting webserver on 'localhost:49276' 04:55:54 INFO - SUITE-START | Running 2 tests 04:55:54 INFO - TEST-START | dromaeo_css 04:55:54 INFO - operating with platform_type : mac_ 04:55:54 INFO - Initialising browser for dromaeo_css test... 04:55:54 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpplmRZ8/profile http://localhost:49276/getInfo.html) 04:55:57 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 04:55:57 INFO - PROCESS | 1657 | colorDepth:24 04:55:57 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 04:55:57 INFO - PROCESS | 1657 | __metrics 04:55:57 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:55:58 INFO - TEST-INFO | 1657: exit 0 04:55:58 INFO - Browser initialized. 04:55:58 INFO - Running cycle 1/1 for dromaeo_css test... 04:55:58 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpplmRZ8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:10 INFO - PROCESS | 1660 | RSS: Main: 248246272 04:56:10 INFO - PROCESS | 1660 | 04:56:59 INFO - PROCESS | 1660 | 1461585419781 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:59:10 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 04:59:12 INFO - PROCESS | 1660 | RSS: Main: 260042752 04:59:12 INFO - PROCESS | 1660 | 05:02:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 05:02:14 INFO - PROCESS | 1660 | RSS: Main: 272457728 05:02:14 INFO - PROCESS | 1660 | 05:05:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 05:05:17 INFO - PROCESS | 1660 | RSS: Main: 274063360 05:05:17 INFO - PROCESS | 1660 | 05:08:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 05:08:19 INFO - PROCESS | 1660 | RSS: Main: 275599360 05:08:19 INFO - PROCESS | 1660 | 05:11:22 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 05:11:23 INFO - PROCESS | 1660 | RSS: Main: 278503424 05:11:23 INFO - PROCESS | 1660 | 05:14:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 05:14:26 INFO - PROCESS | 1660 | RSS: Main: 279740416 05:14:26 INFO - PROCESS | 1660 | 05:14:26 INFO - PROCESS | 1660 | __start_tp_report 05:14:26 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 05:14:26 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 05:14:26 INFO - PROCESS | 1660 | |i|pagename|runs| 05:14:26 INFO - PROCESS | 1660 | |0;dojo.html;3485.3552092862824;3494.0740703713514;3512.473129030645;3541.9114522136942;3568.036630109872;5878.823635290943;5879.706014699264;5890.941090589093;5910.083936989773;5960.6423614583155;5757.971210143954;5869.1196320551835;5886.205362276091;5912.822615321536;6056.364081771417;5233.633645644797;5285.603579731516;5298.523132918037;5334.093204155303;5355.143177091666;356.79192543621156;5293.814716484924;5310.92033619496;5317;5385.865353366158;5288.629795914288;5296.25852380667;5299.708516031636;5319;5339.599530035263;5224.111900976843;5399.730013499309;5416.729163541807;5438.184272359138;5442.455754424565;5216.8001359687105;5218.530332270114;5245.580353571705;5256.763445644955;5302.0721373759825;4487.865364039084;5586.525145362649;5693.601447898649;5705.058665320217;5792.565557583156;6165.722542485599;6167.506599472032;6211.596246243979;6277.7802776903045;6282.654454005028;6256.1866957295715;6281.623102613858;6303.968480157616;6321.494280457552;6327.367263273636;5984.551158663117;6035.3059398169335;6036.275646922398;6048.727807248684;6054.424829641177;6224.315325314303;6261.78083767066;6311;6395.072714456378;6395.584287021329;6006.369331220247;6239.438450539473;6256.906146407808;6280.811575652738;6311.558190926683;6224.502039836802;6242.313345531988;6299.779507717208;6304.464120549713;6308.58994165387;6122.703114648804;6126.578745377165;6228.844278893064;6236.532260080512;6259.561830671809;6102.974033066861;6157.230346206724;6207.534434917309;6227.346128656516;6260.843478912972;4985.651004429655;5025.597952163891;5039.571636410873;5044.9495505045215;5048.848534543969;4246.936295955563;4453.844115455943;4479.260921947907;4489.1021795641;4582.450105987236;4966.627502937295;5963.105534169822;5972.522198224132;5999.910001349983;6007.639541627429;5345.545628621533;6287.717052732638;6307.810765677037;6315.873682526324;6360.459360954278;5852.209951656472;5955.851103722442;6011.368806275278;6016.488598469092;6071.635701857815;5496.038193316153;5524.779008839601;5528.502434780889;5537.197106419627;5538.141588053858;6345.746170153142;6526.151600291932;6535.771248006297;6542.084108224853;6561.14705088345;6199.690015499297;6252.093446450148;6323.146375239284;6334.746610135728;6368.936310637019;6420.036994450869;6424.13274207976;6451;6460.709268082854;6475.028745688184;6014.27828660546;6132.5084813409785;6164.3835616438;6173.382661733791;6178.876422471615;6165.414285642857;6209.627422354492;6213.409726076015;6227.377262273736;6245.437910588069;6118.082287656887;6122.816315510542;6165.599236049642;6169.938300617116;6173.043178307369;5690.203371527907;5805.912911306249;6099.207103076572;6129.325774164928;6136.754529818757;5482.5888058394985;6061.454469097803;6106.490508973675;6136.079588061826;6159.969200153971;6140.907886381798;6198.132261483486;6204.410580994799;6205.069239614094;6205.503559715302;5996.430339117776;6074.939250607437;6111.86523267538;6129.540284478593;6169.84575385619 05:14:26 INFO - PROCESS | 1660 | |1;ext.html;508.14377773451736;522.2610006840321;564.2833601326319;599.8890205312016;621.7979156774047;38519.80740096299;39369.606303936955;39598.812035638904;39709.610163644276;39800.2039959201;41011.58988410115;41286;41501;41604.58395416045;41667;9342.57958391874;9467.763305917339;9493.193078588329;9622.37454565451;9626.422414655108;9514.90485095147;9659.420434773901;9669.323147379686;9781.168600668916;9792.706218813411;9738.707838764813;9780.315377923549;9790.020997900188;9804.705858824247;9805.01949805021;9663.951680241624;9674.75813104671;9755.170810481082;9767;9788.265880058952;9531.761705957337;9594.856077158849;9626.278029147772;9658.903410965871;9692.369995950312;39070;39327.82016539508;39494.21011579781;39552.60447395518;39566.406503902464;2829.3209629688727;3059.5410688396696;3147.889823856154;3187.7768556201077;3421.555197824267;25695.871520642464;25754.613680794802;25872.96508139672;26049.869750651127;26213;2627.277498687857;2632.197179860142;2668.239551727768;2719.3881376690088;2748;391565;392697;393355;397700.0229997692;398875;32804.179895502806;34475.482867757004;34673.47989780155;34778.652213478046;34782.47826282608;32340.514892276635;68852.31147688559;70426;70971.64514177396;71005.64497177584;16371.91814040946;16558.00651960886;16596;16729.247183876512;16849.747253791204;12883.742325153444;12888.355582220851;12984.220946743226;12989.220646761225;13019.414126364336;19697.310594129136;19928.60142797136;19928.70106948397;20013.799862001193;20472.181112755323;7903.288704016666;8050.4364694472;8050.993625796776;8056.798580035546;8097.2307630774985;882.2148288023664;934.1312579301315;997.3118548201862;1012.5291739341242;1028.018242578336;29503.409931801245;29548.113556593336;29795.404091918474;30275.697243027727;30332.938347157742;1081.2755453845941;1202.0683969923205;1209.2744353387898;1216.3249396584981;1239.3555351217317;15330;15432.919695621198;15555.533333999998;15676.843231567538;15833;546337;622126.6723996574;628481;628861.7113828894;633452;58621.70689146612;59365;60722.089168662504;61383.07925381123;61472.69263653653;1461.868431841118;1473.661057956676;1482.5404124721586;1486.9107853528824;1493.2832240524608;29161;29347.826086957135;29372.412551749272;30163.491825408204;30440.543391848696;46925.06149877052;53433.4656653444;54225;54267.72866135644;54354.45645543494;527266;561796;567534;567891;569125;25832.870835645703;26644.46711065729;27009;27425.04012359558;27453.31366715848;45218.77390613026;45799.77100114478;46428.30357544707;47110.76444617755;47326.29010564913;37120.814395927846;37292;37495.43756843595;37972.81013594914;38206.044848879;37250.25499490049;37500.624993750804;37551.43672844964;38244.23511529809;38254.808725956194;33659;36500.26999460049;37623;37753;37812.81093594625;31490;32914.83542582272;33028;33076.66923330736;33489;24090.75909240885;24529.877350613846;24542.877285613456;24950;25154.37114072163 05:14:26 INFO - PROCESS | 1660 | |2;jquery.html;365.56862901775895;388.9688824894007;391.256612436371;395.5372214509025;404.3409242934019;18840.152193151305;20210.59578808423;20737.96310184492;20741.896290518525;20775.376738697843;10413.271071025032;11939.58211462599;12219.572314968978;12224.511019559208;14355;5123.564497017758;5315.282436871031;5339.839804805862;5343.866403339909;5349.358077030762;3836.3094642964393;5559.666420014792;5878.382769809173;5890;5895.233619629442;5820;5837.8832423351505;5863.560232982522;5873.941260587403;5966.37353077927;5197.324347834795;5397.919031214516;5465.9726701366435;5728.255326807488;5872.119182122673;5230.581553475751;5570.136628822539;5673.063944449161;5681.9431805681825;5684.8010319638615;20828.895855520776;21764.58530195532;24073.63889541658;26289.605655915177;26322.21033368983;2108.104055776289;2140.9571808563896;2152.2682288021992;2153.3862849087936;2686.8387896726063;9080;9899.25755568328;10038.397696138181;12185.817212741817;14139.434422623186;1706.7269236922157;1782.5187199456204;1794.1836464408664;1805.5826176451553;1827.7349784281337;118733.21900171504;119673;123106;123630.90922726913;123855.3807230967;11243.156763242789;11560.710982225344;11829.231099978473;11973.880261197452;11999.460024298927;15131.01648392873;15179.620509487351;15180.316885740169;15183.544493665207;15200.391984320504;8717.12828717136;8743.431676940978;8780.560971951378;8787.736367908972;8795.296376289882;8586.270167035747;8650.178233067849;8666.56667166639;8671.479711217347;8773.210411063035;4649.465311489154;4670.673052886265;4678.555537223959;4694.108119457293;4760.952390476051;1815.331216597315;1902.334183035954;1987.3839109875985;2008.658528050235;2011.7686466056591;885.3625389719392;885.9335549833788;940.1068984464786;1042.4735508568124;1048.5753269925692;18851.151698173617;19467.51331216731;19608.8039119607;20084.99575021272;20626.278080267417;862.1550880137376;949.7198326493701;951.1534734086669;957.1003256938455;991.2119864707574;8773;10637.62768303121;10831.783364332668;11011.449427528752;11050.557977680963;573024;592913;604213;606616;608544.8291034155;101835;132176.67823321643;132722.33638831938;134424;139621;968.4431451915177;992.771662517625;1007.6070332570157;1012.4330374990029;1014.5789497358661;17736.379226727004;17800.46598602044;17873.821261787216;17906.462806115836;18110.73224874246;52266.738666306424;52589;53838.73080634572;53840.730796345764;54255.45744542504;77533;79142.6042869782;79251;79314.60342698249;81334.59332703298;7881.58131536329;7976.760697179094;8127.065387480516;8146.5519396433765;8556.700515482178;9277.953610231905;11594.94202528982;11861.110416718953;11869.813018698062;12631.242125472501;10317.123044541298;11207.383593902088;11298.661040168809;11523.53905843757;11668.533258669559;10438.269321147447;10842.837357439803;10910.399928003719;10983.066439352744;11139.10887129044;11003.284786488852;11220.438978051228;11355.261907975955;11613.5354585819;11644.767104658029;8006.679732810622;8083;8216.301614362847;8247.628856701584;8384.07960199005;9805.607775688892;10150.796984060426;11200.943995279971;11431.428428578703;11441.713957150805 05:14:26 INFO - PROCESS | 1660 | |3;mootools.html;1588.952331430057;1601.5915941434932;1883.3878989328464;1949.3664559018323;1984.0972357577305;7919.445638805286;8226.465279756827;8768.342374321928;9024.368294219406;9058.139476749706;7577.659005344759;8907.421017633866;9009.504477253748;9014.278857691384;9025.142611451902;2257.3115199864037;2371.905123795046;2457.7787999080124;2494.8503089814667;2495.9251222463354;2473.6413220083077;2474.5174690935273;2478.8884500197532;2486.689163854518;2487.6268559716095;2208;2485.428351479161;2489.850608963459;2502.987485062572;2505.060602274147;2459.4589190378088;2475.925722228336;2477.442575420534;2478.1821998740375;2495.226479791261;2434.342727463593;2464.5070985802913;2465.9136930207537;2471.4686342436285;2495.238952119603;8944.910550894472;9075.63697452101;9125.041870603623;9126.58930348136;9132.634694612207;5275.947240527584;5462.617616766828;5485.122380419114;5485.259489968843;5508.531774799147;3463.341965026637;3474.704650104744;3562.697170740464;3571.964280357189;3594.209273959751;987.284218941269;1004.8342023566103;1006.7684432580547;1019.0930072235716;1033.7260625934134;10418.531166097468;11513.769724605545;11547.422628868522;11603.361815100166;11616.36110013949;4755.5257870060395;4837;4861.951380486221;4873.220284754422;4878.829240976549;9943.254255930835;9951.950240248752;9965.501724913725;9993.80012399748;10034.598616055422;5390.595705322116;5415.945840541623;5434.64674796137;5435.918461223085;5442.6462279951675;4530.886727831765;4913.263010548375;4980.950190498121;5024.598032157419;5046.772895219724;3472.461768425898;3621.7826930383735;3965.167314863911;4032.4152997815154;4066.6423446430745;1344.4151793969459;1370.5682709946334;1371.4994027180207;1384.190248704519;1389.6178550898583;868.7828042989253;943.3632298198688;944.1219665710955;968.7384406210284;987.9012098790207;6005.309389420273;6029.849253768691;6048.879022419527;6151;6201.007838745869;447.61057879644267;454.99772501137284;457.87179589714935;463.0715415591717;468.88746700791563;3994.420808982681;4025.19496100781;4089.9182016359505;4109.938350924738;4113.1568028554075;10377.948110259551;10818.972197641211;10832.729181770519;10836.241463097507;10838.187135964834;9455.952720236355;10372.740681482872;10669.89330106689;10707.036366726876;10738.140948724084;8022.398320125897;8166.918330816735;8263.752087437386;8280.296174825207;8349.666013359398;5923;5975.701214939322;5987;5987.940120598738;5992.970035149797;9657.613695452384;9939;10000.799984000425;10110;10137.746556336151;9766.511674416393;9810;10137.847932281169;10159.7460063499;10205.74485637865;7071.25751796054;7500.287472690085;7545.132309784445;7678.462507624413;7733.226677332222;8396.37027222973;8571.742847714579;8587.65649374018;8596.871046934426;8650.178233067849;7483.326500614753;7619.08570971487;7663.195364486872;7684.500507466997;7705.807354816175;7365.889511657437;7453.515521491086;7464.440166987389;7475.7009719610605;7597.354224890946;7098.929010710033;7134.892976605459;7174.210836808052;7175.748848790267;7199.1001124859395;4860.173770459101;4985.551300382983;5088.669236499616;5106.310648062464;5119.0017946500075;4988.251762235548;5104.974475127749;5111.233315002779;5155.226715992631;5305.787768489372 05:14:26 INFO - PROCESS | 1660 | |4;prototype.html;310.4412058295069;323.6827908649523;331.40347374725496;332.5693227270686;335.9613644430891;6126.172966649501;6203.193584833965;6248.312955502018;6252.718627661755;6258.3115857255725;5541.27963364763;6084.634921904678;6118.694065296729;6118.938810611892;6143.201383820097;3811.6569508744137;4501.864944051684;4621.09888571727;4624.421947256593;4636;3943.5662077171487;4603.930941035887;4605.503211456274;4615.469221039573;4652.302154676791;4558.954410455903;4572.97713511432;4576.427946506687;4602.171609110359;4638.721676699409;3549.574051113857;4040.9999999999854;4071.839525735181;4360.171567402183;4556.22544167489;3455.2225749206477;3785.958861313161;3951.427043078766;3957.52509698838;3986.5016872890887;5956.106584012389;5981.700914954278;6025.475097068221;6049.4647397631115;6059.545534084918;5245.134552798783;5348.806989134475;5402.621816472849;5435.157550579627;5451.509364157245;6591.242007169189;6608.1409416776;6619.735210591571;6640.402363787282;6648.1800694496105;3844.596317386662;3934.4885164928664;3981.9845939285296;4108.67130629549;4300.78496075195;6959.338862808025;6985.6507174641065;6997.545159564612;7016.543924644881;7038.225795162528;4461.237811064611;4514.300283456069;4535.115652447741;4541.9545804542195;4568.885777855514;3890.708196885245;4148.473797272294;4383.9342409863875;4603.95396046042;4630.814767409266;5394.9460505394445;5395.298611180521;5398.838034858961;5403.918941215885;5438.619296649275;6669.533132680763;6673.632950187689;6700.93299067003;6710.295418981034;6717.294684058202;1526.6107142678545;1583.9287232074585;1589.3404237241416;1591.8328575499638;1594.6126869623502;827.4662842466576;959.9344727352633;980.6273616025865;1043.8538604595362;1066.0778426660881;5899.823005309761;6208.286047104551;6212.937870621236;6250.218722659668;6254.3745625438005;6599.241087274929;6888.345607167311;6910.170779506391;6922.965385173042;6946.2011868634745;5602.047651899187;6087.878242435127;6210.130581718563;6224.408681175281;6272.773165526264;3331.950020749691;3407.539982102434;3611.8013509257244;3644.562652481719;3660.7120549656465;6897;7087.858242835115;7106.253843346374;7134.821629459201;7182.389496892718;7005.54463959841;7033.417481066821;7034.92965070353;7039.401650859734;7097.077379940678;5793.971030144822;6903.447724182053;7021.0532077406315;7046.780264216755;7203.639818009078;5531.363893152178;6038.456538911519;6808.62552559614;6823.931760682528;6882.1783068941495;5356.812511562077;5587.910357480252;6753.527253092237;6839.692213850488;6872.86597711392;6299.149614801943;6469.320721324193;7206.783796486114;7234.710611575478;7240.312170343809;4122.732022418533;4137.338025915839;4395.142947125408;4409.867703968886;4411.602955733999;6391.456726178327;6796.422304104009;6872.931270687229;6877.484188685969;6906.205786334636;6673.132492775908;6673.299303573249;6687.896497077928;6692.230393504615;6714.294999025032;5598.7962588043765;5789.928863160329;6433.388828061326;6685.465162787063;6710.094137291599;6182.752689892354;6293.37066293367;6333.619982800862;6467.579607325509;6521.456631913463;5187;5636.12557595621;6447.2263328400895;6699.330066993261;6712.630805305755;5303.734813259399;6500.187476565429;6572.34276572339;6572.507061970276;6585.176852893388 05:14:26 INFO - PROCESS | 1660 | |5;yui.html;685.6400389795358;700.1598082301236;706.5760543673796;718.6801873166439;727.923568025357;14697.118172909633;14976.326065327059;15168.165750883696;15187.392504299829;15238.466653667125;13872.514461993833;13909.93045034776;13930.164190148598;13944.930275348634;13962.93018534906;875.3085062800396;901.5762591581946;943.8725772020758;950.0546955779009;950.2872845365976;934.7102398256528;938.6949241496507;945.8533927241255;946.9668561600346;948.9430634161938;963.9277054220927;979.4221409368507;988.0021178609584;991.781808002242;992.3450522655049;856.7815207122175;930.5533343994853;977.5307852230969;980.3480685344273;982.1210017034786;641.7272659119902;723.9819004524876;727.8871774874902;731.9194888562254;737.1633196322159;12700.745985080339;15173.924130379388;15240.161791101486;15609.765853512206;15645.843541564665;10757;12430.564930227398;12523.686907827287;12687;13421.993350498655;9967.700968970943;10074.748131296703;10204.948975255076;10551.472426378727;10762.892371076345;3313.884014059496;3471.861125554975;3474.8262586870555;3585.982070089633;3598.6401359864067;83760;85060.57469712613;85217.57391213067;85390.14609853947;85412.57293713554;7934.960325198453;9330.206932410685;9382.343235973416;9417.670381536613;10127.341722787995;20910;21303;21429.89285053565;21430.57138857214;21458.892705536684;6106.6336019838955;7408.111026676834;7425.071866016748;7480.812979675443;7493.625318734042;3888.902777430587;4078.5105787305715;4142.958570414317;4151.709380343407;4172.853950111731;3584.301061293075;3615.9276814463565;3631.909202269964;3666.5966743658178;3672.375696131664;630.6688988281189;641.2081079866362;653.3988730368072;658.1641315529251;658.9703463344065;542.8697112692926;578.1299144787152;585.4233579923772;604.3473049106954;607.2439812433548;7915.287624113857;8082.757517274491;8109.594520273963;8189.058258300372;8326.25063744266;510.54051353781153;591.5563327504372;591.6568390333596;598.2462097756858;633.0156606476972;3537.823108844599;3894.668953139015;3913.2173565287057;3966.0481484444103;3987.401889716508;90370.64444033345;93424.53287733518;93742;95946.56080158803;97575.51212243893;74204.62897685477;76487.61756191183;77060;77251.22748772553;77928.61035694786;66832;67142;68698.65650671715;68717.31282687209;68950;7591.051118610174;7650.196729343339;7675.501092429197;7734.071911370672;7854.764357069297;42070.78964605158;42355;42429.93925151896;42517.57482425136;42784.78607607067;63725.362746371946;64299.392515187494;64446.35553644591;64633.35366646273;64864.35135648772;9096.454212747256;9865.273577124119;10115.544800484144;10733;11406.315621062762;9218.815623687622;9789.021097890154;11658.358790266617;11916.285022898654;12580.433880475217;11409;11445.828312575484;11480.196386252883;11562.479688413874;11657.941710291394;10218.335808172445;10664.66691663542;11271.380074096003;11394.658160255205;11517.712057198301;8604.870926935975;9737.561809718722;11212;11736.119791015537;11947.342896140448;9295.535223238947;9530.332876698842;9668.70993870185;9713.660021899199;9782.608695652094;9615.807683846424;9976.2517811163;10019.998000199921;10026.899731002597;10030.047145521165 05:14:26 INFO - PROCESS | 1660 | __end_tp_report 05:14:26 INFO - PROCESS | 1660 | __start_cc_report 05:14:26 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,393 05:14:26 INFO - PROCESS | 1660 | __end_cc_report 05:14:26 INFO - PROCESS | 1660 | __startTimestamp1461586466006__endTimestamp 05:14:26 INFO - PROCESS | 1660 | 05:14:26 INFO - PROCESS | 1660 | ------- Summary: start ------- 05:14:26 INFO - PROCESS | 1660 | Number of tests: 6 05:14:26 INFO - PROCESS | 1660 | 05:14:26 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5787.20 Median:6071.64 stddev:763.13 (12.6%) stddev-sans-first:743.80 05:14:26 INFO - PROCESS | 1660 | Values: 3485.4 3494.1 3512.5 3541.9 3568.0 5878.8 5879.7 5890.9 5910.1 5960.6 5758.0 5869.1 5886.2 5912.8 6056.4 5233.6 5285.6 5298.5 5334.1 5355.1 356.8 5293.8 5310.9 5317.0 5385.9 5288.6 5296.3 5299.7 5319.0 5339.6 5224.1 5399.7 5416.7 5438.2 5442.5 5216.8 5218.5 5245.6 5256.8 5302.1 4487.9 5586.5 5693.6 5705.1 5792.6 6165.7 6167.5 6211.6 6277.8 6282.7 6256.2 6281.6 6304.0 6321.5 6327.4 5984.6 6035.3 6036.3 6048.7 6054.4 6224.3 6261.8 6311.0 6395.1 6395.6 6006.4 6239.4 6256.9 6280.8 6311.6 6224.5 6242.3 6299.8 6304.5 6308.6 6122.7 6126.6 6228.8 6236.5 6259.6 6103.0 6157.2 6207.5 6227.3 6260.8 4985.7 5025.6 5039.6 5044.9 5048.8 4246.9 4453.8 4479.3 4489.1 4582.5 4966.6 5963.1 5972.5 5999.9 6007.6 5345.5 6287.7 6307.8 6315.9 6360.5 5852.2 5955.9 6011.4 6016.5 6071.6 5496.0 5524.8 5528.5 5537.2 5538.1 6345.7 6526.2 6535.8 6542.1 6561.1 6199.7 6252.1 6323.1 6334.7 6368.9 6420.0 6424.1 6451.0 6460.7 6475.0 6014.3 6132.5 6164.4 6173.4 6178.9 6165.4 6209.6 6213.4 6227.4 6245.4 6118.1 6122.8 6165.6 6169.9 6173.0 5690.2 5805.9 6099.2 6129.3 6136.8 5482.6 6061.5 6106.5 6136.1 6160.0 6140.9 6198.1 6204.4 6205.1 6205.5 5996.4 6074.9 6111.9 6129.5 6169.8 05:14:26 INFO - PROCESS | 1660 | 05:14:26 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:65427.22 Median:38225.14 stddev:141726.01 (370.8%) stddev-sans-first:142039.77 05:14:26 INFO - PROCESS | 1660 | Values: 508.1 522.3 564.3 599.9 621.8 38519.8 39369.6 39598.8 39709.6 39800.2 41011.6 41286.0 41501.0 41604.6 41667.0 9342.6 9467.8 9493.2 9622.4 9626.4 9514.9 9659.4 9669.3 9781.2 9792.7 9738.7 9780.3 9790.0 9804.7 9805.0 9664.0 9674.8 9755.2 9767.0 9788.3 9531.8 9594.9 9626.3 9658.9 9692.4 39070.0 39327.8 39494.2 39552.6 39566.4 2829.3 3059.5 3147.9 3187.8 3421.6 25695.9 25754.6 25873.0 26049.9 26213.0 2627.3 2632.2 2668.2 2719.4 2748.0 391565.0 392697.0 393355.0 397700.0 398875.0 32804.2 34475.5 34673.5 34778.7 34782.5 32340.5 68852.3 70426.0 70971.6 71005.6 16371.9 16558.0 16596.0 16729.2 16849.7 12883.7 12888.4 12984.2 12989.2 13019.4 19697.3 19928.6 19928.7 20013.8 20472.2 7903.3 8050.4 8051.0 8056.8 8097.2 882.2 934.1 997.3 1012.5 1028.0 29503.4 29548.1 29795.4 30275.7 30332.9 1081.3 1202.1 1209.3 1216.3 1239.4 15330.0 15432.9 15555.5 15676.8 15833.0 546337.0 622126.7 628481.0 628861.7 633452.0 58621.7 59365.0 60722.1 61383.1 61472.7 1461.9 1473.7 1482.5 1486.9 1493.3 29161.0 29347.8 29372.4 30163.5 30440.5 46925.1 53433.5 54225.0 54267.7 54354.5 527266.0 561796.0 567534.0 567891.0 569125.0 25832.9 26644.5 27009.0 27425.0 27453.3 45218.8 45799.8 46428.3 47110.8 47326.3 37120.8 37292.0 37495.4 37972.8 38206.0 37250.3 37500.6 37551.4 38244.2 38254.8 33659.0 36500.3 37623.0 37753.0 37812.8 31490.0 32914.8 33028.0 33076.7 33489.0 24090.8 24529.9 24542.9 24950.0 25154.4 05:14:26 INFO - PROCESS | 1660 | 05:14:26 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:34810.03 Median:22919.11 stddev:99883.63 (435.8%) stddev-sans-first:100130.35 05:14:26 INFO - PROCESS | 1660 | Values: 365.6 389.0 391.3 395.5 404.3 18840.2 20210.6 20738.0 20741.9 20775.4 10413.3 11939.6 12219.6 12224.5 14355.0 5123.6 5315.3 5339.8 5343.9 5349.4 3836.3 5559.7 5878.4 5890.0 5895.2 5820.0 5837.9 5863.6 5873.9 5966.4 5197.3 5397.9 5466.0 5728.3 5872.1 5230.6 5570.1 5673.1 5681.9 5684.8 20828.9 21764.6 24073.6 26289.6 26322.2 2108.1 2141.0 2152.3 2153.4 2686.8 9080.0 9899.3 10038.4 12185.8 14139.4 1706.7 1782.5 1794.2 1805.6 1827.7 118733.2 119673.0 123106.0 123630.9 123855.4 11243.2 11560.7 11829.2 11973.9 11999.5 15131.0 15179.6 15180.3 15183.5 15200.4 8717.1 8743.4 8780.6 8787.7 8795.3 8586.3 8650.2 8666.6 8671.5 8773.2 4649.5 4670.7 4678.6 4694.1 4761.0 1815.3 1902.3 1987.4 2008.7 2011.8 885.4 885.9 940.1 1042.5 1048.6 18851.2 19467.5 19608.8 20085.0 20626.3 862.2 949.7 951.2 957.1 991.2 8773.0 10637.6 10831.8 11011.4 11050.6 573024.0 592913.0 604213.0 606616.0 608544.8 101835.0 132176.7 132722.3 134424.0 139621.0 968.4 992.8 1007.6 1012.4 1014.6 17736.4 17800.5 17873.8 17906.5 18110.7 52266.7 52589.0 53838.7 53840.7 54255.5 77533.0 79142.6 79251.0 79314.6 81334.6 7881.6 7976.8 8127.1 8146.6 8556.7 9278.0 11594.9 11861.1 11869.8 12631.2 10317.1 11207.4 11298.7 11523.5 11668.5 10438.3 10842.8 10910.4 10983.1 11139.1 11003.3 11220.4 11355.3 11613.5 11644.8 8006.7 8083.0 8216.3 8247.6 8384.1 9805.6 10150.8 11200.9 11431.4 11441.7 05:14:26 INFO - PROCESS | 1660 | 05:14:26 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5763.59 Median:5006.42 stddev:3185.32 (63.6%) stddev-sans-first:3178.81 05:14:26 INFO - PROCESS | 1660 | Values: 1589.0 1601.6 1883.4 1949.4 1984.1 7919.4 8226.5 8768.3 9024.4 9058.1 7577.7 8907.4 9009.5 9014.3 9025.1 2257.3 2371.9 2457.8 2494.9 2495.9 2473.6 2474.5 2478.9 2486.7 2487.6 2208.0 2485.4 2489.9 2503.0 2505.1 2459.5 2475.9 2477.4 2478.2 2495.2 2434.3 2464.5 2465.9 2471.5 2495.2 8944.9 9075.6 9125.0 9126.6 9132.6 5275.9 5462.6 5485.1 5485.3 5508.5 3463.3 3474.7 3562.7 3572.0 3594.2 987.3 1004.8 1006.8 1019.1 1033.7 10418.5 11513.8 11547.4 11603.4 11616.4 4755.5 4837.0 4862.0 4873.2 4878.8 9943.3 9952.0 9965.5 9993.8 10034.6 5390.6 5415.9 5434.6 5435.9 5442.6 4530.9 4913.3 4981.0 5024.6 5046.8 3472.5 3621.8 3965.2 4032.4 4066.6 1344.4 1370.6 1371.5 1384.2 1389.6 868.8 943.4 944.1 968.7 987.9 6005.3 6029.8 6048.9 6151.0 6201.0 447.6 455.0 457.9 463.1 468.9 3994.4 4025.2 4089.9 4109.9 4113.2 10377.9 10819.0 10832.7 10836.2 10838.2 9456.0 10372.7 10669.9 10707.0 10738.1 8022.4 8166.9 8263.8 8280.3 8349.7 5923.0 5975.7 5987.0 5987.9 5993.0 9657.6 9939.0 10000.8 10110.0 10137.7 9766.5 9810.0 10137.8 10159.7 10205.7 7071.3 7500.3 7545.1 7678.5 7733.2 8396.4 8571.7 8587.7 8596.9 8650.2 7483.3 7619.1 7663.2 7684.5 7705.8 7365.9 7453.5 7464.4 7475.7 7597.4 7098.9 7134.9 7174.2 7175.7 7199.1 4860.2 4985.6 5088.7 5106.3 5119.0 4988.3 5105.0 5111.2 5155.2 5305.8 05:14:26 INFO - PROCESS | 1660 | 05:14:26 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:5347.01 Median:6086.26 stddev:1719.86 (28.3%) stddev-sans-first:1682.63 05:14:26 INFO - PROCESS | 1660 | Values: 310.4 323.7 331.4 332.6 336.0 6126.2 6203.2 6248.3 6252.7 6258.3 5541.3 6084.6 6118.7 6118.9 6143.2 3811.7 4501.9 4621.1 4624.4 4636.0 3943.6 4603.9 4605.5 4615.5 4652.3 4559.0 4573.0 4576.4 4602.2 4638.7 3549.6 4041.0 4071.8 4360.2 4556.2 3455.2 3786.0 3951.4 3957.5 3986.5 5956.1 5981.7 6025.5 6049.5 6059.5 5245.1 5348.8 5402.6 5435.2 5451.5 6591.2 6608.1 6619.7 6640.4 6648.2 3844.6 3934.5 3982.0 4108.7 4300.8 6959.3 6985.7 6997.5 7016.5 7038.2 4461.2 4514.3 4535.1 4542.0 4568.9 3890.7 4148.5 4383.9 4604.0 4630.8 5394.9 5395.3 5398.8 5403.9 5438.6 6669.5 6673.6 6700.9 6710.3 6717.3 1526.6 1583.9 1589.3 1591.8 1594.6 827.5 959.9 980.6 1043.9 1066.1 5899.8 6208.3 6212.9 6250.2 6254.4 6599.2 6888.3 6910.2 6923.0 6946.2 5602.0 6087.9 6210.1 6224.4 6272.8 3332.0 3407.5 3611.8 3644.6 3660.7 6897.0 7087.9 7106.3 7134.8 7182.4 7005.5 7033.4 7034.9 7039.4 7097.1 5794.0 6903.4 7021.1 7046.8 7203.6 5531.4 6038.5 6808.6 6823.9 6882.2 5356.8 5587.9 6753.5 6839.7 6872.9 6299.1 6469.3 7206.8 7234.7 7240.3 4122.7 4137.3 4395.1 4409.9 4411.6 6391.5 6796.4 6872.9 6877.5 6906.2 6673.1 6673.3 6687.9 6692.2 6714.3 5598.8 5789.9 6433.4 6685.5 6710.1 6182.8 6293.4 6333.6 6467.6 6521.5 5187.0 5636.1 6447.2 6699.3 6712.6 5303.7 6500.2 6572.3 6572.5 6585.2 05:14:26 INFO - PROCESS | 1660 | 05:14:26 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:17967.35 Median:641.47 stddev:25566.34 (3985.6%) stddev-sans-first:25605.13 05:14:26 INFO - PROCESS | 1660 | Values: 685.6 700.2 706.6 718.7 727.9 14697.1 14976.3 15168.2 15187.4 15238.5 13872.5 13909.9 13930.2 13944.9 13962.9 875.3 901.6 943.9 950.1 950.3 934.7 938.7 945.9 947.0 948.9 963.9 979.4 988.0 991.8 992.3 856.8 930.6 977.5 980.3 982.1 641.7 724.0 727.9 731.9 737.2 12700.7 15173.9 15240.2 15609.8 15645.8 10757.0 12430.6 12523.7 12687.0 13422.0 9967.7 10074.7 10204.9 10551.5 10762.9 3313.9 3471.9 3474.8 3586.0 3598.6 83760.0 85060.6 85217.6 85390.1 85412.6 7935.0 9330.2 9382.3 9417.7 10127.3 20910.0 21303.0 21429.9 21430.6 21458.9 6106.6 7408.1 7425.1 7480.8 7493.6 3888.9 4078.5 4143.0 4151.7 4172.9 3584.3 3615.9 3631.9 3666.6 3672.4 630.7 641.2 653.4 658.2 659.0 542.9 578.1 585.4 604.3 607.2 7915.3 8082.8 8109.6 8189.1 8326.3 510.5 591.6 591.7 598.2 633.0 3537.8 3894.7 3913.2 3966.0 3987.4 90370.6 93424.5 93742.0 95946.6 97575.5 74204.6 76487.6 77060.0 77251.2 77928.6 66832.0 67142.0 68698.7 68717.3 68950.0 7591.1 7650.2 7675.5 7734.1 7854.8 42070.8 42355.0 42429.9 42517.6 42784.8 63725.4 64299.4 64446.4 64633.4 64864.4 9096.5 9865.3 10115.5 10733.0 11406.3 9218.8 9789.0 11658.4 11916.3 12580.4 11409.0 11445.8 11480.2 11562.5 11657.9 10218.3 10664.7 11271.4 11394.7 11517.7 8604.9 9737.6 11212.0 11736.1 11947.3 9295.5 9530.3 9668.7 9713.7 9782.6 9615.8 9976.3 10020.0 10026.9 10030.0 05:14:26 INFO - PROCESS | 1660 | -------- Summary: end -------- 05:14:26 INFO - PROCESS | 1660 | 05:14:26 INFO - TEST-INFO | 1660: exit 0 05:14:26 INFO - TEST-OK | dromaeo_css | took 1112111ms 05:14:26 INFO - TEST-START | kraken 05:14:26 INFO - operating with platform_type : mac_ 05:14:26 INFO - Initialising browser for kraken test... 05:14:26 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpaQav6i/profile http://localhost:49276/getInfo.html) 05:14:29 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 05:14:29 INFO - PROCESS | 1672 | colorDepth:24 05:14:29 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 05:14:29 INFO - PROCESS | 1672 | __metrics 05:14:29 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:14:29 INFO - TEST-INFO | 1672: exit 0 05:14:29 INFO - Browser initialized. 05:14:29 INFO - Running cycle 1/1 for kraken test... 05:14:29 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpaQav6i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:41 INFO - PROCESS | 1675 | RSS: Main: 248328192 05:14:41 INFO - PROCESS | 1675 | 05:14:44 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 05:14:45 INFO - PROCESS | 1675 | RSS: Main: 260423680 05:14:45 INFO - PROCESS | 1675 | 05:14:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 05:14:48 INFO - PROCESS | 1675 | RSS: Main: 269271040 05:14:48 INFO - PROCESS | 1675 | 05:14:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 05:14:52 INFO - PROCESS | 1675 | RSS: Main: 272629760 05:14:52 INFO - PROCESS | 1675 | 05:14:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 05:14:55 INFO - PROCESS | 1675 | RSS: Main: 274669568 05:14:55 INFO - PROCESS | 1675 | 05:14:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:58 INFO - PROCESS | 1675 | RSS: Main: 275132416 05:14:58 INFO - PROCESS | 1675 | 05:15:01 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 05:15:01 INFO - PROCESS | 1675 | RSS: Main: 276029440 05:15:01 INFO - PROCESS | 1675 | 05:15:04 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 05:15:05 INFO - PROCESS | 1675 | RSS: Main: 276172800 05:15:05 INFO - PROCESS | 1675 | 05:15:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 05:15:08 INFO - PROCESS | 1675 | RSS: Main: 276328448 05:15:08 INFO - PROCESS | 1675 | 05:15:10 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:15:10 INFO - PROCESS | 1675 | RSS: Main: 275525632 05:15:10 INFO - PROCESS | 1675 | 05:15:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:15:13 INFO - PROCESS | 1675 | RSS: Main: 275546112 05:15:13 INFO - PROCESS | 1675 | 05:15:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:15:16 INFO - PROCESS | 1675 | RSS: Main: 275869696 05:15:16 INFO - PROCESS | 1675 | 05:15:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:15:20 INFO - PROCESS | 1675 | RSS: Main: 276127744 05:15:20 INFO - PROCESS | 1675 | 05:15:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:15:23 INFO - PROCESS | 1675 | RSS: Main: 276049920 05:15:23 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 05:15:25 INFO - PROCESS | 1675 | RSS: Main: 277839872 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | __start_tp_report 05:15:25 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 05:15:25 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 05:15:25 INFO - PROCESS | 1675 | |i|pagename|runs| 05:15:25 INFO - PROCESS | 1675 | |0;ai-astar;122;109;116;116;116;129;115;116;118;116 05:15:25 INFO - PROCESS | 1675 | |1;audio-beat-detection;196;157;148;166;125;144;140;136;153;109 05:15:25 INFO - PROCESS | 1675 | |2;audio-dft;195;194;227;222;261;275;219;200;203;195 05:15:25 INFO - PROCESS | 1675 | |3;audio-fft;70;75;88;186;57;83;81;82;158;58 05:15:25 INFO - PROCESS | 1675 | |4;audio-oscillator;78;94;125;76;83;80;122;78;78;152 05:15:25 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;89;86;89;86;89;86;90;87;89;86 05:15:25 INFO - PROCESS | 1675 | |6;imaging-darkroom;94;102;131;95;94;94;121;152;94;95 05:15:25 INFO - PROCESS | 1675 | |7;imaging-desaturate;89;93;96;90;94;90;92;94;93;89 05:15:25 INFO - PROCESS | 1675 | |8;json-parse-financial;63;63;62;61;63;62;61;82;64;59 05:15:25 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;62;69;71;68;71;77;71;68;68;69 05:15:25 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;86;82;101;103;95;74;72;105;111;107 05:15:25 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;169;141;134;128;159;164;156;163;203;169 05:15:25 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;175;174;171;176;222;176;172;173;172;176 05:15:25 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;68;72;72;66;81;70;57;90;68;65 05:15:25 INFO - PROCESS | 1675 | __end_tp_report 05:15:25 INFO - PROCESS | 1675 | __start_cc_report 05:15:25 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1017 05:15:25 INFO - PROCESS | 1675 | __end_cc_report 05:15:25 INFO - PROCESS | 1675 | __startTimestamp1461586525541__endTimestamp 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | ------- Summary: start ------- 05:15:25 INFO - PROCESS | 1675 | Number of tests: 14 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:117.30 Median:116.00 stddev:5.19 (4.5%) stddev-sans-first:5.21 05:15:25 INFO - PROCESS | 1675 | Values: 122.0 109.0 116.0 116.0 116.0 129.0 115.0 116.0 118.0 116.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:150.50 stddev:23.58 (15.7%) stddev-sans-first:17.25 05:15:25 INFO - PROCESS | 1675 | Values: 196.0 157.0 148.0 166.0 125.0 144.0 140.0 136.0 153.0 109.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:219.10 Median:220.50 stddev:28.61 (13.0%) stddev-sans-first:28.99 05:15:25 INFO - PROCESS | 1675 | Values: 195.0 194.0 227.0 222.0 261.0 275.0 219.0 200.0 203.0 195.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:93.80 Median:78.00 stddev:42.99 (55.1%) stddev-sans-first:44.72 05:15:25 INFO - PROCESS | 1675 | Values: 70.0 75.0 88.0 186.0 57.0 83.0 81.0 82.0 158.0 58.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:78.00 stddev:26.77 (34.3%) stddev-sans-first:27.54 05:15:25 INFO - PROCESS | 1675 | Values: 78.0 94.0 125.0 76.0 83.0 80.0 122.0 78.0 78.0 152.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:89.00 stddev:1.64 (1.8%) stddev-sans-first:1.67 05:15:25 INFO - PROCESS | 1675 | Values: 89.0 86.0 89.0 86.0 89.0 86.0 90.0 87.0 89.0 86.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:94.00 stddev:20.51 (21.8%) stddev-sans-first:21.19 05:15:25 INFO - PROCESS | 1675 | Values: 94.0 102.0 131.0 95.0 94.0 94.0 121.0 152.0 94.0 95.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:92.00 Median:93.00 stddev:2.40 (2.6%) stddev-sans-first:2.29 05:15:25 INFO - PROCESS | 1675 | Values: 89.0 93.0 96.0 90.0 94.0 90.0 92.0 94.0 93.0 89.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:63.00 stddev:6.48 (10.3%) stddev-sans-first:6.86 05:15:25 INFO - PROCESS | 1675 | Values: 63.0 63.0 62.0 61.0 63.0 62.0 61.0 82.0 64.0 59.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:70.00 stddev:3.75 (5.4%) stddev-sans-first:2.86 05:15:25 INFO - PROCESS | 1675 | Values: 62.0 69.0 71.0 68.0 71.0 77.0 71.0 68.0 68.0 69.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:73.00 stddev:14.14 (19.4%) stddev-sans-first:14.73 05:15:25 INFO - PROCESS | 1675 | Values: 86.0 82.0 101.0 103.0 95.0 74.0 72.0 105.0 111.0 107.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:158.60 Median:163.50 stddev:21.33 (13.0%) stddev-sans-first:22.29 05:15:25 INFO - PROCESS | 1675 | Values: 169.0 141.0 134.0 128.0 159.0 164.0 156.0 163.0 203.0 169.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:175.50 stddev:15.33 (8.7%) stddev-sans-first:16.20 05:15:25 INFO - PROCESS | 1675 | Values: 175.0 174.0 171.0 176.0 222.0 176.0 172.0 173.0 172.0 176.0 05:15:25 INFO - PROCESS | 1675 | 05:15:25 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:9.06 (12.8%) stddev-sans-first:9.55 05:15:25 INFO - PROCESS | 1675 | Values: 68.0 72.0 72.0 66.0 81.0 70.0 57.0 90.0 68.0 65.0 05:15:25 INFO - PROCESS | 1675 | -------- Summary: end -------- 05:15:25 INFO - PROCESS | 1675 | 05:15:26 INFO - TEST-INFO | 1675: exit 0 05:15:26 INFO - TEST-OK | kraken | took 59748ms 05:15:26 INFO - SUITE-END | took 1171s 05:15:26 INFO - Completed test suite (00:19:32) 05:15:26 INFO - javascript benchmark 05:15:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3485.3552092862824, 3494.0740703713514, 3512.473129030645, 3541.9114522136942, 3568.036630109872, 5878.823635290943, 5879.706014699264, 5890.941090589093, 5910.083936989773, 5960.6423614583155, 5757.971210143954, 5869.1196320551835, 5886.205362276091, 5912.822615321536, 6056.364081771417, 5233.633645644797, 5285.603579731516, 5298.523132918037, 5334.093204155303, 5355.143177091666, 356.79192543621156, 5293.814716484924, 5310.92033619496, 5317.0, 5385.865353366158, 5288.629795914288, 5296.25852380667, 5299.708516031636, 5319.0, 5339.599530035263, 5224.111900976843, 5399.730013499309, 5416.729163541807, 5438.184272359138, 5442.455754424565, 5216.8001359687105, 5218.530332270114, 5245.580353571705, 5256.763445644955, 5302.0721373759825, 4487.865364039084, 5586.525145362649, 5693.601447898649, 5705.058665320217, 5792.565557583156, 6165.722542485599, 6167.506599472032, 6211.596246243979, 6277.7802776903045, 6282.654454005028, 6256.1866957295715, 6281.623102613858, 6303.968480157616, 6321.494280457552, 6327.367263273636, 5984.551158663117, 6035.3059398169335, 6036.275646922398, 6048.727807248684, 6054.424829641177, 6224.315325314303, 6261.78083767066, 6311.0, 6395.072714456378, 6395.584287021329, 6006.369331220247, 6239.438450539473, 6256.906146407808, 6280.811575652738, 6311.558190926683, 6224.502039836802, 6242.313345531988, 6299.779507717208, 6304.464120549713, 6308.58994165387, 6122.703114648804, 6126.578745377165, 6228.844278893064, 6236.532260080512, 6259.561830671809, 6102.974033066861, 6157.230346206724, 6207.534434917309, 6227.346128656516, 6260.843478912972, 4985.651004429655, 5025.597952163891, 5039.571636410873, 5044.9495505045215, 5048.848534543969, 4246.936295955563, 4453.844115455943, 4479.260921947907, 4489.1021795641, 4582.450105987236, 4966.627502937295, 5963.105534169822, 5972.522198224132, 5999.910001349983, 6007.639541627429, 5345.545628621533, 6287.717052732638, 6307.810765677037, 6315.873682526324, 6360.459360954278, 5852.209951656472, 5955.851103722442, 6011.368806275278, 6016.488598469092, 6071.635701857815, 5496.038193316153, 5524.779008839601, 5528.502434780889, 5537.197106419627, 5538.141588053858, 6345.746170153142, 6526.151600291932, 6535.771248006297, 6542.084108224853, 6561.14705088345, 6199.690015499297, 6252.093446450148, 6323.146375239284, 6334.746610135728, 6368.936310637019, 6420.036994450869, 6424.13274207976, 6451.0, 6460.709268082854, 6475.028745688184, 6014.27828660546, 6132.5084813409785, 6164.3835616438, 6173.382661733791, 6178.876422471615, 6165.414285642857, 6209.627422354492, 6213.409726076015, 6227.377262273736, 6245.437910588069, 6118.082287656887, 6122.816315510542, 6165.599236049642, 6169.938300617116, 6173.043178307369, 5690.203371527907, 5805.912911306249, 6099.207103076572, 6129.325774164928, 6136.754529818757, 5482.5888058394985, 6061.454469097803, 6106.490508973675, 6136.079588061826, 6159.969200153971, 6140.907886381798, 6198.132261483486, 6204.410580994799, 6205.069239614094, 6205.503559715302, 5996.430339117776, 6074.939250607437, 6111.86523267538, 6129.540284478593, 6169.84575385619], "value": 5742.824408419228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.14377773451736, 522.2610006840321, 564.2833601326319, 599.8890205312016, 621.7979156774047, 38519.80740096299, 39369.606303936955, 39598.812035638904, 39709.610163644276, 39800.2039959201, 41011.58988410115, 41286.0, 41501.0, 41604.58395416045, 41667.0, 9342.57958391874, 9467.763305917339, 9493.193078588329, 9622.37454565451, 9626.422414655108, 9514.90485095147, 9659.420434773901, 9669.323147379686, 9781.168600668916, 9792.706218813411, 9738.707838764813, 9780.315377923549, 9790.020997900188, 9804.705858824247, 9805.01949805021, 9663.951680241624, 9674.75813104671, 9755.170810481082, 9767.0, 9788.265880058952, 9531.761705957337, 9594.856077158849, 9626.278029147772, 9658.903410965871, 9692.369995950312, 39070.0, 39327.82016539508, 39494.21011579781, 39552.60447395518, 39566.406503902464, 2829.3209629688727, 3059.5410688396696, 3147.889823856154, 3187.7768556201077, 3421.555197824267, 25695.871520642464, 25754.613680794802, 25872.96508139672, 26049.869750651127, 26213.0, 2627.277498687857, 2632.197179860142, 2668.239551727768, 2719.3881376690088, 2748.0, 391565.0, 392697.0, 393355.0, 397700.0229997692, 398875.0, 32804.179895502806, 34475.482867757004, 34673.47989780155, 34778.652213478046, 34782.47826282608, 32340.514892276635, 68852.31147688559, 70426.0, 70971.64514177396, 71005.64497177584, 16371.91814040946, 16558.00651960886, 16596.0, 16729.247183876512, 16849.747253791204, 12883.742325153444, 12888.355582220851, 12984.220946743226, 12989.220646761225, 13019.414126364336, 19697.310594129136, 19928.60142797136, 19928.70106948397, 20013.799862001193, 20472.181112755323, 7903.288704016666, 8050.4364694472, 8050.993625796776, 8056.798580035546, 8097.2307630774985, 882.2148288023664, 934.1312579301315, 997.3118548201862, 1012.5291739341242, 1028.018242578336, 29503.409931801245, 29548.113556593336, 29795.404091918474, 30275.697243027727, 30332.938347157742, 1081.2755453845941, 1202.0683969923205, 1209.2744353387898, 1216.3249396584981, 1239.3555351217317, 15330.0, 15432.919695621198, 15555.533333999998, 15676.843231567538, 15833.0, 546337.0, 622126.6723996574, 628481.0, 628861.7113828894, 633452.0, 58621.70689146612, 59365.0, 60722.089168662504, 61383.07925381123, 61472.69263653653, 1461.868431841118, 1473.661057956676, 1482.5404124721586, 1486.9107853528824, 1493.2832240524608, 29161.0, 29347.826086957135, 29372.412551749272, 30163.491825408204, 30440.543391848696, 46925.06149877052, 53433.4656653444, 54225.0, 54267.72866135644, 54354.45645543494, 527266.0, 561796.0, 567534.0, 567891.0, 569125.0, 25832.870835645703, 26644.46711065729, 27009.0, 27425.04012359558, 27453.31366715848, 45218.77390613026, 45799.77100114478, 46428.30357544707, 47110.76444617755, 47326.29010564913, 37120.814395927846, 37292.0, 37495.43756843595, 37972.81013594914, 38206.044848879, 37250.25499490049, 37500.624993750804, 37551.43672844964, 38244.23511529809, 38254.808725956194, 33659.0, 36500.26999460049, 37623.0, 37753.0, 37812.81093594625, 31490.0, 32914.83542582272, 33028.0, 33076.66923330736, 33489.0, 24090.75909240885, 24529.877350613846, 24542.877285613456, 24950.0, 25154.37114072163], "value": 19474.676997836494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.56862901775895, 388.9688824894007, 391.256612436371, 395.5372214509025, 404.3409242934019, 18840.152193151305, 20210.59578808423, 20737.96310184492, 20741.896290518525, 20775.376738697843, 10413.271071025032, 11939.58211462599, 12219.572314968978, 12224.511019559208, 14355.0, 5123.564497017758, 5315.282436871031, 5339.839804805862, 5343.866403339909, 5349.358077030762, 3836.3094642964393, 5559.666420014792, 5878.382769809173, 5890.0, 5895.233619629442, 5820.0, 5837.8832423351505, 5863.560232982522, 5873.941260587403, 5966.37353077927, 5197.324347834795, 5397.919031214516, 5465.9726701366435, 5728.255326807488, 5872.119182122673, 5230.581553475751, 5570.136628822539, 5673.063944449161, 5681.9431805681825, 5684.8010319638615, 20828.895855520776, 21764.58530195532, 24073.63889541658, 26289.605655915177, 26322.21033368983, 2108.104055776289, 2140.9571808563896, 2152.2682288021992, 2153.3862849087936, 2686.8387896726063, 9080.0, 9899.25755568328, 10038.397696138181, 12185.817212741817, 14139.434422623186, 1706.7269236922157, 1782.5187199456204, 1794.1836464408664, 1805.5826176451553, 1827.7349784281337, 118733.21900171504, 119673.0, 123106.0, 123630.90922726913, 123855.3807230967, 11243.156763242789, 11560.710982225344, 11829.231099978473, 11973.880261197452, 11999.460024298927, 15131.01648392873, 15179.620509487351, 15180.316885740169, 15183.544493665207, 15200.391984320504, 8717.12828717136, 8743.431676940978, 8780.560971951378, 8787.736367908972, 8795.296376289882, 8586.270167035747, 8650.178233067849, 8666.56667166639, 8671.479711217347, 8773.210411063035, 4649.465311489154, 4670.673052886265, 4678.555537223959, 4694.108119457293, 4760.952390476051, 1815.331216597315, 1902.334183035954, 1987.3839109875985, 2008.658528050235, 2011.7686466056591, 885.3625389719392, 885.9335549833788, 940.1068984464786, 1042.4735508568124, 1048.5753269925692, 18851.151698173617, 19467.51331216731, 19608.8039119607, 20084.99575021272, 20626.278080267417, 862.1550880137376, 949.7198326493701, 951.1534734086669, 957.1003256938455, 991.2119864707574, 8773.0, 10637.62768303121, 10831.783364332668, 11011.449427528752, 11050.557977680963, 573024.0, 592913.0, 604213.0, 606616.0, 608544.8291034155, 101835.0, 132176.67823321643, 132722.33638831938, 134424.0, 139621.0, 968.4431451915177, 992.771662517625, 1007.6070332570157, 1012.4330374990029, 1014.5789497358661, 17736.379226727004, 17800.46598602044, 17873.821261787216, 17906.462806115836, 18110.73224874246, 52266.738666306424, 52589.0, 53838.73080634572, 53840.730796345764, 54255.45744542504, 77533.0, 79142.6042869782, 79251.0, 79314.60342698249, 81334.59332703298, 7881.58131536329, 7976.760697179094, 8127.065387480516, 8146.5519396433765, 8556.700515482178, 9277.953610231905, 11594.94202528982, 11861.110416718953, 11869.813018698062, 12631.242125472501, 10317.123044541298, 11207.383593902088, 11298.661040168809, 11523.53905843757, 11668.533258669559, 10438.269321147447, 10842.837357439803, 10910.399928003719, 10983.066439352744, 11139.10887129044, 11003.284786488852, 11220.438978051228, 11355.261907975955, 11613.5354585819, 11644.767104658029, 8006.679732810622, 8083.0, 8216.301614362847, 8247.628856701584, 8384.07960199005, 9805.607775688892, 10150.796984060426, 11200.943995279971, 11431.428428578703, 11441.713957150805], "value": 9376.582173268287, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1588.952331430057, 1601.5915941434932, 1883.3878989328464, 1949.3664559018323, 1984.0972357577305, 7919.445638805286, 8226.465279756827, 8768.342374321928, 9024.368294219406, 9058.139476749706, 7577.659005344759, 8907.421017633866, 9009.504477253748, 9014.278857691384, 9025.142611451902, 2257.3115199864037, 2371.905123795046, 2457.7787999080124, 2494.8503089814667, 2495.9251222463354, 2473.6413220083077, 2474.5174690935273, 2478.8884500197532, 2486.689163854518, 2487.6268559716095, 2208.0, 2485.428351479161, 2489.850608963459, 2502.987485062572, 2505.060602274147, 2459.4589190378088, 2475.925722228336, 2477.442575420534, 2478.1821998740375, 2495.226479791261, 2434.342727463593, 2464.5070985802913, 2465.9136930207537, 2471.4686342436285, 2495.238952119603, 8944.910550894472, 9075.63697452101, 9125.041870603623, 9126.58930348136, 9132.634694612207, 5275.947240527584, 5462.617616766828, 5485.122380419114, 5485.259489968843, 5508.531774799147, 3463.341965026637, 3474.704650104744, 3562.697170740464, 3571.964280357189, 3594.209273959751, 987.284218941269, 1004.8342023566103, 1006.7684432580547, 1019.0930072235716, 1033.7260625934134, 10418.531166097468, 11513.769724605545, 11547.422628868522, 11603.361815100166, 11616.36110013949, 4755.5257870060395, 4837.0, 4861.951380486221, 4873.220284754422, 4878.829240976549, 9943.254255930835, 9951.950240248752, 9965.501724913725, 9993.80012399748, 10034.598616055422, 5390.595705322116, 5415.945840541623, 5434.64674796137, 5435.918461223085, 5442.6462279951675, 4530.886727831765, 4913.263010548375, 4980.950190498121, 5024.598032157419, 5046.772895219724, 3472.461768425898, 3621.7826930383735, 3965.167314863911, 4032.4152997815154, 4066.6423446430745, 1344.4151793969459, 1370.5682709946334, 1371.4994027180207, 1384.190248704519, 1389.6178550898583, 868.7828042989253, 943.3632298198688, 944.1219665710955, 968.7384406210284, 987.9012098790207, 6005.309389420273, 6029.849253768691, 6048.879022419527, 6151.0, 6201.007838745869, 447.61057879644267, 454.99772501137284, 457.87179589714935, 463.0715415591717, 468.88746700791563, 3994.420808982681, 4025.19496100781, 4089.9182016359505, 4109.938350924738, 4113.1568028554075, 10377.948110259551, 10818.972197641211, 10832.729181770519, 10836.241463097507, 10838.187135964834, 9455.952720236355, 10372.740681482872, 10669.89330106689, 10707.036366726876, 10738.140948724084, 8022.398320125897, 8166.918330816735, 8263.752087437386, 8280.296174825207, 8349.666013359398, 5923.0, 5975.701214939322, 5987.0, 5987.940120598738, 5992.970035149797, 9657.613695452384, 9939.0, 10000.799984000425, 10110.0, 10137.746556336151, 9766.511674416393, 9810.0, 10137.847932281169, 10159.7460063499, 10205.74485637865, 7071.25751796054, 7500.287472690085, 7545.132309784445, 7678.462507624413, 7733.226677332222, 8396.37027222973, 8571.742847714579, 8587.65649374018, 8596.871046934426, 8650.178233067849, 7483.326500614753, 7619.08570971487, 7663.195364486872, 7684.500507466997, 7705.807354816175, 7365.889511657437, 7453.515521491086, 7464.440166987389, 7475.7009719610605, 7597.354224890946, 7098.929010710033, 7134.892976605459, 7174.210836808052, 7175.748848790267, 7199.1001124859395, 4860.173770459101, 4985.551300382983, 5088.669236499616, 5106.310648062464, 5119.0017946500075, 4988.251762235548, 5104.974475127749, 5111.233315002779, 5155.226715992631, 5305.787768489372], "value": 4585.670672124363, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.4412058295069, 323.6827908649523, 331.40347374725496, 332.5693227270686, 335.9613644430891, 6126.172966649501, 6203.193584833965, 6248.312955502018, 6252.718627661755, 6258.3115857255725, 5541.27963364763, 6084.634921904678, 6118.694065296729, 6118.938810611892, 6143.201383820097, 3811.6569508744137, 4501.864944051684, 4621.09888571727, 4624.421947256593, 4636.0, 3943.5662077171487, 4603.930941035887, 4605.503211456274, 4615.469221039573, 4652.302154676791, 4558.954410455903, 4572.97713511432, 4576.427946506687, 4602.171609110359, 4638.721676699409, 3549.574051113857, 4040.9999999999854, 4071.839525735181, 4360.171567402183, 4556.22544167489, 3455.2225749206477, 3785.958861313161, 3951.427043078766, 3957.52509698838, 3986.5016872890887, 5956.106584012389, 5981.700914954278, 6025.475097068221, 6049.4647397631115, 6059.545534084918, 5245.134552798783, 5348.806989134475, 5402.621816472849, 5435.157550579627, 5451.509364157245, 6591.242007169189, 6608.1409416776, 6619.735210591571, 6640.402363787282, 6648.1800694496105, 3844.596317386662, 3934.4885164928664, 3981.9845939285296, 4108.67130629549, 4300.78496075195, 6959.338862808025, 6985.6507174641065, 6997.545159564612, 7016.543924644881, 7038.225795162528, 4461.237811064611, 4514.300283456069, 4535.115652447741, 4541.9545804542195, 4568.885777855514, 3890.708196885245, 4148.473797272294, 4383.9342409863875, 4603.95396046042, 4630.814767409266, 5394.9460505394445, 5395.298611180521, 5398.838034858961, 5403.918941215885, 5438.619296649275, 6669.533132680763, 6673.632950187689, 6700.93299067003, 6710.295418981034, 6717.294684058202, 1526.6107142678545, 1583.9287232074585, 1589.3404237241416, 1591.8328575499638, 1594.6126869623502, 827.4662842466576, 959.9344727352633, 980.6273616025865, 1043.8538604595362, 1066.0778426660881, 5899.823005309761, 6208.286047104551, 6212.937870621236, 6250.218722659668, 6254.3745625438005, 6599.241087274929, 6888.345607167311, 6910.170779506391, 6922.965385173042, 6946.2011868634745, 5602.047651899187, 6087.878242435127, 6210.130581718563, 6224.408681175281, 6272.773165526264, 3331.950020749691, 3407.539982102434, 3611.8013509257244, 3644.562652481719, 3660.7120549656465, 6897.0, 7087.858242835115, 7106.253843346374, 7134.821629459201, 7182.389496892718, 7005.54463959841, 7033.417481066821, 7034.92965070353, 7039.401650859734, 7097.077379940678, 5793.971030144822, 6903.447724182053, 7021.0532077406315, 7046.780264216755, 7203.639818009078, 5531.363893152178, 6038.456538911519, 6808.62552559614, 6823.931760682528, 6882.1783068941495, 5356.812511562077, 5587.910357480252, 6753.527253092237, 6839.692213850488, 6872.86597711392, 6299.149614801943, 6469.320721324193, 7206.783796486114, 7234.710611575478, 7240.312170343809, 4122.732022418533, 4137.338025915839, 4395.142947125408, 4409.867703968886, 4411.602955733999, 6391.456726178327, 6796.422304104009, 6872.931270687229, 6877.484188685969, 6906.205786334636, 6673.132492775908, 6673.299303573249, 6687.896497077928, 6692.230393504615, 6714.294999025032, 5598.7962588043765, 5789.928863160329, 6433.388828061326, 6685.465162787063, 6710.094137291599, 6182.752689892354, 6293.37066293367, 6333.619982800862, 6467.579607325509, 6521.456631913463, 5187.0, 5636.12557595621, 6447.2263328400895, 6699.330066993261, 6712.630805305755, 5303.734813259399, 6500.187476565429, 6572.34276572339, 6572.507061970276, 6585.176852893388], "value": 4783.7923344455985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.6400389795358, 700.1598082301236, 706.5760543673796, 718.6801873166439, 727.923568025357, 14697.118172909633, 14976.326065327059, 15168.165750883696, 15187.392504299829, 15238.466653667125, 13872.514461993833, 13909.93045034776, 13930.164190148598, 13944.930275348634, 13962.93018534906, 875.3085062800396, 901.5762591581946, 943.8725772020758, 950.0546955779009, 950.2872845365976, 934.7102398256528, 938.6949241496507, 945.8533927241255, 946.9668561600346, 948.9430634161938, 963.9277054220927, 979.4221409368507, 988.0021178609584, 991.781808002242, 992.3450522655049, 856.7815207122175, 930.5533343994853, 977.5307852230969, 980.3480685344273, 982.1210017034786, 641.7272659119902, 723.9819004524876, 727.8871774874902, 731.9194888562254, 737.1633196322159, 12700.745985080339, 15173.924130379388, 15240.161791101486, 15609.765853512206, 15645.843541564665, 10757.0, 12430.564930227398, 12523.686907827287, 12687.0, 13421.993350498655, 9967.700968970943, 10074.748131296703, 10204.948975255076, 10551.472426378727, 10762.892371076345, 3313.884014059496, 3471.861125554975, 3474.8262586870555, 3585.982070089633, 3598.6401359864067, 83760.0, 85060.57469712613, 85217.57391213067, 85390.14609853947, 85412.57293713554, 7934.960325198453, 9330.206932410685, 9382.343235973416, 9417.670381536613, 10127.341722787995, 20910.0, 21303.0, 21429.89285053565, 21430.57138857214, 21458.892705536684, 6106.6336019838955, 7408.111026676834, 7425.071866016748, 7480.812979675443, 7493.625318734042, 3888.902777430587, 4078.5105787305715, 4142.958570414317, 4151.709380343407, 4172.853950111731, 3584.301061293075, 3615.9276814463565, 3631.909202269964, 3666.5966743658178, 3672.375696131664, 630.6688988281189, 641.2081079866362, 653.3988730368072, 658.1641315529251, 658.9703463344065, 542.8697112692926, 578.1299144787152, 585.4233579923772, 604.3473049106954, 607.2439812433548, 7915.287624113857, 8082.757517274491, 8109.594520273963, 8189.058258300372, 8326.25063744266, 510.54051353781153, 591.5563327504372, 591.6568390333596, 598.2462097756858, 633.0156606476972, 3537.823108844599, 3894.668953139015, 3913.2173565287057, 3966.0481484444103, 3987.401889716508, 90370.64444033345, 93424.53287733518, 93742.0, 95946.56080158803, 97575.51212243893, 74204.62897685477, 76487.61756191183, 77060.0, 77251.22748772553, 77928.61035694786, 66832.0, 67142.0, 68698.65650671715, 68717.31282687209, 68950.0, 7591.051118610174, 7650.196729343339, 7675.501092429197, 7734.071911370672, 7854.764357069297, 42070.78964605158, 42355.0, 42429.93925151896, 42517.57482425136, 42784.78607607067, 63725.362746371946, 64299.392515187494, 64446.35553644591, 64633.35366646273, 64864.35135648772, 9096.454212747256, 9865.273577124119, 10115.544800484144, 10733.0, 11406.315621062762, 9218.815623687622, 9789.021097890154, 11658.358790266617, 11916.285022898654, 12580.433880475217, 11409.0, 11445.828312575484, 11480.196386252883, 11562.479688413874, 11657.941710291394, 10218.335808172445, 10664.66691663542, 11271.380074096003, 11394.658160255205, 11517.712057198301, 8604.870926935975, 9737.561809718722, 11212.0, 11736.119791015537, 11947.342896140448, 9295.535223238947, 9530.332876698842, 9668.70993870185, 9713.660021899199, 9782.608695652094, 9615.807683846424, 9976.2517811163, 10019.998000199921, 10026.899731002597, 10030.047145521165], "value": 6824.89255618436, "unit": "score"}], "name": "dromaeo_css", "value": 7344.997610615982, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 109.0, 116.0, 116.0, 116.0, 129.0, 115.0, 116.0, 118.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 157.0, 148.0, 166.0, 125.0, 144.0, 140.0, 136.0, 153.0, 109.0], "value": 147.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 194.0, 227.0, 222.0, 261.0, 275.0, 219.0, 200.0, 203.0, 195.0], "value": 219.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 88.0, 186.0, 57.0, 83.0, 81.0, 82.0, 158.0, 58.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 94.0, 125.0, 76.0, 83.0, 80.0, 122.0, 78.0, 78.0, 152.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 89.0, 86.0, 90.0, 87.0, 89.0, 86.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 102.0, 131.0, 95.0, 94.0, 94.0, 121.0, 152.0, 94.0, 95.0], "value": 107.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 93.0, 96.0, 90.0, 94.0, 90.0, 92.0, 94.0, 93.0, 89.0], "value": 92.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 61.0, 63.0, 62.0, 61.0, 82.0, 64.0, 59.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 71.0, 68.0, 71.0, 77.0, 71.0, 68.0, 68.0, 69.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 101.0, 103.0, 95.0, 74.0, 72.0, 105.0, 111.0, 107.0], "value": 93.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 141.0, 134.0, 128.0, 159.0, 164.0, 156.0, 163.0, 203.0, 169.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 171.0, 176.0, 222.0, 176.0, 172.0, 173.0, 172.0, 176.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 72.0, 66.0, 81.0, 70.0, 57.0, 90.0, 68.0, 65.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1596.3, "alertThreshold": 2.0}]} 05:15:26 INFO - Return code: 0 05:15:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:15:26 ERROR - # TBPL SUCCESS # 05:15:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:15:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:15:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:15:26 INFO - 2016-04-25 05:15:26.887 screenresolution[1680:10698] starting screenresolution argv=screenresolution get 05:15:26 INFO - 2016-04-25 05:15:26.889 screenresolution[1680:10698] Display 0: 1600x1200x32@60 05:15:26 INFO - 2016-04-25 05:15:26.895 screenresolution[1681:10701] starting screenresolution argv=screenresolution list 05:15:26 INFO - Available Modes on Display 0 05:15:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:15:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:15:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:15:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:15:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:15:27 INFO - Intel Iris: 05:15:27 INFO - Chipset Model: Intel Iris 05:15:27 INFO - Type: GPU 05:15:27 INFO - Bus: Built-In 05:15:27 INFO - VRAM (Dynamic, Max): 1536 MB 05:15:27 INFO - Vendor: Intel (0x8086) 05:15:27 INFO - Device ID: 0x0a2e 05:15:27 INFO - Revision ID: 0x0009 05:15:27 INFO - Displays: 05:15:27 INFO - Display: 05:15:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:15:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:15:27 INFO - Display Serial Number: 1600x1200 60 05:15:27 INFO - Main Display: Yes 05:15:27 INFO - Mirror: Off 05:15:27 INFO - Online: Yes 05:15:27 INFO - Rotation: Supported 05:15:27 INFO - Return code: 0 05:15:27 INFO - Running post-action listener: _resource_record_post_action 05:15:27 INFO - Running post-run listener: _resource_record_post_run 05:15:28 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 37721600; Write bytes: 696685056; Read time: 391; Write time: 2013 05:15:28 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 380086784; Write bytes: 371951104; Read time: 28307; Write time: 829 05:15:28 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 36779520; Write bytes: 299498496; Read time: 377; Write time: 1137 05:15:28 INFO - Running post-run listener: _upload_blobber_files 05:15:28 INFO - Blob upload gear active. 05:15:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:15:28 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:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:15:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:15:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:15:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:15:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:29 INFO - (blobuploader) - INFO - Done attempting. 05:15:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:15:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:15:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:30 INFO - (blobuploader) - INFO - Done attempting. 05:15:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:15:30 INFO - Return code: 0 05:15:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:15:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:15:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c62b3af1ee37c7b52e310bbfd2adccb9952ef2efb74e7f77ef80ebf80a6fa6de5dfcc5a9cbf8fa2d4d869807bbbdc8173115ee9eda8984760f42c68ec3b4db8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4dfec918d31630a908dacef6d6c4d42586368bac44689bf9668dd8423f9a8f1a40e1e3365d253c790157a222356f432931fe91bfbce8e9ea0be55ebb36e09cf"} 05:15:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:15:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:15:30 INFO - Contents: 05:15:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c62b3af1ee37c7b52e310bbfd2adccb9952ef2efb74e7f77ef80ebf80a6fa6de5dfcc5a9cbf8fa2d4d869807bbbdc8173115ee9eda8984760f42c68ec3b4db8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4dfec918d31630a908dacef6d6c4d42586368bac44689bf9668dd8423f9a8f1a40e1e3365d253c790157a222356f432931fe91bfbce8e9ea0be55ebb36e09cf"} 05:15:30 INFO - Running post-run listener: copy_logs_to_upload_dir 05:15:30 INFO - Copying logs to upload dir... 05:15:30 INFO - mkdir: /builds/slave/test/build/upload/logs 05:15:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.848532 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-25 05:15:30.480358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:15:30.484279) ========= 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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c62b3af1ee37c7b52e310bbfd2adccb9952ef2efb74e7f77ef80ebf80a6fa6de5dfcc5a9cbf8fa2d4d869807bbbdc8173115ee9eda8984760f42c68ec3b4db8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4dfec918d31630a908dacef6d6c4d42586368bac44689bf9668dd8423f9a8f1a40e1e3365d253c790157a222356f432931fe91bfbce8e9ea0be55ebb36e09cf"} build_url:https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/IxjqWs15RxqsGSSB6l6AJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c62b3af1ee37c7b52e310bbfd2adccb9952ef2efb74e7f77ef80ebf80a6fa6de5dfcc5a9cbf8fa2d4d869807bbbdc8173115ee9eda8984760f42c68ec3b4db8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4dfec918d31630a908dacef6d6c4d42586368bac44689bf9668dd8423f9a8f1a40e1e3365d253c790157a222356f432931fe91bfbce8e9ea0be55ebb36e09cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:15:30.516787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:15:30.517265) ========= 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.Dc0fckrg8L/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.e3uq3r7dNL/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005008 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:15:30.568557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:15:30.569274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:15:30.570168) ========= ========= Total master_lag: 0.17 =========