builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0122 starttime: 1467889597.68 results: success (0) buildid: 20160706215822 builduid: 005acac198204b229cc2500b323a4168 revision: d142c49033c015f67272562b37dbe2912cfc7f14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.677789) ========= 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:37.678270) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.678585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.721415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.721716) ========= 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.vYSuPz75LJ/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.yOtZy0pekO/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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:37-- 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% 10.5M=0.001s 2016-07-07 04:06:37 (10.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137509 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.892595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.893255) ========= 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.vYSuPz75LJ/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.yOtZy0pekO/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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.021885 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.944910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.945453) ========= 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.vYSuPz75LJ/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.yOtZy0pekO/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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:38,020 truncating revision to first 12 chars 2016-07-07 04:06:38,020 Setting DEBUG logging. 2016-07-07 04:06:38,021 attempt 1/10 2016-07-07 04:06:38,021 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:38,351 unpacking tar archive at: mozilla-beta-d142c49033c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603366 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:38.573471) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:38.573967) ========= script_repo_revision: d142c49033c015f67272562b37dbe2912cfc7f14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:38.574651) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:38.575095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:38.595650) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-07 04:06:38.596093) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vYSuPz75LJ/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.yOtZy0pekO/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04: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-e10s', 04:06:38 INFO - 'system_bits': '32', 04:06:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:38 INFO - 'title': 't-yosemite-r7-0122', 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:40 INFO - Running post-action listener: _resource_record_post_action 04:06:40 INFO - ##### 04:06:40 INFO - ##### Running read-buildbot-config step. 04:06:40 INFO - ##### 04:06:40 INFO - Running pre-action listener: _resource_record_pre_action 04:06:40 INFO - Running main action method: read_buildbot_config 04:06:40 INFO - Using buildbot properties: 04:06:40 INFO - { 04:06:40 INFO - "project": "", 04:06:40 INFO - "product": "firefox", 04:06:40 INFO - "script_repo_revision": "production", 04:06:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:06:40 INFO - "repository": "", 04:06:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:06:40 INFO - "buildid": "20160706215822", 04:06:40 INFO - "pgo_build": "False", 04:06:40 INFO - "basedir": "/builds/slave/test", 04:06:40 INFO - "buildnumber": 27, 04:06:40 INFO - "slavename": "t-yosemite-r7-0122", 04:06:40 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:06:40 INFO - "platform": "yosemite_r7", 04:06:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:06:40 INFO - "branch": "mozilla-beta", 04:06:40 INFO - "repo_path": "releases/mozilla-beta", 04:06:40 INFO - "revision": "d142c49033c015f67272562b37dbe2912cfc7f14", 04:06:40 INFO - "stage_platform": "macosx64", 04:06:40 INFO - "builduid": "005acac198204b229cc2500b323a4168", 04:06:40 INFO - "slavebuilddir": "test" 04:06:40 INFO - } 04:06:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 04:06:40 INFO - Running post-action listener: _resource_record_post_action 04:06:40 INFO - ##### 04:06:40 INFO - ##### Running download-and-extract step. 04:06:40 INFO - ##### 04:06:40 INFO - Running pre-action listener: _resource_record_pre_action 04:06:40 INFO - Running main action method: download_and_extract 04:06:40 INFO - mkdir: /builds/slave/test/build/tests 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.test_packages.json 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.test_packages.json 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.test_packages.json 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.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:06:40 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:44 INFO - Downloaded 1165 bytes. 04:06:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:06:44 INFO - Using the following test package requirements: 04:06:44 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:06:44 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:44 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:06:44 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:44 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:06:44 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:06:44 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:44 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:06:44 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:06:44 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:44 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:06:44 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:44 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:06:44 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:44 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:06:44 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:44 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:06:44 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 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:45 INFO - Downloaded 18351388 bytes. 04:06:45 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:45 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:48 INFO - Return code: 0 04:06:48 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:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:48 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:48 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:48 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:48 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:48 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:50 INFO - Downloaded 18351388 bytes. 04:06:50 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:50 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:54 INFO - Return code: 0 04:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:54 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:54 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:54 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:54 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:54 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:55 INFO - Downloaded 10840145 bytes. 04:06:55 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:55 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:55 INFO - Return code: 0 04:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:55 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:55 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:55 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:55 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:55 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:58 INFO - Downloaded 86189077 bytes. 04:06:58 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:58 INFO - mkdir: /builds/slave/test/properties 04:06:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:58 INFO - Contents: 04:06:58 INFO - build_url:https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:06:59 INFO - Running post-action listener: _resource_record_post_action 04:06:59 INFO - Running post-action listener: set_extra_try_arguments 04:06:59 INFO - ##### 04:06:59 INFO - ##### Running populate-webroot step. 04:06:59 INFO - ##### 04:06:59 INFO - Running pre-action listener: _resource_record_pre_action 04:06:59 INFO - Running main action method: populate_webroot 04:06:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:06:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:06:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:06:59 INFO - '--tppagecycles', 04:06:59 INFO - '7'], 04:06:59 INFO - 'tests': ['tsvgm']}}, 04:06:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:06:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:06:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:06:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:06:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:06:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:06:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:59 INFO - 'talos_options': ['--disable-e10s'], 04:06:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:59 INFO - 'talos_options': ['--disable-e10s'], 04:06:59 INFO - 'tests': ['damp', 'tps']}, 04:06:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:59 INFO - 'tests': ['damp', 'tps']}, 04:06:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:06:59 INFO - 'tests': ['dromaeo_dom']}, 04:06:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:06:59 INFO - 'tests': ['a11yr', 04:06:59 INFO - 'ts_paint', 04:06:59 INFO - 'tpaint', 04:06:59 INFO - 'sessionrestore', 04:06:59 INFO - 'sessionrestore_no_auto_restore', 04:06:59 INFO - 'tabpaint']}, 04:06:59 INFO - 'other-e10s': {'tests': ['a11yr', 04:06:59 INFO - 'ts_paint', 04:06:59 INFO - 'tpaint', 04:06:59 INFO - 'sessionrestore', 04:06:59 INFO - 'sessionrestore_no_auto_restore', 04:06:59 INFO - 'tabpaint']}, 04:06:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:06:59 INFO - 'ts_paint', 04:06:59 INFO - 'tpaint', 04:06:59 INFO - 'sessionrestore', 04:06:59 INFO - 'sessionrestore_no_auto_restore', 04:06:59 INFO - 'tabpaint']}, 04:06:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:06:59 INFO - 'ts_paint', 04:06:59 INFO - 'tpaint', 04:06:59 INFO - 'sessionrestore', 04:06:59 INFO - 'sessionrestore_no_auto_restore', 04:06:59 INFO - 'tabpaint']}, 04:06:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:06:59 INFO - 'tests': ['a11yr', 04:06:59 INFO - 'ts_paint', 04:06:59 INFO - 'tpaint', 04:06:59 INFO - 'sessionrestore', 04:06:59 INFO - 'sessionrestore_no_auto_restore', 04:06:59 INFO - 'tabpaint']}, 04:06:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:06:59 INFO - 'tests': ['a11yr', 04:06:59 INFO - 'ts_paint', 04:06:59 INFO - 'tpaint', 04:06:59 INFO - 'sessionrestore', 04:06:59 INFO - 'sessionrestore_no_auto_restore', 04:06:59 INFO - 'tabpaint']}, 04:06:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:06:59 INFO - 'tests': ['tsvgx', 04:06:59 INFO - 'tsvgr_opacity', 04:06:59 INFO - 'tart', 04:06:59 INFO - 'tscrollx', 04:06:59 INFO - 'cart']}, 04:06:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:06:59 INFO - 'tsvgr_opacity', 04:06:59 INFO - 'tart', 04:06:59 INFO - 'tscrollx', 04:06:59 INFO - 'cart']}, 04:06:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:59 INFO - 'talos_options': ['--disable-e10s'], 04:06:59 INFO - 'tests': ['tp5o']}, 04:06:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:59 INFO - 'tests': ['tp5o']}, 04:06:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:59 INFO - 'talos_options': ['--disable-e10s', 04:06:59 INFO - '--xperf_path', 04:06:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:59 INFO - 'tests': ['tp5n']}, 04:06:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:59 INFO - 'talos_options': ['--xperf_path', 04:06:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:59 INFO - 'tests': ['tp5n']}}, 04:06:59 INFO - 'talos.zip': {'path': '', 04:06:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:06:59 INFO - Running post-action listener: _resource_record_post_action 04:06:59 INFO - ##### 04:06:59 INFO - ##### Running create-virtualenv step. 04:06:59 INFO - ##### 04:06:59 INFO - Running pre-action listener: _resource_record_pre_action 04:06:59 INFO - Running main action method: create_virtualenv 04:06:59 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:59 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:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:07:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:07:00 INFO - Using real prefix '/tools/python27' 04:07:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:07:00 INFO - Installing distribute.............................................................................................................................................................................................done. 04:07:03 INFO - Installing pip.................done. 04:07:03 INFO - Return code: 0 04:07:03 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104df5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e05420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed805ace70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c94e00>, '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 0x104afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c8fb20>, '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.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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', 'pip>=1.5'] 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 pip>=1.5 04:07:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 04:07:03 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 - 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:07:03 INFO - Cleaning up... 04:07:03 INFO - Return code: 0 04:07:03 INFO - Installing psutil>=0.7.1 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', '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 0x104df5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e05420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed805ace70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c94e00>, '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 0x104afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c8fb20>, '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.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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', 'psutil>=0.7.1'] 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 psutil>=0.7.1 04:07:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 04:07:03 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:04 INFO - Downloading/unpacking psutil>=0.7.1 04:07:04 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:04 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:04 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:04 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:04 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:04 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:06 INFO - Installing collected packages: psutil 04:07:06 INFO - Running setup.py install for psutil 04:07:06 INFO - building 'psutil._psutil_osx' extension 04:07:06 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:07 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:07 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:07 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:07 INFO - building 'psutil._psutil_posix' extension 04:07:07 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:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:07:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:07:07 INFO - ^ 04:07:07 INFO - 1 warning generated. 04:07:07 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:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:07 INFO - Successfully installed psutil 04:07:07 INFO - Cleaning up... 04:07:07 INFO - Return code: 0 04:07:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:07:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:07 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 0x104df5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e05420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed805ace70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c94e00>, '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 0x104afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c8fb20>, '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.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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:07 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:07 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:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vYSuPz75LJ/Render', 04:07:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:07 INFO - 'HOME': '/Users/cltbld', 04:07:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:07 INFO - 'LOGNAME': 'cltbld', 04:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:07 INFO - 'MOZ_NO_REMOTE': '1', 04:07:07 INFO - 'NO_EM_RESTART': '1', 04:07:07 INFO - 'PAGER': '/bin/cat', 04:07:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:07 INFO - 'PWD': '/builds/slave/test', 04:07:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:07 INFO - 'SHELL': '/bin/bash', 04:07:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOtZy0pekO/Listeners', 04:07:07 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 04:07:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:07 INFO - 'USER': 'cltbld', 04:07:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:07 INFO - 'XPC_FLAGS': '0x0', 04:07:07 INFO - 'XPC_SERVICE_NAME': '0', 04:07:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:10 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:10 INFO - Installing collected packages: mozsystemmonitor 04:07:10 INFO - Running setup.py install for mozsystemmonitor 04:07:10 INFO - Successfully installed mozsystemmonitor 04:07:10 INFO - Cleaning up... 04:07:10 INFO - Return code: 0 04:07:10 INFO - Installing blobuploader==1.2.4 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', '--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 0x104df5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e05420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed805ace70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c94e00>, '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 0x104afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c8fb20>, '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.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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', '--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:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:07:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 04:07:10 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:07:10 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:10 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:10 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:10 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:10 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:10 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:13 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:07:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:14 INFO - Downloading docopt-0.6.1.tar.gz 04:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:14 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:14 INFO - Running setup.py install for blobuploader 04:07:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:07:14 INFO - Running setup.py install for requests 04:07:15 INFO - Running setup.py install for docopt 04:07:15 INFO - Successfully installed blobuploader requests docopt 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', '--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 0x104df5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e05420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed805ace70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c94e00>, '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 0x104afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c8fb20>, '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.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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', '--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:15 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:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 04:07:15 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-WxdyN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:15 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-wlUNLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:15 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-g27eA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:15 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-oTHwnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:16 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-C58fmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:16 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-MP73cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:16 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Ji75v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:16 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-EJ2cUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:16 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-dTkyRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:16 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-ZUw8oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:16 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-QMM16n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:16 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-D2nR8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:16 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-qqtOls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:17 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-QQIC99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:17 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-H8OBpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:17 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-pfue4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:17 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-dc1Gc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:17 INFO - Running setup.py install for manifestparser 04:07:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:07:17 INFO - Running setup.py install for mozcrash 04:07:17 INFO - Running setup.py install for mozdebug 04:07:17 INFO - Running setup.py install for mozdevice 04:07:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:07:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:07:18 INFO - Running setup.py install for mozfile 04:07:18 INFO - Running setup.py install for mozhttpd 04:07:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:07:18 INFO - Running setup.py install for mozinfo 04:07:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:07:18 INFO - Running setup.py install for mozInstall 04:07:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:07:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:07:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:07:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:07:18 INFO - Running setup.py install for mozleak 04:07:18 INFO - Running setup.py install for mozlog 04:07:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:07:18 INFO - Running setup.py install for moznetwork 04:07:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:07:19 INFO - Running setup.py install for mozprocess 04:07:19 INFO - Running setup.py install for mozprofile 04:07:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:07:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:07:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:07:19 INFO - Running setup.py install for mozrunner 04:07:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:07:19 INFO - Running setup.py install for mozscreenshot 04:07:19 INFO - Running setup.py install for moztest 04:07:19 INFO - Running setup.py install for mozversion 04:07:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:07:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:19 INFO - Cleaning up... 04:07:19 INFO - Return code: 0 04:07:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 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 0x104df5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e05420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed805ace70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c94e00>, '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 0x104afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c8fb20>, '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.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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:19 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:19 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:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vYSuPz75LJ/Render', 04:07:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:20 INFO - 'HOME': '/Users/cltbld', 04:07:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:20 INFO - 'LOGNAME': 'cltbld', 04:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:20 INFO - 'MOZ_NO_REMOTE': '1', 04:07:20 INFO - 'NO_EM_RESTART': '1', 04:07:20 INFO - 'PAGER': '/bin/cat', 04:07:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:20 INFO - 'PWD': '/builds/slave/test', 04:07:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:20 INFO - 'SHELL': '/bin/bash', 04:07:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOtZy0pekO/Listeners', 04:07:20 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 04:07:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:20 INFO - 'USER': 'cltbld', 04:07:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:20 INFO - 'XPC_FLAGS': '0x0', 04:07:20 INFO - 'XPC_SERVICE_NAME': '0', 04:07:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:20 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-TTRIbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:20 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-ynz99Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:20 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-30U8cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:20 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-qqLPof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:20 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-rVNCHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:20 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-sTYwry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:20 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-nkGfB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:21 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-nRDG4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:21 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-caWMj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:21 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-_upWTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:21 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-dQt4Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:21 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-dQSSni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:21 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-UyIAL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:21 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-KCtnDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:21 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-0RrOZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:21 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-wGOk03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:21 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-ZiCYH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:22 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:22 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:22 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:22 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:22 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:22 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 blessings-1.6.tar.gz 04:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:24 INFO - Installing collected packages: blessings 04:07:24 INFO - Running setup.py install for blessings 04:07:24 INFO - Successfully installed blessings 04:07:24 INFO - Cleaning up... 04:07:24 INFO - Return code: 0 04:07:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:25 INFO - Reading from file tmpfile_stdout 04:07:25 INFO - Current package versions: 04:07:25 INFO - blessings == 1.6 04:07:25 INFO - blobuploader == 1.2.4 04:07:25 INFO - docopt == 0.6.1 04:07:25 INFO - manifestparser == 1.1 04:07:25 INFO - mozInstall == 1.12 04:07:25 INFO - mozcrash == 0.17 04:07:25 INFO - mozdebug == 0.1 04:07:25 INFO - mozdevice == 0.48 04:07:25 INFO - mozfile == 1.2 04:07:25 INFO - mozhttpd == 0.7 04:07:25 INFO - mozinfo == 0.9 04:07:25 INFO - mozleak == 0.1 04:07:25 INFO - mozlog == 3.1 04:07:25 INFO - moznetwork == 0.27 04:07:25 INFO - mozprocess == 0.22 04:07:25 INFO - mozprofile == 0.28 04:07:25 INFO - mozrunner == 6.11 04:07:25 INFO - mozscreenshot == 0.1 04:07:25 INFO - mozsystemmonitor == 0.0 04:07:25 INFO - moztest == 0.7 04:07:25 INFO - mozversion == 1.4 04:07:25 INFO - psutil == 3.1.1 04:07:25 INFO - requests == 1.2.3 04:07:25 INFO - wsgiref == 0.1.2 04:07:25 INFO - Installing None 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', '-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 0x104df5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e05420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed805ace70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c94e00>, '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 0x104afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c8fb20>, '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.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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', '-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:25 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:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 04:07:25 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 - 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:25 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:25 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:25 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:25 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:25 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:25 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:25 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:25 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:25 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:25 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:25 INFO - Cleaning up... 04:07:25 INFO - Return code: 0 04:07:25 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104df5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e05420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed805ace70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c94e00>, '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 0x104afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c8fb20>, '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.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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', 'jsonschema'] 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 jsonschema 04:07:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 04:07:25 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 jsonschema 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 jsonschema-2.5.1-py2.py3-none-any.whl 04:07:28 INFO - Downloading/unpacking functools32 (from jsonschema) 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 functools32-3.2.3-2.tar.gz 04:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:28 INFO - warning: no files found matching '*.txt' 04:07:28 INFO - no previously-included directories found matching 'build' 04:07:28 INFO - no previously-included directories found matching 'dist' 04:07:28 INFO - no previously-included directories found matching '.git*' 04:07:28 INFO - Installing collected packages: jsonschema, functools32 04:07:28 INFO - Running setup.py install for functools32 04:07:28 INFO - warning: no files found matching '*.txt' 04:07:28 INFO - no previously-included directories found matching 'build' 04:07:28 INFO - no previously-included directories found matching 'dist' 04:07:28 INFO - no previously-included directories found matching '.git*' 04:07:28 INFO - Successfully installed jsonschema functools32 04:07:28 INFO - Cleaning up... 04:07:28 INFO - Return code: 0 04:07:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104df5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e05420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed805ace70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c94e00>, '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 0x104afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c8fb20>, '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.vYSuPz75LJ/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.yOtZy0pekO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:07:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vYSuPz75LJ/Render', 04:07:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:28 INFO - 'HOME': '/Users/cltbld', 04:07:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:28 INFO - 'LOGNAME': 'cltbld', 04:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:28 INFO - 'MOZ_NO_REMOTE': '1', 04:07:28 INFO - 'NO_EM_RESTART': '1', 04:07:28 INFO - 'PAGER': '/bin/cat', 04:07:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:28 INFO - 'PWD': '/builds/slave/test', 04:07:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:28 INFO - 'SHELL': '/bin/bash', 04:07:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOtZy0pekO/Listeners', 04:07:28 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 04:07:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:28 INFO - 'USER': 'cltbld', 04:07:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:28 INFO - 'XPC_FLAGS': '0x0', 04:07:28 INFO - 'XPC_SERVICE_NAME': '0', 04:07:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:29 INFO - Downloading/unpacking flake8 04:07:29 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:29 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 - 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:29 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:29 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:29 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:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:07:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:07:31 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:31 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:31 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:31 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:31 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:31 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:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:07:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:33 INFO - no previously-included directories found matching 'docs/_build' 04:07:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:07:33 INFO - Running setup.py install for pep8 04:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:33 INFO - no previously-included directories found matching 'docs/_build' 04:07:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:07:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:07:33 INFO - Cleaning up... 04:07:33 INFO - Return code: 0 04:07:33 INFO - Running post-action listener: _resource_record_post_action 04:07:33 INFO - Running post-action listener: _start_resource_monitoring 04:07:33 INFO - Starting resource monitoring. 04:07:33 INFO - ##### 04:07:33 INFO - ##### Running install step. 04:07:33 INFO - ##### 04:07:33 INFO - Running pre-action listener: _resource_record_pre_action 04:07:33 INFO - Running main action method: install 04:07:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:33 INFO - Reading from file tmpfile_stdout 04:07:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:33 INFO - Reading from file tmpfile_stdout 04:07:33 INFO - Output received: 04:07:33 INFO - Usage: mozinstall [options] installer 04:07:33 INFO - Options: 04:07:33 INFO - -h, --help show this help message and exit 04:07:33 INFO - -d DEST, --destination=DEST 04:07:33 INFO - Directory to install application into. [default: 04:07:33 INFO - "/builds/slave/test"] 04:07:33 INFO - --app=APP Application being installed. [default: firefox] 04:07:33 INFO - mkdir: /builds/slave/test/build/application 04:07:33 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:33 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:55 INFO - Reading from file tmpfile_stdout 04:07:55 INFO - Output received: 04:07:55 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:07:55 INFO - Running post-action listener: _resource_record_post_action 04:07:55 INFO - ##### 04:07:55 INFO - ##### Running run-tests step. 04:07:55 INFO - ##### 04:07:55 INFO - Running pre-action listener: _resource_record_pre_action 04:07:55 INFO - Running main action method: run_tests 04:07:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:07:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:07:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:07:55 INFO - 2016-07-07 04:07:55.403 screenresolution[1985:10237] starting screenresolution argv=screenresolution get 04:07:55 INFO - 2016-07-07 04:07:55.405 screenresolution[1985:10237] Display 0: 1600x1200x32@60 04:07:55 INFO - 2016-07-07 04:07:55.411 screenresolution[1986:10240] starting screenresolution argv=screenresolution list 04:07:55 INFO - Available Modes on Display 0 04:07:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:07:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:07:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:07:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:07:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:07:55 INFO - Intel Iris: 04:07:55 INFO - Chipset Model: Intel Iris 04:07:55 INFO - Type: GPU 04:07:55 INFO - Bus: Built-In 04:07:55 INFO - VRAM (Dynamic, Max): 1536 MB 04:07:55 INFO - Vendor: Intel (0x8086) 04:07:55 INFO - Device ID: 0x0a2e 04:07:55 INFO - Revision ID: 0x0009 04:07:55 INFO - Displays: 04:07:55 INFO - Display: 04:07:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:07:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:07:55 INFO - Display Serial Number: 1600x1200 60 04:07:55 INFO - Main Display: Yes 04:07:55 INFO - Mirror: Off 04:07:55 INFO - Online: Yes 04:07:55 INFO - Rotation: Supported 04:07:55 INFO - Return code: 0 04:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:55 INFO - Python 2.7.3 04:07:55 INFO - Return code: 0 04:07:55 INFO - grabbing minidump binary from tooltool 04:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:55 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 0x104c94e00>, '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 0x104afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c8fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:55 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:55 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:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:55 INFO - Return code: 0 04:07:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:07:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:07:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:07:56 INFO - Return code: 0 04:07:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0122 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:07:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vYSuPz75LJ/Render', 04:07:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:56 INFO - 'HOME': '/Users/cltbld', 04:07:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:56 INFO - 'LOGNAME': 'cltbld', 04:07:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:56 INFO - 'MOZ_NO_REMOTE': '1', 04:07:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:56 INFO - 'NO_EM_RESTART': '1', 04:07:56 INFO - 'PAGER': '/bin/cat', 04:07:56 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:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:56 INFO - 'PWD': '/builds/slave/test', 04:07:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:56 INFO - 'SHELL': '/bin/bash', 04:07:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOtZy0pekO/Listeners', 04:07:56 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 04:07:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:56 INFO - 'USER': 'cltbld', 04:07:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:56 INFO - 'XPC_FLAGS': '0x0', 04:07:56 INFO - 'XPC_SERVICE_NAME': '0', 04:07:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:07:57 INFO - mozversion application_buildid: 20160706215822 04:07:57 INFO - mozversion application_changeset: d142c49033c015f67272562b37dbe2912cfc7f14 04:07:57 INFO - mozversion application_display_name: Firefox 04:07:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:57 INFO - mozversion application_name: Firefox 04:07:57 INFO - mozversion application_remotingname: firefox 04:07:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:07:57 INFO - mozversion application_vendor: Mozilla 04:07:57 INFO - mozversion application_version: 48.0 04:07:57 INFO - mozversion platform_buildid: 20160706215822 04:07:57 INFO - mozversion platform_changeset: d142c49033c015f67272562b37dbe2912cfc7f14 04:07:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:07:57 INFO - mozversion platform_version: 48.0 04:07:57 INFO - using testdate: 1467889677 04:07:57 INFO - actual date: 1467889677 04:07:57 INFO - starting webserver on 'localhost:49389' 04:07:57 INFO - SUITE-START | Running 2 tests 04:07:57 INFO - TEST-START | dromaeo_css 04:07:57 INFO - operating with platform_type : mac_ 04:07:57 INFO - Initialising browser for dromaeo_css test... 04:07:57 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpX1sQIb/profile http://localhost:49389/getInfo.html) 04:07:59 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 04:07:59 INFO - PROCESS | 2004 | colorDepth:24 04:07:59 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 04:07:59 INFO - PROCESS | 2004 | __metrics 04:07:59 ERROR - PROCESS | 2004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:08:00 INFO - TEST-INFO | 2004: exit 0 04:08:00 INFO - Browser initialized. 04:08:00 INFO - Running cycle 1/1 for dromaeo_css test... 04:08:00 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpX1sQIb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:12 INFO - PROCESS | 2008 | RSS: Main: 171081728 04:08:12 INFO - PROCESS | 2008 | 04:09:02 INFO - PROCESS | 2008 | 1467889742125 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:12 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49389/tests/dromaeo/cssquery-ext.html) 04:11:13 INFO - PROCESS | 2008 | RSS: Main: 184954880 04:11:13 INFO - PROCESS | 2008 | 04:14:15 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-ext.html (next: http://localhost:49389/tests/dromaeo/cssquery-jquery.html) 04:14:16 INFO - PROCESS | 2008 | RSS: Main: 194748416 04:14:16 INFO - PROCESS | 2008 | 04:17:17 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49389/tests/dromaeo/cssquery-mootools.html) 04:17:18 INFO - PROCESS | 2008 | RSS: Main: 197181440 04:17:18 INFO - PROCESS | 2008 | 04:20:20 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49389/tests/dromaeo/cssquery-prototype.html) 04:20:20 INFO - PROCESS | 2008 | RSS: Main: 200585216 04:20:20 INFO - PROCESS | 2008 | 04:23:23 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49389/tests/dromaeo/cssquery-yui.html) 04:23:24 INFO - PROCESS | 2008 | RSS: Main: 199516160 04:23:24 INFO - PROCESS | 2008 | 04:26:26 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-yui.html (next: http://localhost:49389/tests/dromaeo/cssquery-dojo.html) 04:26:26 INFO - PROCESS | 2008 | RSS: Main: 204509184 04:26:26 INFO - PROCESS | 2008 | 04:26:26 INFO - PROCESS | 2008 | __start_tp_report 04:26:26 INFO - PROCESS | 2008 | _x_x_mozilla_page_load 04:26:26 INFO - PROCESS | 2008 | _x_x_mozilla_page_load_details 04:26:26 INFO - PROCESS | 2008 | |i|pagename|runs| 04:26:26 INFO - PROCESS | 2008 | |0;dojo.html;3493.8078405687684;3659.743817932744;3682.263547290539;3713.9071523211915;3718.423644335129;5957.463828255456;5992.071228959508;5997.610155339906;6001.3698561650945;6011.068284415917;5008.799648014085;5963.761449542013;5972.223610930573;6027.668478233695;6034.69826508675;5037.219231019189;5342.252084708144;5401.972990135064;5429.267048948381;5490.6431081979545;4320.82716691332;5371.248025276464;5390.8921821563545;5426.186072089179;5479.890402191953;5411.621186516945;5419.701916394597;5423.864403389927;5457.345118585776;5459.727013649322;5416.485433883755;5418.051840927822;5437.755301011444;5461.208124821918;5509.559235261169;5220.634555581111;5261.894762104736;5310.946890531084;5336.012837625013;5356.9732151339385;4333.4366532350905;5778.42215778423;5841.7371218295275;5845.678487683176;5898.292204935392;6250.593711408789;6274.592151510137;6298.181236439279;6327.651979141146;6350.650714210717;6239.188905442264;6244.313125556185;6286.025666021774;6308.463780578656;6332.271788744261;6046.304674962347;6048.243969503812;6071.958789593747;6078.452939235446;6103.29812071613;6368.235811702625;6467.320931302145;6501.934980650228;6505.772297969548;6509.02364645307;5127.435982041972;6211.2857021443115;6246.75012999484;6249.062640603855;6289.056641503811;6331.430171284606;6338.334474880164;6360.650164241011;6360.777372792023;6397.264314603787;5159.871003224949;6131.346082861964;6220.844478888064;6266.216722909637;6274.592151510137;6206.565540412128;6277.780277690259;6278.623282602967;6289.088082228142;6314.842128946813;5059.19052951526;5092.312537807348;5104.310918026019;5109.335786347825;5128.230765385148;4527.728336299832;4563.95436045642;4600.102979918951;4626.537346265414;4635.837745678952;6105.664188469588;6113.141862489121;6143.109249158847;6175.96912015437;6224.159738435344;6351.650659213695;6370.8088757337355;6413.358664133642;6418.1656384669695;6445.323241059715;5293.20601909709;6058.363871793486;6215.782447614402;6218.378162183745;6226.875462490725;4332.956670433318;5635.436456354331;5648.15277708347;5653.9151912721345;5676.772929082873;6649.833754156088;6663.167104111986;6672.165979252593;6680.064790929274;6707.42986846104;6008;6030.643105301272;6390.041493775971;6404.391582799627;6424.614523128627;6638.83402914931;6663.000549917551;6669.333066693292;6695.464362851058;6702.631355275506;6296.244450665767;6297.1813664223355;6308.842278943063;6312.495000399865;6320.841978950563;6224.9377506224355;6304.05439184126;6345.460635846005;6380.3619638035825;6384.425401713868;6183.598066125687;6229.906551401823;6232.407921247474;6238.6880655967925;6259.436650701458;6193.947029004989;6235.00239961604;6251.937480625317;6252.062190671254;6262.09199666055;6087.786927457518;6096.481799046954;6096.725647345791;6178.351273116438;6183.659898705614;6144.508439324753;6145.907811382744;6167.6916154193;6227.719752611234;6244.0321750128805;6120.54095942815;6223.844403889939;6226;6231.314555398993;6238.344973777688 04:26:26 INFO - PROCESS | 2008 | |1;ext.html;523.4268476018758;551.1457241276022;556.3657430529195;590.8109404990404;601.0533409879441;40011.79994100029;41139.58860411395;41184.38223426651;41254.79372603136;41293.7935310323;42791.57208427915;42959.78520107403;43189;43306.700798976;43608.34587481182;9681.999999999982;9870.851937220947;9913.058259465339;9913.454759988197;9923.354981926188;9889.208863290956;10020.59917603295;10032.147267482273;10060.949695251513;10089.495525223747;10032.949835250814;10047.246456515753;10055.39667619945;10103.444310562953;10125;10038.247131465168;10043.598256069748;10105.141063009616;10164.644237451654;10170.59317627294;9735.90264097357;9837.90162098377;9855.655052073143;9863.35888167274;9884.802303953953;41881;42032.73901782921;42120;42135.7893210532;42244.36633450501;2985.925351866199;3244.561984132159;3267.15054085937;3378.341223461426;3462.4286992646184;30029.549556756665;30054;30654.846725766452;30757.384852303054;32061.358772824646;2777.805553611248;2831.0374472679387;2844.630198074237;2856.557233628791;2859.6139521164587;387325;397701.0229897722;397735.0226497727;399617;401076;39157;65959;66293.668531658;66339;66699;38254;38343;38352.42471362932;38420.61579384226;38434.42348364777;12708.491660333482;13737.931310343583;16444.342226310815;16535.173241337885;16797.91601041987;13803;13885.583432497042;14106.871450283952;14116.858831411555;14216;7466.962665186639;8387.916120838836;8401.70594029206;8413.326933845277;8571.828563428697;3511.9122021949142;3556.448750443685;3583.749137560346;3606.2607165531003;3631.055925459347;879.9792241000408;1059.6450189186555;1077.4451157653814;1092.8415379770047;1186.6973921650097;29594;30848.074557763302;30909.227269318;31034.224144396572;31617.57720902519;1140.1164097824087;1192.8151136573845;1201.783678937782;1250.9492026697617;1264.9936750316374;12971.41628626714;15715.371385144696;16040.877138600186;16053;16479.670406592042;620849;625410;627940;636327;637503;63843.680781595795;64499.35500644933;64721;64742.35257647457;64749;1544.6447317117127;1565.5694683962001;1572.481081243187;1579.3287852662572;1584.207896051974;30544.698710107026;30556.236094097825;30678.84660576772;31108.911188108308;31188.68811311858;56349;56468.717656411456;56545;56749;57097.85804283808;460119;526984;550606.2469687626;552527;558991.8201636026;28025.579616305364;28698.99553515617;44616.55383446124;45755.31367029564;46028.928698207994;31581;36585.16032774384;47158;48282.5171748278;48430.789230269525;37749.81125094357;38886.41670375003;39124.630637927534;39298.2140357197;39394.2121157581;36802.8159859199;37021.62978370182;37427.81286093552;37655.43516847304;38182;38014.80992595019;38213.42679859749;38840.80579597084;38886.4167037489;39505.407418888164;32034;33744.98765037053;33748.662513374555;33884.32231355408;34108.63565457453;25305.62041569341;25408.872955635103;25842.224733258034;25852.61221081648;26658.866705666347 04:26:26 INFO - PROCESS | 2008 | |2;jquery.html;400.5093760143822;417.75978812182984;419.46937124537453;423.08402309001013;425.25367979196517;18335.54161145969;20209.494762630922;20906;20934;21170;20719.896400517977;20878;21190.83450410227;21690.0239489223;21797.891010544965;5814.09881468371;5925.407459254073;6129.754809807602;6143.170671959296;6145.231846019247;5821.330546987108;6077.848053798668;6130.325664176937;6882.965585172092;6934.757283495053;6850;6885.9326804345155;6888.862222755542;6900.689468973883;6913.861722765541;6577.210734711842;6851.177858656968;6853.588784672886;6897.068895699092;6897.999790030468;6048.092786082123;6104.847378815565;6129.264488261392;6132.662703551303;6157.507399408037;13420.32898355088;14121.505747298897;24969.750302497105;26181;26190;2140.3044010696585;2196.198387588535;2380.571497130516;2657.946841063187;2754.476649436601;9751.414915105046;9776.462294573796;10020.69937901864;10116.797664046679;10132.088112069876;1727.6890159771235;1743.7210046392643;1775.2100315359671;1844.0687452836366;1847.1503108570073;80775;89129.66305505423;105062;107151.46424267828;110873;11942.582009629621;12148.149629526026;12181;12185;12209.938950305192;14093.78859317111;14906.478273260384;15332.386704531917;15484;15487.070775753491;9137.223336016514;9279.257659387367;9427.340086194037;9429.245660347156;9513.381630194015;9298.907010929805;9326;9327.906720932839;9397.76505587352;9420.43477391345;4723.331317805429;4886.3403440535785;4899.6570240083565;4914.198512873912;4914.36113305268;2039.8275836234363;2075.6678931370907;2080.739907511561;2085.8411544052137;2092.455961450034;947.8530827721714;972.5526257921294;997.7705127820642;1045.1482042135635;1109.8113320735495;16498.6700265994;19002.334918277793;19808.306709265107;20082.297119600746;20314.695279570817;934.6401635370431;1013.9442330671884;1031.8555402243692;1049.7270709615555;1116.3636727065657;10858.67423977282;10910.672679819618;10996;11034.227604067799;11042.558297668164;577518;580746;603943;633754;648366;119609;120640.79359206295;121586;121840;122349;1051.9105876000472;1053.4364115198332;1063.7819247054335;1073.736934451049;1089.9128069754402;18228.56203321253;18386.632267354846;18541.81458185455;18569.44291671252;19022.80977190266;39784.80107599444;49166.26250606172;49810;52152.95694086173;53593.73203133959;72861.90707139291;74242;76624.61687691526;78362.21637783549;82405;12102.515899363927;12598.622041338775;12720.87279127197;12836.16564923277;13066.869331306565;13425.194488330731;13551.52569660057;13738.793918091436;13931.651708707363;13987.230702311064;7786.33816125613;9742.805143896941;11835.408229588658;11976.28142311464;12088.637340879788;11634.301941883514;11637.359945203096;11694.47374868116;11721.41392930333;11924.284542927453;11746.530138794353;12036.939815300868;12055.336956467478;12058.095642826647;12225.877741222474;12370.938145309216;12406.81389779136;12473.064520161206;12775.744485110432;12812.61562153137;11679.416029198675;11817.468213930222;11842.28946263227;11863.050955923332;12079.758404831678 04:26:26 INFO - PROCESS | 2008 | |3;mootools.html;1573.9449119280823;1647.7281248593986;1861.9441416757486;1983.2265416487573;2048.150017742636;8470.576471176448;9163.404378715379;9187.77030574236;9506.334556581034;9545.952270238648;9235.584398702058;9247.12152345526;9320.533973301324;9342.392744471621;9361.438313701183;2555.118484122979;2572;2574.201997380818;2574.806889483287;2580.2775222937607;2529.178017144426;2575.111586502663;2586.5085633729627;2587.40489687372;2590.0287392227915;2551.1963731424635;2574.4295979452518;2599.5840665493524;2613.908513202038;2615.411532405203;2576.948461030778;2578.419855532509;2591.222633210048;2592.41670624109;2605.2184344696516;2570.2160840943507;2593.1442623934245;2599.4930988457068;2617.594272887686;2618.4370360372614;9463.668771592962;9510.38182518141;9526.428414295164;9555.092266234697;9615.086566776145;5643.322801263834;5648.068068768648;5657.547396208334;5666.943330566724;5777.942220577783;3612.5664920209742;3755.192633583765;3755.8497660093562;3760.4547340635727;3785.5835858055593;1042.2183362478142;1062.3731998121145;1070.1920050361928;1105.4528008635696;1107.2194103157256;12148.271103733805;12159.939200303941;12180.878191218064;12187.451564679523;12204.633860984184;4973.079980203602;4996.625253106032;5047.747612619428;5065.544101030925;5116.9744151279;10174.796504069876;10175.592976281014;10218.131458825934;10292.228082893664;10352.275340726077;5702.914456283159;5710.942890571124;5724.370319264877;5730.598858079894;5767.596268261182;4664.906701866012;5107.770150343244;5244.737763111829;5255.001549705544;5286.656367336111;4347.7173983690955;4348.152110338517;4387.978060109679;4433.7118087324225;4439.200943830077;1397.343248673122;1413.6395219219032;1419.332913530639;1421.630376102221;1429.6640289531952;869.4348673362365;946.3706635087727;961.2262128986093;978.1636700621009;980.4068538534084;6132.724027418777;6174.197354343996;6298.8425289367215;6307.873842523124;6326.620402775849;483.37644438673715;494.2857570810145;496.4365445219702;501.2456253338702;503.0341743851813;3514.666106719909;3837.4819399381286;4127.33962565988;4197.076643138505;4209.34755112958;9515.286353523514;9583.75411196554;10589.099926506333;10677.62628308021;11053.115750739922;10872.67381978542;10924.180686448548;11051.668449946514;11086.667399978014;11176.385298808644;8482.957585212034;8728.389012769172;8758.211760941545;8950.731478055668;8953.462792232487;5099.92350114756;6018.699065046818;6055;6097.451229389376;6313.08460273267;7925.445218834626;8720;9780.902190977999;10219.693409197736;10266.127379172554;7486.326230639051;9890.653827116017;10592.205584581034;10630.30902991303;10822.891771082188;7220.3140701633265;7680.500767450098;7740.3420709240345;7830.608469576612;7898.407619428451;8616.095309992612;8672.392932494664;8676.392652514263;8677.652893884175;8730.126987301219;7621;7769.494982826324;7805.33654639362;7879.763607091796;7981.48120372174;7695.615219238904;7709.691612335444;7717.18969508216;7803.7268695595385;7807;7011.018457415864;7022.12223472066;7107.18267399235;7132.500724949204;7137.714491420285;4996.6002719783055;5025.095482813129;5147.2279158126585;5235.397929238034;5256.605754568346;5155.793768249228;5200.063988482109;5264.447233040476;5415.377231618414;5437.728113594384 04:26:26 INFO - PROCESS | 2008 | |4;prototype.html;339.08616279127745;342.4469481786915;343.2585615071445;348.7837540724751;350.2190116041228;6873.587584744919;6927.7921662350145;6961.582305061694;7022.15734111906;7059.188193357765;6879.071325371074;6899.413549848269;6920.861582768342;6921.5847049176955;6995.335443132907;5094;5097.974510127444;5102.1836506159025;5112.233165025239;5112.539871411591;4863.927041094369;4949.653524253304;5066.594672426216;5083.79664813407;5097.209932460474;3721.7022638189014;5001.17480615698;5015.971725796203;5019.84940451787;5080.466551012146;5029.2958985742025;5035.068512325213;5046.949530504685;5058.4688607696025;5060.342155519796;4351.28203846365;4352.91294174118;4365.3451982202605;4365.367021781855;4374.628156606692;6722.327767223287;6723.630200338979;6742;6746.291639377893;6768.49236307274;4627.5603817637275;4719.315699223627;5752.5110365618975;5933.406659334075;5947.167396564484;7390.889136662954;7395.334419902181;7433.479656424052;7433.814154646123;7434.665440055211;4764.666473346867;4769.022350418156;4769.403824521934;4779.856604301876;4795.568398844086;7848.254415830487;7923.049234091888;7927.603619818986;7954.840903181962;7960.960195199045;3585.032041348821;3706.666400023957;4157.272477316457;4579.542045795394;4686.554777296152;4055.2903241932545;4108.260513107669;4892.657513973988;4922.704637721748;4957.380327459067;5918.704064796829;5919.289685237799;5923.733431995484;5959.314678811906;5975.581709280309;7511.624418779039;7542.170361260257;7544.962275188699;7564.773056808304;7565.583892885834;1410.330093205719;1706.4283465039102;1734.9392771252947;1736.4530172995467;1740.1473278093897;931.3061768982152;1051.2063392138887;1083.7019819549687;1095.2114477576133;1096.4627332607124;7039.753608623776;7082.822929426806;7144.9285507145305;7151.570905745672;7165.713371465187;7327;7838.764837054898;7841.607919603997;7845.960770196227;7875.054993400829;6913.654317284116;7017.333353331425;7124.643767811589;7146.571205727569;7232;4148.896277593084;4159.480064991876;4163.437935878678;4187.288161012635;4198.307279298942;8323.583820808935;8358.791030224293;8361.372897032747;8362.121977192308;8424.28393586552;6348.492120630339;7979.6035693753365;8137.145599712064;8152.551609661526;8170.714025009096;8000.91987581669;8332.791680208044;8334.249917507332;8340.457870238537;8344.666213351398;7875.448718589644;7927.801804954922;7940.801479963047;7951.045874494866;7955.0851652060755;7265.9273407267365;7750.263724946121;7752.224777522202;7759.883601746092;7777.766666999999;6791;8327.625256863577;8335.208155225244;8345.95827020861;8373.95813020931;4850.490698476609;4871.732054737024;4915.1644220481885;4937.333459982857;4943.925841112315;7877.409194310564;7883.251091146332;7884.172161923145;7889.802754931173;7903.407244456574;7613.809654758676;7614.124375696866;7638.427117966286;7640;7653.617319134132;7302.123745150403;7496.287852653989;7519.812004699927;7570.545767253982;7597.924020759942;7328.78013659591;7359.153697324876;7405.370543503863;7419.851602968019;7448.813779655552;6708.83227919306;6963.990221417765;7070.974708667111;7077.716891324495;7630.198829122862;6448.5486015980305;7182.245864184394;7414.184439711736;7435.7025718970635;7474.551526908403 04:26:26 INFO - PROCESS | 2008 | |5;yui.html;645.6029541831773;765.731993802169;771.5263846054035;789.5657388436363;790.4269404681605;15236.61908452288;15348.232588370578;15480.767788483181;15493.690126197469;15504.992175508598;14094;14419.78370324446;14426.711465770679;14431.855681443183;14469.927650361733;819.1194465949098;990.8266053440638;992.3748038735587;998.7453199434134;1025.4513835098223;952.0051546134272;953.9093786090345;1009.0867764672983;1014.3406785589352;1016.6746641074859;1004.9045340692622;1064.1008347946013;1066.3921564708119;1070.7002039428933;1072.5066469424075;998.2313618513776;1021.7752094539189;1043.3739756146326;1054.4833031814433;1058.2380685906135;748.5620911766623;767.2749251956903;775.7284950267418;790.4624855098531;790.6402586822982;15096.924515377463;15106.942514024022;15307.158106304149;15316.234188290653;15369.538913832603;13042.347882605927;13044.347782610832;13063.216207027608;13196.934015329862;13281.203127812265;9907.950460247652;10076.042775936274;10078.697639070766;10136.847947280796;10181.541830617565;3419.6321471411384;3522.5068490411363;3634.254977729559;3634.3639863024127;3744.8314825832904;83021;83525.16474835174;84220.57889710573;85923;86574;9402.717918462457;9450.385724927995;9630.855537166948;9653.276004299705;9717.12545870861;21757.564848702936;21773;21850.907454627522;21874.671879921814;21941.232056877932;7518;7629.504082234637;7684.423668224906;7725.034370703662;7836.686532538749;3626.9093272667865;4093.959060409358;4140.3375459926265;4151.709380343347;4157.147784704129;3696.5009723687494;3707.017640325316;3776.3013842439236;3792.1657235408165;3807.314683357022;655.4559715436177;659.1628631637889;669.3306693306694;678.5148618737528;682.8702546516146;524.7586110389187;525.1728527569094;543.8749087709849;556.1046714789186;594.2957595249557;8108.675652973933;8141.185881411811;8195.795105122419;8311.6675332986;8321.982907006264;542.3275138827904;578.9305283365939;589.1457386789173;606.7167939807364;607.419913982146;3726.5341832270965;3878.5151856017997;3889.2804831106337;3898.5516665583255;4033.334499807499;72907.63546182236;74236.62881685665;90890;93735.53132234432;94337.52831235937;68603.28491787646;76457.61771191108;77776.61111694406;78631.42737145339;78991.21008789839;59563.702181488814;62384;63096.68451657712;67997;70502.64748676223;6987.8253043672285;8354.582270886553;8421.62102705392;8516.957415213132;8556.828863422572;47618.285725713446;48387;48616.75691621519;48869.755651221516;50949.74525127499;59947.400525994184;61827.6908615454;65092;65288;65377.67311163414;10886;10992.17558683086;11161.665150045512;11251.324920504796;11466.827997579876;11980.46087926028;12128.636140915787;12133.575324863941;12176.756464870476;12304.938475307566;11296.83054754163;11317.264377815416;11427.542898283975;11534.769304614028;11907.047436205256;11355.318680879174;11361.977422032056;11476.655700329004;11513.078953683853;11776.868746613723;8837.734867953972;11451.541938322374;11463.541458341573;11480.82778758336;11693.824592630946;9633.08485693858;9778.559964801743;9811.852822207815;9840.261980351646;9859.35914165577;9646.372985755903;9741.610335586498;9839.704808855746;9904.009599040039;9923.255755818487 04:26:26 INFO - PROCESS | 2008 | __end_tp_report 04:26:26 INFO - PROCESS | 2008 | __start_cc_report 04:26:26 INFO - PROCESS | 2008 | _x_x_mozilla_cycle_collect,403 04:26:26 INFO - PROCESS | 2008 | __end_cc_report 04:26:26 INFO - PROCESS | 2008 | __startTimestamp1467890786591__endTimestamp 04:26:26 INFO - PROCESS | 2008 | 04:26:26 INFO - PROCESS | 2008 | ------- Summary: start ------- 04:26:26 INFO - PROCESS | 2008 | Number of tests: 6 04:26:26 INFO - PROCESS | 2008 | 04:26:26 INFO - PROCESS | 2008 | [#0] dojo.html Cycles:165 Average:5889.48 Median:6175.97 stddev:664.64 (10.8%) stddev-sans-first:639.56 04:26:26 INFO - PROCESS | 2008 | Values: 3493.8 3659.7 3682.3 3713.9 3718.4 5957.5 5992.1 5997.6 6001.4 6011.1 5008.8 5963.8 5972.2 6027.7 6034.7 5037.2 5342.3 5402.0 5429.3 5490.6 4320.8 5371.2 5390.9 5426.2 5479.9 5411.6 5419.7 5423.9 5457.3 5459.7 5416.5 5418.1 5437.8 5461.2 5509.6 5220.6 5261.9 5310.9 5336.0 5357.0 4333.4 5778.4 5841.7 5845.7 5898.3 6250.6 6274.6 6298.2 6327.7 6350.7 6239.2 6244.3 6286.0 6308.5 6332.3 6046.3 6048.2 6072.0 6078.5 6103.3 6368.2 6467.3 6501.9 6505.8 6509.0 5127.4 6211.3 6246.8 6249.1 6289.1 6331.4 6338.3 6360.7 6360.8 6397.3 5159.9 6131.3 6220.8 6266.2 6274.6 6206.6 6277.8 6278.6 6289.1 6314.8 5059.2 5092.3 5104.3 5109.3 5128.2 4527.7 4564.0 4600.1 4626.5 4635.8 6105.7 6113.1 6143.1 6176.0 6224.2 6351.7 6370.8 6413.4 6418.2 6445.3 5293.2 6058.4 6215.8 6218.4 6226.9 4333.0 5635.4 5648.2 5653.9 5676.8 6649.8 6663.2 6672.2 6680.1 6707.4 6008.0 6030.6 6390.0 6404.4 6424.6 6638.8 6663.0 6669.3 6695.5 6702.6 6296.2 6297.2 6308.8 6312.5 6320.8 6224.9 6304.1 6345.5 6380.4 6384.4 6183.6 6229.9 6232.4 6238.7 6259.4 6193.9 6235.0 6251.9 6252.1 6262.1 6087.8 6096.5 6096.7 6178.4 6183.7 6144.5 6145.9 6167.7 6227.7 6244.0 6120.5 6223.8 6226.0 6231.3 6238.3 04:26:26 INFO - PROCESS | 2008 | 04:26:26 INFO - PROCESS | 2008 | [#1] ext.html Cycles:180 Average:65761.12 Median:37702.62 stddev:141018.57 (374.0%) stddev-sans-first:141329.10 04:26:26 INFO - PROCESS | 2008 | Values: 523.4 551.1 556.4 590.8 601.1 40011.8 41139.6 41184.4 41254.8 41293.8 42791.6 42959.8 43189.0 43306.7 43608.3 9682.0 9870.9 9913.1 9913.5 9923.4 9889.2 10020.6 10032.1 10060.9 10089.5 10032.9 10047.2 10055.4 10103.4 10125.0 10038.2 10043.6 10105.1 10164.6 10170.6 9735.9 9837.9 9855.7 9863.4 9884.8 41881.0 42032.7 42120.0 42135.8 42244.4 2985.9 3244.6 3267.2 3378.3 3462.4 30029.5 30054.0 30654.8 30757.4 32061.4 2777.8 2831.0 2844.6 2856.6 2859.6 387325.0 397701.0 397735.0 399617.0 401076.0 39157.0 65959.0 66293.7 66339.0 66699.0 38254.0 38343.0 38352.4 38420.6 38434.4 12708.5 13737.9 16444.3 16535.2 16797.9 13803.0 13885.6 14106.9 14116.9 14216.0 7467.0 8387.9 8401.7 8413.3 8571.8 3511.9 3556.4 3583.7 3606.3 3631.1 880.0 1059.6 1077.4 1092.8 1186.7 29594.0 30848.1 30909.2 31034.2 31617.6 1140.1 1192.8 1201.8 1250.9 1265.0 12971.4 15715.4 16040.9 16053.0 16479.7 620849.0 625410.0 627940.0 636327.0 637503.0 63843.7 64499.4 64721.0 64742.4 64749.0 1544.6 1565.6 1572.5 1579.3 1584.2 30544.7 30556.2 30678.8 31108.9 31188.7 56349.0 56468.7 56545.0 56749.0 57097.9 460119.0 526984.0 550606.2 552527.0 558991.8 28025.6 28699.0 44616.6 45755.3 46028.9 31581.0 36585.2 47158.0 48282.5 48430.8 37749.8 38886.4 39124.6 39298.2 39394.2 36802.8 37021.6 37427.8 37655.4 38182.0 38014.8 38213.4 38840.8 38886.4 39505.4 32034.0 33745.0 33748.7 33884.3 34108.6 25305.6 25408.9 25842.2 25852.6 26658.9 04:26:26 INFO - PROCESS | 2008 | 04:26:26 INFO - PROCESS | 2008 | [#2] jquery.html Cycles:180 Average:34824.67 Median:11397.78 stddev:100953.27 (885.7%) stddev-sans-first:101203.38 04:26:26 INFO - PROCESS | 2008 | Values: 400.5 417.8 419.5 423.1 425.3 18335.5 20209.5 20906.0 20934.0 21170.0 20719.9 20878.0 21190.8 21690.0 21797.9 5814.1 5925.4 6129.8 6143.2 6145.2 5821.3 6077.8 6130.3 6883.0 6934.8 6850.0 6885.9 6888.9 6900.7 6913.9 6577.2 6851.2 6853.6 6897.1 6898.0 6048.1 6104.8 6129.3 6132.7 6157.5 13420.3 14121.5 24969.8 26181.0 26190.0 2140.3 2196.2 2380.6 2657.9 2754.5 9751.4 9776.5 10020.7 10116.8 10132.1 1727.7 1743.7 1775.2 1844.1 1847.2 80775.0 89129.7 105062.0 107151.5 110873.0 11942.6 12148.1 12181.0 12185.0 12209.9 14093.8 14906.5 15332.4 15484.0 15487.1 9137.2 9279.3 9427.3 9429.2 9513.4 9298.9 9326.0 9327.9 9397.8 9420.4 4723.3 4886.3 4899.7 4914.2 4914.4 2039.8 2075.7 2080.7 2085.8 2092.5 947.9 972.6 997.8 1045.1 1109.8 16498.7 19002.3 19808.3 20082.3 20314.7 934.6 1013.9 1031.9 1049.7 1116.4 10858.7 10910.7 10996.0 11034.2 11042.6 577518.0 580746.0 603943.0 633754.0 648366.0 119609.0 120640.8 121586.0 121840.0 122349.0 1051.9 1053.4 1063.8 1073.7 1089.9 18228.6 18386.6 18541.8 18569.4 19022.8 39784.8 49166.3 49810.0 52153.0 53593.7 72861.9 74242.0 76624.6 78362.2 82405.0 12102.5 12598.6 12720.9 12836.2 13066.9 13425.2 13551.5 13738.8 13931.7 13987.2 7786.3 9742.8 11835.4 11976.3 12088.6 11634.3 11637.4 11694.5 11721.4 11924.3 11746.5 12036.9 12055.3 12058.1 12225.9 12370.9 12406.8 12473.1 12775.7 12812.6 11679.4 11817.5 11842.3 11863.1 12079.8 04:26:26 INFO - PROCESS | 2008 | 04:26:26 INFO - PROCESS | 2008 | [#3] mootools.html Cycles:180 Average:5936.16 Median:5103.85 stddev:3258.03 (63.8%) stddev-sans-first:3250.68 04:26:26 INFO - PROCESS | 2008 | Values: 1573.9 1647.7 1861.9 1983.2 2048.2 8470.6 9163.4 9187.8 9506.3 9546.0 9235.6 9247.1 9320.5 9342.4 9361.4 2555.1 2572.0 2574.2 2574.8 2580.3 2529.2 2575.1 2586.5 2587.4 2590.0 2551.2 2574.4 2599.6 2613.9 2615.4 2576.9 2578.4 2591.2 2592.4 2605.2 2570.2 2593.1 2599.5 2617.6 2618.4 9463.7 9510.4 9526.4 9555.1 9615.1 5643.3 5648.1 5657.5 5666.9 5777.9 3612.6 3755.2 3755.8 3760.5 3785.6 1042.2 1062.4 1070.2 1105.5 1107.2 12148.3 12159.9 12180.9 12187.5 12204.6 4973.1 4996.6 5047.7 5065.5 5117.0 10174.8 10175.6 10218.1 10292.2 10352.3 5702.9 5710.9 5724.4 5730.6 5767.6 4664.9 5107.8 5244.7 5255.0 5286.7 4347.7 4348.2 4388.0 4433.7 4439.2 1397.3 1413.6 1419.3 1421.6 1429.7 869.4 946.4 961.2 978.2 980.4 6132.7 6174.2 6298.8 6307.9 6326.6 483.4 494.3 496.4 501.2 503.0 3514.7 3837.5 4127.3 4197.1 4209.3 9515.3 9583.8 10589.1 10677.6 11053.1 10872.7 10924.2 11051.7 11086.7 11176.4 8483.0 8728.4 8758.2 8950.7 8953.5 5099.9 6018.7 6055.0 6097.5 6313.1 7925.4 8720.0 9780.9 10219.7 10266.1 7486.3 9890.7 10592.2 10630.3 10822.9 7220.3 7680.5 7740.3 7830.6 7898.4 8616.1 8672.4 8676.4 8677.7 8730.1 7621.0 7769.5 7805.3 7879.8 7981.5 7695.6 7709.7 7717.2 7803.7 7807.0 7011.0 7022.1 7107.2 7132.5 7137.7 4996.6 5025.1 5147.2 5235.4 5256.6 5155.8 5200.1 5264.4 5415.4 5437.7 04:26:26 INFO - PROCESS | 2008 | 04:26:26 INFO - PROCESS | 2008 | [#4] prototype.html Cycles:180 Average:6095.83 Median:6962.79 stddev:2042.58 (29.3%) stddev-sans-first:2002.08 04:26:26 INFO - PROCESS | 2008 | Values: 339.1 342.4 343.3 348.8 350.2 6873.6 6927.8 6961.6 7022.2 7059.2 6879.1 6899.4 6920.9 6921.6 6995.3 5094.0 5098.0 5102.2 5112.2 5112.5 4863.9 4949.7 5066.6 5083.8 5097.2 3721.7 5001.2 5016.0 5019.8 5080.5 5029.3 5035.1 5046.9 5058.5 5060.3 4351.3 4352.9 4365.3 4365.4 4374.6 6722.3 6723.6 6742.0 6746.3 6768.5 4627.6 4719.3 5752.5 5933.4 5947.2 7390.9 7395.3 7433.5 7433.8 7434.7 4764.7 4769.0 4769.4 4779.9 4795.6 7848.3 7923.0 7927.6 7954.8 7961.0 3585.0 3706.7 4157.3 4579.5 4686.6 4055.3 4108.3 4892.7 4922.7 4957.4 5918.7 5919.3 5923.7 5959.3 5975.6 7511.6 7542.2 7545.0 7564.8 7565.6 1410.3 1706.4 1734.9 1736.5 1740.1 931.3 1051.2 1083.7 1095.2 1096.5 7039.8 7082.8 7144.9 7151.6 7165.7 7327.0 7838.8 7841.6 7846.0 7875.1 6913.7 7017.3 7124.6 7146.6 7232.0 4148.9 4159.5 4163.4 4187.3 4198.3 8323.6 8358.8 8361.4 8362.1 8424.3 6348.5 7979.6 8137.1 8152.6 8170.7 8000.9 8332.8 8334.2 8340.5 8344.7 7875.4 7927.8 7940.8 7951.0 7955.1 7265.9 7750.3 7752.2 7759.9 7777.8 6791.0 8327.6 8335.2 8346.0 8374.0 4850.5 4871.7 4915.2 4937.3 4943.9 7877.4 7883.3 7884.2 7889.8 7903.4 7613.8 7614.1 7638.4 7640.0 7653.6 7302.1 7496.3 7519.8 7570.5 7597.9 7328.8 7359.2 7405.4 7419.9 7448.8 6708.8 6964.0 7071.0 7077.7 7630.2 6448.5 7182.2 7414.2 7435.7 7474.6 04:26:26 INFO - PROCESS | 2008 | 04:26:26 INFO - PROCESS | 2008 | [#5] yui.html Cycles:180 Average:17952.15 Median:25737.25 stddev:24781.13 (96.3%) stddev-sans-first:24816.57 04:26:26 INFO - PROCESS | 2008 | Values: 645.6 765.7 771.5 789.6 790.4 15236.6 15348.2 15480.8 15493.7 15505.0 14094.0 14419.8 14426.7 14431.9 14469.9 819.1 990.8 992.4 998.7 1025.5 952.0 953.9 1009.1 1014.3 1016.7 1004.9 1064.1 1066.4 1070.7 1072.5 998.2 1021.8 1043.4 1054.5 1058.2 748.6 767.3 775.7 790.5 790.6 15096.9 15106.9 15307.2 15316.2 15369.5 13042.3 13044.3 13063.2 13196.9 13281.2 9908.0 10076.0 10078.7 10136.8 10181.5 3419.6 3522.5 3634.3 3634.4 3744.8 83021.0 83525.2 84220.6 85923.0 86574.0 9402.7 9450.4 9630.9 9653.3 9717.1 21757.6 21773.0 21850.9 21874.7 21941.2 7518.0 7629.5 7684.4 7725.0 7836.7 3626.9 4094.0 4140.3 4151.7 4157.1 3696.5 3707.0 3776.3 3792.2 3807.3 655.5 659.2 669.3 678.5 682.9 524.8 525.2 543.9 556.1 594.3 8108.7 8141.2 8195.8 8311.7 8322.0 542.3 578.9 589.1 606.7 607.4 3726.5 3878.5 3889.3 3898.6 4033.3 72907.6 74236.6 90890.0 93735.5 94337.5 68603.3 76457.6 77776.6 78631.4 78991.2 59563.7 62384.0 63096.7 67997.0 70502.6 6987.8 8354.6 8421.6 8517.0 8556.8 47618.3 48387.0 48616.8 48869.8 50949.7 59947.4 61827.7 65092.0 65288.0 65377.7 10886.0 10992.2 11161.7 11251.3 11466.8 11980.5 12128.6 12133.6 12176.8 12304.9 11296.8 11317.3 11427.5 11534.8 11907.0 11355.3 11362.0 11476.7 11513.1 11776.9 8837.7 11451.5 11463.5 11480.8 11693.8 9633.1 9778.6 9811.9 9840.3 9859.4 9646.4 9741.6 9839.7 9904.0 9923.3 04:26:26 INFO - PROCESS | 2008 | -------- Summary: end -------- 04:26:26 INFO - PROCESS | 2008 | 04:26:27 INFO - TEST-INFO | 2008: exit 0 04:26:27 INFO - TEST-OK | dromaeo_css | took 1110055ms 04:26:27 INFO - TEST-START | kraken 04:26:27 INFO - operating with platform_type : mac_ 04:26:27 INFO - Initialising browser for kraken test... 04:26:27 INFO - TEST-INFO | started process 2013 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmp11BOmr/profile http://localhost:49389/getInfo.html) 04:26:29 INFO - PROCESS | 2013 | __metrics Screen width/height:1600/1200 04:26:29 INFO - PROCESS | 2013 | colorDepth:24 04:26:29 INFO - PROCESS | 2013 | Browser inner width/height: 1024/689 04:26:29 INFO - PROCESS | 2013 | __metrics 04:26:29 ERROR - PROCESS | 2013 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:26:30 INFO - TEST-INFO | 2013: exit 0 04:26:30 INFO - Browser initialized. 04:26:30 INFO - Running cycle 1/1 for kraken test... 04:26:30 INFO - TEST-INFO | started process 2017 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmp11BOmr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:42 INFO - PROCESS | 2017 | RSS: Main: 171102208 04:26:42 INFO - PROCESS | 2017 | 04:26:45 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:46 INFO - PROCESS | 2017 | RSS: Main: 183844864 04:26:46 INFO - PROCESS | 2017 | 04:26:48 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-dft) 04:26:49 INFO - PROCESS | 2017 | RSS: Main: 192421888 04:26:49 INFO - PROCESS | 2017 | 04:26:52 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-fft) 04:26:53 INFO - PROCESS | 2017 | RSS: Main: 196059136 04:26:53 INFO - PROCESS | 2017 | 04:26:55 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-oscillator) 04:26:56 INFO - PROCESS | 2017 | RSS: Main: 196861952 04:26:56 INFO - PROCESS | 2017 | 04:26:58 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:58 INFO - PROCESS | 2017 | RSS: Main: 196616192 04:26:58 INFO - PROCESS | 2017 | 04:27:01 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-darkroom) 04:27:02 INFO - PROCESS | 2017 | RSS: Main: 198062080 04:27:02 INFO - PROCESS | 2017 | 04:27:05 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-desaturate) 04:27:06 INFO - PROCESS | 2017 | RSS: Main: 198193152 04:27:06 INFO - PROCESS | 2017 | 04:27:09 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49389/tests/kraken/driver.html?testName=json-parse-financial) 04:27:09 INFO - PROCESS | 2017 | RSS: Main: 198242304 04:27:09 INFO - PROCESS | 2017 | 04:27:11 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:12 INFO - PROCESS | 2017 | RSS: Main: 197873664 04:27:12 INFO - PROCESS | 2017 | 04:27:14 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:14 INFO - PROCESS | 2017 | RSS: Main: 197885952 04:27:14 INFO - PROCESS | 2017 | 04:27:16 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:17 INFO - PROCESS | 2017 | RSS: Main: 197943296 04:27:17 INFO - PROCESS | 2017 | 04:27:20 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:20 INFO - PROCESS | 2017 | RSS: Main: 198017024 04:27:20 INFO - PROCESS | 2017 | 04:27:23 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:24 INFO - PROCESS | 2017 | RSS: Main: 197947392 04:27:24 INFO - PROCESS | 2017 | 04:27:25 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49389/tests/kraken/driver.html?testName=ai-astar) 04:27:26 INFO - PROCESS | 2017 | RSS: Main: 199737344 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | __start_tp_report 04:27:26 INFO - PROCESS | 2017 | _x_x_mozilla_page_load 04:27:26 INFO - PROCESS | 2017 | _x_x_mozilla_page_load_details 04:27:26 INFO - PROCESS | 2017 | |i|pagename|runs| 04:27:26 INFO - PROCESS | 2017 | |0;ai-astar;112;118;92;159;178;140;107;145;95;165 04:27:26 INFO - PROCESS | 2017 | |1;audio-beat-detection;194;133;171;198;142;171;176;125;175;124 04:27:26 INFO - PROCESS | 2017 | |2;audio-dft;196;236;277;200;195;197;199;199;201;198 04:27:26 INFO - PROCESS | 2017 | |3;audio-fft;67;70;76;148;56;57;56;70;146;59 04:27:26 INFO - PROCESS | 2017 | |4;audio-oscillator;77;81;130;78;80;85;125;82;77;128 04:27:26 INFO - PROCESS | 2017 | |5;imaging-gaussian-blur;88;107;136;86;89;85;89;86;107;115 04:27:26 INFO - PROCESS | 2017 | |6;imaging-darkroom;94;128;105;149;151;116;132;126;150;151 04:27:26 INFO - PROCESS | 2017 | |7;imaging-desaturate;138;143;91;125;91;145;151;100;151;130 04:27:26 INFO - PROCESS | 2017 | |8;json-parse-financial;59;67;75;91;96;95;87;81;61;60 04:27:26 INFO - PROCESS | 2017 | |9;json-stringify-tinderbox;62;65;71;65;73;75;71;69;66;68 04:27:26 INFO - PROCESS | 2017 | |10;stanford-crypto-aes;81;81;80;82;80;78;83;80;83;86 04:27:26 INFO - PROCESS | 2017 | |11;stanford-crypto-ccm;128;126;134;122;138;156;138;125;144;139 04:27:26 INFO - PROCESS | 2017 | |12;stanford-crypto-pbkdf2;167;226;166;167;162;164;165;166;159;166 04:27:26 INFO - PROCESS | 2017 | |13;stanford-crypto-sha256-iterative;68;70;67;71;66;69;67;66;84;62 04:27:26 INFO - PROCESS | 2017 | __end_tp_report 04:27:26 INFO - PROCESS | 2017 | __start_cc_report 04:27:26 INFO - PROCESS | 2017 | _x_x_mozilla_cycle_collect,1061 04:27:26 INFO - PROCESS | 2017 | __end_cc_report 04:27:26 INFO - PROCESS | 2017 | __startTimestamp1467890846231__endTimestamp 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | ------- Summary: start ------- 04:27:26 INFO - PROCESS | 2017 | Number of tests: 14 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#0] ai-astar Cycles:10 Average:131.10 Median:162.00 stddev:30.46 (18.8%) stddev-sans-first:31.51 04:27:26 INFO - PROCESS | 2017 | Values: 112.0 118.0 92.0 159.0 178.0 140.0 107.0 145.0 95.0 165.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#1] audio-beat-detection Cycles:10 Average:160.90 Median:173.00 stddev:27.67 (16.0%) stddev-sans-first:26.63 04:27:26 INFO - PROCESS | 2017 | Values: 194.0 133.0 171.0 198.0 142.0 171.0 176.0 125.0 175.0 124.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#2] audio-dft Cycles:10 Average:209.80 Median:199.50 stddev:26.50 (13.3%) stddev-sans-first:27.64 04:27:26 INFO - PROCESS | 2017 | Values: 196.0 236.0 277.0 200.0 195.0 197.0 199.0 199.0 201.0 198.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#3] audio-fft Cycles:10 Average:80.50 Median:63.00 stddev:35.72 (56.7%) stddev-sans-first:37.55 04:27:26 INFO - PROCESS | 2017 | Values: 67.0 70.0 76.0 148.0 56.0 57.0 56.0 70.0 146.0 59.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.00 stddev:23.18 (29.3%) stddev-sans-first:23.73 04:27:26 INFO - PROCESS | 2017 | Values: 77.0 81.0 130.0 78.0 80.0 85.0 125.0 82.0 77.0 128.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#5] imaging-gaussian-blur Cycles:10 Average:98.80 Median:86.00 stddev:17.02 (19.8%) stddev-sans-first:17.60 04:27:26 INFO - PROCESS | 2017 | Values: 88.0 107.0 136.0 86.0 89.0 85.0 89.0 86.0 107.0 115.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#6] imaging-darkroom Cycles:10 Average:130.20 Median:149.50 stddev:20.50 (13.7%) stddev-sans-first:17.06 04:27:26 INFO - PROCESS | 2017 | Values: 94.0 128.0 105.0 149.0 151.0 116.0 132.0 126.0 150.0 151.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#7] imaging-desaturate Cycles:10 Average:126.50 Median:148.00 stddev:24.00 (16.2%) stddev-sans-first:25.09 04:27:26 INFO - PROCESS | 2017 | Values: 138.0 143.0 91.0 125.0 91.0 145.0 151.0 100.0 151.0 130.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#8] json-parse-financial Cycles:10 Average:77.20 Median:84.00 stddev:14.79 (17.6%) stddev-sans-first:14.15 04:27:26 INFO - PROCESS | 2017 | Values: 59.0 67.0 75.0 91.0 96.0 95.0 87.0 81.0 61.0 60.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:70.00 stddev:4.06 (5.8%) stddev-sans-first:3.56 04:27:26 INFO - PROCESS | 2017 | Values: 62.0 65.0 71.0 65.0 73.0 75.0 71.0 69.0 66.0 68.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.50 stddev:2.22 (2.7%) stddev-sans-first:2.35 04:27:26 INFO - PROCESS | 2017 | Values: 81.0 81.0 80.0 82.0 80.0 78.0 83.0 80.0 83.0 86.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:138.00 stddev:10.31 (7.5%) stddev-sans-first:10.62 04:27:26 INFO - PROCESS | 2017 | Values: 128.0 126.0 134.0 122.0 138.0 156.0 138.0 125.0 144.0 139.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:166.00 stddev:19.56 (11.8%) stddev-sans-first:20.69 04:27:26 INFO - PROCESS | 2017 | Values: 167.0 226.0 166.0 167.0 162.0 164.0 165.0 166.0 159.0 166.0 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - PROCESS | 2017 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:5.83 (8.5%) stddev-sans-first:6.17 04:27:26 INFO - PROCESS | 2017 | Values: 68.0 70.0 67.0 71.0 66.0 69.0 67.0 66.0 84.0 62.0 04:27:26 INFO - PROCESS | 2017 | -------- Summary: end -------- 04:27:26 INFO - PROCESS | 2017 | 04:27:26 INFO - TEST-INFO | 2017: exit 0 04:27:26 INFO - TEST-OK | kraken | took 59876ms 04:27:26 INFO - SUITE-END | took 1169s 04:27:27 INFO - Completed test suite (00:19:30) 04:27:27 INFO - javascript benchmark 04:27:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3493.8078405687684, 3659.743817932744, 3682.263547290539, 3713.9071523211915, 3718.423644335129, 5957.463828255456, 5992.071228959508, 5997.610155339906, 6001.3698561650945, 6011.068284415917, 5008.799648014085, 5963.761449542013, 5972.223610930573, 6027.668478233695, 6034.69826508675, 5037.219231019189, 5342.252084708144, 5401.972990135064, 5429.267048948381, 5490.6431081979545, 4320.82716691332, 5371.248025276464, 5390.8921821563545, 5426.186072089179, 5479.890402191953, 5411.621186516945, 5419.701916394597, 5423.864403389927, 5457.345118585776, 5459.727013649322, 5416.485433883755, 5418.051840927822, 5437.755301011444, 5461.208124821918, 5509.559235261169, 5220.634555581111, 5261.894762104736, 5310.946890531084, 5336.012837625013, 5356.9732151339385, 4333.4366532350905, 5778.42215778423, 5841.7371218295275, 5845.678487683176, 5898.292204935392, 6250.593711408789, 6274.592151510137, 6298.181236439279, 6327.651979141146, 6350.650714210717, 6239.188905442264, 6244.313125556185, 6286.025666021774, 6308.463780578656, 6332.271788744261, 6046.304674962347, 6048.243969503812, 6071.958789593747, 6078.452939235446, 6103.29812071613, 6368.235811702625, 6467.320931302145, 6501.934980650228, 6505.772297969548, 6509.02364645307, 5127.435982041972, 6211.2857021443115, 6246.75012999484, 6249.062640603855, 6289.056641503811, 6331.430171284606, 6338.334474880164, 6360.650164241011, 6360.777372792023, 6397.264314603787, 5159.871003224949, 6131.346082861964, 6220.844478888064, 6266.216722909637, 6274.592151510137, 6206.565540412128, 6277.780277690259, 6278.623282602967, 6289.088082228142, 6314.842128946813, 5059.19052951526, 5092.312537807348, 5104.310918026019, 5109.335786347825, 5128.230765385148, 4527.728336299832, 4563.95436045642, 4600.102979918951, 4626.537346265414, 4635.837745678952, 6105.664188469588, 6113.141862489121, 6143.109249158847, 6175.96912015437, 6224.159738435344, 6351.650659213695, 6370.8088757337355, 6413.358664133642, 6418.1656384669695, 6445.323241059715, 5293.20601909709, 6058.363871793486, 6215.782447614402, 6218.378162183745, 6226.875462490725, 4332.956670433318, 5635.436456354331, 5648.15277708347, 5653.9151912721345, 5676.772929082873, 6649.833754156088, 6663.167104111986, 6672.165979252593, 6680.064790929274, 6707.42986846104, 6008.0, 6030.643105301272, 6390.041493775971, 6404.391582799627, 6424.614523128627, 6638.83402914931, 6663.000549917551, 6669.333066693292, 6695.464362851058, 6702.631355275506, 6296.244450665767, 6297.1813664223355, 6308.842278943063, 6312.495000399865, 6320.841978950563, 6224.9377506224355, 6304.05439184126, 6345.460635846005, 6380.3619638035825, 6384.425401713868, 6183.598066125687, 6229.906551401823, 6232.407921247474, 6238.6880655967925, 6259.436650701458, 6193.947029004989, 6235.00239961604, 6251.937480625317, 6252.062190671254, 6262.09199666055, 6087.786927457518, 6096.481799046954, 6096.725647345791, 6178.351273116438, 6183.659898705614, 6144.508439324753, 6145.907811382744, 6167.6916154193, 6227.719752611234, 6244.0321750128805, 6120.54095942815, 6223.844403889939, 6226.0, 6231.314555398993, 6238.344973777688], "value": 5851.15332115631, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.4268476018758, 551.1457241276022, 556.3657430529195, 590.8109404990404, 601.0533409879441, 40011.79994100029, 41139.58860411395, 41184.38223426651, 41254.79372603136, 41293.7935310323, 42791.57208427915, 42959.78520107403, 43189.0, 43306.700798976, 43608.34587481182, 9681.999999999982, 9870.851937220947, 9913.058259465339, 9913.454759988197, 9923.354981926188, 9889.208863290956, 10020.59917603295, 10032.147267482273, 10060.949695251513, 10089.495525223747, 10032.949835250814, 10047.246456515753, 10055.39667619945, 10103.444310562953, 10125.0, 10038.247131465168, 10043.598256069748, 10105.141063009616, 10164.644237451654, 10170.59317627294, 9735.90264097357, 9837.90162098377, 9855.655052073143, 9863.35888167274, 9884.802303953953, 41881.0, 42032.73901782921, 42120.0, 42135.7893210532, 42244.36633450501, 2985.925351866199, 3244.561984132159, 3267.15054085937, 3378.341223461426, 3462.4286992646184, 30029.549556756665, 30054.0, 30654.846725766452, 30757.384852303054, 32061.358772824646, 2777.805553611248, 2831.0374472679387, 2844.630198074237, 2856.557233628791, 2859.6139521164587, 387325.0, 397701.0229897722, 397735.0226497727, 399617.0, 401076.0, 39157.0, 65959.0, 66293.668531658, 66339.0, 66699.0, 38254.0, 38343.0, 38352.42471362932, 38420.61579384226, 38434.42348364777, 12708.491660333482, 13737.931310343583, 16444.342226310815, 16535.173241337885, 16797.91601041987, 13803.0, 13885.583432497042, 14106.871450283952, 14116.858831411555, 14216.0, 7466.962665186639, 8387.916120838836, 8401.70594029206, 8413.326933845277, 8571.828563428697, 3511.9122021949142, 3556.448750443685, 3583.749137560346, 3606.2607165531003, 3631.055925459347, 879.9792241000408, 1059.6450189186555, 1077.4451157653814, 1092.8415379770047, 1186.6973921650097, 29594.0, 30848.074557763302, 30909.227269318, 31034.224144396572, 31617.57720902519, 1140.1164097824087, 1192.8151136573845, 1201.783678937782, 1250.9492026697617, 1264.9936750316374, 12971.41628626714, 15715.371385144696, 16040.877138600186, 16053.0, 16479.670406592042, 620849.0, 625410.0, 627940.0, 636327.0, 637503.0, 63843.680781595795, 64499.35500644933, 64721.0, 64742.35257647457, 64749.0, 1544.6447317117127, 1565.5694683962001, 1572.481081243187, 1579.3287852662572, 1584.207896051974, 30544.698710107026, 30556.236094097825, 30678.84660576772, 31108.911188108308, 31188.68811311858, 56349.0, 56468.717656411456, 56545.0, 56749.0, 57097.85804283808, 460119.0, 526984.0, 550606.2469687626, 552527.0, 558991.8201636026, 28025.579616305364, 28698.99553515617, 44616.55383446124, 45755.31367029564, 46028.928698207994, 31581.0, 36585.16032774384, 47158.0, 48282.5171748278, 48430.789230269525, 37749.81125094357, 38886.41670375003, 39124.630637927534, 39298.2140357197, 39394.2121157581, 36802.8159859199, 37021.62978370182, 37427.81286093552, 37655.43516847304, 38182.0, 38014.80992595019, 38213.42679859749, 38840.80579597084, 38886.4167037489, 39505.407418888164, 32034.0, 33744.98765037053, 33748.662513374555, 33884.32231355408, 34108.63565457453, 25305.62041569341, 25408.872955635103, 25842.224733258034, 25852.61221081648, 26658.866705666347], "value": 19323.623281617365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.5093760143822, 417.75978812182984, 419.46937124537453, 423.08402309001013, 425.25367979196517, 18335.54161145969, 20209.494762630922, 20906.0, 20934.0, 21170.0, 20719.896400517977, 20878.0, 21190.83450410227, 21690.0239489223, 21797.891010544965, 5814.09881468371, 5925.407459254073, 6129.754809807602, 6143.170671959296, 6145.231846019247, 5821.330546987108, 6077.848053798668, 6130.325664176937, 6882.965585172092, 6934.757283495053, 6850.0, 6885.9326804345155, 6888.862222755542, 6900.689468973883, 6913.861722765541, 6577.210734711842, 6851.177858656968, 6853.588784672886, 6897.068895699092, 6897.999790030468, 6048.092786082123, 6104.847378815565, 6129.264488261392, 6132.662703551303, 6157.507399408037, 13420.32898355088, 14121.505747298897, 24969.750302497105, 26181.0, 26190.0, 2140.3044010696585, 2196.198387588535, 2380.571497130516, 2657.946841063187, 2754.476649436601, 9751.414915105046, 9776.462294573796, 10020.69937901864, 10116.797664046679, 10132.088112069876, 1727.6890159771235, 1743.7210046392643, 1775.2100315359671, 1844.0687452836366, 1847.1503108570073, 80775.0, 89129.66305505423, 105062.0, 107151.46424267828, 110873.0, 11942.582009629621, 12148.149629526026, 12181.0, 12185.0, 12209.938950305192, 14093.78859317111, 14906.478273260384, 15332.386704531917, 15484.0, 15487.070775753491, 9137.223336016514, 9279.257659387367, 9427.340086194037, 9429.245660347156, 9513.381630194015, 9298.907010929805, 9326.0, 9327.906720932839, 9397.76505587352, 9420.43477391345, 4723.331317805429, 4886.3403440535785, 4899.6570240083565, 4914.198512873912, 4914.36113305268, 2039.8275836234363, 2075.6678931370907, 2080.739907511561, 2085.8411544052137, 2092.455961450034, 947.8530827721714, 972.5526257921294, 997.7705127820642, 1045.1482042135635, 1109.8113320735495, 16498.6700265994, 19002.334918277793, 19808.306709265107, 20082.297119600746, 20314.695279570817, 934.6401635370431, 1013.9442330671884, 1031.8555402243692, 1049.7270709615555, 1116.3636727065657, 10858.67423977282, 10910.672679819618, 10996.0, 11034.227604067799, 11042.558297668164, 577518.0, 580746.0, 603943.0, 633754.0, 648366.0, 119609.0, 120640.79359206295, 121586.0, 121840.0, 122349.0, 1051.9105876000472, 1053.4364115198332, 1063.7819247054335, 1073.736934451049, 1089.9128069754402, 18228.56203321253, 18386.632267354846, 18541.81458185455, 18569.44291671252, 19022.80977190266, 39784.80107599444, 49166.26250606172, 49810.0, 52152.95694086173, 53593.73203133959, 72861.90707139291, 74242.0, 76624.61687691526, 78362.21637783549, 82405.0, 12102.515899363927, 12598.622041338775, 12720.87279127197, 12836.16564923277, 13066.869331306565, 13425.194488330731, 13551.52569660057, 13738.793918091436, 13931.651708707363, 13987.230702311064, 7786.33816125613, 9742.805143896941, 11835.408229588658, 11976.28142311464, 12088.637340879788, 11634.301941883514, 11637.359945203096, 11694.47374868116, 11721.41392930333, 11924.284542927453, 11746.530138794353, 12036.939815300868, 12055.336956467478, 12058.095642826647, 12225.877741222474, 12370.938145309216, 12406.81389779136, 12473.064520161206, 12775.744485110432, 12812.61562153137, 11679.416029198675, 11817.468213930222, 11842.28946263227, 11863.050955923332, 12079.758404831678], "value": 10084.517126196386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.9449119280823, 1647.7281248593986, 1861.9441416757486, 1983.2265416487573, 2048.150017742636, 8470.576471176448, 9163.404378715379, 9187.77030574236, 9506.334556581034, 9545.952270238648, 9235.584398702058, 9247.12152345526, 9320.533973301324, 9342.392744471621, 9361.438313701183, 2555.118484122979, 2572.0, 2574.201997380818, 2574.806889483287, 2580.2775222937607, 2529.178017144426, 2575.111586502663, 2586.5085633729627, 2587.40489687372, 2590.0287392227915, 2551.1963731424635, 2574.4295979452518, 2599.5840665493524, 2613.908513202038, 2615.411532405203, 2576.948461030778, 2578.419855532509, 2591.222633210048, 2592.41670624109, 2605.2184344696516, 2570.2160840943507, 2593.1442623934245, 2599.4930988457068, 2617.594272887686, 2618.4370360372614, 9463.668771592962, 9510.38182518141, 9526.428414295164, 9555.092266234697, 9615.086566776145, 5643.322801263834, 5648.068068768648, 5657.547396208334, 5666.943330566724, 5777.942220577783, 3612.5664920209742, 3755.192633583765, 3755.8497660093562, 3760.4547340635727, 3785.5835858055593, 1042.2183362478142, 1062.3731998121145, 1070.1920050361928, 1105.4528008635696, 1107.2194103157256, 12148.271103733805, 12159.939200303941, 12180.878191218064, 12187.451564679523, 12204.633860984184, 4973.079980203602, 4996.625253106032, 5047.747612619428, 5065.544101030925, 5116.9744151279, 10174.796504069876, 10175.592976281014, 10218.131458825934, 10292.228082893664, 10352.275340726077, 5702.914456283159, 5710.942890571124, 5724.370319264877, 5730.598858079894, 5767.596268261182, 4664.906701866012, 5107.770150343244, 5244.737763111829, 5255.001549705544, 5286.656367336111, 4347.7173983690955, 4348.152110338517, 4387.978060109679, 4433.7118087324225, 4439.200943830077, 1397.343248673122, 1413.6395219219032, 1419.332913530639, 1421.630376102221, 1429.6640289531952, 869.4348673362365, 946.3706635087727, 961.2262128986093, 978.1636700621009, 980.4068538534084, 6132.724027418777, 6174.197354343996, 6298.8425289367215, 6307.873842523124, 6326.620402775849, 483.37644438673715, 494.2857570810145, 496.4365445219702, 501.2456253338702, 503.0341743851813, 3514.666106719909, 3837.4819399381286, 4127.33962565988, 4197.076643138505, 4209.34755112958, 9515.286353523514, 9583.75411196554, 10589.099926506333, 10677.62628308021, 11053.115750739922, 10872.67381978542, 10924.180686448548, 11051.668449946514, 11086.667399978014, 11176.385298808644, 8482.957585212034, 8728.389012769172, 8758.211760941545, 8950.731478055668, 8953.462792232487, 5099.92350114756, 6018.699065046818, 6055.0, 6097.451229389376, 6313.08460273267, 7925.445218834626, 8720.0, 9780.902190977999, 10219.693409197736, 10266.127379172554, 7486.326230639051, 9890.653827116017, 10592.205584581034, 10630.30902991303, 10822.891771082188, 7220.3140701633265, 7680.500767450098, 7740.3420709240345, 7830.608469576612, 7898.407619428451, 8616.095309992612, 8672.392932494664, 8676.392652514263, 8677.652893884175, 8730.126987301219, 7621.0, 7769.494982826324, 7805.33654639362, 7879.763607091796, 7981.48120372174, 7695.615219238904, 7709.691612335444, 7717.18969508216, 7803.7268695595385, 7807.0, 7011.018457415864, 7022.12223472066, 7107.18267399235, 7132.500724949204, 7137.714491420285, 4996.6002719783055, 5025.095482813129, 5147.2279158126585, 5235.397929238034, 5256.605754568346, 5155.793768249228, 5200.063988482109, 5264.447233040476, 5415.377231618414, 5437.728113594384], "value": 4745.374933844371, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.08616279127745, 342.4469481786915, 343.2585615071445, 348.7837540724751, 350.2190116041228, 6873.587584744919, 6927.7921662350145, 6961.582305061694, 7022.15734111906, 7059.188193357765, 6879.071325371074, 6899.413549848269, 6920.861582768342, 6921.5847049176955, 6995.335443132907, 5094.0, 5097.974510127444, 5102.1836506159025, 5112.233165025239, 5112.539871411591, 4863.927041094369, 4949.653524253304, 5066.594672426216, 5083.79664813407, 5097.209932460474, 3721.7022638189014, 5001.17480615698, 5015.971725796203, 5019.84940451787, 5080.466551012146, 5029.2958985742025, 5035.068512325213, 5046.949530504685, 5058.4688607696025, 5060.342155519796, 4351.28203846365, 4352.91294174118, 4365.3451982202605, 4365.367021781855, 4374.628156606692, 6722.327767223287, 6723.630200338979, 6742.0, 6746.291639377893, 6768.49236307274, 4627.5603817637275, 4719.315699223627, 5752.5110365618975, 5933.406659334075, 5947.167396564484, 7390.889136662954, 7395.334419902181, 7433.479656424052, 7433.814154646123, 7434.665440055211, 4764.666473346867, 4769.022350418156, 4769.403824521934, 4779.856604301876, 4795.568398844086, 7848.254415830487, 7923.049234091888, 7927.603619818986, 7954.840903181962, 7960.960195199045, 3585.032041348821, 3706.666400023957, 4157.272477316457, 4579.542045795394, 4686.554777296152, 4055.2903241932545, 4108.260513107669, 4892.657513973988, 4922.704637721748, 4957.380327459067, 5918.704064796829, 5919.289685237799, 5923.733431995484, 5959.314678811906, 5975.581709280309, 7511.624418779039, 7542.170361260257, 7544.962275188699, 7564.773056808304, 7565.583892885834, 1410.330093205719, 1706.4283465039102, 1734.9392771252947, 1736.4530172995467, 1740.1473278093897, 931.3061768982152, 1051.2063392138887, 1083.7019819549687, 1095.2114477576133, 1096.4627332607124, 7039.753608623776, 7082.822929426806, 7144.9285507145305, 7151.570905745672, 7165.713371465187, 7327.0, 7838.764837054898, 7841.607919603997, 7845.960770196227, 7875.054993400829, 6913.654317284116, 7017.333353331425, 7124.643767811589, 7146.571205727569, 7232.0, 4148.896277593084, 4159.480064991876, 4163.437935878678, 4187.288161012635, 4198.307279298942, 8323.583820808935, 8358.791030224293, 8361.372897032747, 8362.121977192308, 8424.28393586552, 6348.492120630339, 7979.6035693753365, 8137.145599712064, 8152.551609661526, 8170.714025009096, 8000.91987581669, 8332.791680208044, 8334.249917507332, 8340.457870238537, 8344.666213351398, 7875.448718589644, 7927.801804954922, 7940.801479963047, 7951.045874494866, 7955.0851652060755, 7265.9273407267365, 7750.263724946121, 7752.224777522202, 7759.883601746092, 7777.766666999999, 6791.0, 8327.625256863577, 8335.208155225244, 8345.95827020861, 8373.95813020931, 4850.490698476609, 4871.732054737024, 4915.1644220481885, 4937.333459982857, 4943.925841112315, 7877.409194310564, 7883.251091146332, 7884.172161923145, 7889.802754931173, 7903.407244456574, 7613.809654758676, 7614.124375696866, 7638.427117966286, 7640.0, 7653.617319134132, 7302.123745150403, 7496.287852653989, 7519.812004699927, 7570.545767253982, 7597.924020759942, 7328.78013659591, 7359.153697324876, 7405.370543503863, 7419.851602968019, 7448.813779655552, 6708.83227919306, 6963.990221417765, 7070.974708667111, 7077.716891324495, 7630.198829122862, 6448.5486015980305, 7182.245864184394, 7414.184439711736, 7435.7025718970635, 7474.551526908403], "value": 5406.709376039062, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.6029541831773, 765.731993802169, 771.5263846054035, 789.5657388436363, 790.4269404681605, 15236.61908452288, 15348.232588370578, 15480.767788483181, 15493.690126197469, 15504.992175508598, 14094.0, 14419.78370324446, 14426.711465770679, 14431.855681443183, 14469.927650361733, 819.1194465949098, 990.8266053440638, 992.3748038735587, 998.7453199434134, 1025.4513835098223, 952.0051546134272, 953.9093786090345, 1009.0867764672983, 1014.3406785589352, 1016.6746641074859, 1004.9045340692622, 1064.1008347946013, 1066.3921564708119, 1070.7002039428933, 1072.5066469424075, 998.2313618513776, 1021.7752094539189, 1043.3739756146326, 1054.4833031814433, 1058.2380685906135, 748.5620911766623, 767.2749251956903, 775.7284950267418, 790.4624855098531, 790.6402586822982, 15096.924515377463, 15106.942514024022, 15307.158106304149, 15316.234188290653, 15369.538913832603, 13042.347882605927, 13044.347782610832, 13063.216207027608, 13196.934015329862, 13281.203127812265, 9907.950460247652, 10076.042775936274, 10078.697639070766, 10136.847947280796, 10181.541830617565, 3419.6321471411384, 3522.5068490411363, 3634.254977729559, 3634.3639863024127, 3744.8314825832904, 83021.0, 83525.16474835174, 84220.57889710573, 85923.0, 86574.0, 9402.717918462457, 9450.385724927995, 9630.855537166948, 9653.276004299705, 9717.12545870861, 21757.564848702936, 21773.0, 21850.907454627522, 21874.671879921814, 21941.232056877932, 7518.0, 7629.504082234637, 7684.423668224906, 7725.034370703662, 7836.686532538749, 3626.9093272667865, 4093.959060409358, 4140.3375459926265, 4151.709380343347, 4157.147784704129, 3696.5009723687494, 3707.017640325316, 3776.3013842439236, 3792.1657235408165, 3807.314683357022, 655.4559715436177, 659.1628631637889, 669.3306693306694, 678.5148618737528, 682.8702546516146, 524.7586110389187, 525.1728527569094, 543.8749087709849, 556.1046714789186, 594.2957595249557, 8108.675652973933, 8141.185881411811, 8195.795105122419, 8311.6675332986, 8321.982907006264, 542.3275138827904, 578.9305283365939, 589.1457386789173, 606.7167939807364, 607.419913982146, 3726.5341832270965, 3878.5151856017997, 3889.2804831106337, 3898.5516665583255, 4033.334499807499, 72907.63546182236, 74236.62881685665, 90890.0, 93735.53132234432, 94337.52831235937, 68603.28491787646, 76457.61771191108, 77776.61111694406, 78631.42737145339, 78991.21008789839, 59563.702181488814, 62384.0, 63096.68451657712, 67997.0, 70502.64748676223, 6987.8253043672285, 8354.582270886553, 8421.62102705392, 8516.957415213132, 8556.828863422572, 47618.285725713446, 48387.0, 48616.75691621519, 48869.755651221516, 50949.74525127499, 59947.400525994184, 61827.6908615454, 65092.0, 65288.0, 65377.67311163414, 10886.0, 10992.17558683086, 11161.665150045512, 11251.324920504796, 11466.827997579876, 11980.46087926028, 12128.636140915787, 12133.575324863941, 12176.756464870476, 12304.938475307566, 11296.83054754163, 11317.264377815416, 11427.542898283975, 11534.769304614028, 11907.047436205256, 11355.318680879174, 11361.977422032056, 11476.655700329004, 11513.078953683853, 11776.868746613723, 8837.734867953972, 11451.541938322374, 11463.541458341573, 11480.82778758336, 11693.824592630946, 9633.08485693858, 9778.559964801743, 9811.852822207815, 9840.261980351646, 9859.35914165577, 9646.372985755903, 9741.610335586498, 9839.704808855746, 9904.009599040039, 9923.255755818487], "value": 7009.873190592941, "unit": "score"}], "name": "dromaeo_css", "value": 7679.30971034, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 118.0, 92.0, 159.0, 178.0, 140.0, 107.0, 145.0, 95.0, 165.0], "value": 131.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 133.0, 171.0, 198.0, 142.0, 171.0, 176.0, 125.0, 175.0, 124.0], "value": 160.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 236.0, 277.0, 200.0, 195.0, 197.0, 199.0, 199.0, 201.0, 198.0], "value": 209.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 76.0, 148.0, 56.0, 57.0, 56.0, 70.0, 146.0, 59.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 130.0, 78.0, 80.0, 85.0, 125.0, 82.0, 77.0, 128.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 107.0, 136.0, 86.0, 89.0, 85.0, 89.0, 86.0, 107.0, 115.0], "value": 98.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 128.0, 105.0, 149.0, 151.0, 116.0, 132.0, 126.0, 150.0, 151.0], "value": 130.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 143.0, 91.0, 125.0, 91.0, 145.0, 151.0, 100.0, 151.0, 130.0], "value": 126.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 67.0, 75.0, 91.0, 96.0, 95.0, 87.0, 81.0, 61.0, 60.0], "value": 77.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 71.0, 65.0, 73.0, 75.0, 71.0, 69.0, 66.0, 68.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 80.0, 82.0, 80.0, 78.0, 83.0, 80.0, 83.0, 86.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 134.0, 122.0, 138.0, 156.0, 138.0, 125.0, 144.0, 139.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 226.0, 166.0, 167.0, 162.0, 164.0, 165.0, 166.0, 159.0, 166.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 71.0, 66.0, 69.0, 67.0, 66.0, 84.0, 62.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1634.0, "alertThreshold": 2.0}]} 04:27:27 INFO - Return code: 0 04:27:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:27:27 ERROR - # TBPL SUCCESS # 04:27:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:27:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:27:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:27:27 INFO - 2016-07-07 04:27:27.535 screenresolution[2022:12854] starting screenresolution argv=screenresolution get 04:27:27 INFO - 2016-07-07 04:27:27.538 screenresolution[2022:12854] Display 0: 1600x1200x32@60 04:27:27 INFO - 2016-07-07 04:27:27.544 screenresolution[2023:12857] starting screenresolution argv=screenresolution list 04:27:27 INFO - Available Modes on Display 0 04:27:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:27:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:27:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:27:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:27:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:27:27 INFO - Intel Iris: 04:27:27 INFO - Chipset Model: Intel Iris 04:27:27 INFO - Type: GPU 04:27:27 INFO - Bus: Built-In 04:27:27 INFO - VRAM (Dynamic, Max): 1536 MB 04:27:27 INFO - Vendor: Intel (0x8086) 04:27:27 INFO - Device ID: 0x0a2e 04:27:27 INFO - Revision ID: 0x0009 04:27:27 INFO - Displays: 04:27:27 INFO - Display: 04:27:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:27:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:27:27 INFO - Display Serial Number: 1600x1200 60 04:27:27 INFO - Main Display: Yes 04:27:27 INFO - Mirror: Off 04:27:27 INFO - Online: Yes 04:27:27 INFO - Rotation: Supported 04:27:27 INFO - Return code: 0 04:27:27 INFO - Running post-action listener: _resource_record_post_action 04:27:27 INFO - Running post-run listener: _resource_record_post_run 04:27:28 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 446464; Write bytes: 494609408; Read time: 9; Write time: 1616 04:27:28 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 182776320; Write bytes: 175386624; Read time: 16620; Write time: 348 04:27:28 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 446464; Write bytes: 299885568; Read time: 9; Write time: 1213 04:27:28 INFO - Running post-run listener: _upload_blobber_files 04:27:28 INFO - Blob upload gear active. 04:27:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:27:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:27:29 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:27:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:29 INFO - (blobuploader) - INFO - Done attempting. 04:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:30 INFO - (blobuploader) - INFO - Done attempting. 04:27:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:30 INFO - Return code: 0 04:27:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5847caee031463b099ab28362fdb5f83452e087993047e91518c877156702764943cf6d25cefcd315ebc8f2a28eeac3b749f13afd28a291dbd69f552ffe57a9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d4a2d7e899310bc2cfe0587ac430143271ed872b10186da635305bf39e7106229bbb381acc32411c48aae0f8e80a79c29c2da12c567305c5c3a7e24a1610b37c"} 04:27:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:30 INFO - Contents: 04:27:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5847caee031463b099ab28362fdb5f83452e087993047e91518c877156702764943cf6d25cefcd315ebc8f2a28eeac3b749f13afd28a291dbd69f552ffe57a9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d4a2d7e899310bc2cfe0587ac430143271ed872b10186da635305bf39e7106229bbb381acc32411c48aae0f8e80a79c29c2da12c567305c5c3a7e24a1610b37c"} 04:27:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:30 INFO - Copying logs to upload dir... 04:27:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.238456 ========= master_lag: 0.94 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-07 04:27:31.778316) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:31.778965) ========= 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.vYSuPz75LJ/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.yOtZy0pekO/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5847caee031463b099ab28362fdb5f83452e087993047e91518c877156702764943cf6d25cefcd315ebc8f2a28eeac3b749f13afd28a291dbd69f552ffe57a9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d4a2d7e899310bc2cfe0587ac430143271ed872b10186da635305bf39e7106229bbb381acc32411c48aae0f8e80a79c29c2da12c567305c5c3a7e24a1610b37c"} 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.011194 build_url: 'https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5847caee031463b099ab28362fdb5f83452e087993047e91518c877156702764943cf6d25cefcd315ebc8f2a28eeac3b749f13afd28a291dbd69f552ffe57a9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d4a2d7e899310bc2cfe0587ac430143271ed872b10186da635305bf39e7106229bbb381acc32411c48aae0f8e80a79c29c2da12c567305c5c3a7e24a1610b37c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:31.823134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:31.823507) ========= 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.vYSuPz75LJ/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.yOtZy0pekO/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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.005144 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:31.875049) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:27:31.875345) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:27:32.081816) ========= ========= Total master_lag: 1.11 =========