builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0185 starttime: 1479468194.13 results: success (0) buildid: 20161118004020 builduid: 83a5f4abf7c043e5a7aef121e809f673 revision: 7ad438df29922ee13d21100873883eb9dd93423c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:14.132376) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:14.132828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:14.133104) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:14.157101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:14.157378) ========= 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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-11-18 03:23:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.3M=0s 2016-11-18 03:23:14 (24.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.071890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:14.251749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:14.252148) ========= 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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.019718 ========= master_lag: 0.28 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:14.554775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 03:23:14.555133) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ad438df29922ee13d21100873883eb9dd93423c --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-aurora --rev 7ad438df29922ee13d21100873883eb9dd93423c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r3G0YiCWBX/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.NpZLR6f2QD/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-11-18 03:23:14,642 truncating revision to first 12 chars 2016-11-18 03:23:14,642 Setting DEBUG logging. 2016-11-18 03:23:14,642 attempt 1/10 2016-11-18 03:23:14,642 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7ad438df2992?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 03:23:15,593 unpacking tar archive at: mozilla-aurora-7ad438df2992/testing/mozharness/ program finished with exit code 0 elapsedTime=1.207317 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 03:23:15.784881) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:15.785251) ========= script_repo_revision: 7ad438df29922ee13d21100873883eb9dd93423c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:15.785763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:15.786088) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 03:23:15.807449) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-11-18 03:23:15.807906) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r3G0YiCWBX/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.NpZLR6f2QD/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:23:16 INFO - MultiFileLogger online at 20161118 03:23:16 in /builds/slave/test 03:23:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:23:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:23:16 INFO - {'append_to_log': False, 03:23:16 INFO - 'base_work_dir': '/builds/slave/test', 03:23:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:23:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:23:16 INFO - 'branch': 'Mozilla-Aurora', 03:23:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:23:16 INFO - 'config_files': ('talos/mac_config.py',), 03:23:16 INFO - 'default_actions': ('clobber', 03:23:16 INFO - 'read-buildbot-config', 03:23:16 INFO - 'download-and-extract', 03:23:16 INFO - 'populate-webroot', 03:23:16 INFO - 'create-virtualenv', 03:23:16 INFO - 'install', 03:23:16 INFO - 'run-tests'), 03:23:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:23:16 INFO - 'download_minidump_stackwalk': True, 03:23:16 INFO - 'download_symbols': 'ondemand', 03:23:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:23:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:23:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:23:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:23:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:23:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:23:16 INFO - 'installer_path': 'installer.exe', 03:23:16 INFO - 'log_level': 'info', 03:23:16 INFO - 'log_name': 'talos', 03:23:16 INFO - 'log_to_console': True, 03:23:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:23:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:23:16 INFO - 'opt_config_files': (), 03:23:16 INFO - 'pip_index': False, 03:23:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:23:16 INFO - 'cmd': ('bash', 03:23:16 INFO - '-c', 03:23:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:23:16 INFO - 'enabled': True, 03:23:16 INFO - 'halt_on_failure': False, 03:23:16 INFO - 'name': 'check_screen_resolution'},), 03:23:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:23:16 INFO - 'cmd': ('bash', 03:23:16 INFO - '-c', 03:23:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:23:16 INFO - 'enabled': True, 03:23:16 INFO - 'halt_on_failure': False, 03:23:16 INFO - 'name': 'check_screen_resolution'},), 03:23:16 INFO - 'run_cmd_checks_enabled': True, 03:23:16 INFO - 'sps_profile': False, 03:23:16 INFO - 'sps_profile_interval': 0, 03:23:16 INFO - 'suite': 'dromaeojs-e10s', 03:23:16 INFO - 'system_bits': '32', 03:23:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:23:16 INFO - 'title': 't-yosemite-r7-0185', 03:23:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:23:16 INFO - 'use_talos_json': True, 03:23:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:23:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:23:16 INFO - 'work_dir': 'build'} 03:23:16 INFO - [mozharness: 2016-11-18 11:23:16.022389Z] Running clobber step. 03:23:16 INFO - Running pre-action listener: _resource_record_pre_action 03:23:16 INFO - Running main action method: clobber 03:23:16 INFO - rmtree: /builds/slave/test/build 03:23:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:23:17 INFO - Running post-action listener: _resource_record_post_action 03:23:17 INFO - [mozharness: 2016-11-18 11:23:17.575645Z] Finished clobber step (success) 03:23:17 INFO - [mozharness: 2016-11-18 11:23:17.575770Z] Running read-buildbot-config step. 03:23:17 INFO - Running pre-action listener: _resource_record_pre_action 03:23:17 INFO - Running main action method: read_buildbot_config 03:23:17 INFO - Using buildbot properties: 03:23:17 INFO - { 03:23:17 INFO - "project": "", 03:23:17 INFO - "product": "firefox", 03:23:17 INFO - "script_repo_revision": "production", 03:23:17 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:23:17 INFO - "repository": "", 03:23:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:23:17 INFO - "buildid": "20161118004020", 03:23:17 INFO - "stage_platform": "macosx64", 03:23:17 INFO - "basedir": "/builds/slave/test", 03:23:17 INFO - "nightly_build": "True", 03:23:17 INFO - "buildnumber": 21, 03:23:17 INFO - "slavename": "t-yosemite-r7-0185", 03:23:17 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:23:17 INFO - "platform": "yosemite_r7", 03:23:17 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:23:17 INFO - "branch": "mozilla-aurora", 03:23:17 INFO - "repo_path": "releases/mozilla-aurora", 03:23:17 INFO - "revision": "7ad438df29922ee13d21100873883eb9dd93423c", 03:23:17 INFO - "pgo_build": "False", 03:23:17 INFO - "builduid": "83a5f4abf7c043e5a7aef121e809f673", 03:23:17 INFO - "slavebuilddir": "test" 03:23:17 INFO - } 03:23:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 03:23:17 INFO - Running post-action listener: _resource_record_post_action 03:23:17 INFO - [mozharness: 2016-11-18 11:23:17.579312Z] Finished read-buildbot-config step (success) 03:23:17 INFO - [mozharness: 2016-11-18 11:23:17.579396Z] Running download-and-extract step. 03:23:17 INFO - Running pre-action listener: _resource_record_pre_action 03:23:17 INFO - Running main action method: download_and_extract 03:23:17 INFO - mkdir: /builds/slave/test/build/tests 03:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:17 INFO - trying https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 03:23:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 03:23:18 INFO - Downloaded 1199 bytes. 03:23:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:23:18 INFO - Using the following test package requirements: 03:23:18 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:23:18 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:23:18 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 03:23:18 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:23:18 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 03:23:18 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:23:18 INFO - u'jsshell-mac.zip'], 03:23:18 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:23:18 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 03:23:18 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:23:18 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:23:18 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 03:23:18 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:23:18 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 03:23:18 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:23:18 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 03:23:18 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:23:18 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 03:23:18 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:23:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:23:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:23:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:23:18 INFO - Http code: 200 03:23:18 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 03:23:18 INFO - x-amz-cf-id: bOX11k-hFQiw1eMmndifXYkGOr4Aycl-5feqR6BOihufmMef98vLSA== 03:23:18 INFO - x-amz-version-id: vcIV7m32PdeGX37PZ0cu0pMu9X6nzEDY 03:23:19 INFO - Expected file size: 16327895 03:23:19 INFO - Obtained file size: 16327895 03:23:25 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:23:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:23:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:23:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:23:26 INFO - Http code: 200 03:23:26 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 03:23:26 INFO - x-amz-cf-id: aG7JqkSJ1KyGatGM16ntKNK1bdC5uE6B4zijLJEPrZpJSAlHjJNBOw== 03:23:26 INFO - x-amz-version-id: vcIV7m32PdeGX37PZ0cu0pMu9X6nzEDY 03:23:26 INFO - Expected file size: 16327895 03:23:26 INFO - Obtained file size: 16327895 03:23:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 03:23:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:23:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 03:23:34 INFO - Http code: 200 03:23:34 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 03:23:34 INFO - x-amz-cf-id: 7IN4GoB-6FRsKYzVU2BqK6Tgd9qfjpGKz7bOp-a_AqnH-oyBO1nlNQ== 03:23:34 INFO - x-amz-version-id: aziQtoP5WqiXCODf2rILvooJqqCe5mgf 03:23:34 INFO - Expected file size: 14409038 03:23:34 INFO - Obtained file size: 14409038 03:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:35 INFO - trying https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:23:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 03:23:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 03:23:38 INFO - Downloaded 114591626 bytes. 03:23:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:23:38 INFO - mkdir: /builds/slave/test/properties 03:23:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:23:38 INFO - Writing to file /builds/slave/test/properties/build_url 03:23:38 INFO - Contents: 03:23:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:23:38 INFO - Running post-action listener: _resource_record_post_action 03:23:38 INFO - Running post-action listener: set_extra_try_arguments 03:23:38 INFO - [mozharness: 2016-11-18 11:23:38.749748Z] Finished download-and-extract step (success) 03:23:38 INFO - [mozharness: 2016-11-18 11:23:38.749875Z] Running populate-webroot step. 03:23:38 INFO - Running pre-action listener: _resource_record_pre_action 03:23:38 INFO - Running main action method: populate_webroot 03:23:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:23:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:23:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:23:38 INFO - '--tppagecycles', 03:23:38 INFO - '7'], 03:23:38 INFO - 'tests': ['tsvgm']}}, 03:23:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:23:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:23:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:23:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:23:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:23:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:23:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:38 INFO - 'talos_options': ['--disable-e10s'], 03:23:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:38 INFO - 'talos_options': ['--disable-e10s'], 03:23:38 INFO - 'tests': ['damp', 'tps']}, 03:23:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:38 INFO - 'tests': ['damp', 'tps']}, 03:23:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:23:38 INFO - 'tests': ['dromaeo_dom']}, 03:23:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:23:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:23:38 INFO - 'tests': ['basic_compositor_video']}, 03:23:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:23:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:23:38 INFO - 'tests': ['a11yr', 03:23:38 INFO - 'ts_paint', 03:23:38 INFO - 'tpaint', 03:23:38 INFO - 'sessionrestore', 03:23:38 INFO - 'sessionrestore_no_auto_restore', 03:23:38 INFO - 'tabpaint']}, 03:23:38 INFO - 'other-e10s': {'tests': ['a11yr', 03:23:38 INFO - 'ts_paint', 03:23:38 INFO - 'tpaint', 03:23:38 INFO - 'sessionrestore', 03:23:38 INFO - 'sessionrestore_no_auto_restore', 03:23:38 INFO - 'tabpaint']}, 03:23:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:23:38 INFO - 'ts_paint', 03:23:38 INFO - 'tpaint', 03:23:38 INFO - 'sessionrestore', 03:23:38 INFO - 'sessionrestore_no_auto_restore', 03:23:38 INFO - 'tabpaint']}, 03:23:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:23:38 INFO - 'ts_paint', 03:23:38 INFO - 'tpaint', 03:23:38 INFO - 'sessionrestore', 03:23:38 INFO - 'sessionrestore_no_auto_restore', 03:23:38 INFO - 'tabpaint']}, 03:23:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:23:38 INFO - 'tests': ['a11yr', 03:23:38 INFO - 'ts_paint', 03:23:38 INFO - 'tpaint', 03:23:38 INFO - 'sessionrestore', 03:23:38 INFO - 'sessionrestore_no_auto_restore', 03:23:38 INFO - 'tabpaint']}, 03:23:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:23:38 INFO - 'tests': ['a11yr', 03:23:38 INFO - 'ts_paint', 03:23:38 INFO - 'tpaint', 03:23:38 INFO - 'sessionrestore', 03:23:38 INFO - 'sessionrestore_no_auto_restore', 03:23:38 INFO - 'tabpaint']}, 03:23:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:23:38 INFO - 'tests': ['tsvgx', 03:23:38 INFO - 'tsvgr_opacity', 03:23:38 INFO - 'tart', 03:23:38 INFO - 'tscrollx', 03:23:38 INFO - 'cart']}, 03:23:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:23:38 INFO - 'tsvgr_opacity', 03:23:38 INFO - 'tart', 03:23:38 INFO - 'tscrollx', 03:23:38 INFO - 'cart']}, 03:23:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:38 INFO - 'talos_options': ['--disable-e10s'], 03:23:38 INFO - 'tests': ['tp5o']}, 03:23:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:38 INFO - 'tests': ['tp5o']}, 03:23:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:38 INFO - 'talos_options': ['--disable-e10s', 03:23:38 INFO - '--xperf_path', 03:23:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:38 INFO - 'tests': ['tp5n']}, 03:23:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:38 INFO - 'talos_options': ['--xperf_path', 03:23:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:38 INFO - 'tests': ['tp5n']}}, 03:23:38 INFO - 'talos.zip': {'path': '', 03:23:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:23:38 INFO - Running post-action listener: _resource_record_post_action 03:23:38 INFO - [mozharness: 2016-11-18 11:23:38.768548Z] Finished populate-webroot step (success) 03:23:38 INFO - [mozharness: 2016-11-18 11:23:38.768664Z] Running create-virtualenv step. 03:23:38 INFO - Running pre-action listener: _resource_record_pre_action 03:23:38 INFO - Running main action method: create_virtualenv 03:23:38 INFO - Creating virtualenv /builds/slave/test/build/venv 03:23:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:23:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:23:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:23:38 INFO - Using real prefix '/tools/python27' 03:23:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:23:39 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:42 INFO - Installing pip.................done. 03:23:42 INFO - Return code: 0 03:23:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:23:42 INFO - Reading from file tmpfile_stdout 03:23:42 INFO - Output received: 03:23:42 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:23:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:42 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 0x105221490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105197570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8449470400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105035d30>, '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 0x104e9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10502db20>, '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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r3G0YiCWBX/Render', 03:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:42 INFO - 'HOME': '/Users/cltbld', 03:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:42 INFO - 'LOGNAME': 'cltbld', 03:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:42 INFO - 'MOZ_NO_REMOTE': '1', 03:23:42 INFO - 'NO_EM_RESTART': '1', 03:23:42 INFO - 'PAGER': '/bin/cat', 03:23:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:42 INFO - 'PWD': '/builds/slave/test', 03:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:42 INFO - 'SHELL': '/bin/bash', 03:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NpZLR6f2QD/Listeners', 03:23:42 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:42 INFO - 'USER': 'cltbld', 03:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:42 INFO - 'XPC_FLAGS': '0x0', 03:23:42 INFO - 'XPC_SERVICE_NAME': '0', 03:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:23:42 INFO - Cleaning up... 03:23:43 INFO - Return code: 0 03:23:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105221490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105197570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8449470400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105035d30>, '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 0x104e9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10502db20>, '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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:23:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r3G0YiCWBX/Render', 03:23:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:43 INFO - 'HOME': '/Users/cltbld', 03:23:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:43 INFO - 'LOGNAME': 'cltbld', 03:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:43 INFO - 'MOZ_NO_REMOTE': '1', 03:23:43 INFO - 'NO_EM_RESTART': '1', 03:23:43 INFO - 'PAGER': '/bin/cat', 03:23:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:43 INFO - 'PWD': '/builds/slave/test', 03:23:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:43 INFO - 'SHELL': '/bin/bash', 03:23:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NpZLR6f2QD/Listeners', 03:23:43 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:23:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:43 INFO - 'USER': 'cltbld', 03:23:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:43 INFO - 'XPC_FLAGS': '0x0', 03:23:43 INFO - 'XPC_SERVICE_NAME': '0', 03:23:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:43 INFO - Downloading/unpacking psutil>=3.1.1 03:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:46 INFO - Installing collected packages: psutil 03:23:46 INFO - Running setup.py install for psutil 03:23:46 INFO - building 'psutil._psutil_osx' extension 03:23:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:23:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:23:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:23:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:23:47 INFO - building 'psutil._psutil_posix' extension 03:23:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:23:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:23:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:23:47 INFO - ^ 03:23:47 INFO - 1 warning generated. 03:23:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:23:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:47 INFO - Successfully installed psutil 03:23:47 INFO - Cleaning up... 03:23:47 INFO - Return code: 0 03:23:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105221490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105197570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8449470400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105035d30>, '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 0x104e9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10502db20>, '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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r3G0YiCWBX/Render', 03:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:47 INFO - 'HOME': '/Users/cltbld', 03:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:47 INFO - 'LOGNAME': 'cltbld', 03:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:47 INFO - 'MOZ_NO_REMOTE': '1', 03:23:47 INFO - 'NO_EM_RESTART': '1', 03:23:47 INFO - 'PAGER': '/bin/cat', 03:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:47 INFO - 'PWD': '/builds/slave/test', 03:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:47 INFO - 'SHELL': '/bin/bash', 03:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NpZLR6f2QD/Listeners', 03:23:47 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:47 INFO - 'USER': 'cltbld', 03:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:47 INFO - 'XPC_FLAGS': '0x0', 03:23:47 INFO - 'XPC_SERVICE_NAME': '0', 03:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:23:50 INFO - Installing collected packages: mozsystemmonitor 03:23:50 INFO - Running setup.py install for mozsystemmonitor 03:23:50 INFO - Successfully installed mozsystemmonitor 03:23:50 INFO - Cleaning up... 03:23:50 INFO - Return code: 0 03:23:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105221490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105197570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8449470400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105035d30>, '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 0x104e9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10502db20>, '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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:23:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:23:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r3G0YiCWBX/Render', 03:23:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:50 INFO - 'HOME': '/Users/cltbld', 03:23:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:50 INFO - 'LOGNAME': 'cltbld', 03:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:50 INFO - 'MOZ_NO_REMOTE': '1', 03:23:50 INFO - 'NO_EM_RESTART': '1', 03:23:50 INFO - 'PAGER': '/bin/cat', 03:23:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:50 INFO - 'PWD': '/builds/slave/test', 03:23:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:50 INFO - 'SHELL': '/bin/bash', 03:23:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NpZLR6f2QD/Listeners', 03:23:50 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:23:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:50 INFO - 'USER': 'cltbld', 03:23:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:50 INFO - 'XPC_FLAGS': '0x0', 03:23:50 INFO - 'XPC_SERVICE_NAME': '0', 03:23:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:50 INFO - Downloading/unpacking jsonschema==2.5.1 03:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:53 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:53 INFO - warning: no files found matching '*.txt' 03:23:53 INFO - no previously-included directories found matching 'build' 03:23:53 INFO - no previously-included directories found matching 'dist' 03:23:53 INFO - no previously-included directories found matching '.git*' 03:23:53 INFO - Installing collected packages: jsonschema, functools32 03:23:53 INFO - Running setup.py install for functools32 03:23:54 INFO - warning: no files found matching '*.txt' 03:23:54 INFO - no previously-included directories found matching 'build' 03:23:54 INFO - no previously-included directories found matching 'dist' 03:23:54 INFO - no previously-included directories found matching '.git*' 03:23:54 INFO - Successfully installed jsonschema functools32 03:23:54 INFO - Cleaning up... 03:23:54 INFO - Return code: 0 03:23:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105221490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105197570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8449470400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105035d30>, '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 0x104e9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10502db20>, '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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r3G0YiCWBX/Render', 03:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:54 INFO - 'HOME': '/Users/cltbld', 03:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:54 INFO - 'LOGNAME': 'cltbld', 03:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:54 INFO - 'MOZ_NO_REMOTE': '1', 03:23:54 INFO - 'NO_EM_RESTART': '1', 03:23:54 INFO - 'PAGER': '/bin/cat', 03:23:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:54 INFO - 'PWD': '/builds/slave/test', 03:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:54 INFO - 'SHELL': '/bin/bash', 03:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NpZLR6f2QD/Listeners', 03:23:54 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:54 INFO - 'USER': 'cltbld', 03:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:54 INFO - 'XPC_FLAGS': '0x0', 03:23:54 INFO - 'XPC_SERVICE_NAME': '0', 03:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:23:54 INFO - Cleaning up... 03:23:54 INFO - Return code: 0 03:23:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:54 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 0x105221490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105197570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8449470400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105035d30>, '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 0x104e9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10502db20>, '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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r3G0YiCWBX/Render', 03:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:54 INFO - 'HOME': '/Users/cltbld', 03:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:54 INFO - 'LOGNAME': 'cltbld', 03:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:54 INFO - 'MOZ_NO_REMOTE': '1', 03:23:54 INFO - 'NO_EM_RESTART': '1', 03:23:54 INFO - 'PAGER': '/bin/cat', 03:23:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:54 INFO - 'PWD': '/builds/slave/test', 03:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:54 INFO - 'SHELL': '/bin/bash', 03:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NpZLR6f2QD/Listeners', 03:23:54 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:54 INFO - 'USER': 'cltbld', 03:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:54 INFO - 'XPC_FLAGS': '0x0', 03:23:54 INFO - 'XPC_SERVICE_NAME': '0', 03:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:58 INFO - Downloading docopt-0.6.1.tar.gz 03:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:58 INFO - Running setup.py install for blobuploader 03:23:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:58 INFO - Running setup.py install for requests 03:23:59 INFO - Running setup.py install for docopt 03:23:59 INFO - Successfully installed blobuploader requests docopt 03:23:59 INFO - Cleaning up... 03:23:59 INFO - Return code: 0 03:23:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:59 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 0x105221490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105197570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8449470400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105035d30>, '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 0x104e9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10502db20>, '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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r3G0YiCWBX/Render', 03:23:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:59 INFO - 'HOME': '/Users/cltbld', 03:23:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:59 INFO - 'LOGNAME': 'cltbld', 03:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:59 INFO - 'MOZ_NO_REMOTE': '1', 03:23:59 INFO - 'NO_EM_RESTART': '1', 03:23:59 INFO - 'PAGER': '/bin/cat', 03:23:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:59 INFO - 'PWD': '/builds/slave/test', 03:23:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:59 INFO - 'SHELL': '/bin/bash', 03:23:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NpZLR6f2QD/Listeners', 03:23:59 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:23:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:59 INFO - 'USER': 'cltbld', 03:23:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:59 INFO - 'XPC_FLAGS': '0x0', 03:23:59 INFO - 'XPC_SERVICE_NAME': '0', 03:23:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:59 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-HysCdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:59 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-4GWm24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:59 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-7LLkMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:59 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-bLh22Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:00 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-6yeBm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:00 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-BvY62t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:00 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-bMaQ8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:00 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-wy_VAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:00 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Yw0sDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:00 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-JyIdA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:00 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-jaFJWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:00 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-mBkCPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:00 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-rymtHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:01 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-08et4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:01 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-83NMPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:01 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-wVKvEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:01 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-HZod7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:24:01 INFO - Running setup.py install for manifestparser 03:24:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:24:01 INFO - Running setup.py install for mozcrash 03:24:01 INFO - Running setup.py install for mozdebug 03:24:01 INFO - Running setup.py install for mozdevice 03:24:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:24:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:24:02 INFO - Running setup.py install for mozfile 03:24:02 INFO - Running setup.py install for mozhttpd 03:24:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:24:02 INFO - Running setup.py install for mozinfo 03:24:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:24:02 INFO - Running setup.py install for mozInstall 03:24:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:24:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:24:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:24:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:24:02 INFO - Running setup.py install for mozleak 03:24:02 INFO - Running setup.py install for mozlog 03:24:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:24:02 INFO - Running setup.py install for moznetwork 03:24:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:24:03 INFO - Running setup.py install for mozprocess 03:24:03 INFO - Running setup.py install for mozprofile 03:24:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:24:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:24:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:24:03 INFO - Running setup.py install for mozrunner 03:24:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:24:03 INFO - Running setup.py install for mozscreenshot 03:24:03 INFO - Running setup.py install for moztest 03:24:03 INFO - Running setup.py install for mozversion 03:24:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:24:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:24:03 INFO - Cleaning up... 03:24:04 INFO - Return code: 0 03:24:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:04 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 0x105221490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105197570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8449470400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105035d30>, '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 0x104e9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10502db20>, '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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:24:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r3G0YiCWBX/Render', 03:24:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:04 INFO - 'HOME': '/Users/cltbld', 03:24:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:04 INFO - 'LOGNAME': 'cltbld', 03:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:04 INFO - 'MOZ_NO_REMOTE': '1', 03:24:04 INFO - 'NO_EM_RESTART': '1', 03:24:04 INFO - 'PAGER': '/bin/cat', 03:24:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:04 INFO - 'PWD': '/builds/slave/test', 03:24:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:04 INFO - 'SHELL': '/bin/bash', 03:24:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NpZLR6f2QD/Listeners', 03:24:04 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:24:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:04 INFO - 'USER': 'cltbld', 03:24:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:04 INFO - 'XPC_FLAGS': '0x0', 03:24:04 INFO - 'XPC_SERVICE_NAME': '0', 03:24:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:04 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-tSww8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:04 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-940RFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:04 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-5mWiIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:04 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-NXGtcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:04 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-l6x74H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:04 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-0imA9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:04 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-R8z4F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:05 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-9TuR5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:05 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-0ylvpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:05 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-RZbdjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:05 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Iy21Nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:05 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-JQDjIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:05 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-57c8zX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:05 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-GpWn7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:05 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-fIzZQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:05 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-U6LoB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:05 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-3EtdPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:08 INFO - Downloading blessings-1.6.tar.gz 03:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:24:08 INFO - Installing collected packages: blessings 03:24:08 INFO - Running setup.py install for blessings 03:24:08 INFO - Successfully installed blessings 03:24:08 INFO - Cleaning up... 03:24:08 INFO - Return code: 0 03:24:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:09 INFO - Reading from file tmpfile_stdout 03:24:09 INFO - Current package versions: 03:24:09 INFO - blessings == 1.6 03:24:09 INFO - blobuploader == 1.2.4 03:24:09 INFO - docopt == 0.6.1 03:24:09 INFO - functools32 == 3.2.3-2 03:24:09 INFO - jsonschema == 2.5.1 03:24:09 INFO - manifestparser == 1.1 03:24:09 INFO - mozInstall == 1.12 03:24:09 INFO - mozcrash == 1.0 03:24:09 INFO - mozdebug == 0.1 03:24:09 INFO - mozdevice == 0.48 03:24:09 INFO - mozfile == 1.2 03:24:09 INFO - mozhttpd == 0.7 03:24:09 INFO - mozinfo == 0.9 03:24:09 INFO - mozleak == 0.1 03:24:09 INFO - mozlog == 3.4 03:24:09 INFO - moznetwork == 0.27 03:24:09 INFO - mozprocess == 0.23 03:24:09 INFO - mozprofile == 0.28 03:24:09 INFO - mozrunner == 6.13 03:24:09 INFO - mozscreenshot == 0.1 03:24:09 INFO - mozsystemmonitor == 0.3 03:24:09 INFO - moztest == 0.7 03:24:09 INFO - mozversion == 1.4 03:24:09 INFO - psutil == 3.1.1 03:24:09 INFO - requests == 1.2.3 03:24:09 INFO - wsgiref == 0.1.2 03:24:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:09 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 0x105221490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105197570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8449470400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105035d30>, '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 0x104e9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10502db20>, '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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:24:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:24:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r3G0YiCWBX/Render', 03:24:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:09 INFO - 'HOME': '/Users/cltbld', 03:24:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:09 INFO - 'LOGNAME': 'cltbld', 03:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:09 INFO - 'MOZ_NO_REMOTE': '1', 03:24:09 INFO - 'NO_EM_RESTART': '1', 03:24:09 INFO - 'PAGER': '/bin/cat', 03:24:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:09 INFO - 'PWD': '/builds/slave/test', 03:24:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:09 INFO - 'SHELL': '/bin/bash', 03:24:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NpZLR6f2QD/Listeners', 03:24:09 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:24:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:09 INFO - 'USER': 'cltbld', 03:24:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:09 INFO - 'XPC_FLAGS': '0x0', 03:24:09 INFO - 'XPC_SERVICE_NAME': '0', 03:24:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:24:09 INFO - Cleaning up... 03:24:09 INFO - Return code: 0 03:24:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:09 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 0x105221490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105197570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8449470400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105035d30>, '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 0x104e9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10502db20>, '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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:24:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:24:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r3G0YiCWBX/Render', 03:24:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:09 INFO - 'HOME': '/Users/cltbld', 03:24:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:09 INFO - 'LOGNAME': 'cltbld', 03:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:09 INFO - 'MOZ_NO_REMOTE': '1', 03:24:09 INFO - 'NO_EM_RESTART': '1', 03:24:09 INFO - 'PAGER': '/bin/cat', 03:24:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:09 INFO - 'PWD': '/builds/slave/test', 03:24:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:09 INFO - 'SHELL': '/bin/bash', 03:24:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NpZLR6f2QD/Listeners', 03:24:09 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:24:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:09 INFO - 'USER': 'cltbld', 03:24:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:09 INFO - 'XPC_FLAGS': '0x0', 03:24:09 INFO - 'XPC_SERVICE_NAME': '0', 03:24:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:24:09 INFO - Cleaning up... 03:24:09 INFO - Return code: 0 03:24:09 INFO - Running post-action listener: _resource_record_post_action 03:24:09 INFO - Running post-action listener: _start_resource_monitoring 03:24:09 INFO - Starting resource monitoring. 03:24:09 INFO - [mozharness: 2016-11-18 11:24:09.787507Z] Finished create-virtualenv step (success) 03:24:09 INFO - [mozharness: 2016-11-18 11:24:09.788605Z] Running install step. 03:24:09 INFO - Running pre-action listener: _resource_record_pre_action 03:24:09 INFO - Running main action method: install 03:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:10 INFO - Reading from file tmpfile_stdout 03:24:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:24:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:24:10 INFO - Reading from file tmpfile_stdout 03:24:10 INFO - Output received: 03:24:10 INFO - Usage: mozinstall [options] installer 03:24:10 INFO - Options: 03:24:10 INFO - -h, --help show this help message and exit 03:24:10 INFO - -d DEST, --destination=DEST 03:24:10 INFO - Directory to install application into. [default: 03:24:10 INFO - "/builds/slave/test"] 03:24:10 INFO - --app=APP Application being installed. [default: firefox] 03:24:10 INFO - mkdir: /builds/slave/test/build/application 03:24:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:24:41 INFO - Reading from file tmpfile_stdout 03:24:41 INFO - Output received: 03:24:41 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:24:41 INFO - Running post-action listener: _resource_record_post_action 03:24:41 INFO - [mozharness: 2016-11-18 11:24:41.976500Z] Finished install step (success) 03:24:41 INFO - [mozharness: 2016-11-18 11:24:41.976638Z] Running run-tests step. 03:24:41 INFO - Running pre-action listener: _resource_record_pre_action 03:24:41 INFO - Running main action method: run_tests 03:24:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:24:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:24:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:24:41 INFO - 2016-11-18 03:24:41.991 screenresolution[1888:15497] starting screenresolution argv=screenresolution get 03:24:41 INFO - 2016-11-18 03:24:41.993 screenresolution[1888:15497] Display 0: 1600x1200x32@60 03:24:42 INFO - 2016-11-18 03:24:41.999 screenresolution[1889:15499] starting screenresolution argv=screenresolution list 03:24:42 INFO - Available Modes on Display 0 03:24:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:24:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:24:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:24:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:24:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:24:42 INFO - Intel Iris: 03:24:42 INFO - Chipset Model: Intel Iris 03:24:42 INFO - Type: GPU 03:24:42 INFO - Bus: Built-In 03:24:42 INFO - VRAM (Dynamic, Max): 1536 MB 03:24:42 INFO - Vendor: Intel (0x8086) 03:24:42 INFO - Device ID: 0x0a2e 03:24:42 INFO - Revision ID: 0x0009 03:24:42 INFO - Displays: 03:24:42 INFO - Display: 03:24:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:24:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:24:42 INFO - Display Serial Number: 1600x1200 60 03:24:42 INFO - Main Display: Yes 03:24:42 INFO - Mirror: Off 03:24:42 INFO - Online: Yes 03:24:42 INFO - Rotation: Supported 03:24:42 INFO - Return code: 0 03:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:42 INFO - Python 2.7.3 03:24:42 INFO - Return code: 0 03:24:42 INFO - grabbing minidump binary from tooltool 03:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105035d30>, '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 0x104e9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10502db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:24:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:24:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:24:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:42 INFO - Return code: 0 03:24:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:24:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:24:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0185 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:24:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r3G0YiCWBX/Render', 03:24:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:42 INFO - 'HOME': '/Users/cltbld', 03:24:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:42 INFO - 'LOGNAME': 'cltbld', 03:24:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:42 INFO - 'MOZ_NO_REMOTE': '1', 03:24:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:42 INFO - 'NO_EM_RESTART': '1', 03:24:42 INFO - 'PAGER': '/bin/cat', 03:24:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:42 INFO - 'PWD': '/builds/slave/test', 03:24:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:42 INFO - 'SHELL': '/bin/bash', 03:24:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NpZLR6f2QD/Listeners', 03:24:42 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:24:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:42 INFO - 'USER': 'cltbld', 03:24:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:42 INFO - 'XPC_FLAGS': '0x0', 03:24:42 INFO - 'XPC_SERVICE_NAME': '0', 03:24:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:24:42 INFO - mozversion application_buildid: 20161118004020 03:24:42 INFO - mozversion application_changeset: 7ad438df29922ee13d21100873883eb9dd93423c 03:24:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:24:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:24:42 INFO - mozversion application_name: Firefox 03:24:42 INFO - mozversion application_remotingname: firefox-dev 03:24:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:24:42 INFO - mozversion application_vendor: Mozilla 03:24:42 INFO - mozversion application_version: 52.0a2 03:24:42 INFO - mozversion platform_buildid: 20161118004020 03:24:42 INFO - mozversion platform_changeset: 7ad438df29922ee13d21100873883eb9dd93423c 03:24:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:24:42 INFO - mozversion platform_version: 52.0a2 03:24:42 INFO - using testdate: 1479468282 03:24:42 INFO - actual date: 1479468282 03:24:42 INFO - starting webserver on 'localhost:53469' 03:24:42 INFO - SUITE-START | Running 2 tests 03:24:42 INFO - TEST-START | dromaeo_css 03:24:42 INFO - operating with platform_type : mac_ 03:24:42 INFO - Initialising browser for dromaeo_css test... 03:24:42 INFO - TEST-INFO | started process 1899 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpJMoX8G/profile http://localhost:53469/getInfo.html) 03:24:44 ERROR - PROCESS | 1899 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 03:24:45 INFO - PROCESS | 1899 | __metrics Screen width/height:1600/1200 03:24:45 INFO - PROCESS | 1899 | colorDepth:24 03:24:45 INFO - PROCESS | 1899 | Browser inner width/height: 1024/689 03:24:45 INFO - PROCESS | 1899 | __metrics 03:24:45 ERROR - PROCESS | 1899 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 03:24:46 INFO - TEST-INFO | 1899: exit 0 03:24:46 INFO - Browser initialized. 03:24:46 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:46 INFO - TEST-INFO | started process 1903 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpJMoX8G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:58 INFO - PROCESS | 1903 | RSS: Main: 224505856 03:24:58 INFO - PROCESS | 1903 | 03:25:48 INFO - PROCESS | 1903 | 1479468348070 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:28:01 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:53469/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53469/tests/dromaeo/cssquery-ext.html) 03:28:03 INFO - PROCESS | 1903 | RSS: Main: 233783296 03:28:03 INFO - PROCESS | 1903 | 03:31:05 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:53469/tests/dromaeo/cssquery-ext.html (next: http://localhost:53469/tests/dromaeo/cssquery-jquery.html) 03:31:06 INFO - PROCESS | 1903 | RSS: Main: 244752384 03:31:06 INFO - PROCESS | 1903 | 03:34:08 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:53469/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53469/tests/dromaeo/cssquery-mootools.html) 03:34:08 INFO - PROCESS | 1903 | RSS: Main: 249032704 03:34:08 INFO - PROCESS | 1903 | 03:37:10 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:53469/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53469/tests/dromaeo/cssquery-prototype.html) 03:37:11 INFO - PROCESS | 1903 | RSS: Main: 248160256 03:37:11 INFO - PROCESS | 1903 | 03:40:14 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:53469/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53469/tests/dromaeo/cssquery-yui.html) 03:40:14 INFO - PROCESS | 1903 | RSS: Main: 252485632 03:40:14 INFO - PROCESS | 1903 | 03:43:17 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:53469/tests/dromaeo/cssquery-yui.html (next: http://localhost:53469/tests/dromaeo/cssquery-dojo.html) 03:43:17 INFO - PROCESS | 1903 | RSS: Main: 253853696 03:43:17 INFO - PROCESS | 1903 | 03:43:17 INFO - PROCESS | 1903 | __start_tp_report 03:43:17 INFO - PROCESS | 1903 | _x_x_mozilla_page_load 03:43:17 INFO - PROCESS | 1903 | _x_x_mozilla_page_load_details 03:43:17 INFO - PROCESS | 1903 | |i|pagename|runs| 03:43:17 INFO - PROCESS | 1903 | |0;dojo.html;2922.2256102132924;3308.4044871923074;3371.966280337196;3389.322135572885;3394.830258487075;5607.439256074391;5649.6892670903035;5688.345840228375;5699.829005129853;5709.257796486461;4727.385439892818;5711.685857277848;5751.741171647275;5772.105323674838;5793.304803423595;5212.687238765677;5248.211403176619;5249.265102885599;5257.421683614799;5303.28405665236;5298.735063246822;5316.601254905878;5334.119870221409;5360.517553420192;5365;5175.585953123741;5223.660462069973;5292.311999440087;5299.390570084432;5355.758990845421;4291.828326866922;5201.973990130063;5225.824189557357;5257.369115706139;5285.339332583427;5098.745062746885;5171.974140129313;5258.237555554461;5261.605379596545;5299.708516031616;5766.221560089418;5780.624259423124;5799.710014499258;5806.970965145189;5814.0697488402075;5732.254806875121;6076.3316035236085;6118.040554665182;6126.456603435028;6317.241930968313;6271.843203919893;6287.151234583364;6297.33877942814;6298.811035668891;6300.905486417708;4889.731064791435;5830.15462757902;5846.976779063732;5851.414858514115;5887.61730487517;6144.433169541739;6214.223222097238;6226.159468471789;6259.561830671901;6302.243730752339;5692.971535142297;6096.817095487142;6122.081687746873;6154.046122850965;6194.721237544321;6253.1245625612455;6255.093011513305;6259.874802504016;6266.185395898595;6292.685365731695;6142.846428839315;6171.321154672983;6197.783077592263;6206.503479721701;6247.5939063960695;6084.391560843968;6106.4809491192855;6120.265568131853;6131.386861313922;6146.416090471398;4885.682430642068;4903.632227582945;4905.828296009622;4917.9016419672125;4941.2341087130835;4408.53710360414;4411.470623525133;4412.404325416028;4420.8673739787855;4462.709923854939;5643.604947653707;5712.542996560265;5716.771329146871;5802.941970580325;5806.970965145148;4511.255642818898;5356.625036247426;5747.511461525817;6179.3202747697715;6180.042093475518;4589.816407343736;5680.261565996394;5702.914456283159;5706.657600543981;5809.24479817621;4334.479862416467;5351.411344752074;5426.565874730012;5430.565554755689;5439.102548079602;6185.350538193515;6245.219347581552;6295.213098362613;6300.653464059521;6306.211723534559;5097.6941383517105;6124.234470691164;6144.047672610753;6212.844678883064;6240.344763799736;5274.340707411574;6161.507079433724;6183.659898705434;6223.782167624111;6273.498120150468;6193.535484838565;6193.81418557444;6202.131701561695;6203.100550420254;6217.098520714561;4981.551660350586;6067.939320606914;6207.255129384503;6249.937500624936;6265.122882796321;5947.791827286024;6022.337542870368;6029.78895738647;6033.607815491979;6088.4215999479975;6101.877962440638;6107.328193898578;6116.3883611638485;6133.294671112879;6137.754489820536;5827.475527202572;5896.469317761422;5940.8811823764145;5964.224650795369;5969.253843269591;5836.854078648068;5959.314678811992;5963.194968679346;6072.969635151796;6101;5846.269216347957;5866.970665146647;5868.94131058701;5882.264716910387;5897.997340452048 03:43:17 INFO - PROCESS | 1903 | |1;ext.html;483.2606112647648;487.47109386315844;495.9461145066733;519.6907839835297;533.0564900126776;34123.65876341236;39246.60753392465;39304.213915721666;39322.60677393225;39399.80300098499;40198.59801401985;40513.59486405135;40735.14853960224;40802;40806.7959660202;9263.953680231589;9406.717798466058;9416;9443.622255109787;9451.95274023629;9385.95307023464;9445.716628501155;9448.527573621326;9467.384619999679;9470.479123648196;9450.952745236298;9461.81076378472;9463.101005404476;9476.763080922998;9480.525973701322;9388.1081297277;9412.576434060484;9439.480828554426;9454.90545094547;9476.28927830412;9270.44377337362;9357.719268421959;9368.297377696632;9390.389624674443;9393.812123757487;38624.42063369052;38886.80556597199;38901;39007.8049609753;39132.60867391318;3291.53918451417;3301.735861131104;3308.4871844864083;3334.566506354183;3379.459286514146;25939.703014849183;26651.733482665313;29293.56059659107;29646.110616681533;30167;3173.3335999440146;3204.118867311508;3208.8395580220895;3211.132994091582;3218.629857566363;495364;498079.50960245327;499376;501286;501324;54929.45070549243;55180.89638207293;55256.72371638116;55279.17081243785;55330;56663;56783.864322713314;56880.71559642175;57306.713466432404;57335.42664573301;13793.586192414243;14774.778378324334;15386.9230653846;15420.691586168437;15629.921850390676;9886.555105020292;10328.793424131476;10877.292975956538;11020.173486988508;12345.012399008057;11840.230385024946;14168.716625667636;14555.563333100024;14596.197209153386;14707.92646036763;3172.588198251756;6316.3471342036455;6524.380183882618;6601.570897891622;6677.232118306457;851.8551846186164;915.4415806358116;928.6888892221182;991.7371896447447;1091.6233899304727;28907;29063.85468072646;29511.852440737657;30028;30199;948.5589201021559;1031.654395777423;1039.896010398969;1046.1735229168871;1150.4477850631743;13165.946724262036;14069.788953165506;14969.251537423086;15368.846311536741;15404.075755454485;692942;693657.5317123483;699461;699510;700511;53928;54418.45581544213;54584.454155458734;54602.72698636481;54830;1319.3601103464812;1327.4292054416694;1347.3667376333108;1356.0304382366458;1359.864013598652;26011.349716257246;28465.715342847136;28880.98916537911;29328.56007159937;29417.55873661854;46361;46687.29969050399;46705.2994205094;46721.766391169185;46788.7660561695;633392;634490;638078;640061;640641;25476.363090922136;25630.359241019123;26530.469390612467;26534.93860245646;27274.72725272801;44184.558154418046;44414;44602.3309650362;44635.77682111569;44857.775711121234;36834.63165368312;36920.325511921605;37287;37796.62203377931;38393.80803095967;36802;36966.63033369632;37296;37701.81149094237;38119.61880381161;31886.681133188373;32808.67191328056;36834.8158259207;36844.078898027765;37109.81445092757;30302.545461817648;33692.63351381528;33998.66001339955;34139.82930085433;34148;25347.239582812545;25348.74651253464;25356.239312820646;25405.61891571591;25954.610680839425 03:43:17 INFO - PROCESS | 1903 | |2;jquery.html;348.5242643791225;366.5528055771957;373.7458528200824;382.6995808290492;401.7385409813187;14526.63683407914;19334.323298684532;19590.804091959075;20104.99999999998;20313.796862031377;19042.523936901584;19281.325153619626;19461.70807437886;19634.803651963477;19653.705194422095;5594.188842617828;5630.831075067734;5888.205092312547;5898.1447690084915;5899.528037756991;5700.714964251792;5863.853403664921;5866.794662186824;5868.823935281948;5877.67672777997;5552.750126244328;5710.714464276791;5757.453041961028;5766.855828604276;5818.06910894257;5569.192467092249;5697.604086998691;5698.51562617178;5777.0756678931375;5781.046127388997;4915.410150781929;4978.626603004753;5019.121653710586;5062.974685126587;5076.771545280471;19474;22353.888230558907;24168;24514.754852451424;24586.50826983468;2265.0939624150305;2289.6565515172692;2337.3338598499518;2485.850848949051;2985.7163569460868;12022.27866328023;14799.260036998216;15057.247137643075;15194.46819361328;15340.539783806504;1789.1233295685151;1814.3468351393487;1815.7730283714536;1854.9721754173697;1924.788273289937;91235;113407.43296283466;113596;115269.4236528812;115839.42080289545;10304.227182961307;10549.630762923261;10579.206559508068;11057.668269951915;11262.211645184758;13551.457941682222;13558.254296013814;13562.525311614047;13575.728485430434;13594.184348939096;8227.629756660965;8444.155584441629;8463;8535.829283414298;8611.655533778703;8540.829183416297;8546.931633545806;8576.013758417861;8708.08565100668;8744.256738177199;6443.581167224115;6529.237105981453;6564.80305590833;6605.405513503808;6621.834454138685;1789.4273832373515;1825.6896327624336;1827.4060930197738;1830.5881176735395;1832.2304632054302;858.5707146426787;930.6277489004317;932.5477143585356;964.7925695975258;1008.9848652270222;15908.920455397649;19979.700304495444;20377.89811050935;20549.89725051395;21478.355649330544;934.3786382055993;957.0381766324799;979.5836769372988;990.1435258501344;1038.7974345002804;10973.725656858642;11554.480048397842;11556;11583.362915039585;11602.825957610643;252668;541569;549762;622294;631437;119042.21436678457;125202.3739881313;127812;139044.9143262852;141727;848.2874385516196;939.9765005874908;950.230313446097;992.3626017071889;994.945278009702;18315.816841831944;18708.877467352002;18975;18992.24031038743;19372.2251109954;46734.76632616815;50740.49259507358;55174;55557.333280001665;57277;73735.6313218452;75730;76960;78877.0280742986;80520.59739701498;7694.230576942261;7917.841643167219;8031.237032481905;8036.919630803851;8057.274845263954;11344;11620.012298954684;12013.519459221534;12392.94659953914;12827.807582886078;10519.26365154432;10543.525541350504;10702.83945740799;10821.296615719953;10967.287126336763;10668.786624267315;10700.83948740754;10769;10867.728306792393;10944.507497162806;9069.365144439826;10881;10976.615818446317;11247.718807029889;11335.263207891461;7846.450748447783;7896.170902055431;7924.366050716044;7971;8090.1909809018625;8979.50612716307;10790.784184316426;10841.241113122005;11148.721281968015;11269.154813388865 03:43:17 INFO - PROCESS | 1903 | |3;mootools.html;1473.8378778334381;1506.6534697019688;1665.3838079910427;1742.5295170304025;1779.9021053842034;7659.157492675815;7921.247481489264;8208.220219079185;8676.436031657939;8687.782805429868;8181.181881811815;8506.829863402729;8512.276456501204;8575.056743758198;8724.607392667329;2332.265336419027;2365.3022358404314;2365.6924599802;2368.3605426534828;2370.0519792083132;2362.870042147681;2385.666006759055;2402.087206861399;2416.9879150604224;2417.758224177577;2085.593309304686;2253.9098436062536;2324.9883750581225;2340.871252081135;2350.553394854972;2259.4690247791755;2272.602294598447;2299.321700098475;2299.8620082795087;2303.7120359955006;2348.330725743155;2367.656689779972;2376.346504711218;2376.6910301660846;2384.546936082156;8478.321734261244;8566.957165214197;8610.268127209194;8628.654853805903;8640.30877529796;5095.878906640533;5122.948770512285;5194;5291.920621190647;5294.073537131025;3397.184675677844;3444.1389652586854;3576.6959808416054;3586.4082426399614;3630.8729194478333;1040.7398150462384;1071.7052810477103;1076.6070384309671;1103.3269705479652;1111.0611533254387;10960.068394186505;11019.724506887313;11112.666620001331;11126.61056863014;11139;4626.791794369262;4639.768011599406;4788.808447662124;4806;4806.711597304103;9573.234141268682;9652.9034709652;9654.613815447303;9657.130858222794;9671.661491847892;5267.552258058031;5274.945010997816;5280.894382112337;5291.074062039128;5353.892922141536;4303.763293018914;4332.220200363965;4743.644226683013;4770.403699537558;4832.081904438145;3793.468914351993;3833.4058220975794;3887.4168874669026;3925.4896863408144;3944.2308749793515;1277.303869391184;1285.7685616589104;1286.5947226623584;1298.8831005209577;1307.6600083978044;888.4984376403986;896.6951236579595;900.0864122915247;902.264654306738;915.3180880244261;5750.338711048283;5760.6255593386295;5775.913361299584;5915.733791979371;5918.7928422505;452.5587552136706;452.6446739309626;460.4589607211513;919.0074719303136;992.771662517625;3093.783435159517;3251;3942.8108554021287;4000.119973605802;4047.291723948297;8528.360372972053;10099.798004039878;10300.96990300964;10432.582696692047;10626.096781773636;10357.792844143225;10383.896161038445;10385.169186465064;10401.375917444977;10413.739656508496;7683.231676832272;7893.723719669784;7999.240072193133;8006.559639219782;8022.518648881086;4818.68678535894;5596.748146333506;5637.689927054052;5733.971330143323;5851.502622277154;9522.047795220422;9529.142377186086;9556.996515365787;9566.66516671913;9652.855207171757;9592.568334425107;9624;9699.563519641491;9835.16401105914;9869.407835529892;5502.339719233718;6344.524160688059;6542.1168142300185;6848.794536163923;6957.582545047111;7993.760187194393;8214.05538363096;8223.753287401387;8225.42422030476;8236.888020117207;7131.144262688303;7296.817579560554;7302.6713797878165;7312;7390.704371825067;7055.118110236221;7154.320339567733;7155.749548765768;7278.96360518194;7326.633668316669;6827.590344579143;6840.41856442208;6901.033855260167;6901.275366086689;6911.447084233349;4824.028521919327;4890.6821056632625;4925.901481970269;4942;4988.451270360185;4332.328489084197;4821.95178048215;4868.075065737498;4898.975505122452;5024.397072351341 03:43:17 INFO - PROCESS | 1903 | |4;prototype.html;272.2621695205992;281.5691991253383;305.3876976661793;310.5667593706779;313.0889112682095;4669.883252918678;5122.359705036871;5275.208718692198;5421.647592906468;5424.5931555133375;5267.183586544092;5303.7082960437165;5304.3634763828395;5305.310309659739;5323.733813309338;3826.4260360945805;3842.615738426163;3942.6254505821903;3965.9801700991597;4028.395740638898;3349.9162520937048;3600.135967367839;3653.0867283179205;3657.3233951718885;4028.6374226319626;3375.510550970108;3522.5068490411363;3975.721699481023;3997.580254073324;4008.3987401889804;3696.77819330841;3769.2461507698295;3774.8675397380675;4017.4375587417785;4026.9731218539378;2998.6551546572205;3425.2635683328203;3442.3803715331233;3445.2248244145117;3448.413769659164;4732.384789977315;5120.722737447999;5120.769565369567;5152.196731144107;5169.190783225841;3688.7458264190304;4582.862514124582;4584.358189853423;4609.83865564707;4651.186042442593;5154.762856914351;5203.320290050627;5629.577781666391;5630;5635.380108188096;3202.727768139711;3853.8033321007038;3855.9807200964096;3867.323218436762;3868.8065596720053;5052.823151189691;5172.689638621695;5208.244804503326;5735.225744524478;5928.851778705523;2988.296670897611;3127.4526957782296;3272.8690852366117;3880.592537783492;3897.6881849451975;3972.682185425159;3977.6420122189143;3981.980090099531;3986.943459983049;3987.023179321085;3431.6396778338412;3617.5839778425816;3957.782321972319;4024.832798488464;4670.486246512881;5150.974245128826;5338.572914166857;5620.297462817148;5693.430656934273;5722.7710891563875;1108.0581505720234;1162.4245998230929;1200.9759804803855;1209.2865209526421;1246.6883279180206;841.4068082002174;869.2090197919863;873.5457562067689;884.1777147252988;890.4523717913567;4665.037701059784;4905.945221777335;5069.847904562869;5375;5445.264889239981;4543.954560454419;5181.326427564392;5805.7387417566315;5836.766529338779;5858.8242352729485;4061.5126184858004;4276.439099728639;4639;4805.870620404202;5395.3525576931015;2362.9172978946;2657.8803953822126;2781.972180278212;2871.784616153797;2898.9565156522667;4956.727379994063;5188.792448302102;5784.2769653793275;5808.941910580925;5879.853003674857;5085.415177254589;5192.221166825007;5355.3305836770405;5677.403872593318;5697.259356283656;4940.431850337185;5253.264542963988;5435.668261276012;5732.283464566929;5753.626014309057;5382.219578161066;5591.580631452576;5594.468525490072;5624.746886390204;5643.746031428514;5236.816711415235;5243.973780131075;5373.919391209213;5494.736210671488;5498.45015498447;5745.6552606843725;5771.769129234784;5821.330546987151;5827.271591051119;5870.970645146747;3209.6790320967716;3722.236941427055;3723.311187430334;3731.197792474631;3746.3069332173636;5216.695826043489;5331.573474122139;5479.794195514357;5515.145152501369;5524.447555244444;4485.667452924396;4793.712377257376;4935.914098898236;4968.882001549622;5488.615796894179;4753.001869607421;4911.754412279443;4920.4326863024025;5328.733563321896;5341.62608617393;5184.844454666366;5218.277968270538;5227.712475813867;5238.245187861957;5260.736963151904;4671.271629497108;5342.76762558662;5362.356517217959;5362.490563396471;5534.916976245279;4433.866983990485;5061.974690126526;5523.751431185526;5527.391986881359;5538.972305138448 03:43:17 INFO - PROCESS | 1903 | |5;yui.html;680.8842496775544;743.2047708951422;757.1482082657011;762.9923700762997;784.5018413307549;14544.709105817878;15194.240287985584;15205.619859503518;15207.619809504768;15253.771193432107;13464.057515973886;13581.932090339558;13590.456381744718;13601.931990340034;13621;796.6136423834436;814.2102160903913;815.4821688227959;818.7093581778472;818.811673315135;778.8714862047756;785.0148064179447;799.4164260090138;800.8198155415043;805.5287656720825;856.6873091321685;857.3655494933736;858.9778163984869;859.5401460218784;863.5293764898146;819.5041999590281;843.5065486690294;850.0437008365589;852.1435956863374;852.2202185000717;598.2940130645836;635.7615894039735;640.4268179978893;642.6722371590475;642.7493277621732;10272.897271027268;12472.50109995599;12511.874881251162;12534.185277956994;12886.162399444007;10632.840507392395;11591.942040289829;11701.3564253966;12423;12664.81002784959;10922.85310042442;12028.218165819193;12298;12305.630831075083;12350.44423000967;4230.090530535949;4370.2133615949115;4422.5356337584735;4424.977875110636;4442.577955094261;82867;83019.5849020751;85038;86933.56533217293;88672.55663721704;10164.186865050779;10227.386356818615;10296.845547316796;10363.689089327332;10640.201984851166;18757.624847503248;19094.522636934187;19125.90437047806;19180.232790688497;19278.036098195316;6453.645049522227;7471.51435156724;7532.585707786015;7552.697892084255;7674.616269186518;3569.697060572872;3604.8558057677924;3733.738638295293;4200.684948628865;4205.726627769185;2813.521701310782;2842.7725781937397;3249.9350012999607;3326.600807903067;3347.681970212826;580.9078931608549;664.5149041199951;691.0670594697119;692.9861402772017;700.352174238827;603.6287683074966;660.1780782925289;669.1434963247052;674.9055132281485;688.8312363470982;6637.601743895381;9196;9209.815803684023;9279.814403711887;9405.012473690302;563.276190095725;616.7193926763312;637;668.6289109544152;683.0676127086491;4388.245840824557;4564.269716845289;4564.589186973122;4570.565796249351;4646.512116227815;97103.51448242855;98344.50827745958;99700.00299997053;103730;118717.40641296911;92483;94932;96394.03605963991;99143;103266;80185.59907200544;80686.59656701796;82587.5870620655;84315.15684843196;84393.57803211067;9510.4307789214;9891.060349266809;9936.503174841084;9937.10566049059;9947.651832185838;44314;54220.728896355264;54855.451445485036;56586.71706641441;56980.43019569751;77219;78820;80403.59798200971;82454.58772706098;83188;12112.394380281126;12314.692132696755;12389.318587477776;12440.626781196579;12591.559295424982;13826.723465530835;13845.584632461043;14111.929440352733;14358.425662973365;14940.954133211006;12400.317982510687;12699.682507937006;13615.115017523829;13833.515826946008;13874.236916969663;9994.850077248702;12985.155964862253;13292.268925209206;13324.333783310602;13893.513727019506;12349.814752778535;12851.742965140831;13139.737205256033;13410.195388276734;13572.524961626295;10873.945630271797;11258.887411125785;11296.209265351346;11371.772564548828;11589.108886244798;10555.065464531568;11173.217874748689;11458.713532161762;11468.541258349573;11540.961313481826 03:43:17 INFO - PROCESS | 1903 | __end_tp_report 03:43:17 INFO - PROCESS | 1903 | __start_cc_report 03:43:17 INFO - PROCESS | 1903 | _x_x_mozilla_cycle_collect,369 03:43:17 INFO - PROCESS | 1903 | __end_cc_report 03:43:17 INFO - PROCESS | 1903 | __startTimestamp1479469397747__endTimestamp 03:43:17 INFO - PROCESS | 1903 | 03:43:17 INFO - PROCESS | 1903 | ------- Summary: start ------- 03:43:17 INFO - PROCESS | 1903 | Number of tests: 6 03:43:17 INFO - PROCESS | 1903 | 03:43:17 INFO - PROCESS | 1903 | [#0] dojo.html Cycles:165 Average:5666.63 Median:5846.27 stddev:663.48 (11.3%) stddev-sans-first:629.62 03:43:17 INFO - PROCESS | 1903 | Values: 2922.2 3308.4 3372.0 3389.3 3394.8 5607.4 5649.7 5688.3 5699.8 5709.3 4727.4 5711.7 5751.7 5772.1 5793.3 5212.7 5248.2 5249.3 5257.4 5303.3 5298.7 5316.6 5334.1 5360.5 5365.0 5175.6 5223.7 5292.3 5299.4 5355.8 4291.8 5202.0 5225.8 5257.4 5285.3 5098.7 5172.0 5258.2 5261.6 5299.7 5766.2 5780.6 5799.7 5807.0 5814.1 5732.3 6076.3 6118.0 6126.5 6317.2 6271.8 6287.2 6297.3 6298.8 6300.9 4889.7 5830.2 5847.0 5851.4 5887.6 6144.4 6214.2 6226.2 6259.6 6302.2 5693.0 6096.8 6122.1 6154.0 6194.7 6253.1 6255.1 6259.9 6266.2 6292.7 6142.8 6171.3 6197.8 6206.5 6247.6 6084.4 6106.5 6120.3 6131.4 6146.4 4885.7 4903.6 4905.8 4917.9 4941.2 4408.5 4411.5 4412.4 4420.9 4462.7 5643.6 5712.5 5716.8 5802.9 5807.0 4511.3 5356.6 5747.5 6179.3 6180.0 4589.8 5680.3 5702.9 5706.7 5809.2 4334.5 5351.4 5426.6 5430.6 5439.1 6185.4 6245.2 6295.2 6300.7 6306.2 5097.7 6124.2 6144.0 6212.8 6240.3 5274.3 6161.5 6183.7 6223.8 6273.5 6193.5 6193.8 6202.1 6203.1 6217.1 4981.6 6067.9 6207.3 6249.9 6265.1 5947.8 6022.3 6029.8 6033.6 6088.4 6101.9 6107.3 6116.4 6133.3 6137.8 5827.5 5896.5 5940.9 5964.2 5969.3 5836.9 5959.3 5963.2 6073.0 6101.0 5846.3 5867.0 5868.9 5882.3 5898.0 03:43:17 INFO - PROCESS | 1903 | 03:43:17 INFO - PROCESS | 1903 | [#1] ext.html Cycles:180 Average:72453.60 Median:39189.61 stddev:165512.66 (422.3%) stddev-sans-first:165888.76 03:43:17 INFO - PROCESS | 1903 | Values: 483.3 487.5 495.9 519.7 533.1 34123.7 39246.6 39304.2 39322.6 39399.8 40198.6 40513.6 40735.1 40802.0 40806.8 9264.0 9406.7 9416.0 9443.6 9452.0 9386.0 9445.7 9448.5 9467.4 9470.5 9451.0 9461.8 9463.1 9476.8 9480.5 9388.1 9412.6 9439.5 9454.9 9476.3 9270.4 9357.7 9368.3 9390.4 9393.8 38624.4 38886.8 38901.0 39007.8 39132.6 3291.5 3301.7 3308.5 3334.6 3379.5 25939.7 26651.7 29293.6 29646.1 30167.0 3173.3 3204.1 3208.8 3211.1 3218.6 495364.0 498079.5 499376.0 501286.0 501324.0 54929.5 55180.9 55256.7 55279.2 55330.0 56663.0 56783.9 56880.7 57306.7 57335.4 13793.6 14774.8 15386.9 15420.7 15629.9 9886.6 10328.8 10877.3 11020.2 12345.0 11840.2 14168.7 14555.6 14596.2 14707.9 3172.6 6316.3 6524.4 6601.6 6677.2 851.9 915.4 928.7 991.7 1091.6 28907.0 29063.9 29511.9 30028.0 30199.0 948.6 1031.7 1039.9 1046.2 1150.4 13165.9 14069.8 14969.3 15368.8 15404.1 692942.0 693657.5 699461.0 699510.0 700511.0 53928.0 54418.5 54584.5 54602.7 54830.0 1319.4 1327.4 1347.4 1356.0 1359.9 26011.3 28465.7 28881.0 29328.6 29417.6 46361.0 46687.3 46705.3 46721.8 46788.8 633392.0 634490.0 638078.0 640061.0 640641.0 25476.4 25630.4 26530.5 26534.9 27274.7 44184.6 44414.0 44602.3 44635.8 44857.8 36834.6 36920.3 37287.0 37796.6 38393.8 36802.0 36966.6 37296.0 37701.8 38119.6 31886.7 32808.7 36834.8 36844.1 37109.8 30302.5 33692.6 33998.7 34139.8 34148.0 25347.2 25348.7 25356.2 25405.6 25954.6 03:43:17 INFO - PROCESS | 1903 | 03:43:17 INFO - PROCESS | 1903 | [#2] jquery.html Cycles:180 Average:32556.65 Median:24550.63 stddev:90426.36 (368.3%) stddev-sans-first:90647.69 03:43:17 INFO - PROCESS | 1903 | Values: 348.5 366.6 373.7 382.7 401.7 14526.6 19334.3 19590.8 20105.0 20313.8 19042.5 19281.3 19461.7 19634.8 19653.7 5594.2 5630.8 5888.2 5898.1 5899.5 5700.7 5863.9 5866.8 5868.8 5877.7 5552.8 5710.7 5757.5 5766.9 5818.1 5569.2 5697.6 5698.5 5777.1 5781.0 4915.4 4978.6 5019.1 5063.0 5076.8 19474.0 22353.9 24168.0 24514.8 24586.5 2265.1 2289.7 2337.3 2485.9 2985.7 12022.3 14799.3 15057.2 15194.5 15340.5 1789.1 1814.3 1815.8 1855.0 1924.8 91235.0 113407.4 113596.0 115269.4 115839.4 10304.2 10549.6 10579.2 11057.7 11262.2 13551.5 13558.3 13562.5 13575.7 13594.2 8227.6 8444.2 8463.0 8535.8 8611.7 8540.8 8546.9 8576.0 8708.1 8744.3 6443.6 6529.2 6564.8 6605.4 6621.8 1789.4 1825.7 1827.4 1830.6 1832.2 858.6 930.6 932.5 964.8 1009.0 15908.9 19979.7 20377.9 20549.9 21478.4 934.4 957.0 979.6 990.1 1038.8 10973.7 11554.5 11556.0 11583.4 11602.8 252668.0 541569.0 549762.0 622294.0 631437.0 119042.2 125202.4 127812.0 139044.9 141727.0 848.3 940.0 950.2 992.4 994.9 18315.8 18708.9 18975.0 18992.2 19372.2 46734.8 50740.5 55174.0 55557.3 57277.0 73735.6 75730.0 76960.0 78877.0 80520.6 7694.2 7917.8 8031.2 8036.9 8057.3 11344.0 11620.0 12013.5 12392.9 12827.8 10519.3 10543.5 10702.8 10821.3 10967.3 10668.8 10700.8 10769.0 10867.7 10944.5 9069.4 10881.0 10976.6 11247.7 11335.3 7846.5 7896.2 7924.4 7971.0 8090.2 8979.5 10790.8 10841.2 11148.7 11269.2 03:43:17 INFO - PROCESS | 1903 | 03:43:17 INFO - PROCESS | 1903 | [#3] mootools.html Cycles:180 Average:5522.18 Median:4965.23 stddev:3060.74 (61.6%) stddev-sans-first:3054.21 03:43:17 INFO - PROCESS | 1903 | Values: 1473.8 1506.7 1665.4 1742.5 1779.9 7659.2 7921.2 8208.2 8676.4 8687.8 8181.2 8506.8 8512.3 8575.1 8724.6 2332.3 2365.3 2365.7 2368.4 2370.1 2362.9 2385.7 2402.1 2417.0 2417.8 2085.6 2253.9 2325.0 2340.9 2350.6 2259.5 2272.6 2299.3 2299.9 2303.7 2348.3 2367.7 2376.3 2376.7 2384.5 8478.3 8567.0 8610.3 8628.7 8640.3 5095.9 5122.9 5194.0 5291.9 5294.1 3397.2 3444.1 3576.7 3586.4 3630.9 1040.7 1071.7 1076.6 1103.3 1111.1 10960.1 11019.7 11112.7 11126.6 11139.0 4626.8 4639.8 4788.8 4806.0 4806.7 9573.2 9652.9 9654.6 9657.1 9671.7 5267.6 5274.9 5280.9 5291.1 5353.9 4303.8 4332.2 4743.6 4770.4 4832.1 3793.5 3833.4 3887.4 3925.5 3944.2 1277.3 1285.8 1286.6 1298.9 1307.7 888.5 896.7 900.1 902.3 915.3 5750.3 5760.6 5775.9 5915.7 5918.8 452.6 452.6 460.5 919.0 992.8 3093.8 3251.0 3942.8 4000.1 4047.3 8528.4 10099.8 10301.0 10432.6 10626.1 10357.8 10383.9 10385.2 10401.4 10413.7 7683.2 7893.7 7999.2 8006.6 8022.5 4818.7 5596.7 5637.7 5734.0 5851.5 9522.0 9529.1 9557.0 9566.7 9652.9 9592.6 9624.0 9699.6 9835.2 9869.4 5502.3 6344.5 6542.1 6848.8 6957.6 7993.8 8214.1 8223.8 8225.4 8236.9 7131.1 7296.8 7302.7 7312.0 7390.7 7055.1 7154.3 7155.7 7279.0 7326.6 6827.6 6840.4 6901.0 6901.3 6911.4 4824.0 4890.7 4925.9 4942.0 4988.5 4332.3 4822.0 4868.1 4899.0 5024.4 03:43:17 INFO - PROCESS | 1903 | 03:43:17 INFO - PROCESS | 1903 | [#4] prototype.html Cycles:180 Average:4390.23 Median:5057.40 stddev:1379.33 (27.3%) stddev-sans-first:1348.12 03:43:17 INFO - PROCESS | 1903 | Values: 272.3 281.6 305.4 310.6 313.1 4669.9 5122.4 5275.2 5421.6 5424.6 5267.2 5303.7 5304.4 5305.3 5323.7 3826.4 3842.6 3942.6 3966.0 4028.4 3349.9 3600.1 3653.1 3657.3 4028.6 3375.5 3522.5 3975.7 3997.6 4008.4 3696.8 3769.2 3774.9 4017.4 4027.0 2998.7 3425.3 3442.4 3445.2 3448.4 4732.4 5120.7 5120.8 5152.2 5169.2 3688.7 4582.9 4584.4 4609.8 4651.2 5154.8 5203.3 5629.6 5630.0 5635.4 3202.7 3853.8 3856.0 3867.3 3868.8 5052.8 5172.7 5208.2 5735.2 5928.9 2988.3 3127.5 3272.9 3880.6 3897.7 3972.7 3977.6 3982.0 3986.9 3987.0 3431.6 3617.6 3957.8 4024.8 4670.5 5151.0 5338.6 5620.3 5693.4 5722.8 1108.1 1162.4 1201.0 1209.3 1246.7 841.4 869.2 873.5 884.2 890.5 4665.0 4905.9 5069.8 5375.0 5445.3 4544.0 5181.3 5805.7 5836.8 5858.8 4061.5 4276.4 4639.0 4805.9 5395.4 2362.9 2657.9 2782.0 2871.8 2899.0 4956.7 5188.8 5784.3 5808.9 5879.9 5085.4 5192.2 5355.3 5677.4 5697.3 4940.4 5253.3 5435.7 5732.3 5753.6 5382.2 5591.6 5594.5 5624.7 5643.7 5236.8 5244.0 5373.9 5494.7 5498.5 5745.7 5771.8 5821.3 5827.3 5871.0 3209.7 3722.2 3723.3 3731.2 3746.3 5216.7 5331.6 5479.8 5515.1 5524.4 4485.7 4793.7 4935.9 4968.9 5488.6 4753.0 4911.8 4920.4 5328.7 5341.6 5184.8 5218.3 5227.7 5238.2 5260.7 4671.3 5342.8 5362.4 5362.5 5534.9 4433.9 5062.0 5523.8 5527.4 5539.0 03:43:17 INFO - PROCESS | 1903 | 03:43:17 INFO - PROCESS | 1903 | [#5] yui.html Cycles:180 Average:20359.38 Median:4567.58 stddev:29655.57 (649.3%) stddev-sans-first:29701.95 03:43:17 INFO - PROCESS | 1903 | Values: 680.9 743.2 757.1 763.0 784.5 14544.7 15194.2 15205.6 15207.6 15253.8 13464.1 13581.9 13590.5 13601.9 13621.0 796.6 814.2 815.5 818.7 818.8 778.9 785.0 799.4 800.8 805.5 856.7 857.4 859.0 859.5 863.5 819.5 843.5 850.0 852.1 852.2 598.3 635.8 640.4 642.7 642.7 10272.9 12472.5 12511.9 12534.2 12886.2 10632.8 11591.9 11701.4 12423.0 12664.8 10922.9 12028.2 12298.0 12305.6 12350.4 4230.1 4370.2 4422.5 4425.0 4442.6 82867.0 83019.6 85038.0 86933.6 88672.6 10164.2 10227.4 10296.8 10363.7 10640.2 18757.6 19094.5 19125.9 19180.2 19278.0 6453.6 7471.5 7532.6 7552.7 7674.6 3569.7 3604.9 3733.7 4200.7 4205.7 2813.5 2842.8 3249.9 3326.6 3347.7 580.9 664.5 691.1 693.0 700.4 603.6 660.2 669.1 674.9 688.8 6637.6 9196.0 9209.8 9279.8 9405.0 563.3 616.7 637.0 668.6 683.1 4388.2 4564.3 4564.6 4570.6 4646.5 97103.5 98344.5 99700.0 103730.0 118717.4 92483.0 94932.0 96394.0 99143.0 103266.0 80185.6 80686.6 82587.6 84315.2 84393.6 9510.4 9891.1 9936.5 9937.1 9947.7 44314.0 54220.7 54855.5 56586.7 56980.4 77219.0 78820.0 80403.6 82454.6 83188.0 12112.4 12314.7 12389.3 12440.6 12591.6 13826.7 13845.6 14111.9 14358.4 14941.0 12400.3 12699.7 13615.1 13833.5 13874.2 9994.9 12985.2 13292.3 13324.3 13893.5 12349.8 12851.7 13139.7 13410.2 13572.5 10873.9 11258.9 11296.2 11371.8 11589.1 10555.1 11173.2 11458.7 11468.5 11541.0 03:43:17 INFO - PROCESS | 1903 | -------- Summary: end -------- 03:43:17 INFO - PROCESS | 1903 | 03:43:18 INFO - TEST-INFO | 1903: exit 0 03:43:18 INFO - TEST-OK | dromaeo_css | took 1115821ms 03:43:18 INFO - TEST-START | kraken 03:43:18 INFO - operating with platform_type : mac_ 03:43:18 INFO - Initialising browser for kraken test... 03:43:18 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpnmREVX/profile http://localhost:53469/getInfo.html) 03:43:19 ERROR - PROCESS | 1933 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 03:43:21 INFO - PROCESS | 1933 | __metrics Screen width/height:1600/1200 03:43:21 INFO - PROCESS | 1933 | colorDepth:24 03:43:21 INFO - PROCESS | 1933 | Browser inner width/height: 1024/689 03:43:21 INFO - PROCESS | 1933 | __metrics 03:43:21 ERROR - PROCESS | 1933 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 03:43:21 INFO - TEST-INFO | 1933: exit 0 03:43:21 INFO - Browser initialized. 03:43:21 INFO - Running cycle 1/1 for kraken test... 03:43:21 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpnmREVX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:34 INFO - PROCESS | 1936 | RSS: Main: 224120832 03:43:34 INFO - PROCESS | 1936 | 03:43:36 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53469/tests/kraken/driver.html?testName=audio-beat-detection) 03:43:37 INFO - PROCESS | 1936 | RSS: Main: 236638208 03:43:37 INFO - PROCESS | 1936 | 03:43:40 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53469/tests/kraken/driver.html?testName=audio-dft) 03:43:41 INFO - PROCESS | 1936 | RSS: Main: 244178944 03:43:41 INFO - PROCESS | 1936 | 03:43:44 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53469/tests/kraken/driver.html?testName=audio-fft) 03:43:45 INFO - PROCESS | 1936 | RSS: Main: 247914496 03:43:45 INFO - PROCESS | 1936 | 03:43:47 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53469/tests/kraken/driver.html?testName=audio-oscillator) 03:43:47 INFO - PROCESS | 1936 | RSS: Main: 248320000 03:43:47 INFO - PROCESS | 1936 | 03:43:49 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53469/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:43:50 INFO - PROCESS | 1936 | RSS: Main: 249511936 03:43:50 INFO - PROCESS | 1936 | 03:43:53 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53469/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:53 INFO - PROCESS | 1936 | RSS: Main: 254128128 03:43:53 INFO - PROCESS | 1936 | 03:43:56 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53469/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:57 INFO - PROCESS | 1936 | RSS: Main: 254001152 03:43:57 INFO - PROCESS | 1936 | 03:44:00 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53469/tests/kraken/driver.html?testName=json-parse-financial) 03:44:00 INFO - PROCESS | 1936 | RSS: Main: 253280256 03:44:00 INFO - PROCESS | 1936 | 03:44:02 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53469/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:44:02 INFO - PROCESS | 1936 | RSS: Main: 252354560 03:44:02 INFO - PROCESS | 1936 | 03:44:04 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53469/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:44:05 INFO - PROCESS | 1936 | RSS: Main: 252411904 03:44:05 INFO - PROCESS | 1936 | 03:44:07 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53469/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:44:08 INFO - PROCESS | 1936 | RSS: Main: 252354560 03:44:08 INFO - PROCESS | 1936 | 03:44:11 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:44:12 INFO - PROCESS | 1936 | RSS: Main: 252444672 03:44:12 INFO - PROCESS | 1936 | 03:44:15 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:44:15 INFO - PROCESS | 1936 | RSS: Main: 253034496 03:44:15 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53469/tests/kraken/driver.html?testName=ai-astar) 03:44:17 INFO - PROCESS | 1936 | RSS: Main: 254287872 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | __start_tp_report 03:44:17 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 03:44:17 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 03:44:17 INFO - PROCESS | 1936 | |i|pagename|runs| 03:44:17 INFO - PROCESS | 1936 | |0;ai-astar;105;114;117;113;118;118;117;115;169;171 03:44:17 INFO - PROCESS | 1936 | |1;audio-beat-detection;169;146;97;178;143;142;126;120;141;114 03:44:17 INFO - PROCESS | 1936 | |2;audio-dft;200;198;198;198;196;195;196;197;196;196 03:44:17 INFO - PROCESS | 1936 | |3;audio-fft;88;60;59;87;58;59;60;54;81;81 03:44:17 INFO - PROCESS | 1936 | |4;audio-oscillator;83;60;121;104;98;102;96;67;68;87 03:44:17 INFO - PROCESS | 1936 | |5;imaging-gaussian-blur;88;86;87;85;88;85;88;86;88;85 03:44:17 INFO - PROCESS | 1936 | |6;imaging-darkroom;98;98;98;97;98;98;97;100;97;97 03:44:17 INFO - PROCESS | 1936 | |7;imaging-desaturate;87;91;85;87;92;104;128;122;95;134 03:44:17 INFO - PROCESS | 1936 | |8;json-parse-financial;56;56;56;57;60;58;59;59;59;60 03:44:17 INFO - PROCESS | 1936 | |9;json-stringify-tinderbox;67;75;82;71;93;82;60;88;99;90 03:44:17 INFO - PROCESS | 1936 | |10;stanford-crypto-aes;82;83;86;93;78;82;81;81;90;79 03:44:17 INFO - PROCESS | 1936 | |11;stanford-crypto-ccm;164;165;134;157;164;157;164;153;194;152 03:44:17 INFO - PROCESS | 1936 | |12;stanford-crypto-pbkdf2;169;172;170;167;173;227;214;169;166;167 03:44:17 INFO - PROCESS | 1936 | |13;stanford-crypto-sha256-iterative;66;67;83;70;63;88;88;87;60;73 03:44:17 INFO - PROCESS | 1936 | __end_tp_report 03:44:17 INFO - PROCESS | 1936 | __start_cc_report 03:44:17 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,991 03:44:17 INFO - PROCESS | 1936 | __end_cc_report 03:44:17 INFO - PROCESS | 1936 | __startTimestamp1479469457767__endTimestamp 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | ------- Summary: start ------- 03:44:17 INFO - PROCESS | 1936 | Number of tests: 14 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#0] ai-astar Cycles:10 Average:125.70 Median:117.50 stddev:23.66 (20.1%) stddev-sans-first:23.88 03:44:17 INFO - PROCESS | 1936 | Values: 105.0 114.0 117.0 113.0 118.0 118.0 117.0 115.0 169.0 171.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:144.50 stddev:24.49 (16.9%) stddev-sans-first:23.19 03:44:17 INFO - PROCESS | 1936 | Values: 169.0 146.0 97.0 178.0 143.0 142.0 126.0 120.0 141.0 114.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#2] audio-dft Cycles:10 Average:197.00 Median:197.50 stddev:1.49 (0.8%) stddev-sans-first:1.12 03:44:17 INFO - PROCESS | 1936 | Values: 200.0 198.0 198.0 198.0 196.0 195.0 196.0 197.0 196.0 196.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#3] audio-fft Cycles:10 Average:68.70 Median:70.50 stddev:13.66 (19.4%) stddev-sans-first:12.58 03:44:17 INFO - PROCESS | 1936 | Values: 88.0 60.0 59.0 87.0 58.0 59.0 60.0 54.0 81.0 81.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:75.50 stddev:19.30 (25.6%) stddev-sans-first:20.36 03:44:17 INFO - PROCESS | 1936 | Values: 83.0 60.0 121.0 104.0 98.0 102.0 96.0 67.0 68.0 87.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.50 stddev:1.35 (1.5%) stddev-sans-first:1.33 03:44:17 INFO - PROCESS | 1936 | Values: 88.0 86.0 87.0 85.0 88.0 85.0 88.0 86.0 88.0 85.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:98.00 stddev:0.92 (0.9%) stddev-sans-first:0.97 03:44:17 INFO - PROCESS | 1936 | Values: 98.0 98.0 98.0 97.0 98.0 98.0 97.0 100.0 97.0 97.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#7] imaging-desaturate Cycles:10 Average:102.50 Median:87.00 stddev:18.59 (21.4%) stddev-sans-first:18.85 03:44:17 INFO - PROCESS | 1936 | Values: 87.0 91.0 85.0 87.0 92.0 104.0 128.0 122.0 95.0 134.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:59.00 stddev:1.63 (2.8%) stddev-sans-first:1.56 03:44:17 INFO - PROCESS | 1936 | Values: 56.0 56.0 56.0 57.0 60.0 58.0 59.0 59.0 59.0 60.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#9] json-stringify-tinderbox Cycles:10 Average:80.70 Median:85.00 stddev:12.35 (14.5%) stddev-sans-first:12.06 03:44:17 INFO - PROCESS | 1936 | Values: 67.0 75.0 82.0 71.0 93.0 82.0 60.0 88.0 99.0 90.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:82.50 stddev:4.79 (5.8%) stddev-sans-first:5.05 03:44:17 INFO - PROCESS | 1936 | Values: 82.0 83.0 86.0 93.0 78.0 82.0 81.0 81.0 90.0 79.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#11] stanford-crypto-ccm Cycles:10 Average:160.40 Median:164.00 stddev:15.03 (9.2%) stddev-sans-first:15.89 03:44:17 INFO - PROCESS | 1936 | Values: 164.0 165.0 134.0 157.0 164.0 157.0 164.0 153.0 194.0 152.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:171.00 stddev:21.99 (12.9%) stddev-sans-first:23.00 03:44:17 INFO - PROCESS | 1936 | Values: 169.0 172.0 170.0 167.0 173.0 227.0 214.0 169.0 166.0 167.0 03:44:17 INFO - PROCESS | 1936 | 03:44:17 INFO - PROCESS | 1936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:78.00 stddev:10.99 (14.1%) stddev-sans-first:11.22 03:44:17 INFO - PROCESS | 1936 | Values: 66.0 67.0 83.0 70.0 63.0 88.0 88.0 87.0 60.0 73.0 03:44:17 INFO - PROCESS | 1936 | -------- Summary: end -------- 03:44:17 INFO - PROCESS | 1936 | 03:44:18 INFO - TEST-INFO | 1936: exit 0 03:44:18 INFO - TEST-OK | kraken | took 60199ms 03:44:18 INFO - SUITE-END | took 1176s 03:44:18 INFO - Completed test suite (00:19:36) 03:44:18 INFO - javascript benchmark 03:44:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7117.224674495353, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2922.2256102132924, 3308.4044871923074, 3371.966280337196, 3389.322135572885, 3394.830258487075, 5607.439256074391, 5649.6892670903035, 5688.345840228375, 5699.829005129853, 5709.257796486461, 4727.385439892818, 5711.685857277848, 5751.741171647275, 5772.105323674838, 5793.304803423595, 5212.687238765677, 5248.211403176619, 5249.265102885599, 5257.421683614799, 5303.28405665236, 5298.735063246822, 5316.601254905878, 5334.119870221409, 5360.517553420192, 5365.0, 5175.585953123741, 5223.660462069973, 5292.311999440087, 5299.390570084432, 5355.758990845421, 4291.828326866922, 5201.973990130063, 5225.824189557357, 5257.369115706139, 5285.339332583427, 5098.745062746885, 5171.974140129313, 5258.237555554461, 5261.605379596545, 5299.708516031616, 5766.221560089418, 5780.624259423124, 5799.710014499258, 5806.970965145189, 5814.0697488402075, 5732.254806875121, 6076.3316035236085, 6118.040554665182, 6126.456603435028, 6317.241930968313, 6271.843203919893, 6287.151234583364, 6297.33877942814, 6298.811035668891, 6300.905486417708, 4889.731064791435, 5830.15462757902, 5846.976779063732, 5851.414858514115, 5887.61730487517, 6144.433169541739, 6214.223222097238, 6226.159468471789, 6259.561830671901, 6302.243730752339, 5692.971535142297, 6096.817095487142, 6122.081687746873, 6154.046122850965, 6194.721237544321, 6253.1245625612455, 6255.093011513305, 6259.874802504016, 6266.185395898595, 6292.685365731695, 6142.846428839315, 6171.321154672983, 6197.783077592263, 6206.503479721701, 6247.5939063960695, 6084.391560843968, 6106.4809491192855, 6120.265568131853, 6131.386861313922, 6146.416090471398, 4885.682430642068, 4903.632227582945, 4905.828296009622, 4917.9016419672125, 4941.2341087130835, 4408.53710360414, 4411.470623525133, 4412.404325416028, 4420.8673739787855, 4462.709923854939, 5643.604947653707, 5712.542996560265, 5716.771329146871, 5802.941970580325, 5806.970965145148, 4511.255642818898, 5356.625036247426, 5747.511461525817, 6179.3202747697715, 6180.042093475518, 4589.816407343736, 5680.261565996394, 5702.914456283159, 5706.657600543981, 5809.24479817621, 4334.479862416467, 5351.411344752074, 5426.565874730012, 5430.565554755689, 5439.102548079602, 6185.350538193515, 6245.219347581552, 6295.213098362613, 6300.653464059521, 6306.211723534559, 5097.6941383517105, 6124.234470691164, 6144.047672610753, 6212.844678883064, 6240.344763799736, 5274.340707411574, 6161.507079433724, 6183.659898705434, 6223.782167624111, 6273.498120150468, 6193.535484838565, 6193.81418557444, 6202.131701561695, 6203.100550420254, 6217.098520714561, 4981.551660350586, 6067.939320606914, 6207.255129384503, 6249.937500624936, 6265.122882796321, 5947.791827286024, 6022.337542870368, 6029.78895738647, 6033.607815491979, 6088.4215999479975, 6101.877962440638, 6107.328193898578, 6116.3883611638485, 6133.294671112879, 6137.754489820536, 5827.475527202572, 5896.469317761422, 5940.8811823764145, 5964.224650795369, 5969.253843269591, 5836.854078648068, 5959.314678811992, 5963.194968679346, 6072.969635151796, 6101.0, 5846.269216347957, 5866.970665146647, 5868.94131058701, 5882.264716910387, 5897.997340452048], "value": 5626.46455013537, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.2606112647648, 487.47109386315844, 495.9461145066733, 519.6907839835297, 533.0564900126776, 34123.65876341236, 39246.60753392465, 39304.213915721666, 39322.60677393225, 39399.80300098499, 40198.59801401985, 40513.59486405135, 40735.14853960224, 40802.0, 40806.7959660202, 9263.953680231589, 9406.717798466058, 9416.0, 9443.622255109787, 9451.95274023629, 9385.95307023464, 9445.716628501155, 9448.527573621326, 9467.384619999679, 9470.479123648196, 9450.952745236298, 9461.81076378472, 9463.101005404476, 9476.763080922998, 9480.525973701322, 9388.1081297277, 9412.576434060484, 9439.480828554426, 9454.90545094547, 9476.28927830412, 9270.44377337362, 9357.719268421959, 9368.297377696632, 9390.389624674443, 9393.812123757487, 38624.42063369052, 38886.80556597199, 38901.0, 39007.8049609753, 39132.60867391318, 3291.53918451417, 3301.735861131104, 3308.4871844864083, 3334.566506354183, 3379.459286514146, 25939.703014849183, 26651.733482665313, 29293.56059659107, 29646.110616681533, 30167.0, 3173.3335999440146, 3204.118867311508, 3208.8395580220895, 3211.132994091582, 3218.629857566363, 495364.0, 498079.50960245327, 499376.0, 501286.0, 501324.0, 54929.45070549243, 55180.89638207293, 55256.72371638116, 55279.17081243785, 55330.0, 56663.0, 56783.864322713314, 56880.71559642175, 57306.713466432404, 57335.42664573301, 13793.586192414243, 14774.778378324334, 15386.9230653846, 15420.691586168437, 15629.921850390676, 9886.555105020292, 10328.793424131476, 10877.292975956538, 11020.173486988508, 12345.012399008057, 11840.230385024946, 14168.716625667636, 14555.563333100024, 14596.197209153386, 14707.92646036763, 3172.588198251756, 6316.3471342036455, 6524.380183882618, 6601.570897891622, 6677.232118306457, 851.8551846186164, 915.4415806358116, 928.6888892221182, 991.7371896447447, 1091.6233899304727, 28907.0, 29063.85468072646, 29511.852440737657, 30028.0, 30199.0, 948.5589201021559, 1031.654395777423, 1039.896010398969, 1046.1735229168871, 1150.4477850631743, 13165.946724262036, 14069.788953165506, 14969.251537423086, 15368.846311536741, 15404.075755454485, 692942.0, 693657.5317123483, 699461.0, 699510.0, 700511.0, 53928.0, 54418.45581544213, 54584.454155458734, 54602.72698636481, 54830.0, 1319.3601103464812, 1327.4292054416694, 1347.3667376333108, 1356.0304382366458, 1359.864013598652, 26011.349716257246, 28465.715342847136, 28880.98916537911, 29328.56007159937, 29417.55873661854, 46361.0, 46687.29969050399, 46705.2994205094, 46721.766391169185, 46788.7660561695, 633392.0, 634490.0, 638078.0, 640061.0, 640641.0, 25476.363090922136, 25630.359241019123, 26530.469390612467, 26534.93860245646, 27274.72725272801, 44184.558154418046, 44414.0, 44602.3309650362, 44635.77682111569, 44857.775711121234, 36834.63165368312, 36920.325511921605, 37287.0, 37796.62203377931, 38393.80803095967, 36802.0, 36966.63033369632, 37296.0, 37701.81149094237, 38119.61880381161, 31886.681133188373, 32808.67191328056, 36834.8158259207, 36844.078898027765, 37109.81445092757, 30302.545461817648, 33692.63351381528, 33998.66001339955, 34139.82930085433, 34148.0, 25347.239582812545, 25348.74651253464, 25356.239312820646, 25405.61891571591, 25954.610680839425], "value": 19095.589486514007, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.5242643791225, 366.5528055771957, 373.7458528200824, 382.6995808290492, 401.7385409813187, 14526.63683407914, 19334.323298684532, 19590.804091959075, 20104.99999999998, 20313.796862031377, 19042.523936901584, 19281.325153619626, 19461.70807437886, 19634.803651963477, 19653.705194422095, 5594.188842617828, 5630.831075067734, 5888.205092312547, 5898.1447690084915, 5899.528037756991, 5700.714964251792, 5863.853403664921, 5866.794662186824, 5868.823935281948, 5877.67672777997, 5552.750126244328, 5710.714464276791, 5757.453041961028, 5766.855828604276, 5818.06910894257, 5569.192467092249, 5697.604086998691, 5698.51562617178, 5777.0756678931375, 5781.046127388997, 4915.410150781929, 4978.626603004753, 5019.121653710586, 5062.974685126587, 5076.771545280471, 19474.0, 22353.888230558907, 24168.0, 24514.754852451424, 24586.50826983468, 2265.0939624150305, 2289.6565515172692, 2337.3338598499518, 2485.850848949051, 2985.7163569460868, 12022.27866328023, 14799.260036998216, 15057.247137643075, 15194.46819361328, 15340.539783806504, 1789.1233295685151, 1814.3468351393487, 1815.7730283714536, 1854.9721754173697, 1924.788273289937, 91235.0, 113407.43296283466, 113596.0, 115269.4236528812, 115839.42080289545, 10304.227182961307, 10549.630762923261, 10579.206559508068, 11057.668269951915, 11262.211645184758, 13551.457941682222, 13558.254296013814, 13562.525311614047, 13575.728485430434, 13594.184348939096, 8227.629756660965, 8444.155584441629, 8463.0, 8535.829283414298, 8611.655533778703, 8540.829183416297, 8546.931633545806, 8576.013758417861, 8708.08565100668, 8744.256738177199, 6443.581167224115, 6529.237105981453, 6564.80305590833, 6605.405513503808, 6621.834454138685, 1789.4273832373515, 1825.6896327624336, 1827.4060930197738, 1830.5881176735395, 1832.2304632054302, 858.5707146426787, 930.6277489004317, 932.5477143585356, 964.7925695975258, 1008.9848652270222, 15908.920455397649, 19979.700304495444, 20377.89811050935, 20549.89725051395, 21478.355649330544, 934.3786382055993, 957.0381766324799, 979.5836769372988, 990.1435258501344, 1038.7974345002804, 10973.725656858642, 11554.480048397842, 11556.0, 11583.362915039585, 11602.825957610643, 252668.0, 541569.0, 549762.0, 622294.0, 631437.0, 119042.21436678457, 125202.3739881313, 127812.0, 139044.9143262852, 141727.0, 848.2874385516196, 939.9765005874908, 950.230313446097, 992.3626017071889, 994.945278009702, 18315.816841831944, 18708.877467352002, 18975.0, 18992.24031038743, 19372.2251109954, 46734.76632616815, 50740.49259507358, 55174.0, 55557.333280001665, 57277.0, 73735.6313218452, 75730.0, 76960.0, 78877.0280742986, 80520.59739701498, 7694.230576942261, 7917.841643167219, 8031.237032481905, 8036.919630803851, 8057.274845263954, 11344.0, 11620.012298954684, 12013.519459221534, 12392.94659953914, 12827.807582886078, 10519.26365154432, 10543.525541350504, 10702.83945740799, 10821.296615719953, 10967.287126336763, 10668.786624267315, 10700.83948740754, 10769.0, 10867.728306792393, 10944.507497162806, 9069.365144439826, 10881.0, 10976.615818446317, 11247.718807029889, 11335.263207891461, 7846.450748447783, 7896.170902055431, 7924.366050716044, 7971.0, 8090.1909809018625, 8979.50612716307, 10790.784184316426, 10841.241113122005, 11148.721281968015, 11269.154813388865], "value": 9510.726679347299, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.8378778334381, 1506.6534697019688, 1665.3838079910427, 1742.5295170304025, 1779.9021053842034, 7659.157492675815, 7921.247481489264, 8208.220219079185, 8676.436031657939, 8687.782805429868, 8181.181881811815, 8506.829863402729, 8512.276456501204, 8575.056743758198, 8724.607392667329, 2332.265336419027, 2365.3022358404314, 2365.6924599802, 2368.3605426534828, 2370.0519792083132, 2362.870042147681, 2385.666006759055, 2402.087206861399, 2416.9879150604224, 2417.758224177577, 2085.593309304686, 2253.9098436062536, 2324.9883750581225, 2340.871252081135, 2350.553394854972, 2259.4690247791755, 2272.602294598447, 2299.321700098475, 2299.8620082795087, 2303.7120359955006, 2348.330725743155, 2367.656689779972, 2376.346504711218, 2376.6910301660846, 2384.546936082156, 8478.321734261244, 8566.957165214197, 8610.268127209194, 8628.654853805903, 8640.30877529796, 5095.878906640533, 5122.948770512285, 5194.0, 5291.920621190647, 5294.073537131025, 3397.184675677844, 3444.1389652586854, 3576.6959808416054, 3586.4082426399614, 3630.8729194478333, 1040.7398150462384, 1071.7052810477103, 1076.6070384309671, 1103.3269705479652, 1111.0611533254387, 10960.068394186505, 11019.724506887313, 11112.666620001331, 11126.61056863014, 11139.0, 4626.791794369262, 4639.768011599406, 4788.808447662124, 4806.0, 4806.711597304103, 9573.234141268682, 9652.9034709652, 9654.613815447303, 9657.130858222794, 9671.661491847892, 5267.552258058031, 5274.945010997816, 5280.894382112337, 5291.074062039128, 5353.892922141536, 4303.763293018914, 4332.220200363965, 4743.644226683013, 4770.403699537558, 4832.081904438145, 3793.468914351993, 3833.4058220975794, 3887.4168874669026, 3925.4896863408144, 3944.2308749793515, 1277.303869391184, 1285.7685616589104, 1286.5947226623584, 1298.8831005209577, 1307.6600083978044, 888.4984376403986, 896.6951236579595, 900.0864122915247, 902.264654306738, 915.3180880244261, 5750.338711048283, 5760.6255593386295, 5775.913361299584, 5915.733791979371, 5918.7928422505, 452.5587552136706, 452.6446739309626, 460.4589607211513, 919.0074719303136, 992.771662517625, 3093.783435159517, 3251.0, 3942.8108554021287, 4000.119973605802, 4047.291723948297, 8528.360372972053, 10099.798004039878, 10300.96990300964, 10432.582696692047, 10626.096781773636, 10357.792844143225, 10383.896161038445, 10385.169186465064, 10401.375917444977, 10413.739656508496, 7683.231676832272, 7893.723719669784, 7999.240072193133, 8006.559639219782, 8022.518648881086, 4818.68678535894, 5596.748146333506, 5637.689927054052, 5733.971330143323, 5851.502622277154, 9522.047795220422, 9529.142377186086, 9556.996515365787, 9566.66516671913, 9652.855207171757, 9592.568334425107, 9624.0, 9699.563519641491, 9835.16401105914, 9869.407835529892, 5502.339719233718, 6344.524160688059, 6542.1168142300185, 6848.794536163923, 6957.582545047111, 7993.760187194393, 8214.05538363096, 8223.753287401387, 8225.42422030476, 8236.888020117207, 7131.144262688303, 7296.817579560554, 7302.6713797878165, 7312.0, 7390.704371825067, 7055.118110236221, 7154.320339567733, 7155.749548765768, 7278.96360518194, 7326.633668316669, 6827.590344579143, 6840.41856442208, 6901.033855260167, 6901.275366086689, 6911.447084233349, 4824.028521919327, 4890.6821056632625, 4925.901481970269, 4942.0, 4988.451270360185, 4332.328489084197, 4821.95178048215, 4868.075065737498, 4898.975505122452, 5024.397072351341], "value": 4438.227358289304, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [272.2621695205992, 281.5691991253383, 305.3876976661793, 310.5667593706779, 313.0889112682095, 4669.883252918678, 5122.359705036871, 5275.208718692198, 5421.647592906468, 5424.5931555133375, 5267.183586544092, 5303.7082960437165, 5304.3634763828395, 5305.310309659739, 5323.733813309338, 3826.4260360945805, 3842.615738426163, 3942.6254505821903, 3965.9801700991597, 4028.395740638898, 3349.9162520937048, 3600.135967367839, 3653.0867283179205, 3657.3233951718885, 4028.6374226319626, 3375.510550970108, 3522.5068490411363, 3975.721699481023, 3997.580254073324, 4008.3987401889804, 3696.77819330841, 3769.2461507698295, 3774.8675397380675, 4017.4375587417785, 4026.9731218539378, 2998.6551546572205, 3425.2635683328203, 3442.3803715331233, 3445.2248244145117, 3448.413769659164, 4732.384789977315, 5120.722737447999, 5120.769565369567, 5152.196731144107, 5169.190783225841, 3688.7458264190304, 4582.862514124582, 4584.358189853423, 4609.83865564707, 4651.186042442593, 5154.762856914351, 5203.320290050627, 5629.577781666391, 5630.0, 5635.380108188096, 3202.727768139711, 3853.8033321007038, 3855.9807200964096, 3867.323218436762, 3868.8065596720053, 5052.823151189691, 5172.689638621695, 5208.244804503326, 5735.225744524478, 5928.851778705523, 2988.296670897611, 3127.4526957782296, 3272.8690852366117, 3880.592537783492, 3897.6881849451975, 3972.682185425159, 3977.6420122189143, 3981.980090099531, 3986.943459983049, 3987.023179321085, 3431.6396778338412, 3617.5839778425816, 3957.782321972319, 4024.832798488464, 4670.486246512881, 5150.974245128826, 5338.572914166857, 5620.297462817148, 5693.430656934273, 5722.7710891563875, 1108.0581505720234, 1162.4245998230929, 1200.9759804803855, 1209.2865209526421, 1246.6883279180206, 841.4068082002174, 869.2090197919863, 873.5457562067689, 884.1777147252988, 890.4523717913567, 4665.037701059784, 4905.945221777335, 5069.847904562869, 5375.0, 5445.264889239981, 4543.954560454419, 5181.326427564392, 5805.7387417566315, 5836.766529338779, 5858.8242352729485, 4061.5126184858004, 4276.439099728639, 4639.0, 4805.870620404202, 5395.3525576931015, 2362.9172978946, 2657.8803953822126, 2781.972180278212, 2871.784616153797, 2898.9565156522667, 4956.727379994063, 5188.792448302102, 5784.2769653793275, 5808.941910580925, 5879.853003674857, 5085.415177254589, 5192.221166825007, 5355.3305836770405, 5677.403872593318, 5697.259356283656, 4940.431850337185, 5253.264542963988, 5435.668261276012, 5732.283464566929, 5753.626014309057, 5382.219578161066, 5591.580631452576, 5594.468525490072, 5624.746886390204, 5643.746031428514, 5236.816711415235, 5243.973780131075, 5373.919391209213, 5494.736210671488, 5498.45015498447, 5745.6552606843725, 5771.769129234784, 5821.330546987151, 5827.271591051119, 5870.970645146747, 3209.6790320967716, 3722.236941427055, 3723.311187430334, 3731.197792474631, 3746.3069332173636, 5216.695826043489, 5331.573474122139, 5479.794195514357, 5515.145152501369, 5524.447555244444, 4485.667452924396, 4793.712377257376, 4935.914098898236, 4968.882001549622, 5488.615796894179, 4753.001869607421, 4911.754412279443, 4920.4326863024025, 5328.733563321896, 5341.62608617393, 5184.844454666366, 5218.277968270538, 5227.712475813867, 5238.245187861957, 5260.736963151904, 4671.271629497108, 5342.76762558662, 5362.356517217959, 5362.490563396471, 5534.916976245279, 4433.866983990485, 5061.974690126526, 5523.751431185526, 5527.391986881359, 5538.972305138448], "value": 3948.900551845714, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.8842496775544, 743.2047708951422, 757.1482082657011, 762.9923700762997, 784.5018413307549, 14544.709105817878, 15194.240287985584, 15205.619859503518, 15207.619809504768, 15253.771193432107, 13464.057515973886, 13581.932090339558, 13590.456381744718, 13601.931990340034, 13621.0, 796.6136423834436, 814.2102160903913, 815.4821688227959, 818.7093581778472, 818.811673315135, 778.8714862047756, 785.0148064179447, 799.4164260090138, 800.8198155415043, 805.5287656720825, 856.6873091321685, 857.3655494933736, 858.9778163984869, 859.5401460218784, 863.5293764898146, 819.5041999590281, 843.5065486690294, 850.0437008365589, 852.1435956863374, 852.2202185000717, 598.2940130645836, 635.7615894039735, 640.4268179978893, 642.6722371590475, 642.7493277621732, 10272.897271027268, 12472.50109995599, 12511.874881251162, 12534.185277956994, 12886.162399444007, 10632.840507392395, 11591.942040289829, 11701.3564253966, 12423.0, 12664.81002784959, 10922.85310042442, 12028.218165819193, 12298.0, 12305.630831075083, 12350.44423000967, 4230.090530535949, 4370.2133615949115, 4422.5356337584735, 4424.977875110636, 4442.577955094261, 82867.0, 83019.5849020751, 85038.0, 86933.56533217293, 88672.55663721704, 10164.186865050779, 10227.386356818615, 10296.845547316796, 10363.689089327332, 10640.201984851166, 18757.624847503248, 19094.522636934187, 19125.90437047806, 19180.232790688497, 19278.036098195316, 6453.645049522227, 7471.51435156724, 7532.585707786015, 7552.697892084255, 7674.616269186518, 3569.697060572872, 3604.8558057677924, 3733.738638295293, 4200.684948628865, 4205.726627769185, 2813.521701310782, 2842.7725781937397, 3249.9350012999607, 3326.600807903067, 3347.681970212826, 580.9078931608549, 664.5149041199951, 691.0670594697119, 692.9861402772017, 700.352174238827, 603.6287683074966, 660.1780782925289, 669.1434963247052, 674.9055132281485, 688.8312363470982, 6637.601743895381, 9196.0, 9209.815803684023, 9279.814403711887, 9405.012473690302, 563.276190095725, 616.7193926763312, 637.0, 668.6289109544152, 683.0676127086491, 4388.245840824557, 4564.269716845289, 4564.589186973122, 4570.565796249351, 4646.512116227815, 97103.51448242855, 98344.50827745958, 99700.00299997053, 103730.0, 118717.40641296911, 92483.0, 94932.0, 96394.03605963991, 99143.0, 103266.0, 80185.59907200544, 80686.59656701796, 82587.5870620655, 84315.15684843196, 84393.57803211067, 9510.4307789214, 9891.060349266809, 9936.503174841084, 9937.10566049059, 9947.651832185838, 44314.0, 54220.728896355264, 54855.451445485036, 56586.71706641441, 56980.43019569751, 77219.0, 78820.0, 80403.59798200971, 82454.58772706098, 83188.0, 12112.394380281126, 12314.692132696755, 12389.318587477776, 12440.626781196579, 12591.559295424982, 13826.723465530835, 13845.584632461043, 14111.929440352733, 14358.425662973365, 14940.954133211006, 12400.317982510687, 12699.682507937006, 13615.115017523829, 13833.515826946008, 13874.236916969663, 9994.850077248702, 12985.155964862253, 13292.268925209206, 13324.333783310602, 13893.513727019506, 12349.814752778535, 12851.742965140831, 13139.737205256033, 13410.195388276734, 13572.524961626295, 10873.945630271797, 11258.887411125785, 11296.209265351346, 11371.772564548828, 11589.108886244798, 10555.065464531568, 11173.217874748689, 11458.713532161762, 11468.541258349573, 11540.961313481826], "value": 7256.861187650841, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 117.0, 113.0, 118.0, 118.0, 117.0, 115.0, 169.0, 171.0], "value": 125.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 146.0, 97.0, 178.0, 143.0, 142.0, 126.0, 120.0, 141.0, 114.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 198.0, 198.0, 198.0, 196.0, 195.0, 196.0, 197.0, 196.0, 196.0], "value": 197.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 60.0, 59.0, 87.0, 58.0, 59.0, 60.0, 54.0, 81.0, 81.0], "value": 68.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 121.0, 104.0, 98.0, 102.0, 96.0, 67.0, 68.0, 87.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 85.0, 88.0, 85.0, 88.0, 86.0, 88.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 97.0, 98.0, 98.0, 97.0, 100.0, 97.0, 97.0], "value": 97.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 85.0, 87.0, 92.0, 104.0, 128.0, 122.0, 95.0, 134.0], "value": 102.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 60.0, 58.0, 59.0, 59.0, 59.0, 60.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 82.0, 71.0, 93.0, 82.0, 60.0, 88.0, 99.0, 90.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 86.0, 93.0, 78.0, 82.0, 81.0, 81.0, 90.0, 79.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 134.0, 157.0, 164.0, 157.0, 164.0, 153.0, 194.0, 152.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 170.0, 167.0, 173.0, 227.0, 214.0, 169.0, 166.0, 167.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 83.0, 70.0, 63.0, 88.0, 88.0, 87.0, 60.0, 73.0], "value": 74.5, "unit": "score"}]}]} 03:44:19 INFO - Return code: 0 03:44:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:44:19 ERROR - # TBPL SUCCESS # 03:44:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:44:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:44:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:44:19 INFO - 2016-11-18 03:44:19.099 screenresolution[1941:18517] starting screenresolution argv=screenresolution get 03:44:19 INFO - 2016-11-18 03:44:19.102 screenresolution[1941:18517] Display 0: 1600x1200x32@60 03:44:19 INFO - 2016-11-18 03:44:19.108 screenresolution[1942:18520] starting screenresolution argv=screenresolution list 03:44:19 INFO - Available Modes on Display 0 03:44:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:44:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:44:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:44:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:44:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:44:19 INFO - Intel Iris: 03:44:19 INFO - Chipset Model: Intel Iris 03:44:19 INFO - Type: GPU 03:44:19 INFO - Bus: Built-In 03:44:19 INFO - VRAM (Dynamic, Max): 1536 MB 03:44:19 INFO - Vendor: Intel (0x8086) 03:44:19 INFO - Device ID: 0x0a2e 03:44:19 INFO - Revision ID: 0x0009 03:44:19 INFO - Displays: 03:44:19 INFO - Display: 03:44:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:44:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:44:19 INFO - Display Serial Number: 1600x1200 60 03:44:19 INFO - Main Display: Yes 03:44:19 INFO - Mirror: Off 03:44:19 INFO - Online: Yes 03:44:19 INFO - Rotation: Supported 03:44:19 INFO - Return code: 0 03:44:19 INFO - Running post-action listener: _resource_record_post_action 03:44:19 INFO - [mozharness: 2016-11-18 11:44:19.342601Z] Finished run-tests step (success) 03:44:19 INFO - Running post-run listener: _resource_record_post_run 03:44:19 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 839680; Write bytes: 656645120; Read time: 13; Write time: 1847 03:44:19 INFO - TinderboxPrint: CPU usage
54.4% 03:44:19 INFO - TinderboxPrint: I/O read bytes / time
839,680 / 13 03:44:19 INFO - TinderboxPrint: I/O write bytes / time
656,645,120 / 1,847 03:44:19 INFO - TinderboxPrint: CPU idle
2,207.2 (45.6%) 03:44:19 INFO - TinderboxPrint: CPU system
977.3 (20.2%) 03:44:19 INFO - TinderboxPrint: CPU user
1,653.3 (34.2%) 03:44:19 INFO - TinderboxPrint: Swap in / out
354,369,536 / 0 03:44:19 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 353788416; Write bytes: 353355264; Read time: 27943; Write time: 677 03:44:19 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 692224; Write bytes: 299337216; Read time: 11; Write time: 1147 03:44:19 INFO - Running post-run listener: _upload_blobber_files 03:44:19 INFO - Blob upload gear active. 03:44:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:44:19 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 03:44:19 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:44:19 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:44:20 INFO - (blobuploader) - INFO - Open directory for files ... 03:44:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:44:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:44:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:20 INFO - (blobuploader) - INFO - Done attempting. 03:44:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:44:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:44:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:21 INFO - (blobuploader) - INFO - Done attempting. 03:44:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:44:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:24 INFO - (blobuploader) - INFO - Done attempting. 03:44:24 INFO - (blobuploader) - INFO - Iteration through files over. 03:44:24 INFO - Return code: 0 03:44:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:44:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:44:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f127cce5a9a6afeda0975b6de121c6ee1406091a7ca8004fcbe2264e595989e8bf8c3548b368ea82a2e1847492444bce9048848846fefdd59d061fa68168340c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6915bb2ef3b2720bf729628bcc3fe10ad488ccc604b2dcfdf3b200f9f915e8b1e4bbaf81c868a0ccc5bbe293e216b6774f5eb47f645b437ce76c2bbe63107ea3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39999d9b478e84798a178fe947fde12b0e08109aa5cb4037d5fa35250318c7a9625b8ecb888f9d4e0f5675cd1646a0be808531e67c8d34e11d966a66fcd239ed"} 03:44:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:44:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:44:24 INFO - Contents: 03:44:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f127cce5a9a6afeda0975b6de121c6ee1406091a7ca8004fcbe2264e595989e8bf8c3548b368ea82a2e1847492444bce9048848846fefdd59d061fa68168340c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6915bb2ef3b2720bf729628bcc3fe10ad488ccc604b2dcfdf3b200f9f915e8b1e4bbaf81c868a0ccc5bbe293e216b6774f5eb47f645b437ce76c2bbe63107ea3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39999d9b478e84798a178fe947fde12b0e08109aa5cb4037d5fa35250318c7a9625b8ecb888f9d4e0f5675cd1646a0be808531e67c8d34e11d966a66fcd239ed"} 03:44:24 INFO - Running post-run listener: copy_logs_to_upload_dir 03:44:24 INFO - Copying logs to upload dir... 03:44:24 INFO - mkdir: /builds/slave/test/build/upload/logs 03:44:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.011724 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-11-18 03:44:24.863750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 03:44:24.867427) ========= 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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-Aurora/sha512/f127cce5a9a6afeda0975b6de121c6ee1406091a7ca8004fcbe2264e595989e8bf8c3548b368ea82a2e1847492444bce9048848846fefdd59d061fa68168340c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6915bb2ef3b2720bf729628bcc3fe10ad488ccc604b2dcfdf3b200f9f915e8b1e4bbaf81c868a0ccc5bbe293e216b6774f5eb47f645b437ce76c2bbe63107ea3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39999d9b478e84798a178fe947fde12b0e08109aa5cb4037d5fa35250318c7a9625b8ecb888f9d4e0f5675cd1646a0be808531e67c8d34e11d966a66fcd239ed"} build_url:https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/Vdr3onKHRyWoW_ji7uSIUw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f127cce5a9a6afeda0975b6de121c6ee1406091a7ca8004fcbe2264e595989e8bf8c3548b368ea82a2e1847492444bce9048848846fefdd59d061fa68168340c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6915bb2ef3b2720bf729628bcc3fe10ad488ccc604b2dcfdf3b200f9f915e8b1e4bbaf81c868a0ccc5bbe293e216b6774f5eb47f645b437ce76c2bbe63107ea3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39999d9b478e84798a178fe947fde12b0e08109aa5cb4037d5fa35250318c7a9625b8ecb888f9d4e0f5675cd1646a0be808531e67c8d34e11d966a66fcd239ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 03:44:24.901899) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:44:24.902229) ========= 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.r3G0YiCWBX/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.NpZLR6f2QD/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.005253 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:44:24.950733) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 03:44:24.951058) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 03:44:24.951400) ========= ========= Total master_lag: 0.44 =========