builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0072 starttime: 1467889594.88 results: success (0) buildid: 20160706215822 builduid: 005acac198204b229cc2500b323a4168 revision: d142c49033c015f67272562b37dbe2912cfc7f14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:34.884200) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:34.884697) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:34.885325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:34.917138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:34.917477) ========= 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.5L7kseQoA9/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.C3M6fPispO/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-07 04:06:34-- 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% 7.75M=0.001s 2016-07-07 04:06:35 (7.75 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130948 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:35.071837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:35.072341) ========= 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.5L7kseQoA9/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.C3M6fPispO/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.021184 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:35.185680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-07 04:06:35.186253) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d142c49033c015f67272562b37dbe2912cfc7f14 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d142c49033c015f67272562b37dbe2912cfc7f14 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5L7kseQoA9/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.C3M6fPispO/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-07 04:06:36,093 truncating revision to first 12 chars 2016-07-07 04:06:36,093 Setting DEBUG logging. 2016-07-07 04:06:36,093 attempt 1/10 2016-07-07 04:06:36,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d142c49033c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 04:06:37,801 unpacking tar archive at: mozilla-beta-d142c49033c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.958957 ========= master_lag: 0.86 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-07 04:06:38.003802) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:38.004172) ========= script_repo_revision: d142c49033c015f67272562b37dbe2912cfc7f14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:38.004596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:38.004863) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:38.024886) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-07 04:06:38.025482) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5L7kseQoA9/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.C3M6fPispO/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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:06:38 INFO - MultiFileLogger online at 20160707 04:06:38 in /builds/slave/test 04:06:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:06:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:06:38 INFO - {'append_to_log': False, 04:06:38 INFO - 'base_work_dir': '/builds/slave/test', 04:06:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:06:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:06:38 INFO - 'branch': 'Mozilla-Beta', 04:06:38 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:38 INFO - 'config_files': ('talos/mac_config.py',), 04:06:38 INFO - 'default_actions': ('clobber', 04:06:38 INFO - 'read-buildbot-config', 04:06:38 INFO - 'download-and-extract', 04:06:38 INFO - 'populate-webroot', 04:06:38 INFO - 'create-virtualenv', 04:06:38 INFO - 'install', 04:06:38 INFO - 'run-tests'), 04:06:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:38 INFO - 'download_minidump_stackwalk': True, 04:06:38 INFO - 'download_symbols': 'ondemand', 04:06:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:38 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:38 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:38 INFO - 'installer_path': 'installer.exe', 04:06:38 INFO - 'log_level': 'info', 04:06:38 INFO - 'log_name': 'talos', 04:06:38 INFO - 'log_to_console': True, 04:06:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:06:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:06:38 INFO - 'opt_config_files': (), 04:06:38 INFO - 'pip_index': False, 04:06:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:06:38 INFO - 'cmd': ('bash', 04:06:38 INFO - '-c', 04:06:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:06:38 INFO - 'enabled': True, 04:06:38 INFO - 'halt_on_failure': False, 04:06:38 INFO - 'name': 'check_screen_resolution'},), 04:06:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:06:38 INFO - 'cmd': ('bash', 04:06:38 INFO - '-c', 04:06:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:06:38 INFO - 'enabled': True, 04:06:38 INFO - 'halt_on_failure': False, 04:06:38 INFO - 'name': 'check_screen_resolution'},), 04:06:38 INFO - 'run_cmd_checks_enabled': True, 04:06:38 INFO - 'sps_profile': False, 04:06:38 INFO - 'sps_profile_interval': 0, 04:06:38 INFO - 'suite': 'dromaeojs', 04:06:38 INFO - 'system_bits': '32', 04:06:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:38 INFO - 'title': 't-yosemite-r7-0072', 04:06:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:38 INFO - 'use_talos_json': True, 04:06:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:06:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:38 INFO - 'work_dir': 'build'} 04:06:38 INFO - ##### 04:06:38 INFO - ##### Running clobber step. 04:06:38 INFO - ##### 04:06:38 INFO - Running pre-action listener: _resource_record_pre_action 04:06:38 INFO - Running main action method: clobber 04:06:38 INFO - rmtree: /builds/slave/test/build 04:06:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:06:38 INFO - Running post-action listener: _resource_record_post_action 04:06:38 INFO - ##### 04:06:38 INFO - ##### Running read-buildbot-config step. 04:06:38 INFO - ##### 04:06:38 INFO - Running pre-action listener: _resource_record_pre_action 04:06:38 INFO - Running main action method: read_buildbot_config 04:06:38 INFO - Using buildbot properties: 04:06:38 INFO - { 04:06:38 INFO - "project": "", 04:06:38 INFO - "product": "firefox", 04:06:38 INFO - "script_repo_revision": "production", 04:06:38 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:06:38 INFO - "repository": "", 04:06:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:06:38 INFO - "buildid": "20160706215822", 04:06:38 INFO - "pgo_build": "False", 04:06:38 INFO - "basedir": "/builds/slave/test", 04:06:38 INFO - "buildnumber": 22, 04:06:38 INFO - "slavename": "t-yosemite-r7-0072", 04:06:38 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:06:38 INFO - "platform": "yosemite_r7", 04:06:38 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:06:38 INFO - "branch": "mozilla-beta", 04:06:38 INFO - "repo_path": "releases/mozilla-beta", 04:06:38 INFO - "revision": "d142c49033c015f67272562b37dbe2912cfc7f14", 04:06:38 INFO - "stage_platform": "macosx64", 04:06:38 INFO - "builduid": "005acac198204b229cc2500b323a4168", 04:06:38 INFO - "slavebuilddir": "test" 04:06:38 INFO - } 04:06:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 04:06:38 INFO - Running post-action listener: _resource_record_post_action 04:06:38 INFO - ##### 04:06:38 INFO - ##### Running download-and-extract step. 04:06:38 INFO - ##### 04:06:38 INFO - Running pre-action listener: _resource_record_pre_action 04:06:38 INFO - Running main action method: download_and_extract 04:06:38 INFO - mkdir: /builds/slave/test/build/tests 04:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:38 INFO - https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:06:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:06:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:06:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 04:06:40 INFO - Downloaded 1165 bytes. 04:06:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:06:40 INFO - Using the following test package requirements: 04:06:40 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:06:40 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:40 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:06:40 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:40 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:06:40 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:06:40 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:40 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:06:40 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:06:40 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:40 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:06:40 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:40 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:06:40 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:40 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:06:40 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:40 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:06:40 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 04:06: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:06:40 INFO - https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:06:41 INFO - Downloaded 18351388 bytes. 04:06:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:06:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:06:44 INFO - Return code: 0 04:06:44 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:06:44 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:06:44 INFO - https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:06:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:06:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:06:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:06:46 INFO - Downloaded 18351388 bytes. 04:06:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:06:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:06:49 INFO - Return code: 0 04:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:49 INFO - https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:06:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:06:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:06:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 04:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 04:06:51 INFO - Downloaded 10840145 bytes. 04:06:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:06:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:06:51 INFO - Return code: 0 04:06:51 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:06:51 INFO - https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 04:06:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:06:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:06:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 04:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 04:06:53 INFO - Downloaded 86189077 bytes. 04:06:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:06:53 INFO - mkdir: /builds/slave/test/properties 04:06:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:53 INFO - Contents: 04:06:53 INFO - build_url:https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:06:54 INFO - Running post-action listener: _resource_record_post_action 04:06:54 INFO - Running post-action listener: set_extra_try_arguments 04:06:54 INFO - ##### 04:06:54 INFO - ##### Running populate-webroot step. 04:06:54 INFO - ##### 04:06:54 INFO - Running pre-action listener: _resource_record_pre_action 04:06:54 INFO - Running main action method: populate_webroot 04:06:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:06:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:06:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:06:54 INFO - '--tppagecycles', 04:06:54 INFO - '7'], 04:06:54 INFO - 'tests': ['tsvgm']}}, 04:06:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:06:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:06:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:06:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:06:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:06:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:06:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:54 INFO - 'talos_options': ['--disable-e10s'], 04:06:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:54 INFO - 'talos_options': ['--disable-e10s'], 04:06:54 INFO - 'tests': ['damp', 'tps']}, 04:06:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:54 INFO - 'tests': ['damp', 'tps']}, 04:06:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:06:54 INFO - 'tests': ['dromaeo_dom']}, 04:06:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:06:54 INFO - 'tests': ['a11yr', 04:06:54 INFO - 'ts_paint', 04:06:54 INFO - 'tpaint', 04:06:54 INFO - 'sessionrestore', 04:06:54 INFO - 'sessionrestore_no_auto_restore', 04:06:54 INFO - 'tabpaint']}, 04:06:54 INFO - 'other-e10s': {'tests': ['a11yr', 04:06:54 INFO - 'ts_paint', 04:06:54 INFO - 'tpaint', 04:06:54 INFO - 'sessionrestore', 04:06:54 INFO - 'sessionrestore_no_auto_restore', 04:06:54 INFO - 'tabpaint']}, 04:06:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:06:54 INFO - 'ts_paint', 04:06:54 INFO - 'tpaint', 04:06:54 INFO - 'sessionrestore', 04:06:54 INFO - 'sessionrestore_no_auto_restore', 04:06:54 INFO - 'tabpaint']}, 04:06:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:06:54 INFO - 'ts_paint', 04:06:54 INFO - 'tpaint', 04:06:54 INFO - 'sessionrestore', 04:06:54 INFO - 'sessionrestore_no_auto_restore', 04:06:54 INFO - 'tabpaint']}, 04:06:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:06:54 INFO - 'tests': ['a11yr', 04:06:54 INFO - 'ts_paint', 04:06:54 INFO - 'tpaint', 04:06:54 INFO - 'sessionrestore', 04:06:54 INFO - 'sessionrestore_no_auto_restore', 04:06:54 INFO - 'tabpaint']}, 04:06:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:06:54 INFO - 'tests': ['a11yr', 04:06:54 INFO - 'ts_paint', 04:06:54 INFO - 'tpaint', 04:06:54 INFO - 'sessionrestore', 04:06:54 INFO - 'sessionrestore_no_auto_restore', 04:06:54 INFO - 'tabpaint']}, 04:06:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:06:54 INFO - 'tests': ['tsvgx', 04:06:54 INFO - 'tsvgr_opacity', 04:06:54 INFO - 'tart', 04:06:54 INFO - 'tscrollx', 04:06:54 INFO - 'cart']}, 04:06:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:06:54 INFO - 'tsvgr_opacity', 04:06:54 INFO - 'tart', 04:06:54 INFO - 'tscrollx', 04:06:54 INFO - 'cart']}, 04:06:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:54 INFO - 'talos_options': ['--disable-e10s'], 04:06:54 INFO - 'tests': ['tp5o']}, 04:06:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:54 INFO - 'tests': ['tp5o']}, 04:06:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:54 INFO - 'talos_options': ['--disable-e10s', 04:06:54 INFO - '--xperf_path', 04:06:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:54 INFO - 'tests': ['tp5n']}, 04:06:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:54 INFO - 'talos_options': ['--xperf_path', 04:06:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:54 INFO - 'tests': ['tp5n']}}, 04:06:54 INFO - 'talos.zip': {'path': '', 04:06:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:06:54 INFO - Running post-action listener: _resource_record_post_action 04:06:54 INFO - ##### 04:06:54 INFO - ##### Running create-virtualenv step. 04:06:54 INFO - ##### 04:06:54 INFO - Running pre-action listener: _resource_record_pre_action 04:06:54 INFO - Running main action method: create_virtualenv 04:06:54 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:54 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:06:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:06:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:06:55 INFO - Using real prefix '/tools/python27' 04:06:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:06:55 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:58 INFO - Installing pip.................done. 04:06:58 INFO - Return code: 0 04:06:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:58 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 0x10236ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10237b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9682c51280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10220ae00>, '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 0x102073db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102205b20>, '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.5L7kseQoA9/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.C3M6fPispO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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:06:58 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:06:58 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:06:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5L7kseQoA9/Render', 04:06:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:58 INFO - 'HOME': '/Users/cltbld', 04:06:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:58 INFO - 'LOGNAME': 'cltbld', 04:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:58 INFO - 'MOZ_NO_REMOTE': '1', 04:06:58 INFO - 'NO_EM_RESTART': '1', 04:06:58 INFO - 'PAGER': '/bin/cat', 04:06:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:58 INFO - 'PWD': '/builds/slave/test', 04:06:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:58 INFO - 'SHELL': '/bin/bash', 04:06:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C3M6fPispO/Listeners', 04:06:58 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 04:06:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:58 INFO - 'USER': 'cltbld', 04:06:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:58 INFO - 'XPC_FLAGS': '0x0', 04:06:58 INFO - 'XPC_SERVICE_NAME': '0', 04:06:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:58 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:06:58 INFO - Cleaning up... 04:06:58 INFO - Return code: 0 04:06:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:58 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 0x10236ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10237b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9682c51280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10220ae00>, '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 0x102073db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102205b20>, '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.5L7kseQoA9/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.C3M6fPispO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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:06:58 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:06:58 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:06:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5L7kseQoA9/Render', 04:06:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:58 INFO - 'HOME': '/Users/cltbld', 04:06:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:58 INFO - 'LOGNAME': 'cltbld', 04:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:58 INFO - 'MOZ_NO_REMOTE': '1', 04:06:58 INFO - 'NO_EM_RESTART': '1', 04:06:58 INFO - 'PAGER': '/bin/cat', 04:06:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:58 INFO - 'PWD': '/builds/slave/test', 04:06:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:58 INFO - 'SHELL': '/bin/bash', 04:06:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C3M6fPispO/Listeners', 04:06:58 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 04:06:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:58 INFO - 'USER': 'cltbld', 04:06:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:58 INFO - 'XPC_FLAGS': '0x0', 04:06:58 INFO - 'XPC_SERVICE_NAME': '0', 04:06:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:59 INFO - Downloading/unpacking psutil>=0.7.1 04:06: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:06: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:06: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:06: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:06: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:06: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:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:02 INFO - Installing collected packages: psutil 04:07:02 INFO - Running setup.py install for psutil 04:07:02 INFO - building 'psutil._psutil_osx' extension 04:07:02 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:07:02 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:07:02 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:07:02 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:07:02 INFO - building 'psutil._psutil_posix' extension 04:07:02 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:07:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:07:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:07:02 INFO - ^ 04:07:02 INFO - 1 warning generated. 04:07:02 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:07:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:02 INFO - Successfully installed psutil 04:07:02 INFO - Cleaning up... 04:07:03 INFO - Return code: 0 04:07:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:03 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 0x10236ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10237b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9682c51280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10220ae00>, '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 0x102073db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102205b20>, '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.5L7kseQoA9/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.C3M6fPispO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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:07:03 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:07:03 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:07:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5L7kseQoA9/Render', 04:07:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:03 INFO - 'HOME': '/Users/cltbld', 04:07:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:03 INFO - 'LOGNAME': 'cltbld', 04:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:03 INFO - 'MOZ_NO_REMOTE': '1', 04:07:03 INFO - 'NO_EM_RESTART': '1', 04:07:03 INFO - 'PAGER': '/bin/cat', 04:07:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:03 INFO - 'PWD': '/builds/slave/test', 04:07:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:03 INFO - 'SHELL': '/bin/bash', 04:07:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C3M6fPispO/Listeners', 04:07:03 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 04:07:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:03 INFO - 'USER': 'cltbld', 04:07:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:03 INFO - 'XPC_FLAGS': '0x0', 04:07:03 INFO - 'XPC_SERVICE_NAME': '0', 04:07:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:05 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:07:05 INFO - Installing collected packages: mozsystemmonitor 04:07:05 INFO - Running setup.py install for mozsystemmonitor 04:07:05 INFO - Successfully installed mozsystemmonitor 04:07:05 INFO - Cleaning up... 04:07:06 INFO - Return code: 0 04:07:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:07:06 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:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:06 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:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:06 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 0x10236ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10237b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9682c51280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10220ae00>, '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 0x102073db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102205b20>, '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.5L7kseQoA9/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.C3M6fPispO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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:07:06 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:07:06 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:07:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5L7kseQoA9/Render', 04:07:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:06 INFO - 'HOME': '/Users/cltbld', 04:07:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:06 INFO - 'LOGNAME': 'cltbld', 04:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:06 INFO - 'MOZ_NO_REMOTE': '1', 04:07:06 INFO - 'NO_EM_RESTART': '1', 04:07:06 INFO - 'PAGER': '/bin/cat', 04:07:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:06 INFO - 'PWD': '/builds/slave/test', 04:07:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:06 INFO - 'SHELL': '/bin/bash', 04:07:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C3M6fPispO/Listeners', 04:07:06 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 04:07:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:06 INFO - 'USER': 'cltbld', 04:07:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:06 INFO - 'XPC_FLAGS': '0x0', 04:07:06 INFO - 'XPC_SERVICE_NAME': '0', 04:07:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:07:06 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:07:06 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:07:06 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:07:06 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:07:06 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:07:06 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:07:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:08 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:07:08 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:07:08 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:07:08 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:07:08 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:07:08 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:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:07:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 INFO - Downloading docopt-0.6.1.tar.gz 04:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:10 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:10 INFO - Running setup.py install for blobuploader 04:07:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:07:10 INFO - Running setup.py install for requests 04:07:10 INFO - Running setup.py install for docopt 04:07:10 INFO - Successfully installed blobuploader requests docopt 04:07:10 INFO - Cleaning up... 04:07:10 INFO - Return code: 0 04:07:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07: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:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07: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:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:10 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 0x10236ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10237b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9682c51280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10220ae00>, '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 0x102073db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102205b20>, '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.5L7kseQoA9/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.C3M6fPispO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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:07:10 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:07:10 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:07:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5L7kseQoA9/Render', 04:07:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:10 INFO - 'HOME': '/Users/cltbld', 04:07:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:10 INFO - 'LOGNAME': 'cltbld', 04:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:10 INFO - 'MOZ_NO_REMOTE': '1', 04:07:10 INFO - 'NO_EM_RESTART': '1', 04:07:10 INFO - 'PAGER': '/bin/cat', 04:07:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:10 INFO - 'PWD': '/builds/slave/test', 04:07:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:10 INFO - 'SHELL': '/bin/bash', 04:07:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C3M6fPispO/Listeners', 04:07:10 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 04:07:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:10 INFO - 'USER': 'cltbld', 04:07:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:10 INFO - 'XPC_FLAGS': '0x0', 04:07:10 INFO - 'XPC_SERVICE_NAME': '0', 04:07:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:11 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Nw93vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:11 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Gxuy4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:11 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-7Q25VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:11 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-XMI4Tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:11 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Ub7FqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:11 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ifA3jX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:11 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-TKw5Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:11 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Lw3uuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:11 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-68zLCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:12 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-b0Sn8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:12 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-smfltE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:12 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Or2lXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:12 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-uaOgBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:12 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ws2hyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:12 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-jT2LLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:12 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Aewmju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:12 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-OhAsF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:12 INFO - Running setup.py install for manifestparser 04:07:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:07:13 INFO - Running setup.py install for mozcrash 04:07:13 INFO - Running setup.py install for mozdebug 04:07:13 INFO - Running setup.py install for mozdevice 04:07:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:07:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:07:13 INFO - Running setup.py install for mozfile 04:07:13 INFO - Running setup.py install for mozhttpd 04:07:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:07:13 INFO - Running setup.py install for mozinfo 04:07:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:07:13 INFO - Running setup.py install for mozInstall 04:07:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Running setup.py install for mozleak 04:07:14 INFO - Running setup.py install for mozlog 04:07:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Running setup.py install for moznetwork 04:07:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Running setup.py install for mozprocess 04:07:14 INFO - Running setup.py install for mozprofile 04:07:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Running setup.py install for mozrunner 04:07:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:07:15 INFO - Running setup.py install for mozscreenshot 04:07:15 INFO - Running setup.py install for moztest 04:07:15 INFO - Running setup.py install for mozversion 04:07:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:07:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:15 INFO - Cleaning up... 04:07:15 INFO - Return code: 0 04:07:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:15 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 0x10236ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10237b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9682c51280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10220ae00>, '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 0x102073db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102205b20>, '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.5L7kseQoA9/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.C3M6fPispO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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:07:15 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:07:15 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:07:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5L7kseQoA9/Render', 04:07:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:15 INFO - 'HOME': '/Users/cltbld', 04:07:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:15 INFO - 'LOGNAME': 'cltbld', 04:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:15 INFO - 'MOZ_NO_REMOTE': '1', 04:07:15 INFO - 'NO_EM_RESTART': '1', 04:07:15 INFO - 'PAGER': '/bin/cat', 04:07:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:15 INFO - 'PWD': '/builds/slave/test', 04:07:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:15 INFO - 'SHELL': '/bin/bash', 04:07:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C3M6fPispO/Listeners', 04:07:15 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 04:07:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:15 INFO - 'USER': 'cltbld', 04:07:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:15 INFO - 'XPC_FLAGS': '0x0', 04:07:15 INFO - 'XPC_SERVICE_NAME': '0', 04:07:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-imV2oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:15 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:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-wCJRo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:15 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:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-coMso1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-OSPqJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-61kbPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-XWw5gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-zOjACr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-nFHTlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-h2Ynho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-fWXszC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-jRhyLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ZwOn05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:17 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-eMI_M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:17 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-mMW7d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:17 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-BaRmdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:17 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-8pPjQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:17 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-noaT3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:17 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:07:17 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:07:17 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:07:17 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:07:17 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:07:17 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:07:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:07: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:07: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:07: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:07: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:07: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:07: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:07:19 INFO - Downloading blessings-1.6.tar.gz 04:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:20 INFO - Installing collected packages: blessings 04:07:20 INFO - Running setup.py install for blessings 04:07:20 INFO - Successfully installed blessings 04:07:20 INFO - Cleaning up... 04:07:20 INFO - Return code: 0 04:07:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:20 INFO - Reading from file tmpfile_stdout 04:07:20 INFO - Current package versions: 04:07:20 INFO - blessings == 1.6 04:07:20 INFO - blobuploader == 1.2.4 04:07:20 INFO - docopt == 0.6.1 04:07:20 INFO - manifestparser == 1.1 04:07:20 INFO - mozInstall == 1.12 04:07:20 INFO - mozcrash == 0.17 04:07:20 INFO - mozdebug == 0.1 04:07:20 INFO - mozdevice == 0.48 04:07:20 INFO - mozfile == 1.2 04:07:20 INFO - mozhttpd == 0.7 04:07:20 INFO - mozinfo == 0.9 04:07:20 INFO - mozleak == 0.1 04:07:20 INFO - mozlog == 3.1 04:07:20 INFO - moznetwork == 0.27 04:07:20 INFO - mozprocess == 0.22 04:07:20 INFO - mozprofile == 0.28 04:07:20 INFO - mozrunner == 6.11 04:07:20 INFO - mozscreenshot == 0.1 04:07:20 INFO - mozsystemmonitor == 0.0 04:07:20 INFO - moztest == 0.7 04:07:20 INFO - mozversion == 1.4 04:07:20 INFO - psutil == 3.1.1 04:07:20 INFO - requests == 1.2.3 04:07:20 INFO - wsgiref == 0.1.2 04:07:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:20 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:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:21 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 0x10236ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10237b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9682c51280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10220ae00>, '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 0x102073db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102205b20>, '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.5L7kseQoA9/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.C3M6fPispO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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:07:21 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:07:21 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:07:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5L7kseQoA9/Render', 04:07:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:21 INFO - 'HOME': '/Users/cltbld', 04:07:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:21 INFO - 'LOGNAME': 'cltbld', 04:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:21 INFO - 'MOZ_NO_REMOTE': '1', 04:07:21 INFO - 'NO_EM_RESTART': '1', 04:07:21 INFO - 'PAGER': '/bin/cat', 04:07:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:21 INFO - 'PWD': '/builds/slave/test', 04:07:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:21 INFO - 'SHELL': '/bin/bash', 04:07:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C3M6fPispO/Listeners', 04:07:21 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 04:07:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:21 INFO - 'USER': 'cltbld', 04:07:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:21 INFO - 'XPC_FLAGS': '0x0', 04:07:21 INFO - 'XPC_SERVICE_NAME': '0', 04:07:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:21 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:07:21 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:07:21 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:07:21 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:07:21 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:07:21 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:07:21 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:07:21 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:07:21 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:07:21 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:07:21 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:07:21 INFO - Cleaning up... 04:07:21 INFO - Return code: 0 04:07:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10236ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10237b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9682c51280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10220ae00>, '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 0x102073db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102205b20>, '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.5L7kseQoA9/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.C3M6fPispO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:07:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5L7kseQoA9/Render', 04:07:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:21 INFO - 'HOME': '/Users/cltbld', 04:07:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:21 INFO - 'LOGNAME': 'cltbld', 04:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:21 INFO - 'MOZ_NO_REMOTE': '1', 04:07:21 INFO - 'NO_EM_RESTART': '1', 04:07:21 INFO - 'PAGER': '/bin/cat', 04:07:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:21 INFO - 'PWD': '/builds/slave/test', 04:07:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:21 INFO - 'SHELL': '/bin/bash', 04:07:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C3M6fPispO/Listeners', 04:07:21 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 04:07:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:21 INFO - 'USER': 'cltbld', 04:07:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:21 INFO - 'XPC_FLAGS': '0x0', 04:07:21 INFO - 'XPC_SERVICE_NAME': '0', 04:07:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:21 INFO - Downloading/unpacking jsonschema 04:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:24 INFO - Downloading/unpacking functools32 (from jsonschema) 04:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:24 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:25 INFO - warning: no files found matching '*.txt' 04:07:25 INFO - no previously-included directories found matching 'build' 04:07:25 INFO - no previously-included directories found matching 'dist' 04:07:25 INFO - no previously-included directories found matching '.git*' 04:07:25 INFO - Installing collected packages: jsonschema, functools32 04:07:25 INFO - Running setup.py install for functools32 04:07:25 INFO - warning: no files found matching '*.txt' 04:07:25 INFO - no previously-included directories found matching 'build' 04:07:25 INFO - no previously-included directories found matching 'dist' 04:07:25 INFO - no previously-included directories found matching '.git*' 04:07:25 INFO - Successfully installed jsonschema functools32 04:07:25 INFO - Cleaning up... 04:07:25 INFO - Return code: 0 04:07:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10236ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10237b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9682c51280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10220ae00>, '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 0x102073db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102205b20>, '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.5L7kseQoA9/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.C3M6fPispO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:07:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5L7kseQoA9/Render', 04:07:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:25 INFO - 'HOME': '/Users/cltbld', 04:07:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:25 INFO - 'LOGNAME': 'cltbld', 04:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:25 INFO - 'MOZ_NO_REMOTE': '1', 04:07:25 INFO - 'NO_EM_RESTART': '1', 04:07:25 INFO - 'PAGER': '/bin/cat', 04:07:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:25 INFO - 'PWD': '/builds/slave/test', 04:07:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:25 INFO - 'SHELL': '/bin/bash', 04:07:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C3M6fPispO/Listeners', 04:07:25 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 04:07:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:25 INFO - 'USER': 'cltbld', 04:07:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:25 INFO - 'XPC_FLAGS': '0x0', 04:07:25 INFO - 'XPC_SERVICE_NAME': '0', 04:07:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:25 INFO - Downloading/unpacking flake8 04:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:07:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:07:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:07:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:29 INFO - no previously-included directories found matching 'docs/_build' 04:07:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:07:29 INFO - Running setup.py install for pep8 04:07:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:29 INFO - no previously-included directories found matching 'docs/_build' 04:07:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:07:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:07:29 INFO - Cleaning up... 04:07:29 INFO - Return code: 0 04:07:29 INFO - Running post-action listener: _resource_record_post_action 04:07:29 INFO - Running post-action listener: _start_resource_monitoring 04:07:29 INFO - Starting resource monitoring. 04:07:29 INFO - ##### 04:07:29 INFO - ##### Running install step. 04:07:29 INFO - ##### 04:07:29 INFO - Running pre-action listener: _resource_record_pre_action 04:07:29 INFO - Running main action method: install 04:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:29 INFO - Reading from file tmpfile_stdout 04:07:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:30 INFO - Reading from file tmpfile_stdout 04:07:30 INFO - Output received: 04:07:30 INFO - Usage: mozinstall [options] installer 04:07:30 INFO - Options: 04:07:30 INFO - -h, --help show this help message and exit 04:07:30 INFO - -d DEST, --destination=DEST 04:07:30 INFO - Directory to install application into. [default: 04:07:30 INFO - "/builds/slave/test"] 04:07:30 INFO - --app=APP Application being installed. [default: firefox] 04:07:30 INFO - mkdir: /builds/slave/test/build/application 04:07:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:07:51 INFO - Reading from file tmpfile_stdout 04:07:51 INFO - Output received: 04:07:51 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:07:51 INFO - Running post-action listener: _resource_record_post_action 04:07:51 INFO - ##### 04:07:51 INFO - ##### Running run-tests step. 04:07:51 INFO - ##### 04:07:51 INFO - Running pre-action listener: _resource_record_pre_action 04:07:51 INFO - Running main action method: run_tests 04:07:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:07:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:07:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:07:51 INFO - 2016-07-07 04:07:51.990 screenresolution[1907:9305] starting screenresolution argv=screenresolution get 04:07:51 INFO - 2016-07-07 04:07:51.992 screenresolution[1907:9305] Display 0: 1600x1200x32@60 04:07:51 INFO - 2016-07-07 04:07:51.998 screenresolution[1908:9307] starting screenresolution argv=screenresolution list 04:07:52 INFO - Available Modes on Display 0 04:07:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:07:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:07:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:07:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:07:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:07:52 INFO - Intel Iris: 04:07:52 INFO - Chipset Model: Intel Iris 04:07:52 INFO - Type: GPU 04:07:52 INFO - Bus: Built-In 04:07:52 INFO - VRAM (Dynamic, Max): 1536 MB 04:07:52 INFO - Vendor: Intel (0x8086) 04:07:52 INFO - Device ID: 0x0a2e 04:07:52 INFO - Revision ID: 0x0009 04:07:52 INFO - Displays: 04:07:52 INFO - Display: 04:07:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:07:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:07:52 INFO - Display Serial Number: 1600x1200 60 04:07:52 INFO - Main Display: Yes 04:07:52 INFO - Mirror: Off 04:07:52 INFO - Online: Yes 04:07:52 INFO - Rotation: Supported 04:07:52 INFO - Return code: 0 04:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:52 INFO - Python 2.7.3 04:07:52 INFO - Return code: 0 04:07:52 INFO - grabbing minidump binary from tooltool 04:07: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:07: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 0x10220ae00>, '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 0x102073db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102205b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07: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:07: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:07:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:52 INFO - Return code: 0 04:07:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:07:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:07:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:07:53 INFO - Return code: 0 04:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0072 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:07:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5L7kseQoA9/Render', 04:07:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:53 INFO - 'HOME': '/Users/cltbld', 04:07:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:53 INFO - 'LOGNAME': 'cltbld', 04:07:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:53 INFO - 'MOZ_NO_REMOTE': '1', 04:07:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:53 INFO - 'NO_EM_RESTART': '1', 04:07:53 INFO - 'PAGER': '/bin/cat', 04:07:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:53 INFO - 'PWD': '/builds/slave/test', 04:07:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:53 INFO - 'SHELL': '/bin/bash', 04:07:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C3M6fPispO/Listeners', 04:07:53 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 04:07:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:53 INFO - 'USER': 'cltbld', 04:07:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:53 INFO - 'XPC_FLAGS': '0x0', 04:07:53 INFO - 'XPC_SERVICE_NAME': '0', 04:07:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:07:53 INFO - mozversion application_buildid: 20160706215822 04:07:53 INFO - mozversion application_changeset: d142c49033c015f67272562b37dbe2912cfc7f14 04:07:53 INFO - mozversion application_display_name: Firefox 04:07:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:53 INFO - mozversion application_name: Firefox 04:07:53 INFO - mozversion application_remotingname: firefox 04:07:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:07:53 INFO - mozversion application_vendor: Mozilla 04:07:53 INFO - mozversion application_version: 48.0 04:07:53 INFO - mozversion platform_buildid: 20160706215822 04:07:53 INFO - mozversion platform_changeset: d142c49033c015f67272562b37dbe2912cfc7f14 04:07:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:07:53 INFO - mozversion platform_version: 48.0 04:07:53 INFO - using testdate: 1467889673 04:07:53 INFO - actual date: 1467889673 04:07:53 INFO - starting webserver on 'localhost:49462' 04:07:53 INFO - SUITE-START | Running 2 tests 04:07:53 INFO - TEST-START | dromaeo_css 04:07:53 INFO - operating with platform_type : mac_ 04:07:53 INFO - Initialising browser for dromaeo_css test... 04:07:53 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpW_XA65/profile http://localhost:49462/getInfo.html) 04:07:55 INFO - PROCESS | 1926 | __metrics Screen width/height:1600/1200 04:07:55 INFO - PROCESS | 1926 | colorDepth:24 04:07:55 INFO - PROCESS | 1926 | Browser inner width/height: 1024/689 04:07:55 INFO - PROCESS | 1926 | __metrics 04:07:55 INFO - PROCESS | 1926 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:07:55 ERROR - PROCESS | 1926 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:07:56 INFO - TEST-INFO | 1926: exit 0 04:07:56 INFO - Browser initialized. 04:07:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:07:56 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpW_XA65/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:08 INFO - PROCESS | 1929 | RSS: Main: 161894400 04:08:08 INFO - PROCESS | 1929 | 04:08:59 INFO - PROCESS | 1929 | 1467889739406 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:11:09 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49462/tests/dromaeo/cssquery-ext.html) 04:11:10 INFO - PROCESS | 1929 | RSS: Main: 277200896 04:11:10 INFO - PROCESS | 1929 | 04:14:13 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-ext.html (next: http://localhost:49462/tests/dromaeo/cssquery-jquery.html) 04:14:13 INFO - PROCESS | 1929 | RSS: Main: 305958912 04:14:13 INFO - PROCESS | 1929 | 04:17:16 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49462/tests/dromaeo/cssquery-mootools.html) 04:17:16 INFO - PROCESS | 1929 | RSS: Main: 307318784 04:17:16 INFO - PROCESS | 1929 | 04:20:18 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49462/tests/dromaeo/cssquery-prototype.html) 04:20:19 INFO - PROCESS | 1929 | RSS: Main: 302747648 04:20:19 INFO - PROCESS | 1929 | 04:23:22 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49462/tests/dromaeo/cssquery-yui.html) 04:23:22 INFO - PROCESS | 1929 | RSS: Main: 273735680 04:23:22 INFO - PROCESS | 1929 | 04:26:25 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-yui.html (next: http://localhost:49462/tests/dromaeo/cssquery-dojo.html) 04:26:25 INFO - PROCESS | 1929 | RSS: Main: 352952320 04:26:25 INFO - PROCESS | 1929 | 04:26:25 INFO - PROCESS | 1929 | __start_tp_report 04:26:25 INFO - PROCESS | 1929 | _x_x_mozilla_page_load 04:26:25 INFO - PROCESS | 1929 | _x_x_mozilla_page_load_details 04:26:25 INFO - PROCESS | 1929 | |i|pagename|runs| 04:26:25 INFO - PROCESS | 1929 | |0;dojo.html;3481.0949153220163;3510.1751088494216;3518.6833185013343;3526.7531272810916;3627.9818600906992;5885.617434866731;5888.558358123137;5915.260592425947;5927.2590926134235;5964.79123230687;5882.000059989801;5985.5810093293485;5994.0709190075495;5994.790182343619;6003.189569408129;5197.1424714922;5262.368515778103;5273.57811375091;5348.91976620349;5412.783488660449;5271.051210782058;5371.57027437804;5374.408815030343;5383.4616538346045;5385;5285.339332583427;5326.946730532703;5335.653182543142;5346;5349.3045904032615;5375.892482150374;5376.435474275184;5382.273393091921;5390.434004429518;5400.864978375533;5145.434002259748;5232.581393488512;5296.364436267634;5307.336582927134;5320.308359913225;5705.2012718219485;5716.085426331809;5732.971335143297;5748.396418376052;5802.680852553108;6240.968795155995;6273.7176827042895;6276.874462510724;6283.622982621012;6288.465480434169;6195.44241018306;6197.504199664016;6326.082718005863;6343.873122537523;6577.309382514815;5802.477777000048;5819.418058194189;5824.912626310609;5848.064309710426;6044.455998960115;6405.583637063576;6442.452391546677;6444.806655800334;6447.323031081763;6452.419282264619;6178.382161783786;6184.103305020837;6275.184226050585;6277.52918531112;6318.526110541636;6244.718987645567;6317.684115794192;6332.620042797447;6332.810015699536;6363;6234.0337247726675;6293.087502312139;6294.559380843297;6303.149074874833;6331.841703957346;5369.731513424391;6116.914073580098;6267.122602835607;6285.465735412449;6300.401461861115;5051.393832740095;5058.215976523645;5087.618428617869;5092.949070509321;5094.796208151706;4445.044315472189;4513.277875539963;4520.299353600197;4584.083183363341;4612.331211974245;5838.9124163137585;5860.765569377178;6107.29766076898;6108.7861924833305;6119.877602447926;6215.378462153749;6232.3144454110015;6309;6313.210848643919;6330.208723909512;6006.879862402728;6049;6119.746288422706;6122.448979591858;6134.78528251509;5557.77768889248;5561.165825126263;5562;5570.888582228333;5577.44225577439;6395.328490508429;6485.837854053686;6547.770828020996;6593.241777195588;6620.238672552622;6289.779857704958;6315.905261421174;6321.146645203023;6334.619922804646;6352.872942541216;6561.507886908405;6578.605283682994;6586;6587.835304117435;6596.637184954873;6174.876502470015;6217;6255.280642725963;6319.526035547445;6338.90491642635;6222.533310001678;6239.875202495834;6303.936960630335;6307.053941908567;6316.3367846377305;6232.439080482778;6295.18162638854;6309.432151106423;6321.747130114928;6330.746770129143;6263.749450021948;6307.369263073656;6316.905246421215;6325.019621958604;6338.239411270677;4575.062112267044;6069.666168360783;6109.602875813058;6186.845328866814;6200.720967556561;6229.968850155901;6234.470070043915;6237.064440333987;6253.687315634109;6280.434760871361;5977.820665380045;6163.229596300463;6230.221222347207;6231.158793562811;6244.188255526934 04:26:25 INFO - PROCESS | 1929 | |1;ext.html;531.4711861697612;546.3362015151592;569.4647031790116;580.1327016110915;618.8916939535583;32711.67288327116;33190.50214246785;39381.40927886084;39572.604273957215;40501.79749101258;45151.64545063653;45209;45331.86670333243;45348.319775203396;45369.77315113428;9902.108810207097;10086.344387614818;10087.142592879614;10112.241581881352;10113;9206;9408.341416100875;9427.198688111484;11892.989095926856;12216.511339546407;11774.823377649342;11837.704057398549;11928.642140735792;11936.582219622314;11938.224015439013;11908.880911190863;11982.340971246578;11991.04071674264;12004.159708820385;12022.51909923602;11733.296002239893;11835.822462663067;11865.881341186563;11867.406629668569;11874.762504749942;41861.58138418607;42551.361729574084;42597.935051623645;42629;42645.57354426447;2882.855857207131;3309.8179600121985;3335.6497567755277;3722.981385093084;3806.915029216688;28121.57817632737;28669.996550120853;30214.54678179829;30471;30598.84700576483;2808.8595570221405;2820.591014302935;2841.7300356466103;2851.9714802852122;2872.6840047594746;491868.540657298;497231;498561.53596160025;498967;499581;37728.24543509114;64035;65831;65995;66146.33853661497;35990.820045900124;36081.27837443237;36089.819550902605;36198.095047623494;36233;16148.919255403647;16412.83587164137;16434.260458279405;16440.917795410947;16451.095189764677;13017.088803783645;14334.856651433352;14384.136951782926;14386.35261413239;14392.784108238386;8026;8455.069942306342;8556.657733690583;8611;8629.43908645936;3499.632538583463;3568.018794831442;3568.803715795604;3568.964310356915;3592.2456284180093;1030.3302853145515;1051.7212938571286;1065.738893970982;1164.4643464006483;1170.8126699728002;29948.251293717833;30067.94762183313;30485.542716859265;30610.092041256044;31760.419355478927;1169.5964892112208;1181.149572307937;1191.7199458127334;1203.7171264752776;1282.6985658370274;15989.440369587008;16047.438339658056;16188.271527781279;16359.100249486393;16489.422870199727;637032;740883;746907;748017;751092;61714;61748;62595.6870215646;62684;62946.37053629405;1404.4241860837212;1465.2234315812636;1537.2390666620095;1563.8123425188824;1578.7710781936785;29580;30438.695613043586;30499.93250236231;30770.384592308477;30890.53664195084;51703.74148129386;52381.7380913093;52443.73778131085;52480;52544;402790;414445;418525;419724;420308;25290.494190116464;28412;29004.12987610375;44055;45793.77103114463;44911.32633010442;45204.77397612991;45321.64035078953;45398.54601453943;45637.77181114206;36062.91811245667;36543.63456365402;37026.6297337034;37120.814395927846;37348.43977340397;36984.07539811418;37103.217258706245;37433.62566374301;37490;37709.622903770614;36091.27817443689;38019.85940421792;38023;39021.21957560776;39317;33245.667543325224;33808.49287260644;34212;34418.82790586031;34510;23762.93066811963;24016.87991560031;24248.1513147039;24458.877705611358;24503.264902052968 04:26:25 INFO - PROCESS | 1929 | |2;jquery.html;399.4866596423594;418.5646927195716;420.09469593027;422.2715815218746;432.75333060155725;20495.385138445832;21011.36965891026;21257.236559247314;21961.341159765234;22665.52674076188;22317.10731570739;22347.55304893901;22520.887395563;22634.54730905381;22658.88670556645;5800.419958004208;6065.514758819284;6131.785387511438;6135.693215339237;6148.231471066117;4486.955130448703;4676.69601475903;6049.395060493959;6135.570510064297;6438.3883531064475;6671.232808227068;6678.76624318149;6683.264840867525;6685.598864068147;6686.699098540577;6380.042993550958;6553.115329430538;6564.901526477107;6569.80290591283;6580.769673061443;4030.9395359069636;5576.386597474275;5777.740001699934;5782.10377391505;5847.210626565402;26062.739372606222;26163.476730465285;26504;26571.335716607045;26607.600885986725;2212.4358288636454;2246.539459410817;2545.325488745484;2859.170840456265;2897.797154199207;14572.489962851248;15119.319630616648;15563.22183890801;15747;15768.684626307524;1725.9137043147791;1789.5436663650817;1812.6737187306412;1822.9088545572802;1836.219606667161;115144.84855151425;115248.84751152465;115934;116210.41894790556;117072;9550.418593027614;11290.04034657047;11594.88405115955;11775.17573769845;11855.881441185651;13505;14855.925720371546;14918.328675209641;14978.925105374403;14988.700225995419;8520.70177543783;9247.491387973592;9294.209992150743;9310.301727370474;9394.107559781809;9470.479123648265;9479.099485548863;9498.857517137249;9594.42433453995;9600.615975361046;6361.823062733409;6475.222973243241;7045.753398631024;7079;7085.751998680124;1800.1278670182862;1832.7891048104566;1921.5868588253593;1941.9708704369446;1963.1460314762837;874.9212570868652;940.5109343141528;1015.5886865819207;1051.5846240734868;1112.2881355932209;19882.50293742668;21643;21714.674279885814;21776.782232177793;21778.782212177994;920.3189639666732;1049.7008352619466;1063.0910571461443;1106.5352551928208;1130.2766229613055;11278.210525263154;11686.065114790796;11699.415029248674;11726.94136529312;11849.940750296193;567064;613489;614165;622732;644094;67931.66034169798;111479.44260278808;117406.41296793461;117755;122625;978.3054031637618;1078.2075174746556;1102.239454776202;1120.0647459371353;1123.253036730565;16541.58646033859;18783;19621.70567441461;19832.70250946266;19994.60010799805;46863.06273874435;47601.285980709625;48047.75976120097;49097.50902490929;51583.742081289354;63775;67274.66362668155;68207.65896170487;69175.65412172907;70560;8165.2243036911395;8257.256846883569;8554.443961142506;8576.871346929676;8785.341099417441;11953.22304050234;13131.803022954473;13274.535391261259;13549.458021679022;13586.86413135856;10560.735981600214;11069.893010698866;11311.830322545333;11397.544098235978;11717.824232636687;9584.472853993097;10913.508892099715;11132.220744548127;11279.718007049889;11650.76698466009;11276.94361528187;11715.355655439032;11748.177627565989;11907.880921191023;12059.457324420247;8401;8499.95750021246;8661.220490155916;8669.91330086691;8880.51157186361;10846.837297440703;11273.7745245093;11458.968692817687;11629.011534019703;11787.174897757075 04:26:25 INFO - PROCESS | 1929 | |3;mootools.html;1326.6882282663578;1651.05064587862;1679.0177746018578;1953.199188332783;2019.838412926965;8393.034800997888;9120.087991200877;9237.630494780218;9239.907600923989;9260.120288572574;8845.955770221157;9122.452652840817;9123.863142052858;9132.360734748554;9141.222996045344;2565.063751730619;2585.069375024999;2586.314626623946;2586.6508021417058;2586.7283935186815;2510.3975045988923;2583.1992082454403;2586.4180559374086;2587.2626301504074;2588.754068363512;2542.8982840686444;2551.6937967443932;2593.1572239022394;2597.142942828862;2604.93487662809;2538.4796116796106;2566.7048289446766;2573.74262573743;2591.6630837990942;2597.181887705367;2536.1757428835704;2560.7951363890843;2576.871156442189;2584.78029367504;2590.2747230775412;8908;9362.625494980193;9379.484128372937;9401.905980940172;9404.341696081277;5738.024535828919;5853.385394533555;5917.52659787216;5935.940640593625;5949.464548190684;3608.2061946371755;3680.8527658893613;3700.2414505026672;3716.2753263113705;3752.7935963521995;883.3021912688968;923.4736200365794;1088.0968795899385;1090.0407641275706;1101.7631209290041;12212.877871221352;12386.318752468611;12415.130940834146;12424.254544727255;12446.688832779162;4272.700910936267;4714.622830173578;4795.544423279783;4811.542903424169;4902.803887844446;9709.854352184722;9723.659671911591;9724.367916085432;9726.562304696306;9733.951330243444;5638.436156384329;5659.8019069333195;5701;5704.800331988444;5738.5982981191755;4781.2350023996;4877.804887804519;5153.123968925292;5225.6603320784025;5355.973220133875;3999.7600143991453;4015.7551159140176;4085.7957102144774;4108.137291168888;4128.091819799639;1276.3618190904547;1282.0192552697195;1288.8968882489378;1296.2093123195032;1307.8229593366048;957.7414098193589;1000.2797985450464;1002.0560113380019;1012.6101450941441;1017.7913527726798;6062.9090563641585;6189.133521307021;6197.03945888388;6225.875482490324;6275.090111933744;492.38206051405257;498.5164390541169;500.07735727582553;512;512.2188662290038;3995.9400608990886;4054.959450405458;4082.1631565529588;4097.631213190767;4120.835166593302;11185.161112916563;11755.353455559854;11768.705782355339;11768.88231117695;11780.234284771463;11422;11444.02725768319;11546.422678866023;11550.59572914944;11552.6534203974;8708.43395179324;8800.383973121949;8834.734957951272;8837.381383303236;8873.467591944504;4495.52796956328;5628;6037.279375377996;6038.788642397495;6060.8782883407675;10124.443155626512;10214.285000050222;10360.274780765274;10379.273450858367;10406.635767748092;8858.822823543363;10076.19390448777;10654.89345106539;10663.46682665879;10836.403997780199;6631.568948018364;6805.2854450283985;6812.523123381316;7380.372668323038;7455.888161677471;7831.647575858986;8686.435381700168;8717.956410217908;8729.869051964099;8736.650533978824;6546.705398256994;7541.962290188514;7639.541627502367;7678.385729141543;7758.301752842045;7487.925120748723;7528.774136775905;7536.434767392577;7598.316151546387;7659.846803064019;7213.242609525924;7277.781666550012;7285.635718213962;7319.817004574928;7368.189499155196;4976.701397916137;4983.426905905722;5101.744912754273;5152.072626927189;5192.299039629753;5070.6957582545165;5112.693238405707;5139.357580302462;5204.843854684365;5372.409035006068 04:26:25 INFO - PROCESS | 1929 | |4;prototype.html;324.207313119423;336.85515228451754;343.6048544174199;347.12870694556653;347.45623099848734;6596.307387724291;6611.867762644744;6705.128333316668;6722.058911752359;6723.562968407063;6619.271880093186;6644.069830223772;6645.169353830771;6663.167104111986;6673.332666733337;4704.294355846616;4813;4842.322074909498;4848.854534363974;4851.878703032417;4802.471728109905;4867.610591152717;4897.432821497122;4946.629002824802;4956.87607809804;3922.4900762900784;3923.391874259494;4768.570828625423;4848.200046992242;4856.878578035559;4837.0567739290855;4838.854834354975;4851.151048566487;4851.708897466164;4886.853394398174;4030.2745505808944;4057.8579749708915;4094.959050409517;4105.035316700573;4125.711200215986;6326.715297811564;6454.580452270588;6466.0300954856675;6476.963685810295;6481.93518064818;5882.529397648221;5892.292924849003;5897.469227769521;5898.675572843492;5900.498457631106;5744.827655170351;7111.075560177195;7141.964290178568;7144.428445724329;7165.534240274417;4434.334849772527;4750;4751.596114330286;4751.95248047522;4766.38037055184;7462.10454745434;7519.887201692034;7572.280633339824;7602.695892164307;7623.085229772408;3864.53625564934;4109.458952892665;4698.083873644675;4724.244120940702;4730.219513780187;4809.711417314972;4812.759362031885;4822.807087716452;4832.95167048332;4840.685355451885;5739.62692424991;5754.683492407958;5757.395473475309;5757.568182386338;5764.682942438122;5785.305763308345;6288.339724328971;7081.92918070823;7177.569345839266;7178.353948144692;1351;1645.0623144807346;1658.4195531563855;1662.3433743671183;1668.4327328708298;899.6941040046415;1025.8102251083574;1030.1449796668746;1043.8903915088958;1057.9206559508068;6714.563553369016;6715.664216789239;6717.193936727624;6731.091302674175;6734.326567343324;7124.109486314211;7350.117985841626;7353.522021068614;7450.96274518624;7466.887996680054;6574.3754343337305;6632.137822083098;6636.601803891782;6642.66786660665;6798.830029249309;3921.8039098044983;3951.031997160714;3961.1285517186175;3967.2263908538134;3974.4435778990965;7898.960505197438;7904.0910295315625;7904.644291006918;7914.722984695623;7930.365570754326;7399.149097853816;7640.044994375703;7742.7677169685;7749.108852481924;7758.301752842159;7849.4897831640765;7906.802329941683;7909.288164065031;7920.920790792134;7921.564313962672;6562.278149403466;6952.44380449573;7456.979923131141;7472.514286571355;7483.401327893646;7314.670839812327;7328.743493977899;7331.890021649786;7333.596652184181;7343.302386273295;7544.4341674373545;7862.2923936845955;7927.682892684228;7938.880916786368;7962.84074318522;4657.394538709946;4749.121412538691;4753.215719406259;4753.976230118966;4757;7424.962875185805;7427.665755040928;7432.702691892264;7436.479446438698;7438.293362130589;6989.30106989297;7231.927680723125;7233.674484648098;7247.057882475245;7266.927330726625;6013.737115205856;7169.964150179216;7190.7483238086415;7210;7210.747623833141;5612.494875461228;6868.278830722702;6889.448844092361;7065.046218760402;7073.292670732885;7211.891821622575;7227.205007449282;7233.240509746401;7241.312075352833;7251.057362542836;6757.425618822259;7056.08270924797;7078.398336141279;7083.433325334064;7093.964530177316 04:26:25 INFO - PROCESS | 1929 | |5;yui.html;723.5080145501059;748.4910261022505;765.4947734495234;783.5024759277857;805.3798575097176;15142;15448.613784655388;15487.690246195083;15562.688746225069;15565.688686226269;14128.505502307422;14307.141571505717;14307.284635768223;14316.642083947907;14399.496017639385;788.9092754333253;807.4872455990459;955.5652178258875;986.171615842692;993.9652112176075;884.8363052835214;913.9268858491305;972.7568107973007;981.4405788700443;985.2315194148575;831.1771346367113;1040.5161599856065;1043.2280112716574;1044.0081922173927;1044.4412239451894;1017.3743147964022;1034.7723500829804;1038.2161468091617;1038.761084950458;1039.8128336899356;743.84007438401;770.0220719685967;778.353966208046;780.4107898536625;781.945263831532;15448;15487.922560387238;15522.5343239703;15523.767143492856;15542.533723988185;13019.47922083125;13334.799978000337;13360;13418.53035143775;13670.794938075936;10308.536115874804;10397.896021039769;10497.055265026109;10710.785784284271;10911.181661375429;3591.497190393347;3670.853165873362;3688.8708895188806;3694.1503454205413;3704.85180592776;80542;81178.78231826528;82680.58659706663;82924.58537707334;83205.58397207975;10043.849342259871;10074.244431667654;10098.394096354243;10273.640422585173;10613.991670791262;22817.771822281564;23057.53884922292;23104.884475577514;23105.768942310697;23125.190618328277;7996.840063198703;8014.639341229658;8077.474964127313;8218.753437396888;8311.542865142475;4244.3209086546;4245.915081698348;4309.030468144642;4383.3863259143745;4508.985478267364;3854.2291541691775;3897.1036661567996;3908.4528166056775;3911.0808959894403;3914.825552334288;570.3099249907575;619.6994457688018;695.7947405515386;718.90294810201;736.823162441021;562.1230879827482;577.1342985521718;587.0401892905131;611.5571414411683;623.5666211982629;8037.196280371916;8122.5126492410645;8179.591020448954;8226.958865205635;8484;603.3785201242727;607.1651479216077;611.6691452936552;617.8856911471393;624.3257282135284;3318.900432987014;3695.74129810916;3828.9617103828605;3863.3046051710962;3893.8831835044994;90993.09006909978;92493.53753231191;93900.53049734708;94151.52924235472;94308;51613.741931290104;74596.13509662302;75236;76153.85769213467;77436;63999;64204;64479.67760161169;64650;65551.67224163849;8077.676892924217;8215.178482151738;8326.958365208135;8336.416450848383;8401.15988401155;47327.76336118297;50160;50460.49539504558;51010;51948.96102078013;50369.740756481384;65655.67172164109;67537.3246267531;68305;68629.2842678937;11048.116150707763;11175.832362514731;11427.085833133164;11482.94258528702;11540.82688759686;11846.111541634584;11949.044076473687;12029;12072.517099316281;12531.310777907303;11350.772984540097;11411.871129357722;11577.363245021605;11828.40857957116;11892.881071189177;8782.604782784918;11183.217174797686;11497.54009839597;11580.478878450658;11625.534978600761;10705.518251678848;11531.1351648625;11553.075753939833;11647.30116193031;11680.883191167979;9407.529623518934;9559.761005974906;9864.21086313079;9877.456739879375;10162.288639795144;7544.556330063094;8399.496030238206;9409.247260219303;9447;9641.27690423207 04:26:25 INFO - PROCESS | 1929 | __end_tp_report 04:26:25 INFO - PROCESS | 1929 | __start_cc_report 04:26:25 INFO - PROCESS | 1929 | _x_x_mozilla_cycle_collect,1043 04:26:25 INFO - PROCESS | 1929 | __end_cc_report 04:26:25 INFO - PROCESS | 1929 | __startTimestamp1467890785712__endTimestamp 04:26:25 INFO - PROCESS | 1929 | 04:26:25 INFO - PROCESS | 1929 | ------- Summary: start ------- 04:26:25 INFO - PROCESS | 1929 | Number of tests: 6 04:26:25 INFO - PROCESS | 1929 | 04:26:25 INFO - PROCESS | 1929 | [#0] dojo.html Cycles:165 Average:5878.82 Median:6174.88 stddev:645.54 (10.5%) stddev-sans-first:619.51 04:26:25 INFO - PROCESS | 1929 | Values: 3481.1 3510.2 3518.7 3526.8 3628.0 5885.6 5888.6 5915.3 5927.3 5964.8 5882.0 5985.6 5994.1 5994.8 6003.2 5197.1 5262.4 5273.6 5348.9 5412.8 5271.1 5371.6 5374.4 5383.5 5385.0 5285.3 5326.9 5335.7 5346.0 5349.3 5375.9 5376.4 5382.3 5390.4 5400.9 5145.4 5232.6 5296.4 5307.3 5320.3 5705.2 5716.1 5733.0 5748.4 5802.7 6241.0 6273.7 6276.9 6283.6 6288.5 6195.4 6197.5 6326.1 6343.9 6577.3 5802.5 5819.4 5824.9 5848.1 6044.5 6405.6 6442.5 6444.8 6447.3 6452.4 6178.4 6184.1 6275.2 6277.5 6318.5 6244.7 6317.7 6332.6 6332.8 6363.0 6234.0 6293.1 6294.6 6303.1 6331.8 5369.7 6116.9 6267.1 6285.5 6300.4 5051.4 5058.2 5087.6 5092.9 5094.8 4445.0 4513.3 4520.3 4584.1 4612.3 5838.9 5860.8 6107.3 6108.8 6119.9 6215.4 6232.3 6309.0 6313.2 6330.2 6006.9 6049.0 6119.7 6122.4 6134.8 5557.8 5561.2 5562.0 5570.9 5577.4 6395.3 6485.8 6547.8 6593.2 6620.2 6289.8 6315.9 6321.1 6334.6 6352.9 6561.5 6578.6 6586.0 6587.8 6596.6 6174.9 6217.0 6255.3 6319.5 6338.9 6222.5 6239.9 6303.9 6307.1 6316.3 6232.4 6295.2 6309.4 6321.7 6330.7 6263.7 6307.4 6316.9 6325.0 6338.2 4575.1 6069.7 6109.6 6186.8 6200.7 6230.0 6234.5 6237.1 6253.7 6280.4 5977.8 6163.2 6230.2 6231.2 6244.2 04:26:25 INFO - PROCESS | 1929 | 04:26:25 INFO - PROCESS | 1929 | [#1] ext.html Cycles:180 Average:67754.79 Median:3568.41 stddev:150604.58 (4220.5%) stddev-sans-first:150942.50 04:26:25 INFO - PROCESS | 1929 | Values: 531.5 546.3 569.5 580.1 618.9 32711.7 33190.5 39381.4 39572.6 40501.8 45151.6 45209.0 45331.9 45348.3 45369.8 9902.1 10086.3 10087.1 10112.2 10113.0 9206.0 9408.3 9427.2 11893.0 12216.5 11774.8 11837.7 11928.6 11936.6 11938.2 11908.9 11982.3 11991.0 12004.2 12022.5 11733.3 11835.8 11865.9 11867.4 11874.8 41861.6 42551.4 42597.9 42629.0 42645.6 2882.9 3309.8 3335.6 3723.0 3806.9 28121.6 28670.0 30214.5 30471.0 30598.8 2808.9 2820.6 2841.7 2852.0 2872.7 491868.5 497231.0 498561.5 498967.0 499581.0 37728.2 64035.0 65831.0 65995.0 66146.3 35990.8 36081.3 36089.8 36198.1 36233.0 16148.9 16412.8 16434.3 16440.9 16451.1 13017.1 14334.9 14384.1 14386.4 14392.8 8026.0 8455.1 8556.7 8611.0 8629.4 3499.6 3568.0 3568.8 3569.0 3592.2 1030.3 1051.7 1065.7 1164.5 1170.8 29948.3 30067.9 30485.5 30610.1 31760.4 1169.6 1181.1 1191.7 1203.7 1282.7 15989.4 16047.4 16188.3 16359.1 16489.4 637032.0 740883.0 746907.0 748017.0 751092.0 61714.0 61748.0 62595.7 62684.0 62946.4 1404.4 1465.2 1537.2 1563.8 1578.8 29580.0 30438.7 30499.9 30770.4 30890.5 51703.7 52381.7 52443.7 52480.0 52544.0 402790.0 414445.0 418525.0 419724.0 420308.0 25290.5 28412.0 29004.1 44055.0 45793.8 44911.3 45204.8 45321.6 45398.5 45637.8 36062.9 36543.6 37026.6 37120.8 37348.4 36984.1 37103.2 37433.6 37490.0 37709.6 36091.3 38019.9 38023.0 39021.2 39317.0 33245.7 33808.5 34212.0 34418.8 34510.0 23762.9 24016.9 24248.2 24458.9 24503.3 04:26:25 INFO - PROCESS | 1929 | 04:26:25 INFO - PROCESS | 1929 | [#2] jquery.html Cycles:180 Average:34905.80 Median:12383.71 stddev:101455.53 (819.3%) stddev-sans-first:101707.05 04:26:25 INFO - PROCESS | 1929 | Values: 399.5 418.6 420.1 422.3 432.8 20495.4 21011.4 21257.2 21961.3 22665.5 22317.1 22347.6 22520.9 22634.5 22658.9 5800.4 6065.5 6131.8 6135.7 6148.2 4487.0 4676.7 6049.4 6135.6 6438.4 6671.2 6678.8 6683.3 6685.6 6686.7 6380.0 6553.1 6564.9 6569.8 6580.8 4030.9 5576.4 5777.7 5782.1 5847.2 26062.7 26163.5 26504.0 26571.3 26607.6 2212.4 2246.5 2545.3 2859.2 2897.8 14572.5 15119.3 15563.2 15747.0 15768.7 1725.9 1789.5 1812.7 1822.9 1836.2 115144.8 115248.8 115934.0 116210.4 117072.0 9550.4 11290.0 11594.9 11775.2 11855.9 13505.0 14855.9 14918.3 14978.9 14988.7 8520.7 9247.5 9294.2 9310.3 9394.1 9470.5 9479.1 9498.9 9594.4 9600.6 6361.8 6475.2 7045.8 7079.0 7085.8 1800.1 1832.8 1921.6 1942.0 1963.1 874.9 940.5 1015.6 1051.6 1112.3 19882.5 21643.0 21714.7 21776.8 21778.8 920.3 1049.7 1063.1 1106.5 1130.3 11278.2 11686.1 11699.4 11726.9 11849.9 567064.0 613489.0 614165.0 622732.0 644094.0 67931.7 111479.4 117406.4 117755.0 122625.0 978.3 1078.2 1102.2 1120.1 1123.3 16541.6 18783.0 19621.7 19832.7 19994.6 46863.1 47601.3 48047.8 49097.5 51583.7 63775.0 67274.7 68207.7 69175.7 70560.0 8165.2 8257.3 8554.4 8576.9 8785.3 11953.2 13131.8 13274.5 13549.5 13586.9 10560.7 11069.9 11311.8 11397.5 11717.8 9584.5 10913.5 11132.2 11279.7 11650.8 11276.9 11715.4 11748.2 11907.9 12059.5 8401.0 8500.0 8661.2 8669.9 8880.5 10846.8 11273.8 11459.0 11629.0 11787.2 04:26:25 INFO - PROCESS | 1929 | 04:26:25 INFO - PROCESS | 1929 | [#3] mootools.html Cycles:180 Average:5931.37 Median:2737.61 stddev:3351.15 (122.4%) stddev-sans-first:3342.68 04:26:25 INFO - PROCESS | 1929 | Values: 1326.7 1651.1 1679.0 1953.2 2019.8 8393.0 9120.1 9237.6 9239.9 9260.1 8846.0 9122.5 9123.9 9132.4 9141.2 2565.1 2585.1 2586.3 2586.7 2586.7 2510.4 2583.2 2586.4 2587.3 2588.8 2542.9 2551.7 2593.2 2597.1 2604.9 2538.5 2566.7 2573.7 2591.7 2597.2 2536.2 2560.8 2576.9 2584.8 2590.3 8908.0 9362.6 9379.5 9401.9 9404.3 5738.0 5853.4 5917.5 5935.9 5949.5 3608.2 3680.9 3700.2 3716.3 3752.8 883.3 923.5 1088.1 1090.0 1101.8 12212.9 12386.3 12415.1 12424.3 12446.7 4272.7 4714.6 4795.5 4811.5 4902.8 9709.9 9723.7 9724.4 9726.6 9734.0 5638.4 5659.8 5701.0 5704.8 5738.6 4781.2 4877.8 5153.1 5225.7 5356.0 3999.8 4015.8 4085.8 4108.1 4128.1 1276.4 1282.0 1288.9 1296.2 1307.8 957.7 1000.3 1002.1 1012.6 1017.8 6062.9 6189.1 6197.0 6225.9 6275.1 492.4 498.5 500.1 512.0 512.2 3995.9 4055.0 4082.2 4097.6 4120.8 11185.2 11755.4 11768.7 11768.9 11780.2 11422.0 11444.0 11546.4 11550.6 11552.7 8708.4 8800.4 8834.7 8837.4 8873.5 4495.5 5628.0 6037.3 6038.8 6060.9 10124.4 10214.3 10360.3 10379.3 10406.6 8858.8 10076.2 10654.9 10663.5 10836.4 6631.6 6805.3 6812.5 7380.4 7455.9 7831.6 8686.4 8718.0 8729.9 8736.7 6546.7 7542.0 7639.5 7678.4 7758.3 7487.9 7528.8 7536.4 7598.3 7659.8 7213.2 7277.8 7285.6 7319.8 7368.2 4976.7 4983.4 5101.7 5152.1 5192.3 5070.7 5112.7 5139.4 5204.8 5372.4 04:26:25 INFO - PROCESS | 1929 | 04:26:25 INFO - PROCESS | 1929 | [#4] prototype.html Cycles:180 Average:5841.94 Median:6639.63 stddev:1906.60 (28.7%) stddev-sans-first:1866.43 04:26:25 INFO - PROCESS | 1929 | Values: 324.2 336.9 343.6 347.1 347.5 6596.3 6611.9 6705.1 6722.1 6723.6 6619.3 6644.1 6645.2 6663.2 6673.3 4704.3 4813.0 4842.3 4848.9 4851.9 4802.5 4867.6 4897.4 4946.6 4956.9 3922.5 3923.4 4768.6 4848.2 4856.9 4837.1 4838.9 4851.2 4851.7 4886.9 4030.3 4057.9 4095.0 4105.0 4125.7 6326.7 6454.6 6466.0 6477.0 6481.9 5882.5 5892.3 5897.5 5898.7 5900.5 5744.8 7111.1 7142.0 7144.4 7165.5 4434.3 4750.0 4751.6 4752.0 4766.4 7462.1 7519.9 7572.3 7602.7 7623.1 3864.5 4109.5 4698.1 4724.2 4730.2 4809.7 4812.8 4822.8 4833.0 4840.7 5739.6 5754.7 5757.4 5757.6 5764.7 5785.3 6288.3 7081.9 7177.6 7178.4 1351.0 1645.1 1658.4 1662.3 1668.4 899.7 1025.8 1030.1 1043.9 1057.9 6714.6 6715.7 6717.2 6731.1 6734.3 7124.1 7350.1 7353.5 7451.0 7466.9 6574.4 6632.1 6636.6 6642.7 6798.8 3921.8 3951.0 3961.1 3967.2 3974.4 7899.0 7904.1 7904.6 7914.7 7930.4 7399.1 7640.0 7742.8 7749.1 7758.3 7849.5 7906.8 7909.3 7920.9 7921.6 6562.3 6952.4 7457.0 7472.5 7483.4 7314.7 7328.7 7331.9 7333.6 7343.3 7544.4 7862.3 7927.7 7938.9 7962.8 4657.4 4749.1 4753.2 4754.0 4757.0 7425.0 7427.7 7432.7 7436.5 7438.3 6989.3 7231.9 7233.7 7247.1 7266.9 6013.7 7170.0 7190.7 7210.0 7210.7 5612.5 6868.3 6889.4 7065.0 7073.3 7211.9 7227.2 7233.2 7241.3 7251.1 6757.4 7056.1 7078.4 7083.4 7094.0 04:26:25 INFO - PROCESS | 1929 | 04:26:25 INFO - PROCESS | 1929 | [#5] yui.html Cycles:180 Average:18087.49 Median:50264.87 stddev:24983.96 (49.7%) stddev-sans-first:25020.02 04:26:25 INFO - PROCESS | 1929 | Values: 723.5 748.5 765.5 783.5 805.4 15142.0 15448.6 15487.7 15562.7 15565.7 14128.5 14307.1 14307.3 14316.6 14399.5 788.9 807.5 955.6 986.2 994.0 884.8 913.9 972.8 981.4 985.2 831.2 1040.5 1043.2 1044.0 1044.4 1017.4 1034.8 1038.2 1038.8 1039.8 743.8 770.0 778.4 780.4 781.9 15448.0 15487.9 15522.5 15523.8 15542.5 13019.5 13334.8 13360.0 13418.5 13670.8 10308.5 10397.9 10497.1 10710.8 10911.2 3591.5 3670.9 3688.9 3694.2 3704.9 80542.0 81178.8 82680.6 82924.6 83205.6 10043.8 10074.2 10098.4 10273.6 10614.0 22817.8 23057.5 23104.9 23105.8 23125.2 7996.8 8014.6 8077.5 8218.8 8311.5 4244.3 4245.9 4309.0 4383.4 4509.0 3854.2 3897.1 3908.5 3911.1 3914.8 570.3 619.7 695.8 718.9 736.8 562.1 577.1 587.0 611.6 623.6 8037.2 8122.5 8179.6 8227.0 8484.0 603.4 607.2 611.7 617.9 624.3 3318.9 3695.7 3829.0 3863.3 3893.9 90993.1 92493.5 93900.5 94151.5 94308.0 51613.7 74596.1 75236.0 76153.9 77436.0 63999.0 64204.0 64479.7 64650.0 65551.7 8077.7 8215.2 8327.0 8336.4 8401.2 47327.8 50160.0 50460.5 51010.0 51949.0 50369.7 65655.7 67537.3 68305.0 68629.3 11048.1 11175.8 11427.1 11482.9 11540.8 11846.1 11949.0 12029.0 12072.5 12531.3 11350.8 11411.9 11577.4 11828.4 11892.9 8782.6 11183.2 11497.5 11580.5 11625.5 10705.5 11531.1 11553.1 11647.3 11680.9 9407.5 9559.8 9864.2 9877.5 10162.3 7544.6 8399.5 9409.2 9447.0 9641.3 04:26:25 INFO - PROCESS | 1929 | -------- Summary: end -------- 04:26:25 INFO - PROCESS | 1929 | 04:26:26 INFO - TEST-INFO | 1929: exit 0 04:26:26 INFO - TEST-OK | dromaeo_css | took 1112639ms 04:26:26 INFO - TEST-START | kraken 04:26:26 INFO - operating with platform_type : mac_ 04:26:26 INFO - Initialising browser for kraken test... 04:26:26 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpZtf2qS/profile http://localhost:49462/getInfo.html) 04:26:28 INFO - PROCESS | 1935 | __metrics Screen width/height:1600/1200 04:26:28 INFO - PROCESS | 1935 | colorDepth:24 04:26:28 INFO - PROCESS | 1935 | Browser inner width/height: 1024/689 04:26:28 INFO - PROCESS | 1935 | __metrics 04:26:28 INFO - PROCESS | 1935 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:26:28 ERROR - PROCESS | 1935 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:26:29 INFO - TEST-INFO | 1935: exit 0 04:26:29 INFO - Browser initialized. 04:26:29 INFO - Running cycle 1/1 for kraken test... 04:26:29 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpZtf2qS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:40 INFO - PROCESS | 1938 | RSS: Main: 162168832 04:26:40 INFO - PROCESS | 1938 | 04:26:43 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:44 INFO - PROCESS | 1938 | RSS: Main: 223997952 04:26:44 INFO - PROCESS | 1938 | 04:26:47 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-dft) 04:26:47 INFO - PROCESS | 1938 | RSS: Main: 239341568 04:26:47 INFO - PROCESS | 1938 | 04:26:50 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-fft) 04:26:51 INFO - PROCESS | 1938 | RSS: Main: 323936256 04:26:51 INFO - PROCESS | 1938 | 04:26:53 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-oscillator) 04:26:54 INFO - PROCESS | 1938 | RSS: Main: 231006208 04:26:54 INFO - PROCESS | 1938 | 04:26:56 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:56 INFO - PROCESS | 1938 | RSS: Main: 231960576 04:26:56 INFO - PROCESS | 1938 | 04:26:59 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-darkroom) 04:27:00 INFO - PROCESS | 1938 | RSS: Main: 269447168 04:27:00 INFO - PROCESS | 1938 | 04:27:02 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-desaturate) 04:27:03 INFO - PROCESS | 1938 | RSS: Main: 268312576 04:27:03 INFO - PROCESS | 1938 | 04:27:06 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49462/tests/kraken/driver.html?testName=json-parse-financial) 04:27:06 INFO - PROCESS | 1938 | RSS: Main: 268754944 04:27:06 INFO - PROCESS | 1938 | 04:27:08 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:09 INFO - PROCESS | 1938 | RSS: Main: 260317184 04:27:09 INFO - PROCESS | 1938 | 04:27:10 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:11 INFO - PROCESS | 1938 | RSS: Main: 267051008 04:27:11 INFO - PROCESS | 1938 | 04:27:13 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:14 INFO - PROCESS | 1938 | RSS: Main: 270778368 04:27:14 INFO - PROCESS | 1938 | 04:27:17 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:17 INFO - PROCESS | 1938 | RSS: Main: 277897216 04:27:17 INFO - PROCESS | 1938 | 04:27:20 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:21 INFO - PROCESS | 1938 | RSS: Main: 275050496 04:27:21 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49462/tests/kraken/driver.html?testName=ai-astar) 04:27:23 INFO - PROCESS | 1938 | RSS: Main: 336084992 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | __start_tp_report 04:27:23 INFO - PROCESS | 1938 | _x_x_mozilla_page_load 04:27:23 INFO - PROCESS | 1938 | _x_x_mozilla_page_load_details 04:27:23 INFO - PROCESS | 1938 | |i|pagename|runs| 04:27:23 INFO - PROCESS | 1938 | |0;ai-astar;114;115;121;112;113;112;113;114;114;136 04:27:23 INFO - PROCESS | 1938 | |1;audio-beat-detection;193;155;127;191;148;140;140;118;166;118 04:27:23 INFO - PROCESS | 1938 | |2;audio-dft;184;187;181;182;183;188;186;183;183;183 04:27:23 INFO - PROCESS | 1938 | |3;audio-fft;69;76;74;158;55;55;55;62;130;54 04:27:23 INFO - PROCESS | 1938 | |4;audio-oscillator;92;90;145;80;78;79;125;80;76;127 04:27:23 INFO - PROCESS | 1938 | |5;imaging-gaussian-blur;88;85;87;85;87;83;88;84;93;112 04:27:23 INFO - PROCESS | 1938 | |6;imaging-darkroom;92;92;93;91;93;92;93;92;91;92 04:27:23 INFO - PROCESS | 1938 | |7;imaging-desaturate;85;83;83;90;84;83;85;83;88;82 04:27:23 INFO - PROCESS | 1938 | |8;json-parse-financial;59;65;61;61;62;63;62;78;57;56 04:27:23 INFO - PROCESS | 1938 | |9;json-stringify-tinderbox;60;58;60;68;67;70;69;66;66;64 04:27:23 INFO - PROCESS | 1938 | |10;stanford-crypto-aes;79;83;102;103;106;75;79;84;79;83 04:27:23 INFO - PROCESS | 1938 | |11;stanford-crypto-ccm;124;113;131;136;132;123;126;126;170;161 04:27:23 INFO - PROCESS | 1938 | |12;stanford-crypto-pbkdf2;180;205;207;161;143;202;229;212;160;163 04:27:23 INFO - PROCESS | 1938 | |13;stanford-crypto-sha256-iterative;66;68;67;66;68;65;67;66;65;65 04:27:23 INFO - PROCESS | 1938 | __end_tp_report 04:27:23 INFO - PROCESS | 1938 | __start_cc_report 04:27:23 INFO - PROCESS | 1938 | _x_x_mozilla_cycle_collect,1941 04:27:23 INFO - PROCESS | 1938 | __end_cc_report 04:27:23 INFO - PROCESS | 1938 | __startTimestamp1467890843294__endTimestamp 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | ------- Summary: start ------- 04:27:23 INFO - PROCESS | 1938 | Number of tests: 14 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#0] ai-astar Cycles:10 Average:116.40 Median:114.00 stddev:7.35 (6.4%) stddev-sans-first:7.75 04:27:23 INFO - PROCESS | 1938 | Values: 114.0 115.0 121.0 112.0 113.0 112.0 113.0 114.0 114.0 136.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:151.50 stddev:27.06 (17.9%) stddev-sans-first:23.71 04:27:23 INFO - PROCESS | 1938 | Values: 193.0 155.0 127.0 191.0 148.0 140.0 140.0 118.0 166.0 118.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#2] audio-dft Cycles:10 Average:184.00 Median:183.50 stddev:2.26 (1.2%) stddev-sans-first:2.40 04:27:23 INFO - PROCESS | 1938 | Values: 184.0 187.0 181.0 182.0 183.0 188.0 186.0 183.0 183.0 183.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#3] audio-fft Cycles:10 Average:78.80 Median:58.50 stddev:35.93 (61.4%) stddev-sans-first:37.93 04:27:23 INFO - PROCESS | 1938 | Values: 69.0 76.0 74.0 158.0 55.0 55.0 55.0 62.0 130.0 54.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:79.50 stddev:25.31 (31.8%) stddev-sans-first:26.78 04:27:23 INFO - PROCESS | 1938 | Values: 92.0 90.0 145.0 80.0 78.0 79.0 125.0 80.0 76.0 127.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#5] imaging-gaussian-blur Cycles:10 Average:89.20 Median:87.00 stddev:8.48 (9.8%) stddev-sans-first:8.99 04:27:23 INFO - PROCESS | 1938 | Values: 88.0 85.0 87.0 85.0 87.0 83.0 88.0 84.0 93.0 112.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#6] imaging-darkroom Cycles:10 Average:92.10 Median:92.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 04:27:23 INFO - PROCESS | 1938 | Values: 92.0 92.0 93.0 91.0 93.0 92.0 93.0 92.0 91.0 92.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.50 stddev:2.55 (3.0%) stddev-sans-first:2.70 04:27:23 INFO - PROCESS | 1938 | Values: 85.0 83.0 83.0 90.0 84.0 83.0 85.0 83.0 88.0 82.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.00 stddev:6.11 (9.9%) stddev-sans-first:6.36 04:27:23 INFO - PROCESS | 1938 | Values: 59.0 65.0 61.0 61.0 62.0 63.0 62.0 78.0 57.0 56.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:66.50 stddev:4.16 (6.3%) stddev-sans-first:4.03 04:27:23 INFO - PROCESS | 1938 | Values: 60.0 58.0 60.0 68.0 67.0 70.0 69.0 66.0 66.0 64.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:79.00 stddev:11.63 (14.7%) stddev-sans-first:11.95 04:27:23 INFO - PROCESS | 1938 | Values: 79.0 83.0 102.0 103.0 106.0 75.0 79.0 84.0 79.0 83.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:131.50 stddev:17.74 (13.5%) stddev-sans-first:18.43 04:27:23 INFO - PROCESS | 1938 | Values: 124.0 113.0 131.0 136.0 132.0 123.0 126.0 126.0 170.0 161.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.20 Median:203.50 stddev:28.48 (14.0%) stddev-sans-first:30.11 04:27:23 INFO - PROCESS | 1938 | Values: 180.0 205.0 207.0 161.0 143.0 202.0 229.0 212.0 160.0 163.0 04:27:23 INFO - PROCESS | 1938 | 04:27:23 INFO - PROCESS | 1938 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.16 (1.7%) stddev-sans-first:1.22 04:27:23 INFO - PROCESS | 1938 | Values: 66.0 68.0 67.0 66.0 68.0 65.0 67.0 66.0 65.0 65.0 04:27:23 INFO - PROCESS | 1938 | -------- Summary: end -------- 04:27:23 INFO - PROCESS | 1938 | 04:27:24 INFO - TEST-INFO | 1938: exit 0 04:27:24 INFO - TEST-OK | kraken | took 57804ms 04:27:24 INFO - SUITE-END | took 1170s 04:27:24 INFO - Completed test suite (00:19:30) 04:27:24 INFO - javascript benchmark 04:27:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3481.0949153220163, 3510.1751088494216, 3518.6833185013343, 3526.7531272810916, 3627.9818600906992, 5885.617434866731, 5888.558358123137, 5915.260592425947, 5927.2590926134235, 5964.79123230687, 5882.000059989801, 5985.5810093293485, 5994.0709190075495, 5994.790182343619, 6003.189569408129, 5197.1424714922, 5262.368515778103, 5273.57811375091, 5348.91976620349, 5412.783488660449, 5271.051210782058, 5371.57027437804, 5374.408815030343, 5383.4616538346045, 5385.0, 5285.339332583427, 5326.946730532703, 5335.653182543142, 5346.0, 5349.3045904032615, 5375.892482150374, 5376.435474275184, 5382.273393091921, 5390.434004429518, 5400.864978375533, 5145.434002259748, 5232.581393488512, 5296.364436267634, 5307.336582927134, 5320.308359913225, 5705.2012718219485, 5716.085426331809, 5732.971335143297, 5748.396418376052, 5802.680852553108, 6240.968795155995, 6273.7176827042895, 6276.874462510724, 6283.622982621012, 6288.465480434169, 6195.44241018306, 6197.504199664016, 6326.082718005863, 6343.873122537523, 6577.309382514815, 5802.477777000048, 5819.418058194189, 5824.912626310609, 5848.064309710426, 6044.455998960115, 6405.583637063576, 6442.452391546677, 6444.806655800334, 6447.323031081763, 6452.419282264619, 6178.382161783786, 6184.103305020837, 6275.184226050585, 6277.52918531112, 6318.526110541636, 6244.718987645567, 6317.684115794192, 6332.620042797447, 6332.810015699536, 6363.0, 6234.0337247726675, 6293.087502312139, 6294.559380843297, 6303.149074874833, 6331.841703957346, 5369.731513424391, 6116.914073580098, 6267.122602835607, 6285.465735412449, 6300.401461861115, 5051.393832740095, 5058.215976523645, 5087.618428617869, 5092.949070509321, 5094.796208151706, 4445.044315472189, 4513.277875539963, 4520.299353600197, 4584.083183363341, 4612.331211974245, 5838.9124163137585, 5860.765569377178, 6107.29766076898, 6108.7861924833305, 6119.877602447926, 6215.378462153749, 6232.3144454110015, 6309.0, 6313.210848643919, 6330.208723909512, 6006.879862402728, 6049.0, 6119.746288422706, 6122.448979591858, 6134.78528251509, 5557.77768889248, 5561.165825126263, 5562.0, 5570.888582228333, 5577.44225577439, 6395.328490508429, 6485.837854053686, 6547.770828020996, 6593.241777195588, 6620.238672552622, 6289.779857704958, 6315.905261421174, 6321.146645203023, 6334.619922804646, 6352.872942541216, 6561.507886908405, 6578.605283682994, 6586.0, 6587.835304117435, 6596.637184954873, 6174.876502470015, 6217.0, 6255.280642725963, 6319.526035547445, 6338.90491642635, 6222.533310001678, 6239.875202495834, 6303.936960630335, 6307.053941908567, 6316.3367846377305, 6232.439080482778, 6295.18162638854, 6309.432151106423, 6321.747130114928, 6330.746770129143, 6263.749450021948, 6307.369263073656, 6316.905246421215, 6325.019621958604, 6338.239411270677, 4575.062112267044, 6069.666168360783, 6109.602875813058, 6186.845328866814, 6200.720967556561, 6229.968850155901, 6234.470070043915, 6237.064440333987, 6253.687315634109, 6280.434760871361, 5977.820665380045, 6163.229596300463, 6230.221222347207, 6231.158793562811, 6244.188255526934], "value": 5839.0439801902185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.4711861697612, 546.3362015151592, 569.4647031790116, 580.1327016110915, 618.8916939535583, 32711.67288327116, 33190.50214246785, 39381.40927886084, 39572.604273957215, 40501.79749101258, 45151.64545063653, 45209.0, 45331.86670333243, 45348.319775203396, 45369.77315113428, 9902.108810207097, 10086.344387614818, 10087.142592879614, 10112.241581881352, 10113.0, 9206.0, 9408.341416100875, 9427.198688111484, 11892.989095926856, 12216.511339546407, 11774.823377649342, 11837.704057398549, 11928.642140735792, 11936.582219622314, 11938.224015439013, 11908.880911190863, 11982.340971246578, 11991.04071674264, 12004.159708820385, 12022.51909923602, 11733.296002239893, 11835.822462663067, 11865.881341186563, 11867.406629668569, 11874.762504749942, 41861.58138418607, 42551.361729574084, 42597.935051623645, 42629.0, 42645.57354426447, 2882.855857207131, 3309.8179600121985, 3335.6497567755277, 3722.981385093084, 3806.915029216688, 28121.57817632737, 28669.996550120853, 30214.54678179829, 30471.0, 30598.84700576483, 2808.8595570221405, 2820.591014302935, 2841.7300356466103, 2851.9714802852122, 2872.6840047594746, 491868.540657298, 497231.0, 498561.53596160025, 498967.0, 499581.0, 37728.24543509114, 64035.0, 65831.0, 65995.0, 66146.33853661497, 35990.820045900124, 36081.27837443237, 36089.819550902605, 36198.095047623494, 36233.0, 16148.919255403647, 16412.83587164137, 16434.260458279405, 16440.917795410947, 16451.095189764677, 13017.088803783645, 14334.856651433352, 14384.136951782926, 14386.35261413239, 14392.784108238386, 8026.0, 8455.069942306342, 8556.657733690583, 8611.0, 8629.43908645936, 3499.632538583463, 3568.018794831442, 3568.803715795604, 3568.964310356915, 3592.2456284180093, 1030.3302853145515, 1051.7212938571286, 1065.738893970982, 1164.4643464006483, 1170.8126699728002, 29948.251293717833, 30067.94762183313, 30485.542716859265, 30610.092041256044, 31760.419355478927, 1169.5964892112208, 1181.149572307937, 1191.7199458127334, 1203.7171264752776, 1282.6985658370274, 15989.440369587008, 16047.438339658056, 16188.271527781279, 16359.100249486393, 16489.422870199727, 637032.0, 740883.0, 746907.0, 748017.0, 751092.0, 61714.0, 61748.0, 62595.6870215646, 62684.0, 62946.37053629405, 1404.4241860837212, 1465.2234315812636, 1537.2390666620095, 1563.8123425188824, 1578.7710781936785, 29580.0, 30438.695613043586, 30499.93250236231, 30770.384592308477, 30890.53664195084, 51703.74148129386, 52381.7380913093, 52443.73778131085, 52480.0, 52544.0, 402790.0, 414445.0, 418525.0, 419724.0, 420308.0, 25290.494190116464, 28412.0, 29004.12987610375, 44055.0, 45793.77103114463, 44911.32633010442, 45204.77397612991, 45321.64035078953, 45398.54601453943, 45637.77181114206, 36062.91811245667, 36543.63456365402, 37026.6297337034, 37120.814395927846, 37348.43977340397, 36984.07539811418, 37103.217258706245, 37433.62566374301, 37490.0, 37709.622903770614, 36091.27817443689, 38019.85940421792, 38023.0, 39021.21957560776, 39317.0, 33245.667543325224, 33808.49287260644, 34212.0, 34418.82790586031, 34510.0, 23762.93066811963, 24016.87991560031, 24248.1513147039, 24458.877705611358, 24503.264902052968], "value": 19559.857512419178, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.4866596423594, 418.5646927195716, 420.09469593027, 422.2715815218746, 432.75333060155725, 20495.385138445832, 21011.36965891026, 21257.236559247314, 21961.341159765234, 22665.52674076188, 22317.10731570739, 22347.55304893901, 22520.887395563, 22634.54730905381, 22658.88670556645, 5800.419958004208, 6065.514758819284, 6131.785387511438, 6135.693215339237, 6148.231471066117, 4486.955130448703, 4676.69601475903, 6049.395060493959, 6135.570510064297, 6438.3883531064475, 6671.232808227068, 6678.76624318149, 6683.264840867525, 6685.598864068147, 6686.699098540577, 6380.042993550958, 6553.115329430538, 6564.901526477107, 6569.80290591283, 6580.769673061443, 4030.9395359069636, 5576.386597474275, 5777.740001699934, 5782.10377391505, 5847.210626565402, 26062.739372606222, 26163.476730465285, 26504.0, 26571.335716607045, 26607.600885986725, 2212.4358288636454, 2246.539459410817, 2545.325488745484, 2859.170840456265, 2897.797154199207, 14572.489962851248, 15119.319630616648, 15563.22183890801, 15747.0, 15768.684626307524, 1725.9137043147791, 1789.5436663650817, 1812.6737187306412, 1822.9088545572802, 1836.219606667161, 115144.84855151425, 115248.84751152465, 115934.0, 116210.41894790556, 117072.0, 9550.418593027614, 11290.04034657047, 11594.88405115955, 11775.17573769845, 11855.881441185651, 13505.0, 14855.925720371546, 14918.328675209641, 14978.925105374403, 14988.700225995419, 8520.70177543783, 9247.491387973592, 9294.209992150743, 9310.301727370474, 9394.107559781809, 9470.479123648265, 9479.099485548863, 9498.857517137249, 9594.42433453995, 9600.615975361046, 6361.823062733409, 6475.222973243241, 7045.753398631024, 7079.0, 7085.751998680124, 1800.1278670182862, 1832.7891048104566, 1921.5868588253593, 1941.9708704369446, 1963.1460314762837, 874.9212570868652, 940.5109343141528, 1015.5886865819207, 1051.5846240734868, 1112.2881355932209, 19882.50293742668, 21643.0, 21714.674279885814, 21776.782232177793, 21778.782212177994, 920.3189639666732, 1049.7008352619466, 1063.0910571461443, 1106.5352551928208, 1130.2766229613055, 11278.210525263154, 11686.065114790796, 11699.415029248674, 11726.94136529312, 11849.940750296193, 567064.0, 613489.0, 614165.0, 622732.0, 644094.0, 67931.66034169798, 111479.44260278808, 117406.41296793461, 117755.0, 122625.0, 978.3054031637618, 1078.2075174746556, 1102.239454776202, 1120.0647459371353, 1123.253036730565, 16541.58646033859, 18783.0, 19621.70567441461, 19832.70250946266, 19994.60010799805, 46863.06273874435, 47601.285980709625, 48047.75976120097, 49097.50902490929, 51583.742081289354, 63775.0, 67274.66362668155, 68207.65896170487, 69175.65412172907, 70560.0, 8165.2243036911395, 8257.256846883569, 8554.443961142506, 8576.871346929676, 8785.341099417441, 11953.22304050234, 13131.803022954473, 13274.535391261259, 13549.458021679022, 13586.86413135856, 10560.735981600214, 11069.893010698866, 11311.830322545333, 11397.544098235978, 11717.824232636687, 9584.472853993097, 10913.508892099715, 11132.220744548127, 11279.718007049889, 11650.76698466009, 11276.94361528187, 11715.355655439032, 11748.177627565989, 11907.880921191023, 12059.457324420247, 8401.0, 8499.95750021246, 8661.220490155916, 8669.91330086691, 8880.51157186361, 10846.837297440703, 11273.7745245093, 11458.968692817687, 11629.011534019703, 11787.174897757075], "value": 10043.574265744564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.6882282663578, 1651.05064587862, 1679.0177746018578, 1953.199188332783, 2019.838412926965, 8393.034800997888, 9120.087991200877, 9237.630494780218, 9239.907600923989, 9260.120288572574, 8845.955770221157, 9122.452652840817, 9123.863142052858, 9132.360734748554, 9141.222996045344, 2565.063751730619, 2585.069375024999, 2586.314626623946, 2586.6508021417058, 2586.7283935186815, 2510.3975045988923, 2583.1992082454403, 2586.4180559374086, 2587.2626301504074, 2588.754068363512, 2542.8982840686444, 2551.6937967443932, 2593.1572239022394, 2597.142942828862, 2604.93487662809, 2538.4796116796106, 2566.7048289446766, 2573.74262573743, 2591.6630837990942, 2597.181887705367, 2536.1757428835704, 2560.7951363890843, 2576.871156442189, 2584.78029367504, 2590.2747230775412, 8908.0, 9362.625494980193, 9379.484128372937, 9401.905980940172, 9404.341696081277, 5738.024535828919, 5853.385394533555, 5917.52659787216, 5935.940640593625, 5949.464548190684, 3608.2061946371755, 3680.8527658893613, 3700.2414505026672, 3716.2753263113705, 3752.7935963521995, 883.3021912688968, 923.4736200365794, 1088.0968795899385, 1090.0407641275706, 1101.7631209290041, 12212.877871221352, 12386.318752468611, 12415.130940834146, 12424.254544727255, 12446.688832779162, 4272.700910936267, 4714.622830173578, 4795.544423279783, 4811.542903424169, 4902.803887844446, 9709.854352184722, 9723.659671911591, 9724.367916085432, 9726.562304696306, 9733.951330243444, 5638.436156384329, 5659.8019069333195, 5701.0, 5704.800331988444, 5738.5982981191755, 4781.2350023996, 4877.804887804519, 5153.123968925292, 5225.6603320784025, 5355.973220133875, 3999.7600143991453, 4015.7551159140176, 4085.7957102144774, 4108.137291168888, 4128.091819799639, 1276.3618190904547, 1282.0192552697195, 1288.8968882489378, 1296.2093123195032, 1307.8229593366048, 957.7414098193589, 1000.2797985450464, 1002.0560113380019, 1012.6101450941441, 1017.7913527726798, 6062.9090563641585, 6189.133521307021, 6197.03945888388, 6225.875482490324, 6275.090111933744, 492.38206051405257, 498.5164390541169, 500.07735727582553, 512.0, 512.2188662290038, 3995.9400608990886, 4054.959450405458, 4082.1631565529588, 4097.631213190767, 4120.835166593302, 11185.161112916563, 11755.353455559854, 11768.705782355339, 11768.88231117695, 11780.234284771463, 11422.0, 11444.02725768319, 11546.422678866023, 11550.59572914944, 11552.6534203974, 8708.43395179324, 8800.383973121949, 8834.734957951272, 8837.381383303236, 8873.467591944504, 4495.52796956328, 5628.0, 6037.279375377996, 6038.788642397495, 6060.8782883407675, 10124.443155626512, 10214.285000050222, 10360.274780765274, 10379.273450858367, 10406.635767748092, 8858.822823543363, 10076.19390448777, 10654.89345106539, 10663.46682665879, 10836.403997780199, 6631.568948018364, 6805.2854450283985, 6812.523123381316, 7380.372668323038, 7455.888161677471, 7831.647575858986, 8686.435381700168, 8717.956410217908, 8729.869051964099, 8736.650533978824, 6546.705398256994, 7541.962290188514, 7639.541627502367, 7678.385729141543, 7758.301752842045, 7487.925120748723, 7528.774136775905, 7536.434767392577, 7598.316151546387, 7659.846803064019, 7213.242609525924, 7277.781666550012, 7285.635718213962, 7319.817004574928, 7368.189499155196, 4976.701397916137, 4983.426905905722, 5101.744912754273, 5152.072626927189, 5192.299039629753, 5070.6957582545165, 5112.693238405707, 5139.357580302462, 5204.843854684365, 5372.409035006068], "value": 4704.757488455897, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.207313119423, 336.85515228451754, 343.6048544174199, 347.12870694556653, 347.45623099848734, 6596.307387724291, 6611.867762644744, 6705.128333316668, 6722.058911752359, 6723.562968407063, 6619.271880093186, 6644.069830223772, 6645.169353830771, 6663.167104111986, 6673.332666733337, 4704.294355846616, 4813.0, 4842.322074909498, 4848.854534363974, 4851.878703032417, 4802.471728109905, 4867.610591152717, 4897.432821497122, 4946.629002824802, 4956.87607809804, 3922.4900762900784, 3923.391874259494, 4768.570828625423, 4848.200046992242, 4856.878578035559, 4837.0567739290855, 4838.854834354975, 4851.151048566487, 4851.708897466164, 4886.853394398174, 4030.2745505808944, 4057.8579749708915, 4094.959050409517, 4105.035316700573, 4125.711200215986, 6326.715297811564, 6454.580452270588, 6466.0300954856675, 6476.963685810295, 6481.93518064818, 5882.529397648221, 5892.292924849003, 5897.469227769521, 5898.675572843492, 5900.498457631106, 5744.827655170351, 7111.075560177195, 7141.964290178568, 7144.428445724329, 7165.534240274417, 4434.334849772527, 4750.0, 4751.596114330286, 4751.95248047522, 4766.38037055184, 7462.10454745434, 7519.887201692034, 7572.280633339824, 7602.695892164307, 7623.085229772408, 3864.53625564934, 4109.458952892665, 4698.083873644675, 4724.244120940702, 4730.219513780187, 4809.711417314972, 4812.759362031885, 4822.807087716452, 4832.95167048332, 4840.685355451885, 5739.62692424991, 5754.683492407958, 5757.395473475309, 5757.568182386338, 5764.682942438122, 5785.305763308345, 6288.339724328971, 7081.92918070823, 7177.569345839266, 7178.353948144692, 1351.0, 1645.0623144807346, 1658.4195531563855, 1662.3433743671183, 1668.4327328708298, 899.6941040046415, 1025.8102251083574, 1030.1449796668746, 1043.8903915088958, 1057.9206559508068, 6714.563553369016, 6715.664216789239, 6717.193936727624, 6731.091302674175, 6734.326567343324, 7124.109486314211, 7350.117985841626, 7353.522021068614, 7450.96274518624, 7466.887996680054, 6574.3754343337305, 6632.137822083098, 6636.601803891782, 6642.66786660665, 6798.830029249309, 3921.8039098044983, 3951.031997160714, 3961.1285517186175, 3967.2263908538134, 3974.4435778990965, 7898.960505197438, 7904.0910295315625, 7904.644291006918, 7914.722984695623, 7930.365570754326, 7399.149097853816, 7640.044994375703, 7742.7677169685, 7749.108852481924, 7758.301752842159, 7849.4897831640765, 7906.802329941683, 7909.288164065031, 7920.920790792134, 7921.564313962672, 6562.278149403466, 6952.44380449573, 7456.979923131141, 7472.514286571355, 7483.401327893646, 7314.670839812327, 7328.743493977899, 7331.890021649786, 7333.596652184181, 7343.302386273295, 7544.4341674373545, 7862.2923936845955, 7927.682892684228, 7938.880916786368, 7962.84074318522, 4657.394538709946, 4749.121412538691, 4753.215719406259, 4753.976230118966, 4757.0, 7424.962875185805, 7427.665755040928, 7432.702691892264, 7436.479446438698, 7438.293362130589, 6989.30106989297, 7231.927680723125, 7233.674484648098, 7247.057882475245, 7266.927330726625, 6013.737115205856, 7169.964150179216, 7190.7483238086415, 7210.0, 7210.747623833141, 5612.494875461228, 6868.278830722702, 6889.448844092361, 7065.046218760402, 7073.292670732885, 7211.891821622575, 7227.205007449282, 7233.240509746401, 7241.312075352833, 7251.057362542836, 6757.425618822259, 7056.08270924797, 7078.398336141279, 7083.433325334064, 7093.964530177316], "value": 5199.772143693173, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.5080145501059, 748.4910261022505, 765.4947734495234, 783.5024759277857, 805.3798575097176, 15142.0, 15448.613784655388, 15487.690246195083, 15562.688746225069, 15565.688686226269, 14128.505502307422, 14307.141571505717, 14307.284635768223, 14316.642083947907, 14399.496017639385, 788.9092754333253, 807.4872455990459, 955.5652178258875, 986.171615842692, 993.9652112176075, 884.8363052835214, 913.9268858491305, 972.7568107973007, 981.4405788700443, 985.2315194148575, 831.1771346367113, 1040.5161599856065, 1043.2280112716574, 1044.0081922173927, 1044.4412239451894, 1017.3743147964022, 1034.7723500829804, 1038.2161468091617, 1038.761084950458, 1039.8128336899356, 743.84007438401, 770.0220719685967, 778.353966208046, 780.4107898536625, 781.945263831532, 15448.0, 15487.922560387238, 15522.5343239703, 15523.767143492856, 15542.533723988185, 13019.47922083125, 13334.799978000337, 13360.0, 13418.53035143775, 13670.794938075936, 10308.536115874804, 10397.896021039769, 10497.055265026109, 10710.785784284271, 10911.181661375429, 3591.497190393347, 3670.853165873362, 3688.8708895188806, 3694.1503454205413, 3704.85180592776, 80542.0, 81178.78231826528, 82680.58659706663, 82924.58537707334, 83205.58397207975, 10043.849342259871, 10074.244431667654, 10098.394096354243, 10273.640422585173, 10613.991670791262, 22817.771822281564, 23057.53884922292, 23104.884475577514, 23105.768942310697, 23125.190618328277, 7996.840063198703, 8014.639341229658, 8077.474964127313, 8218.753437396888, 8311.542865142475, 4244.3209086546, 4245.915081698348, 4309.030468144642, 4383.3863259143745, 4508.985478267364, 3854.2291541691775, 3897.1036661567996, 3908.4528166056775, 3911.0808959894403, 3914.825552334288, 570.3099249907575, 619.6994457688018, 695.7947405515386, 718.90294810201, 736.823162441021, 562.1230879827482, 577.1342985521718, 587.0401892905131, 611.5571414411683, 623.5666211982629, 8037.196280371916, 8122.5126492410645, 8179.591020448954, 8226.958865205635, 8484.0, 603.3785201242727, 607.1651479216077, 611.6691452936552, 617.8856911471393, 624.3257282135284, 3318.900432987014, 3695.74129810916, 3828.9617103828605, 3863.3046051710962, 3893.8831835044994, 90993.09006909978, 92493.53753231191, 93900.53049734708, 94151.52924235472, 94308.0, 51613.741931290104, 74596.13509662302, 75236.0, 76153.85769213467, 77436.0, 63999.0, 64204.0, 64479.67760161169, 64650.0, 65551.67224163849, 8077.676892924217, 8215.178482151738, 8326.958365208135, 8336.416450848383, 8401.15988401155, 47327.76336118297, 50160.0, 50460.49539504558, 51010.0, 51948.96102078013, 50369.740756481384, 65655.67172164109, 67537.3246267531, 68305.0, 68629.2842678937, 11048.116150707763, 11175.832362514731, 11427.085833133164, 11482.94258528702, 11540.82688759686, 11846.111541634584, 11949.044076473687, 12029.0, 12072.517099316281, 12531.310777907303, 11350.772984540097, 11411.871129357722, 11577.363245021605, 11828.40857957116, 11892.881071189177, 8782.604782784918, 11183.217174797686, 11497.54009839597, 11580.478878450658, 11625.534978600761, 10705.518251678848, 11531.1351648625, 11553.075753939833, 11647.30116193031, 11680.883191167979, 9407.529623518934, 9559.761005974906, 9864.21086313079, 9877.456739879375, 10162.288639795144, 7544.556330063094, 8399.496030238206, 9409.247260219303, 9447.0, 9641.27690423207], "value": 7060.829712899287, "unit": "score"}], "name": "dromaeo_css", "value": 7635.453153104163, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 121.0, 112.0, 113.0, 112.0, 113.0, 114.0, 114.0, 136.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 155.0, 127.0, 191.0, 148.0, 140.0, 140.0, 118.0, 166.0, 118.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 181.0, 182.0, 183.0, 188.0, 186.0, 183.0, 183.0, 183.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 74.0, 158.0, 55.0, 55.0, 55.0, 62.0, 130.0, 54.0], "value": 78.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 145.0, 80.0, 78.0, 79.0, 125.0, 80.0, 76.0, 127.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 85.0, 87.0, 83.0, 88.0, 84.0, 93.0, 112.0], "value": 89.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 91.0, 93.0, 92.0, 93.0, 92.0, 91.0, 92.0], "value": 92.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 90.0, 84.0, 83.0, 85.0, 83.0, 88.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 65.0, 61.0, 61.0, 62.0, 63.0, 62.0, 78.0, 57.0, 56.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 60.0, 68.0, 67.0, 70.0, 69.0, 66.0, 66.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 102.0, 103.0, 106.0, 75.0, 79.0, 84.0, 79.0, 83.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 113.0, 131.0, 136.0, 132.0, 123.0, 126.0, 126.0, 170.0, 161.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 205.0, 207.0, 161.0, 143.0, 202.0, 229.0, 212.0, 160.0, 163.0], "value": 186.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 66.0, 68.0, 65.0, 67.0, 66.0, 65.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1493.1000000000001, "alertThreshold": 2.0}]} 04:27:24 INFO - Return code: 0 04:27:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:27:24 ERROR - # TBPL SUCCESS # 04:27:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:27:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:27:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:27:24 INFO - 2016-07-07 04:27:24.628 screenresolution[1942:11347] starting screenresolution argv=screenresolution get 04:27:24 INFO - 2016-07-07 04:27:24.631 screenresolution[1942:11347] Display 0: 1600x1200x32@60 04:27:24 INFO - 2016-07-07 04:27:24.637 screenresolution[1943:11350] starting screenresolution argv=screenresolution list 04:27:24 INFO - Available Modes on Display 0 04:27:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:27:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:27:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:27:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:27:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:27:24 INFO - Intel Iris: 04:27:24 INFO - Chipset Model: Intel Iris 04:27:24 INFO - Type: GPU 04:27:24 INFO - Bus: Built-In 04:27:24 INFO - VRAM (Dynamic, Max): 1536 MB 04:27:24 INFO - Vendor: Intel (0x8086) 04:27:24 INFO - Device ID: 0x0a2e 04:27:24 INFO - Revision ID: 0x0009 04:27:24 INFO - Displays: 04:27:24 INFO - Display: 04:27:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:27:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:27:24 INFO - Display Serial Number: 1600x1200 60 04:27:24 INFO - Main Display: Yes 04:27:24 INFO - Mirror: Off 04:27:24 INFO - Online: Yes 04:27:24 INFO - Rotation: Supported 04:27:24 INFO - Return code: 0 04:27:24 INFO - Running post-action listener: _resource_record_post_action 04:27:24 INFO - Running post-run listener: _resource_record_post_run 04:27:25 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 2117632; Write bytes: 493604352; Read time: 25; Write time: 1822 04:27:25 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193204736; Write bytes: 188090368; Read time: 18015; Write time: 457 04:27:25 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 1257472; Write bytes: 295769600; Read time: 20; Write time: 1331 04:27:25 INFO - Running post-run listener: _upload_blobber_files 04:27:25 INFO - Blob upload gear active. 04:27:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:27:26 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:27:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:27:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:26 INFO - (blobuploader) - INFO - Done attempting. 04:27:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:27:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:27:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:27 INFO - (blobuploader) - INFO - Done attempting. 04:27:27 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:27 INFO - Return code: 0 04:27:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16fe210f9b89356fb6ce71ed4ccc3d1cbffcc9cd61de7eae458a64eab5cbe2538d6d2ad2a1dc507672f479c86940864e8799706c1ce340b5eceb0052b8224128", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f24497ae2d37cfd7cda04f53c5cf1ee2d7effd7255f9dbb8f90a9356618afae5fc9134207e403d69047bf3066fa924c585bf43a7efc1e2999569dad70bae4da"} 04:27:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:27 INFO - Contents: 04:27:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16fe210f9b89356fb6ce71ed4ccc3d1cbffcc9cd61de7eae458a64eab5cbe2538d6d2ad2a1dc507672f479c86940864e8799706c1ce340b5eceb0052b8224128", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f24497ae2d37cfd7cda04f53c5cf1ee2d7effd7255f9dbb8f90a9356618afae5fc9134207e403d69047bf3066fa924c585bf43a7efc1e2999569dad70bae4da"} 04:27:27 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:27 INFO - Copying logs to upload dir... 04:27:27 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.979713 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-07 04:27:28.057331) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:28.062239) ========= 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.5L7kseQoA9/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.C3M6fPispO/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16fe210f9b89356fb6ce71ed4ccc3d1cbffcc9cd61de7eae458a64eab5cbe2538d6d2ad2a1dc507672f479c86940864e8799706c1ce340b5eceb0052b8224128", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f24497ae2d37cfd7cda04f53c5cf1ee2d7effd7255f9dbb8f90a9356618afae5fc9134207e403d69047bf3066fa924c585bf43a7efc1e2999569dad70bae4da"} build_url:https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16fe210f9b89356fb6ce71ed4ccc3d1cbffcc9cd61de7eae458a64eab5cbe2538d6d2ad2a1dc507672f479c86940864e8799706c1ce340b5eceb0052b8224128", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f24497ae2d37cfd7cda04f53c5cf1ee2d7effd7255f9dbb8f90a9356618afae5fc9134207e403d69047bf3066fa924c585bf43a7efc1e2999569dad70bae4da"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:28.098517) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:28.099340) ========= 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.5L7kseQoA9/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.C3M6fPispO/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005056 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:28.157672) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:27:28.158110) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:27:28.158514) ========= ========= Total master_lag: 1.10 =========