builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0136 starttime: 1479145788.95 results: success (0) buildid: 20161114043447 builduid: b3ce9a064b684e8d999f5a98ceef2059 revision: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:48.952146) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:48.952594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:48.952871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:48.978284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:48.978617) ========= 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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-14 09:49:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.28M=0.001s 2016-11-14 09:49:49 (8.28 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141646 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:49.141879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:49.145212) ========= 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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.019923 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:49.193594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-14 09:49:49.193914) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f --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 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-14 09:49:49,273 truncating revision to first 12 chars 2016-11-14 09:49:49,273 Setting DEBUG logging. 2016-11-14 09:49:49,274 attempt 1/10 2016-11-14 09:49:49,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7e29173b1641?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 09:49:51,341 unpacking tar archive at: mozilla-aurora-7e29173b1641/testing/mozharness/ program finished with exit code 0 elapsedTime=2.321842 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-14 09:49:51.543674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:51.544060) ========= script_repo_revision: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:51.544519) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:51.544800) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 09:49:51.563345) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-14 09:49:51.563730) ========= /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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 09:49:51 INFO - MultiFileLogger online at 20161114 09:49:51 in /builds/slave/test 09:49:51 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 09:49:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:49:51 INFO - {'append_to_log': False, 09:49:51 INFO - 'base_work_dir': '/builds/slave/test', 09:49:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:49:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:49:51 INFO - 'branch': 'Mozilla-Aurora', 09:49:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:49:51 INFO - 'config_files': ('talos/mac_config.py',), 09:49:51 INFO - 'default_actions': ('clobber', 09:49:51 INFO - 'read-buildbot-config', 09:49:51 INFO - 'download-and-extract', 09:49:51 INFO - 'populate-webroot', 09:49:51 INFO - 'create-virtualenv', 09:49:51 INFO - 'install', 09:49:51 INFO - 'run-tests'), 09:49:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:49:51 INFO - 'download_minidump_stackwalk': True, 09:49:51 INFO - 'download_symbols': 'ondemand', 09:49:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:49:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:49:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:49:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:49:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:49:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:49:51 INFO - 'installer_path': 'installer.exe', 09:49:51 INFO - 'log_level': 'info', 09:49:51 INFO - 'log_name': 'talos', 09:49:51 INFO - 'log_to_console': True, 09:49:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:49:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:49:51 INFO - 'opt_config_files': (), 09:49:51 INFO - 'pip_index': False, 09:49:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:49:51 INFO - 'cmd': ('bash', 09:49:51 INFO - '-c', 09:49:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:49:51 INFO - 'enabled': True, 09:49:51 INFO - 'halt_on_failure': False, 09:49:51 INFO - 'name': 'check_screen_resolution'},), 09:49:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:49:51 INFO - 'cmd': ('bash', 09:49:51 INFO - '-c', 09:49:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:49:51 INFO - 'enabled': True, 09:49:51 INFO - 'halt_on_failure': False, 09:49:51 INFO - 'name': 'check_screen_resolution'},), 09:49:51 INFO - 'run_cmd_checks_enabled': True, 09:49:51 INFO - 'sps_profile': False, 09:49:51 INFO - 'sps_profile_interval': 0, 09:49:51 INFO - 'suite': 'dromaeojs-e10s', 09:49:51 INFO - 'system_bits': '32', 09:49:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:49:51 INFO - 'title': 't-yosemite-r7-0136', 09:49:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:49:51 INFO - 'use_talos_json': True, 09:49:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:49:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:49:51 INFO - 'work_dir': 'build'} 09:49:51 INFO - [mozharness: 2016-11-14 17:49:51.768999Z] Running clobber step. 09:49:51 INFO - Running pre-action listener: _resource_record_pre_action 09:49:51 INFO - Running main action method: clobber 09:49:51 INFO - rmtree: /builds/slave/test/build 09:49:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:49:52 INFO - Running post-action listener: _resource_record_post_action 09:49:52 INFO - [mozharness: 2016-11-14 17:49:52.762509Z] Finished clobber step (success) 09:49:52 INFO - [mozharness: 2016-11-14 17:49:52.762660Z] Running read-buildbot-config step. 09:49:52 INFO - Running pre-action listener: _resource_record_pre_action 09:49:52 INFO - Running main action method: read_buildbot_config 09:49:52 INFO - Using buildbot properties: 09:49:52 INFO - { 09:49:52 INFO - "project": "", 09:49:52 INFO - "product": "firefox", 09:49:52 INFO - "script_repo_revision": "production", 09:49:52 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:49:52 INFO - "repository": "", 09:49:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:49:52 INFO - "buildid": "20161114043447", 09:49:52 INFO - "pgo_build": "False", 09:49:52 INFO - "basedir": "/builds/slave/test", 09:49:52 INFO - "buildnumber": 159, 09:49:52 INFO - "slavename": "t-yosemite-r7-0136", 09:49:52 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:49:52 INFO - "platform": "yosemite_r7", 09:49:52 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:49:52 INFO - "branch": "mozilla-aurora", 09:49:52 INFO - "repo_path": "releases/mozilla-aurora", 09:49:52 INFO - "revision": "7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f", 09:49:52 INFO - "stage_platform": "macosx64", 09:49:52 INFO - "builduid": "b3ce9a064b684e8d999f5a98ceef2059", 09:49:52 INFO - "slavebuilddir": "test" 09:49:52 INFO - } 09:49:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 09:49:52 INFO - Running post-action listener: _resource_record_post_action 09:49:52 INFO - [mozharness: 2016-11-14 17:49:52.765700Z] Finished read-buildbot-config step (success) 09:49:52 INFO - [mozharness: 2016-11-14 17:49:52.765834Z] Running download-and-extract step. 09:49:52 INFO - Running pre-action listener: _resource_record_pre_action 09:49:52 INFO - Running main action method: download_and_extract 09:49:52 INFO - mkdir: /builds/slave/test/build/tests 09:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:52 INFO - trying https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 09:49:52 INFO - Downloading https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/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 09:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/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 09:49:53 INFO - Downloaded 1199 bytes. 09:49:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 09:49:53 INFO - Using the following test package requirements: 09:49:53 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 09:49:53 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:49:53 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 09:49:53 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:49:53 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 09:49:53 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:49:53 INFO - u'jsshell-mac.zip'], 09:49:53 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:49:53 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 09:49:53 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 09:49:53 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:49:53 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 09:49:53 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:49:53 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 09:49:53 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:49:53 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 09:49:53 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:49:53 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 09:49:53 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:49:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 09:49:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:49:53 INFO - Fetch https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 09:49:54 INFO - Http code: 200 09:49:54 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 09:49:54 INFO - x-amz-cf-id: sL6h4c66gkBV3rpTm9p5a0CEkxc9H7hoTvu01_Kh1Freofz9tAGpIA== 09:49:54 INFO - x-amz-version-id: 46b3rovJZlUGpegJJyUApBTnVWK4pxSj 09:49:54 INFO - Expected file size: 16327493 09:49:54 INFO - Obtained file size: 16327493 09:50:01 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 09:50:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 09:50:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:50:01 INFO - Fetch https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 09:50:02 INFO - Http code: 200 09:50:02 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 09:50:02 INFO - x-amz-cf-id: EV5QjaEFnOFCA-vmAL02c41i3PZN5DIZ8iClxpbDQmeR_AgUNiwlpA== 09:50:02 INFO - x-amz-version-id: 46b3rovJZlUGpegJJyUApBTnVWK4pxSj 09:50:02 INFO - Expected file size: 16327493 09:50:02 INFO - Obtained file size: 16327493 09:50:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 09:50:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:50:09 INFO - Fetch https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 09:50:09 INFO - Http code: 200 09:50:09 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 09:50:09 INFO - x-amz-cf-id: HhH9yKRh1sN8UEwrKoOUfQuqbYf7uVRIMeI9YEHhPh1vIjbAuI4jjw== 09:50:09 INFO - x-amz-version-id: nZy2TRubHfItKTFzKY23wLmggGtvzYcP 09:50:09 INFO - Expected file size: 14409038 09:50:09 INFO - Obtained file size: 14409038 09:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:10 INFO - trying https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:50:10 INFO - Downloading https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 09:50:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/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 09:50:13 INFO - Downloaded 114362976 bytes. 09:50:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:50:13 INFO - mkdir: /builds/slave/test/properties 09:50:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:50:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:50:13 INFO - Contents: 09:50:13 INFO - build_url:https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:50:14 INFO - Running post-action listener: _resource_record_post_action 09:50:14 INFO - Running post-action listener: set_extra_try_arguments 09:50:14 INFO - [mozharness: 2016-11-14 17:50:14.105671Z] Finished download-and-extract step (success) 09:50:14 INFO - [mozharness: 2016-11-14 17:50:14.105793Z] Running populate-webroot step. 09:50:14 INFO - Running pre-action listener: _resource_record_pre_action 09:50:14 INFO - Running main action method: populate_webroot 09:50:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:14 INFO - '--tppagecycles', 09:50:14 INFO - '7'], 09:50:14 INFO - 'tests': ['tsvgm']}}, 09:50:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:50:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:50:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:50:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:14 INFO - 'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:14 INFO - 'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['damp', 'tps']}, 09:50:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:14 INFO - 'tests': ['damp', 'tps']}, 09:50:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['dromaeo_dom']}, 09:50:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['basic_compositor_video']}, 09:50:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:50:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['a11yr', 09:50:14 INFO - 'ts_paint', 09:50:14 INFO - 'tpaint', 09:50:14 INFO - 'sessionrestore', 09:50:14 INFO - 'sessionrestore_no_auto_restore', 09:50:14 INFO - 'tabpaint']}, 09:50:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['tsvgx', 09:50:14 INFO - 'tsvgr_opacity', 09:50:14 INFO - 'tart', 09:50:14 INFO - 'tscrollx', 09:50:14 INFO - 'cart']}, 09:50:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:50:14 INFO - 'tsvgr_opacity', 09:50:14 INFO - 'tart', 09:50:14 INFO - 'tscrollx', 09:50:14 INFO - 'cart']}, 09:50:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:14 INFO - 'talos_options': ['--disable-e10s'], 09:50:14 INFO - 'tests': ['tp5o']}, 09:50:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:14 INFO - 'tests': ['tp5o']}, 09:50:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:14 INFO - 'talos_options': ['--disable-e10s', 09:50:14 INFO - '--xperf_path', 09:50:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:14 INFO - 'tests': ['tp5n']}, 09:50:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:14 INFO - 'talos_options': ['--xperf_path', 09:50:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:14 INFO - 'tests': ['tp5n']}}, 09:50:14 INFO - 'talos.zip': {'path': '', 09:50:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:14 INFO - Running post-action listener: _resource_record_post_action 09:50:14 INFO - [mozharness: 2016-11-14 17:50:14.124700Z] Finished populate-webroot step (success) 09:50:14 INFO - [mozharness: 2016-11-14 17:50:14.124833Z] Running create-virtualenv step. 09:50:14 INFO - Running pre-action listener: _resource_record_pre_action 09:50:14 INFO - Running main action method: create_virtualenv 09:50:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:50:14 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 09:50:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:50:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:14 INFO - Using real prefix '/tools/python27' 09:50:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:50:14 INFO - Installing distribute.............................................................................................................................................................................................done. 09:50:17 INFO - Installing pip.................done. 09:50:17 INFO - Return code: 0 09:50:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:50:18 INFO - Reading from file tmpfile_stdout 09:50:18 INFO - Output received: 09:50:18 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) 09:50:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:50:18 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')]} 09:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:18 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')]} 09:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:18 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 0x100d22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ad86bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b36d30>, '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 0x10099cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b2eb20>, '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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 09:50:18 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 09:50:18 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 09:50:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mMvOdcBcjG/Render', 09:50:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:18 INFO - 'HOME': '/Users/cltbld', 09:50:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:18 INFO - 'LOGNAME': 'cltbld', 09:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:18 INFO - 'MOZ_NO_REMOTE': '1', 09:50:18 INFO - 'NO_EM_RESTART': '1', 09:50:18 INFO - 'PAGER': '/bin/cat', 09:50:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:18 INFO - 'PWD': '/builds/slave/test', 09:50:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:18 INFO - 'SHELL': '/bin/bash', 09:50:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q9D1cyzG1N/Listeners', 09:50:18 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 09:50:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:18 INFO - 'USER': 'cltbld', 09:50:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:18 INFO - 'XPC_FLAGS': '0x0', 09:50:18 INFO - 'XPC_SERVICE_NAME': '0', 09:50:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:18 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 09:50:18 INFO - Cleaning up... 09:50:18 INFO - Return code: 0 09:50:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:50:18 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')]} 09:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:18 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')]} 09:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:18 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 0x100d22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ad86bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b36d30>, '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 0x10099cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b2eb20>, '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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 09:50:18 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 09:50:18 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 09:50:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mMvOdcBcjG/Render', 09:50:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:18 INFO - 'HOME': '/Users/cltbld', 09:50:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:18 INFO - 'LOGNAME': 'cltbld', 09:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:18 INFO - 'MOZ_NO_REMOTE': '1', 09:50:18 INFO - 'NO_EM_RESTART': '1', 09:50:18 INFO - 'PAGER': '/bin/cat', 09:50:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:18 INFO - 'PWD': '/builds/slave/test', 09:50:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:18 INFO - 'SHELL': '/bin/bash', 09:50:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q9D1cyzG1N/Listeners', 09:50:18 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 09:50:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:18 INFO - 'USER': 'cltbld', 09:50:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:18 INFO - 'XPC_FLAGS': '0x0', 09:50:18 INFO - 'XPC_SERVICE_NAME': '0', 09:50:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:18 INFO - Downloading/unpacking psutil>=3.1.1 09:50:18 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 09:50:18 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 09:50:18 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 09:50:18 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 09:50:18 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 09:50:18 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 09:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:50:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:22 INFO - Installing collected packages: psutil 09:50:22 INFO - Running setup.py install for psutil 09:50:22 INFO - building 'psutil._psutil_osx' extension 09:50:22 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 09:50:22 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 09:50:22 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 09:50:22 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 09:50:22 INFO - building 'psutil._psutil_posix' extension 09:50:22 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 09:50:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:50:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:50:22 INFO - ^ 09:50:22 INFO - 1 warning generated. 09:50:22 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 09:50:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:22 INFO - Successfully installed psutil 09:50:22 INFO - Cleaning up... 09:50:23 INFO - Return code: 0 09:50:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:23 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 0x100d22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ad86bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b36d30>, '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 0x10099cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b2eb20>, '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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 09:50:23 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 09:50:23 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 09:50:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mMvOdcBcjG/Render', 09:50:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:23 INFO - 'HOME': '/Users/cltbld', 09:50:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:23 INFO - 'LOGNAME': 'cltbld', 09:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:23 INFO - 'MOZ_NO_REMOTE': '1', 09:50:23 INFO - 'NO_EM_RESTART': '1', 09:50:23 INFO - 'PAGER': '/bin/cat', 09:50:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:23 INFO - 'PWD': '/builds/slave/test', 09:50:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:23 INFO - 'SHELL': '/bin/bash', 09:50:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q9D1cyzG1N/Listeners', 09:50:23 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 09:50:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:23 INFO - 'USER': 'cltbld', 09:50:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:23 INFO - 'XPC_FLAGS': '0x0', 09:50:23 INFO - 'XPC_SERVICE_NAME': '0', 09:50:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:50:23 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 09:50:23 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 09:50:23 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 09:50:23 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 09:50:23 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 09:50:23 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 09:50:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:50:25 INFO - Installing collected packages: mozsystemmonitor 09:50:25 INFO - Running setup.py install for mozsystemmonitor 09:50:26 INFO - Successfully installed mozsystemmonitor 09:50:26 INFO - Cleaning up... 09:50:26 INFO - Return code: 0 09:50:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:50:26 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')]} 09:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:26 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')]} 09:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:26 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 0x100d22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ad86bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b36d30>, '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 0x10099cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b2eb20>, '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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 09:50:26 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 09:50:26 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 09:50:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mMvOdcBcjG/Render', 09:50:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:26 INFO - 'HOME': '/Users/cltbld', 09:50:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:26 INFO - 'LOGNAME': 'cltbld', 09:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:26 INFO - 'MOZ_NO_REMOTE': '1', 09:50:26 INFO - 'NO_EM_RESTART': '1', 09:50:26 INFO - 'PAGER': '/bin/cat', 09:50:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:26 INFO - 'PWD': '/builds/slave/test', 09:50:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:26 INFO - 'SHELL': '/bin/bash', 09:50:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q9D1cyzG1N/Listeners', 09:50:26 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 09:50:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:26 INFO - 'USER': 'cltbld', 09:50:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:26 INFO - 'XPC_FLAGS': '0x0', 09:50:26 INFO - 'XPC_SERVICE_NAME': '0', 09:50:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:26 INFO - Downloading/unpacking jsonschema==2.5.1 09:50:26 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 09:50:26 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 09:50:26 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 09:50:26 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 09:50:26 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 09:50:26 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 09:50:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:50:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:29 INFO - Downloading functools32-3.2.3-2.tar.gz 09:50:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:50:29 INFO - warning: no files found matching '*.txt' 09:50:29 INFO - no previously-included directories found matching 'build' 09:50:29 INFO - no previously-included directories found matching 'dist' 09:50:29 INFO - no previously-included directories found matching '.git*' 09:50:29 INFO - Installing collected packages: jsonschema, functools32 09:50:29 INFO - Running setup.py install for functools32 09:50:29 INFO - warning: no files found matching '*.txt' 09:50:29 INFO - no previously-included directories found matching 'build' 09:50:29 INFO - no previously-included directories found matching 'dist' 09:50:29 INFO - no previously-included directories found matching '.git*' 09:50:29 INFO - Successfully installed jsonschema functools32 09:50:29 INFO - Cleaning up... 09:50:29 INFO - Return code: 0 09:50:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:50:29 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')]} 09:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:29 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')]} 09:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:29 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 0x100d22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ad86bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b36d30>, '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 0x10099cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b2eb20>, '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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 09:50:29 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 09:50:29 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 09:50:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mMvOdcBcjG/Render', 09:50:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:29 INFO - 'HOME': '/Users/cltbld', 09:50:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:29 INFO - 'LOGNAME': 'cltbld', 09:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:29 INFO - 'MOZ_NO_REMOTE': '1', 09:50:29 INFO - 'NO_EM_RESTART': '1', 09:50:29 INFO - 'PAGER': '/bin/cat', 09:50:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:29 INFO - 'PWD': '/builds/slave/test', 09:50:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:29 INFO - 'SHELL': '/bin/bash', 09:50:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q9D1cyzG1N/Listeners', 09:50:29 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 09:50:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:29 INFO - 'USER': 'cltbld', 09:50:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:29 INFO - 'XPC_FLAGS': '0x0', 09:50:29 INFO - 'XPC_SERVICE_NAME': '0', 09:50:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:50:29 INFO - Cleaning up... 09:50:29 INFO - Return code: 0 09:50:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:50:29 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')]} 09:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:29 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')]} 09:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:29 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 0x100d22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ad86bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b36d30>, '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 0x10099cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b2eb20>, '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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 09:50:29 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 09:50:29 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 09:50:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mMvOdcBcjG/Render', 09:50:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:29 INFO - 'HOME': '/Users/cltbld', 09:50:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:29 INFO - 'LOGNAME': 'cltbld', 09:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:29 INFO - 'MOZ_NO_REMOTE': '1', 09:50:29 INFO - 'NO_EM_RESTART': '1', 09:50:29 INFO - 'PAGER': '/bin/cat', 09:50:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:29 INFO - 'PWD': '/builds/slave/test', 09:50:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:29 INFO - 'SHELL': '/bin/bash', 09:50:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q9D1cyzG1N/Listeners', 09:50:29 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 09:50:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:29 INFO - 'USER': 'cltbld', 09:50:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:29 INFO - 'XPC_FLAGS': '0x0', 09:50:29 INFO - 'XPC_SERVICE_NAME': '0', 09:50:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:30 INFO - Downloading/unpacking blobuploader==1.2.4 09:50:30 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 09:50:30 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 09:50:30 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 09:50:30 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 09:50:30 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 09:50:30 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 09:50:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:50:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:50:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:50:33 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 09:50:33 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 09:50:33 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 09:50:33 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 09:50:33 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 09:50:33 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 09:50:33 INFO - Downloading docopt-0.6.1.tar.gz 09:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:50:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:50:33 INFO - Running setup.py install for blobuploader 09:50:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:50:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:50:34 INFO - Running setup.py install for requests 09:50:34 INFO - Running setup.py install for docopt 09:50:34 INFO - Successfully installed blobuploader requests docopt 09:50:34 INFO - Cleaning up... 09:50:34 INFO - Return code: 0 09:50:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:34 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 0x100d22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ad86bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b36d30>, '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 0x10099cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b2eb20>, '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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 09:50:34 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 09:50:34 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 09:50:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mMvOdcBcjG/Render', 09:50:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:34 INFO - 'HOME': '/Users/cltbld', 09:50:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:34 INFO - 'LOGNAME': 'cltbld', 09:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:34 INFO - 'MOZ_NO_REMOTE': '1', 09:50:34 INFO - 'NO_EM_RESTART': '1', 09:50:34 INFO - 'PAGER': '/bin/cat', 09:50:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:34 INFO - 'PWD': '/builds/slave/test', 09:50:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:34 INFO - 'SHELL': '/bin/bash', 09:50:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q9D1cyzG1N/Listeners', 09:50:34 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 09:50:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:34 INFO - 'USER': 'cltbld', 09:50:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:34 INFO - 'XPC_FLAGS': '0x0', 09:50:34 INFO - 'XPC_SERVICE_NAME': '0', 09:50:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:50:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-kvPPbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:50:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Nxm_tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:50:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Dx7KZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:50:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-LQjhQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:50:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-MvwyOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:50:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-o4qlFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:50:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-A9hNq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:50:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-lLODoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:50:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-8_ibTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:50:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-qE9K2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:50:36 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-QlzU4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:50:36 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-VrqnDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:50:36 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-RjGFDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:50:36 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-ioP9Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:36 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-zFRBQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:50:36 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-qF0Xv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:50:36 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-bhUl1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:50:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:50:36 INFO - Running setup.py install for manifestparser 09:50:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:50:36 INFO - Running setup.py install for mozcrash 09:50:37 INFO - Running setup.py install for mozdebug 09:50:37 INFO - Running setup.py install for mozdevice 09:50:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:50:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:50:37 INFO - Running setup.py install for mozfile 09:50:37 INFO - Running setup.py install for mozhttpd 09:50:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:50:37 INFO - Running setup.py install for mozinfo 09:50:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:50:37 INFO - Running setup.py install for mozInstall 09:50:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:50:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:50:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:50:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:50:37 INFO - Running setup.py install for mozleak 09:50:38 INFO - Running setup.py install for mozlog 09:50:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:50:38 INFO - Running setup.py install for moznetwork 09:50:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:50:38 INFO - Running setup.py install for mozprocess 09:50:38 INFO - Running setup.py install for mozprofile 09:50:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:50:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:50:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:50:38 INFO - Running setup.py install for mozrunner 09:50:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:50:38 INFO - Running setup.py install for mozscreenshot 09:50:39 INFO - Running setup.py install for moztest 09:50:39 INFO - Running setup.py install for mozversion 09:50:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:50:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:50:39 INFO - Cleaning up... 09:50:39 INFO - Return code: 0 09:50:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:39 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 0x100d22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ad86bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b36d30>, '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 0x10099cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b2eb20>, '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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 09:50:39 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 09:50:39 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 09:50:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mMvOdcBcjG/Render', 09:50:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:39 INFO - 'HOME': '/Users/cltbld', 09:50:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:39 INFO - 'LOGNAME': 'cltbld', 09:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:39 INFO - 'MOZ_NO_REMOTE': '1', 09:50:39 INFO - 'NO_EM_RESTART': '1', 09:50:39 INFO - 'PAGER': '/bin/cat', 09:50:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:39 INFO - 'PWD': '/builds/slave/test', 09:50:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:39 INFO - 'SHELL': '/bin/bash', 09:50:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q9D1cyzG1N/Listeners', 09:50:39 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 09:50:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:39 INFO - 'USER': 'cltbld', 09:50:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:39 INFO - 'XPC_FLAGS': '0x0', 09:50:39 INFO - 'XPC_SERVICE_NAME': '0', 09:50:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:50:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-UOhKjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:50:39 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)) 09:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:50:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-NbhUm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:50:39 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)) 09:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:50:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-alkS7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:50:39 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)) 09:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:50:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-oxmJY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:50:40 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)) 09:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:50:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-tfObx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:50:40 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)) 09:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:50:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-IrYzIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:50:40 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)) 09:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:50:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-9aqRC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:50:40 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)) 09:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:50:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-zU1e0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:50:40 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)) 09:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:50:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-tbZsww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:50:40 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)) 09:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:50:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-HIeD7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:50:40 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)) 09:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:50:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-5QePW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:50:40 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)) 09:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:50:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-jujKP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:50:40 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)) 09:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:50:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-KwT2CP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:50:40 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)) 09:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:50:41 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-D2DTBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:50:41 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)) 09:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:41 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-j97Wyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:41 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)) 09:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:50:41 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-n3nAOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:50:41 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)) 09:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:50:41 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-n9oFQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:50:41 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)) 09:50:41 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)) 09:50:41 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)) 09:50:41 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)) 09:50:41 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)) 09:50:41 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)) 09:50:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:43 INFO - Downloading blessings-1.6.tar.gz 09:50:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:50:43 INFO - Installing collected packages: blessings 09:50:43 INFO - Running setup.py install for blessings 09:50:44 INFO - Successfully installed blessings 09:50:44 INFO - Cleaning up... 09:50:44 INFO - Return code: 0 09:50:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:50:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:50:44 INFO - Reading from file tmpfile_stdout 09:50:44 INFO - Current package versions: 09:50:44 INFO - blessings == 1.6 09:50:44 INFO - blobuploader == 1.2.4 09:50:44 INFO - docopt == 0.6.1 09:50:44 INFO - functools32 == 3.2.3-2 09:50:44 INFO - jsonschema == 2.5.1 09:50:44 INFO - manifestparser == 1.1 09:50:44 INFO - mozInstall == 1.12 09:50:44 INFO - mozcrash == 1.0 09:50:44 INFO - mozdebug == 0.1 09:50:44 INFO - mozdevice == 0.48 09:50:44 INFO - mozfile == 1.2 09:50:44 INFO - mozhttpd == 0.7 09:50:44 INFO - mozinfo == 0.9 09:50:44 INFO - mozleak == 0.1 09:50:44 INFO - mozlog == 3.4 09:50:44 INFO - moznetwork == 0.27 09:50:44 INFO - mozprocess == 0.23 09:50:44 INFO - mozprofile == 0.28 09:50:44 INFO - mozrunner == 6.13 09:50:44 INFO - mozscreenshot == 0.1 09:50:44 INFO - mozsystemmonitor == 0.3 09:50:44 INFO - moztest == 0.7 09:50:44 INFO - mozversion == 1.4 09:50:44 INFO - psutil == 3.1.1 09:50:44 INFO - requests == 1.2.3 09:50:44 INFO - wsgiref == 0.1.2 09:50:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:45 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')]} 09:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:45 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 0x100d22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ad86bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b36d30>, '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 0x10099cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b2eb20>, '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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 09:50:45 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 09:50:45 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 09:50:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mMvOdcBcjG/Render', 09:50:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:45 INFO - 'HOME': '/Users/cltbld', 09:50:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:45 INFO - 'LOGNAME': 'cltbld', 09:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:45 INFO - 'MOZ_NO_REMOTE': '1', 09:50:45 INFO - 'NO_EM_RESTART': '1', 09:50:45 INFO - 'PAGER': '/bin/cat', 09:50:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:45 INFO - 'PWD': '/builds/slave/test', 09:50:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:45 INFO - 'SHELL': '/bin/bash', 09:50:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q9D1cyzG1N/Listeners', 09:50:45 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 09:50:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:45 INFO - 'USER': 'cltbld', 09:50:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:45 INFO - 'XPC_FLAGS': '0x0', 09:50:45 INFO - 'XPC_SERVICE_NAME': '0', 09:50:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:45 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)) 09:50:45 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)) 09:50:45 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)) 09:50:45 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)) 09:50:45 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)) 09:50:45 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)) 09:50:45 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)) 09:50:45 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)) 09:50:45 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)) 09:50:45 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)) 09:50:45 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)) 09:50:45 INFO - Cleaning up... 09:50:45 INFO - Return code: 0 09:50:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:50:45 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')]} 09:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:45 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')]} 09:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:46 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 0x100d22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ad86bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b36d30>, '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 0x10099cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b2eb20>, '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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 09:50:46 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 09:50:46 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 09:50:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mMvOdcBcjG/Render', 09:50:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:46 INFO - 'HOME': '/Users/cltbld', 09:50:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:46 INFO - 'LOGNAME': 'cltbld', 09:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:46 INFO - 'MOZ_NO_REMOTE': '1', 09:50:46 INFO - 'NO_EM_RESTART': '1', 09:50:46 INFO - 'PAGER': '/bin/cat', 09:50:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:46 INFO - 'PWD': '/builds/slave/test', 09:50:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:46 INFO - 'SHELL': '/bin/bash', 09:50:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q9D1cyzG1N/Listeners', 09:50:46 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 09:50:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:46 INFO - 'USER': 'cltbld', 09:50:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:46 INFO - 'XPC_FLAGS': '0x0', 09:50:46 INFO - 'XPC_SERVICE_NAME': '0', 09:50:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:50:46 INFO - Cleaning up... 09:50:46 INFO - Return code: 0 09:50:46 INFO - Running post-action listener: _resource_record_post_action 09:50:46 INFO - Running post-action listener: _start_resource_monitoring 09:50:46 INFO - Starting resource monitoring. 09:50:46 INFO - [mozharness: 2016-11-14 17:50:46.720369Z] Finished create-virtualenv step (success) 09:50:46 INFO - [mozharness: 2016-11-14 17:50:46.721358Z] Running install step. 09:50:46 INFO - Running pre-action listener: _resource_record_pre_action 09:50:46 INFO - Running main action method: install 09:50:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:50:46 INFO - Reading from file tmpfile_stdout 09:50:46 INFO - Detecting whether we're running mozinstall >=1.0... 09:50:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:50:47 INFO - Reading from file tmpfile_stdout 09:50:47 INFO - Output received: 09:50:47 INFO - Usage: mozinstall [options] installer 09:50:47 INFO - Options: 09:50:47 INFO - -h, --help show this help message and exit 09:50:47 INFO - -d DEST, --destination=DEST 09:50:47 INFO - Directory to install application into. [default: 09:50:47 INFO - "/builds/slave/test"] 09:50:47 INFO - --app=APP Application being installed. [default: firefox] 09:50:47 INFO - mkdir: /builds/slave/test/build/application 09:50:47 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'] 09:50:47 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 09:51:18 INFO - Reading from file tmpfile_stdout 09:51:18 INFO - Output received: 09:51:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:51:18 INFO - Running post-action listener: _resource_record_post_action 09:51:18 INFO - [mozharness: 2016-11-14 17:51:18.755346Z] Finished install step (success) 09:51:18 INFO - [mozharness: 2016-11-14 17:51:18.755496Z] Running run-tests step. 09:51:18 INFO - Running pre-action listener: _resource_record_pre_action 09:51:18 INFO - Running main action method: run_tests 09:51:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:51:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:51:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:51:18 INFO - 2016-11-14 09:51:18.769 screenresolution[1922:14227] starting screenresolution argv=screenresolution get 09:51:18 INFO - 2016-11-14 09:51:18.772 screenresolution[1922:14227] Display 0: 1600x1200x32@60 09:51:18 INFO - 2016-11-14 09:51:18.778 screenresolution[1923:14229] starting screenresolution argv=screenresolution list 09:51:18 INFO - Available Modes on Display 0 09:51:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:51:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:51:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:51:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:51:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:51:19 INFO - Intel Iris: 09:51:19 INFO - Chipset Model: Intel Iris 09:51:19 INFO - Type: GPU 09:51:19 INFO - Bus: Built-In 09:51:19 INFO - VRAM (Dynamic, Max): 1536 MB 09:51:19 INFO - Vendor: Intel (0x8086) 09:51:19 INFO - Device ID: 0x0a2e 09:51:19 INFO - Revision ID: 0x0009 09:51:19 INFO - Displays: 09:51:19 INFO - Display: 09:51:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:51:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:51:19 INFO - Display Serial Number: 1600x1200 60 09:51:19 INFO - Main Display: Yes 09:51:19 INFO - Mirror: Off 09:51:19 INFO - Online: Yes 09:51:19 INFO - Rotation: Supported 09:51:19 INFO - Return code: 0 09:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:51:19 INFO - Python 2.7.3 09:51:19 INFO - Return code: 0 09:51:19 INFO - grabbing minidump binary from tooltool 09:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:19 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 0x100b36d30>, '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 0x10099cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b2eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:51:19 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 09:51:19 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 09:51:19 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 09:51:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:51:19 INFO - Return code: 0 09:51:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:51:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:51:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:51:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:51:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:51:19 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/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 09:51:19 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/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0136 --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 09:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mMvOdcBcjG/Render', 09:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:19 INFO - 'HOME': '/Users/cltbld', 09:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:19 INFO - 'LOGNAME': 'cltbld', 09:51:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:51:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:19 INFO - 'MOZ_NO_REMOTE': '1', 09:51:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:51:19 INFO - 'NO_EM_RESTART': '1', 09:51:19 INFO - 'PAGER': '/bin/cat', 09:51:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:19 INFO - 'PWD': '/builds/slave/test', 09:51:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:19 INFO - 'SHELL': '/bin/bash', 09:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q9D1cyzG1N/Listeners', 09:51:19 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 09:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:19 INFO - 'USER': 'cltbld', 09:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:19 INFO - 'XPC_FLAGS': '0x0', 09:51:19 INFO - 'XPC_SERVICE_NAME': '0', 09:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:19 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/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 09:51:19 INFO - mozversion application_buildid: 20161114043447 09:51:19 INFO - mozversion application_changeset: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f 09:51:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:51:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:51:19 INFO - mozversion application_name: Firefox 09:51:19 INFO - mozversion application_remotingname: firefox-dev 09:51:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:51:19 INFO - mozversion application_vendor: Mozilla 09:51:19 INFO - mozversion application_version: 52.0a2 09:51:19 INFO - mozversion platform_buildid: 20161114043447 09:51:19 INFO - mozversion platform_changeset: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f 09:51:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:51:19 INFO - mozversion platform_version: 52.0a2 09:51:19 INFO - using testdate: 1479145879 09:51:19 INFO - actual date: 1479145879 09:51:19 INFO - starting webserver on 'localhost:49433' 09:51:19 INFO - SUITE-START | Running 2 tests 09:51:19 INFO - TEST-START | dromaeo_css 09:51:19 INFO - operating with platform_type : mac_ 09:51:19 INFO - Initialising browser for dromaeo_css test... 09:51:19 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpO6V5Bw/profile http://localhost:49433/getInfo.html) 09:51:21 ERROR - PROCESS | 1933 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 09:51:22 INFO - PROCESS | 1933 | __metrics Screen width/height:1600/1200 09:51:22 INFO - PROCESS | 1933 | colorDepth:24 09:51:22 INFO - PROCESS | 1933 | Browser inner width/height: 1024/689 09:51:22 INFO - PROCESS | 1933 | __metrics 09:51:22 ERROR - PROCESS | 1933 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 09:51:22 INFO - TEST-INFO | 1933: exit 0 09:51:22 INFO - Browser initialized. 09:51:22 INFO - Running cycle 1/1 for dromaeo_css test... 09:51:22 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpO6V5Bw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:34 INFO - PROCESS | 1936 | RSS: Main: 223911936 09:51:34 INFO - PROCESS | 1936 | 09:52:24 INFO - PROCESS | 1936 | 1479145944545 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] 09:54:39 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49433/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49433/tests/dromaeo/cssquery-ext.html) 09:54:40 INFO - PROCESS | 1936 | RSS: Main: 236335104 09:54:40 INFO - PROCESS | 1936 | 09:57:42 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49433/tests/dromaeo/cssquery-ext.html (next: http://localhost:49433/tests/dromaeo/cssquery-jquery.html) 09:57:43 INFO - PROCESS | 1936 | RSS: Main: 248279040 09:57:43 INFO - PROCESS | 1936 | 10:00:45 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49433/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49433/tests/dromaeo/cssquery-mootools.html) 10:00:45 INFO - PROCESS | 1936 | RSS: Main: 251523072 10:00:45 INFO - PROCESS | 1936 | 10:03:47 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49433/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49433/tests/dromaeo/cssquery-prototype.html) 10:03:48 INFO - PROCESS | 1936 | RSS: Main: 250679296 10:03:48 INFO - PROCESS | 1936 | 10:06:51 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49433/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49433/tests/dromaeo/cssquery-yui.html) 10:06:51 INFO - PROCESS | 1936 | RSS: Main: 254214144 10:06:51 INFO - PROCESS | 1936 | 10:09:54 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49433/tests/dromaeo/cssquery-yui.html (next: http://localhost:49433/tests/dromaeo/cssquery-dojo.html) 10:09:54 INFO - PROCESS | 1936 | RSS: Main: 255266816 10:09:54 INFO - PROCESS | 1936 | 10:09:54 INFO - PROCESS | 1936 | __start_tp_report 10:09:54 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 10:09:54 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 10:09:54 INFO - PROCESS | 1936 | |i|pagename|runs| 10:09:54 INFO - PROCESS | 1936 | |0;dojo.html;3018.185090025693;3361.008502491765;3364.192593777494;3376.25722341085;3381.5265862779215;5678.545716342693;5683.65898046117;5742.081266997281;5783.942160578398;5798.2172406725185;4557.293619488976;4782.067496838118;4907.190313598252;5415.13357862742;5795.2466179396615;5212.895742085156;5216.478352164772;5221.112410890158;5273.499017593323;5307.38965019022;5237.3453318335205;5276.314079169702;5292.36491621006;5306;5328.040952628526;4169.541350451448;4310.482742070956;4826.7586620669;5150.484951504838;5294.85070534869;4360.672949528798;4833.854984350458;5215.530602245778;5227.921581176285;5250.159974404115;4312.654987601016;5065.518775716301;5069.391672999227;5190.584753219733;5212.29633999409;5723.198752174699;5754.510866576346;5773.9422605773825;5785.768569257225;5812.854678633025;4455.933161002587;5255.500727430888;5797.724500609859;6150;6189.752409903598;4935.5804756595735;6177.011678131522;6195.349488303708;6268.592541484834;6316.494680425555;5819.621724587888;5827.79602713903;5835.5915085944;5862.325832529228;5897.882042359129;6191.535634827316;6294.716737746767;6294.779682711129;6300.59046161998;6413.909635362;6071.2714474263375;6089.391060893964;6106.175666284995;6113.449789518964;6129.969350153221;5790.681512516852;6147.907781383283;6163;6182.938170618326;6211.689415529296;6106.642687876592;6199.5660303779205;6202.534809889276;6218.098375735583;6251.9687401562705;6174.567780255429;6203.596766210182;6279.466245369194;6280.811575652738;6294.244690637152;4757.333973243749;4760.143174228672;4839.927401088987;4861.076395484917;4997.175466048134;4360.127974405132;4361.803718832597;4388.319810429389;4402.965303153756;4407.647388208936;5833.79581714638;5851.180834683148;5858.56060795442;5877.177195192677;5903.970480147572;5133.640645154804;6140.166841500592;6183.96908015466;6205.100260462208;6293.527985401113;5887.558433117533;5907.940920590825;5909.6158749681135;5968.582199246011;5970.641761494324;5457.126859702508;5459.836204913859;5467.425920278393;5475.315585551806;5482.095454250004;6211.9068213977735;6232.407921247474;6293.496520278275;6339.080833279241;6367.140436041261;6209.96895015522;6296.181496405438;6296.937030629635;6304.842378940563;6317.96841015792;6193.411625895713;6282.371762823681;6287.088372186099;6330.430261276323;6353.14232578596;6138.6336396323695;6181.3200547938795;6199.225096862892;6240.344763799736;6267.749290028531;4565.7488838112895;5318.813841515528;5823.505002074701;6167.044108163242;6300.558960872695;5051.520105589963;6131.509479241561;6144.692765361625;6146.5390095742105;6168.475679567107;6087.847803804941;6143.784967526115;6160.229971253593;6165.106059621419;6170.10533472635;5043.067032598981;5598.076317407582;5798.913016304675;5974.4324289192455;5979.402059793986;6148.1699970503405;6155.692215389302;6156.015037593964;6171.59884607499;6182.690865456799;4454.777261136995;5993.520518358434;6006.3693312201585;6014.849628759316;6020.698965051817 10:09:54 INFO - PROCESS | 1936 | |1;ext.html;474.8053298147759;525.3590619444277;526.4735264735265;527.3434573955426;539.2073651731953;37722.81138594307;39550.60449395505;39622.603773962284;39708.60291397085;41375.79312103435;39817.00457488557;40506.59493405065;40713.79643101781;40763.79618101913;40768.796156019256;9118.726438206864;9268.119528644767;9304.116108969638;9304.72085837426;9320.114589114024;5190.403103643072;5238.13570760824;5263.421023687391;5273.156294992802;5288.127458969266;5237.2144178373355;5263.315768950031;5275.736213189325;5285.920711189336;5304.469553044703;5260.1583746600745;5271.051210782058;5272.156454967187;5274.789008439677;5281.524662780349;9120.771980700469;9178.908210917873;9217.170454659046;9217.539123043887;9236.769080772967;38783.8060809697;38815.61184388148;38829.611703883165;38852.80573597114;38923.026924326834;3268.852901619433;3348.7153591944716;3348.916277093068;3375.2405708715587;3736.327461057009;25802.096926607668;29285.41429171426;29929;30557.847210763804;30852.845735771178;3013.89451369201;3109.129443755752;3118.70372314632;3162.130414136108;3202.1674364665123;416038;494962;499596.5020174912;500794;501625;60692;61088.38911610916;61441;61442.385576143664;61604.07593886095;63207;63732.68133659302;63756;64249;64593.67703161548;14843.851561484464;14848.2575871206;14917.776233356508;14958.878084143733;15072.397104115931;12326.691832704075;12359.196652217577;12368.690782730504;12394.690132746753;12394.75210495803;15881.52355429339;17001.894876832965;18193.49336052188;19122.52193695169;19338.90330548338;3146.528020796899;6413.583117097373;6732.798016059526;7632.1986191450205;7759.650815713307;839.8740188971703;1014.4724743133677;1033.245730616654;1086.8261078227445;1110.622388387952;24856.627150592754;29857.85071074674;29886.701132988826;30237.848810755804;30257.848710756305;779.9571023593757;914.5290175559592;948.4167237149242;982.6266018912768;1048.8688913885765;14646.095749173806;14681.632959176106;15478.380864765508;15778;16121.952073115444;670868;677732;678658;679276;680986;57671.71164144152;58331.541711457554;58396;58590.707046465344;58758;1314.1655049043734;1337.1442276942764;1361.6936189357514;1363.1820907455447;1367.589723083071;24391.51216975686;29964.22802897479;30904.0728778137;31273.37453250968;31431.057068287988;50896.49103508917;51563;51629.48370516247;51646.70883227799;51913.22130168126;615352;618699;621582;621671;623150;22907.19824806124;25365.98536058537;26395;26695;26800.865995669898;42229.521966731016;45197;46127.76936115432;46212.7689361551;46633.533664664275;30485.847570762005;36113;38293;38629.806850965564;39584;37746.87134575738;37869.24261514809;38313.61686383212;38397.424038638885;38883.611163887996;30677.846610767698;36787.264254715294;36905.63094369022;37071.81464092662;37876;32199.839000804845;34025.65974340225;34095.31809363848;34163.316733665684;34211.31577368489;21172.788272117083;25193.622095668947;25274.494510110064;25354.60549669786;25630.615540766532 10:09:54 INFO - PROCESS | 1936 | |2;jquery.html;360.4665095658427;369.7596562234547;378.73677793933194;381.4316668164435;401.29372304743663;16351.182440877938;18806.717899231506;18992.715109273373;19717.901410492963;19925.900370498126;11568.958793708565;14074;18262;19795.406137815888;19808.504787380287;5235.1885457754015;5483.479069488392;5491.533219676332;5503.229547863302;5504.394516603171;5207.297014902996;5356.1697936819855;5368.141097424413;5424.972875135619;5438.646487978269;5411.756470958816;5417.3770016448025;5427.158790387496;5440.4287549807095;5459.290292262001;5212.6611770235;5403.189521571776;5420.322459692538;5448.318960129984;5454.072807622713;5303.840884773463;5311.62818602698;5316.76074576645;5318.335208098988;5321.201819727034;10654.467276636136;12788.360581970865;12947.611571652771;13106.344682765919;13210.405531750997;1909.5608010157603;2076.909622448227;2165.155589320166;2410.5781488239486;2927.975208676946;9416.952915235448;9951.55218015191;10134.189264858793;10285.9485702571;10299.53652085658;1774.698301288771;1786.22299299805;1825.6257467219189;1835.4310163849116;1843.8801477903894;114055;117605;117818.82181178078;117918;118424.81575184224;11303.03924166455;11483;11633.825492617618;11657.242279251821;11675.299482031105;14604.488842890449;14614.196219208046;14617.707645847024;14618.707625847423;14661.853381466262;7571.3500274903345;7586.62066896653;8406.285465735358;8470.322374210049;8535.914640853636;8103.716369927024;8148.429609927248;8164.795880102926;8261.710840120568;8280.544570048585;4400.22995975703;4494.258447356215;4506.3465797459185;4612.123696497655;4618.399608050999;1919.5393105654543;1929.8938558379423;1946.1728765274702;1995.5310502032012;1999.4001799460104;797.3820289275858;943.1417410156862;949.027247071757;965.1120968708805;995.2535598301274;15634.3746250151;16665.583360416087;17962.640747185244;18372.632547349247;20559.794402055788;894.1058941058941;897.4570384917162;901.5176880368971;908.9368827052874;911.2846415563884;8066.798330041796;8674.696385626472;9389.530523473935;10795;11073.72315692098;598148;598957;600769;609918;611973;116993.41503292428;119434.40282798531;121888;126265;132323;787.8857565653063;967.5210770668424;992.836182029957;993.5345365585704;993.7316924430363;14192.290385480892;14753.704925901207;18732.812671873107;18737.625247495245;18886.96121713319;38965.61034389733;39424.605753942094;39849.800750997216;53382.46617533775;56346.7182664084;75101.62449187718;75303.62348188224;76055.23944760703;78856.2114378849;79110.60444697739;7862.056553213651;7897.131315555399;7916.485428447132;8142.7557173284895;8238.423310368216;11175.161862860155;12029.759404811679;12296.631101066982;12367.75264494723;12434.875651243372;10427.843582346119;10540.789184216426;10554.841677374692;10659.360438373722;10937.671869843918;9693.903060969582;9953.203743700631;10412.635557755442;10582.523786429783;10747.516361763583;9879.259055570717;10717.732056698333;10755.677329680122;10779.299345542515;11013.063889569476;7857.567833769198;7917.604119794102;7922.286994170552;8116.310113640407;8132.634031468479;10410.791784164427;10524.210684198868;10727.302725322828;10853.077488413574;10981.83527247076 10:09:54 INFO - PROCESS | 1936 | |3;mootools.html;1452.5787521618727;1490.2474250503494;1662.7672125902375;1800.13593475132;1817.100535235059;7669.923300766991;7892.329152022085;8101.473404228728;8570.957145214274;8592.398532102756;8125.796855078626;8373.58132093396;8403.327733781298;8550.65797368106;8562.914370856306;2286.908523659056;2325.2907863101746;2329.301209637111;2332.24202134307;2337.0768546424238;2307.3078076577044;2338.7778161074757;2353.4587044979667;2355.611324131516;2358.5636657218383;2315.953680926389;2321.2339927823778;2336.8130549555995;2343.261872510154;2347.6149072047488;2295.747467778543;2298.1841446286494;2329.2080692564523;2331.4404542909665;2333.953320933572;2152.1821707750955;2185.519185779126;2185.9016344264546;2188.2888061379954;2194;8243.05204901432;8308.459950103224;8317.168283171695;8327.250547450758;8327.83344333116;5104.183330667112;5232.502912223333;5280.49835265653;5281.551068159172;5298.523132918017;3245.1562593725566;3288.3094550144497;3585;3587.7847329160336;3597.3344931187553;1019.7450637340664;1025.3950169400016;1067.2849191042021;1076.5962763963514;1077.983830242547;10980.615678451215;11074.723131921686;11151.665450036511;11172.944135279353;11178.161637877192;4576.931346029813;4623.352730617717;4697.530246975275;4722.126406614787;4815.398075240595;9537.712408824858;9579;9614.615415383307;9616.855747163798;9629.855552166724;3964.9691080319326;4914.287428322873;5221.843344699665;5265.315508983884;5437.293151890229;4215.430916826251;4342.5874541918465;4477.350784136282;4607.9308810367875;4740.478547359788;3818.1218319786603;3880.6507414332846;3936.5079365079364;3959.287328280937;3978.9403158952637;1278.2905487454552;1283.8716128387086;1284.1203775413871;1296;1297.8455763432844;811.7645882693953;881.6076845803556;896.3098414221143;898.0749827677503;898.1108702384593;5578.24693666358;5599.32808063035;5675.574331925122;5723.971380143073;5761.049426844524;818.6929901287017;856.8357781183444;904.7511934218011;906.3338446242007;939.1922946266205;3471.8264086795557;3665.376885929398;3803.866864659779;3946.1910308386714;3966.861159859449;9806.411615303105;10293.073623373932;10307.433091179908;10351.430671312999;10358.326708763907;10229.539670714836;10244.743881402876;10252.6411575596;10283.023112804272;10340.017698318648;7430.96284518574;7756.340711039512;7771.028621422322;7861.4103942204565;7886.64510097047;4908.410990681141;5010.273510340907;5598.972005139948;5723.170140329712;5928.762849485972;9321.161095501437;9366.765830854283;9406;9467.810643786948;9526.237900967768;9602.759931001781;9633.566489507848;9656.082672146134;9691.563879625293;9733.318667693477;6639.435647969976;6873.48448866327;7038.331358520933;7139.500234983501;7285.635718213962;7857.017872765904;8089;8098.5545794981845;8100.473469224482;8127;7083.7520686775715;7192.172900116553;7204.71181152748;7259.9274007259255;7341.74303899361;7035.929640703527;7106.218315985341;7110.14678238594;7212.278772122746;7244.239354867874;6649.800505984828;6659.234188068434;6728.192616886005;6732.831679208059;6752.155980502437;4848.9757551212015;4892.608591312757;4894.339264199288;4895.971845912399;4944.554990050912;4828.275758636232;4829.6860704054125;4863.221884498464;4974.855783169964;5001.299818025552 10:09:54 INFO - PROCESS | 1936 | |4;prototype.html;262.1545515711828;270.73738473680527;303.76761777240415;311.27783542182135;314.26775612822127;4706.882327941803;5137.972405518897;5189.6107791915565;5292.708901010443;5480.588955828314;4179.799301701785;4851.63612729045;4950.8860506386045;5346.652467589604;5357.919631205535;3563.269529746409;4062.8827072554986;4099.754014759109;4099.847580020491;4139.4204811326435;3574.8391322390553;3591.5690117185845;4001.1997600479876;4090.3046482098116;4152.68854835887;3702.759320644163;4029.97985010076;4083.8162282697203;4093.7339072960312;4103.322951712964;4048.1340319994333;4048.967513284094;4074.8166332515107;4075.6331930126134;4095.0376661484825;3302.8513716882558;3392.4741665041956;3422.57217847769;3549.7337699672626;3562.5190599269026;5176.844694659128;5180.777666202033;5192.1432963560965;5197.402298735656;5198.376194856603;3857.537095548524;4554.931676024862;4570.520095389969;4572.177008138534;4583.495815460296;4425.8229670813125;5328.307320048408;5527.447255274481;5629.380768115504;5630.211770352113;3806.124591343979;3810.9519882032387;3832.291026160169;3841.8079096045085;3842.154725960312;4978.954419571858;5878.706064696748;5884.617499862538;5898.528117750569;5912;3401.3537427888623;3425.1950791563963;3863.5363756349416;3870.3420418528917;3903.980480097581;3878.7478813877005;3930.3121953657997;3930.449737036817;3942.3495123304906;3955.64399204073;4529.909401811945;4579.221532339444;4587.9541204588195;4596.816127354935;4608.815647374067;5530.474604912527;5729.338491837404;5729.512991395694;5730.914036289459;5740.302058032718;1215.197969340231;1257.767313047071;1261.703499677575;1289.7420515896858;1290.2129700882454;848.4230723108345;867.6616119713317;877.8324827978773;879.4855009819199;881.5592203898051;4401.559844015573;5141.5886729061585;5148;5148.3564554430695;5173.008391769121;4780.641451891122;4867;5598.944010559923;5611.959389239741;5617.438256174431;4363.738175709467;4599.611805106282;4889.584385327216;5014.598832093424;5175.741212939338;2841.3606938438684;2922.824630522133;2936.265933516621;2940.750181172993;2958.65975412826;4862.854114376574;5336.46635336471;5649.943500565024;5886.793962211302;5891.440313170242;4728.361671174347;4749.643776716691;5272.883455191959;5601.159826026129;6067.696615169224;6165.660888651168;6169.722362493609;6177.8455538611;6194.938050619527;6225.252969643671;5245.973770131278;5449.972750136224;5650.180723795109;5692.48767610917;6014.609050411709;4625.398698169217;5566.192902029264;5874.148248503858;5876.6180198286975;5904.911426328695;5600.431879073866;5682.977064128497;6200.224971878515;6202.503799695924;6227.377262273918;3378.915527111842;3552.5026496290025;3888;3892.9805350973065;3930.5479869815335;5255.1884741663025;5768.625039372428;5783.595148339576;5814.982378083903;5892.204552385545;5699.8860022800145;5703.600747947769;5713.571482138773;5715.342735585461;5732.684702341411;4781.952180478151;5516.400243929215;5545.390007099135;5603.915941260802;5675.205471234113;4817.566419022305;4994.850154495371;5509.311336082989;5598.356189038313;5689.288838895138;4532.796024178986;4752;4963.671319068217;5207.843764687065;5450.656217826214;4833.830815921426;5139.066496163725;5459;5460.836174914759;5544.390117087037 10:09:54 INFO - PROCESS | 1936 | |5;yui.html;673.6766352150964;680.6086500262348;737.2185483387609;741.2093468092636;781.3631890009642;13692.11001284917;14580.416783328654;14608.634784130401;14646.414143434276;14656.926715366422;11852.288862668225;11874.821877671842;11968.640940771791;11980.34108124053;12035.03719702424;620.7175735040546;650.0476801485822;777.4635501503973;794.972175973841;809.5385630190793;779.5050143159107;805.7784109369941;809.1867672988639;809.3929552835374;810.4205493072452;848.5417874347845;850.1795767084762;858.120426562775;858.6479543387212;859.9871001934976;712.8609921065395;850.0479463001416;854.2909385210261;857.1128881607507;859.0292968945115;613.1875265273486;629.9811005669792;634.0679201573679;635.4535099814157;635.6821589205397;13291.800622990662;13295.734085318336;13301.534446294334;13325.533606323828;13343.799843002364;12801.743965120646;13317;13328.266945318004;13352.86647133526;13479.258640774753;10935.890641093567;11045;11274.379909104997;11281.37952412617;11284;3426.794392336468;3564.6613571710905;3582.301451217014;3615.891523254307;3708.6662200401825;86736.6989495158;87366;87681;89910;90221.54889225577;10039.598416063422;10204.285700001077;10410.427426491615;10452.843207351896;10516.158707303397;19711;19937.900310498353;20000.399988000383;20282.59434811325;20308.492287692632;7439.479236453504;7474.887876681854;7492.812679683051;7587.544747315179;7646.120696120018;4122.3404255319;4136.73111247768;4233.280342341748;4304.440422745023;4308.698391112592;3213.3091385352263;3301;3324.983375083109;3326.7005969462866;3330.0842268375904;533;601.4016054026184;621.0652967284209;621.6674079367517;632.4782054804805;556.6799090522966;561.6770357044634;581.2153592649889;628.3308276685407;682.7269092362995;8854;8943.747875297464;9121.680741174026;9161.954190229006;9175.954120229357;576.2105914896619;660.9966950165218;662.5329142954206;665.4942243894675;671.358852296056;4122.361034039729;4478.641708663299;4491.146682130385;4529.496661556225;4617.653675974316;104452;105746.88506229833;108359;109560;110859;75204.24795751972;87266.56366718125;89671.55164224138;91894.54052729828;97946.53080203803;48158.796030099526;57026;72494.63752681203;80044.19955800367;81309.59345203236;6949.270326615632;8790.95604521999;8956.865647015169;9365.57854896545;9400.482973436254;37804.86585402442;38847.805760971016;48580.78548036327;51885;53159;71813.20466988366;72579;74668.62665686637;74704.62647686944;77461.61269193619;12134.211276267015;12336.198147120409;12370.381480926098;12570.43433045497;12680.619581412573;13511.527096551574;14047.719045619235;14436.927815360856;14455;14521.709565808413;12237.388130593612;12788.040896932582;13051.543195988095;13655;13666.590002299947;12451.315177665316;12882.162659427107;13531.391087400894;13620.659483512594;13962.79055814184;12935.741285174056;13017.088803784023;13055.934720326337;13480.662983425493;13493.39279732434;10444.268901177149;10761.784764304513;11037.392943388191;11374.94312528432;11454.14093942941;7443.292887175709;8934;10570.788584228427;10748;11364.829527556927 10:09:54 INFO - PROCESS | 1936 | __end_tp_report 10:09:54 INFO - PROCESS | 1936 | __start_cc_report 10:09:54 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,374 10:09:54 INFO - PROCESS | 1936 | __end_cc_report 10:09:54 INFO - PROCESS | 1936 | __startTimestamp1479146994720__endTimestamp 10:09:54 INFO - PROCESS | 1936 | 10:09:54 INFO - PROCESS | 1936 | ------- Summary: start ------- 10:09:54 INFO - PROCESS | 1936 | Number of tests: 6 10:09:54 INFO - PROCESS | 1936 | 10:09:54 INFO - PROCESS | 1936 | [#0] dojo.html Cycles:165 Average:5644.53 Median:5887.56 stddev:716.74 (12.2%) stddev-sans-first:688.69 10:09:54 INFO - PROCESS | 1936 | Values: 3018.2 3361.0 3364.2 3376.3 3381.5 5678.5 5683.7 5742.1 5783.9 5798.2 4557.3 4782.1 4907.2 5415.1 5795.2 5212.9 5216.5 5221.1 5273.5 5307.4 5237.3 5276.3 5292.4 5306.0 5328.0 4169.5 4310.5 4826.8 5150.5 5294.9 4360.7 4833.9 5215.5 5227.9 5250.2 4312.7 5065.5 5069.4 5190.6 5212.3 5723.2 5754.5 5773.9 5785.8 5812.9 4455.9 5255.5 5797.7 6150.0 6189.8 4935.6 6177.0 6195.3 6268.6 6316.5 5819.6 5827.8 5835.6 5862.3 5897.9 6191.5 6294.7 6294.8 6300.6 6413.9 6071.3 6089.4 6106.2 6113.4 6130.0 5790.7 6147.9 6163.0 6182.9 6211.7 6106.6 6199.6 6202.5 6218.1 6252.0 6174.6 6203.6 6279.5 6280.8 6294.2 4757.3 4760.1 4839.9 4861.1 4997.2 4360.1 4361.8 4388.3 4403.0 4407.6 5833.8 5851.2 5858.6 5877.2 5904.0 5133.6 6140.2 6184.0 6205.1 6293.5 5887.6 5907.9 5909.6 5968.6 5970.6 5457.1 5459.8 5467.4 5475.3 5482.1 6211.9 6232.4 6293.5 6339.1 6367.1 6210.0 6296.2 6296.9 6304.8 6318.0 6193.4 6282.4 6287.1 6330.4 6353.1 6138.6 6181.3 6199.2 6240.3 6267.7 4565.7 5318.8 5823.5 6167.0 6300.6 5051.5 6131.5 6144.7 6146.5 6168.5 6087.8 6143.8 6160.2 6165.1 6170.1 5043.1 5598.1 5798.9 5974.4 5979.4 6148.2 6155.7 6156.0 6171.6 6182.7 4454.8 5993.5 6006.4 6014.8 6020.7 10:09:54 INFO - PROCESS | 1936 | 10:09:54 INFO - PROCESS | 1936 | [#1] ext.html Cycles:180 Average:71485.66 Median:39236.82 stddev:160709.03 (409.6%) stddev-sans-first:161071.42 10:09:54 INFO - PROCESS | 1936 | Values: 474.8 525.4 526.5 527.3 539.2 37722.8 39550.6 39622.6 39708.6 41375.8 39817.0 40506.6 40713.8 40763.8 40768.8 9118.7 9268.1 9304.1 9304.7 9320.1 5190.4 5238.1 5263.4 5273.2 5288.1 5237.2 5263.3 5275.7 5285.9 5304.5 5260.2 5271.1 5272.2 5274.8 5281.5 9120.8 9178.9 9217.2 9217.5 9236.8 38783.8 38815.6 38829.6 38852.8 38923.0 3268.9 3348.7 3348.9 3375.2 3736.3 25802.1 29285.4 29929.0 30557.8 30852.8 3013.9 3109.1 3118.7 3162.1 3202.2 416038.0 494962.0 499596.5 500794.0 501625.0 60692.0 61088.4 61441.0 61442.4 61604.1 63207.0 63732.7 63756.0 64249.0 64593.7 14843.9 14848.3 14917.8 14958.9 15072.4 12326.7 12359.2 12368.7 12394.7 12394.8 15881.5 17001.9 18193.5 19122.5 19338.9 3146.5 6413.6 6732.8 7632.2 7759.7 839.9 1014.5 1033.2 1086.8 1110.6 24856.6 29857.9 29886.7 30237.8 30257.8 780.0 914.5 948.4 982.6 1048.9 14646.1 14681.6 15478.4 15778.0 16122.0 670868.0 677732.0 678658.0 679276.0 680986.0 57671.7 58331.5 58396.0 58590.7 58758.0 1314.2 1337.1 1361.7 1363.2 1367.6 24391.5 29964.2 30904.1 31273.4 31431.1 50896.5 51563.0 51629.5 51646.7 51913.2 615352.0 618699.0 621582.0 621671.0 623150.0 22907.2 25366.0 26395.0 26695.0 26800.9 42229.5 45197.0 46127.8 46212.8 46633.5 30485.8 36113.0 38293.0 38629.8 39584.0 37746.9 37869.2 38313.6 38397.4 38883.6 30677.8 36787.3 36905.6 37071.8 37876.0 32199.8 34025.7 34095.3 34163.3 34211.3 21172.8 25193.6 25274.5 25354.6 25630.6 10:09:54 INFO - PROCESS | 1936 | 10:09:54 INFO - PROCESS | 1936 | [#2] jquery.html Cycles:180 Average:33971.06 Median:19673.52 stddev:100734.04 (512.0%) stddev-sans-first:100985.01 10:09:54 INFO - PROCESS | 1936 | Values: 360.5 369.8 378.7 381.4 401.3 16351.2 18806.7 18992.7 19717.9 19925.9 11569.0 14074.0 18262.0 19795.4 19808.5 5235.2 5483.5 5491.5 5503.2 5504.4 5207.3 5356.2 5368.1 5425.0 5438.6 5411.8 5417.4 5427.2 5440.4 5459.3 5212.7 5403.2 5420.3 5448.3 5454.1 5303.8 5311.6 5316.8 5318.3 5321.2 10654.5 12788.4 12947.6 13106.3 13210.4 1909.6 2076.9 2165.2 2410.6 2928.0 9417.0 9951.6 10134.2 10285.9 10299.5 1774.7 1786.2 1825.6 1835.4 1843.9 114055.0 117605.0 117818.8 117918.0 118424.8 11303.0 11483.0 11633.8 11657.2 11675.3 14604.5 14614.2 14617.7 14618.7 14661.9 7571.4 7586.6 8406.3 8470.3 8535.9 8103.7 8148.4 8164.8 8261.7 8280.5 4400.2 4494.3 4506.3 4612.1 4618.4 1919.5 1929.9 1946.2 1995.5 1999.4 797.4 943.1 949.0 965.1 995.3 15634.4 16665.6 17962.6 18372.6 20559.8 894.1 897.5 901.5 908.9 911.3 8066.8 8674.7 9389.5 10795.0 11073.7 598148.0 598957.0 600769.0 609918.0 611973.0 116993.4 119434.4 121888.0 126265.0 132323.0 787.9 967.5 992.8 993.5 993.7 14192.3 14753.7 18732.8 18737.6 18887.0 38965.6 39424.6 39849.8 53382.5 56346.7 75101.6 75303.6 76055.2 78856.2 79110.6 7862.1 7897.1 7916.5 8142.8 8238.4 11175.2 12029.8 12296.6 12367.8 12434.9 10427.8 10540.8 10554.8 10659.4 10937.7 9693.9 9953.2 10412.6 10582.5 10747.5 9879.3 10717.7 10755.7 10779.3 11013.1 7857.6 7917.6 7922.3 8116.3 8132.6 10410.8 10524.2 10727.3 10853.1 10981.8 10:09:54 INFO - PROCESS | 1936 | 10:09:54 INFO - PROCESS | 1936 | [#3] mootools.html Cycles:180 Average:5490.56 Median:4988.08 stddev:3035.91 (60.9%) stddev-sans-first:3029.26 10:09:54 INFO - PROCESS | 1936 | Values: 1452.6 1490.2 1662.8 1800.1 1817.1 7669.9 7892.3 8101.5 8571.0 8592.4 8125.8 8373.6 8403.3 8550.7 8562.9 2286.9 2325.3 2329.3 2332.2 2337.1 2307.3 2338.8 2353.5 2355.6 2358.6 2316.0 2321.2 2336.8 2343.3 2347.6 2295.7 2298.2 2329.2 2331.4 2334.0 2152.2 2185.5 2185.9 2188.3 2194.0 8243.1 8308.5 8317.2 8327.3 8327.8 5104.2 5232.5 5280.5 5281.6 5298.5 3245.2 3288.3 3585.0 3587.8 3597.3 1019.7 1025.4 1067.3 1076.6 1078.0 10980.6 11074.7 11151.7 11172.9 11178.2 4576.9 4623.4 4697.5 4722.1 4815.4 9537.7 9579.0 9614.6 9616.9 9629.9 3965.0 4914.3 5221.8 5265.3 5437.3 4215.4 4342.6 4477.4 4607.9 4740.5 3818.1 3880.7 3936.5 3959.3 3978.9 1278.3 1283.9 1284.1 1296.0 1297.8 811.8 881.6 896.3 898.1 898.1 5578.2 5599.3 5675.6 5724.0 5761.0 818.7 856.8 904.8 906.3 939.2 3471.8 3665.4 3803.9 3946.2 3966.9 9806.4 10293.1 10307.4 10351.4 10358.3 10229.5 10244.7 10252.6 10283.0 10340.0 7431.0 7756.3 7771.0 7861.4 7886.6 4908.4 5010.3 5599.0 5723.2 5928.8 9321.2 9366.8 9406.0 9467.8 9526.2 9602.8 9633.6 9656.1 9691.6 9733.3 6639.4 6873.5 7038.3 7139.5 7285.6 7857.0 8089.0 8098.6 8100.5 8127.0 7083.8 7192.2 7204.7 7259.9 7341.7 7035.9 7106.2 7110.1 7212.3 7244.2 6649.8 6659.2 6728.2 6732.8 6752.2 4849.0 4892.6 4894.3 4896.0 4944.6 4828.3 4829.7 4863.2 4974.9 5001.3 10:09:54 INFO - PROCESS | 1936 | 10:09:54 INFO - PROCESS | 1936 | [#4] prototype.html Cycles:180 Average:4517.17 Median:4971.31 stddev:1404.05 (28.2%) stddev-sans-first:1371.19 10:09:54 INFO - PROCESS | 1936 | Values: 262.2 270.7 303.8 311.3 314.3 4706.9 5138.0 5189.6 5292.7 5480.6 4179.8 4851.6 4950.9 5346.7 5357.9 3563.3 4062.9 4099.8 4099.8 4139.4 3574.8 3591.6 4001.2 4090.3 4152.7 3702.8 4030.0 4083.8 4093.7 4103.3 4048.1 4049.0 4074.8 4075.6 4095.0 3302.9 3392.5 3422.6 3549.7 3562.5 5176.8 5180.8 5192.1 5197.4 5198.4 3857.5 4554.9 4570.5 4572.2 4583.5 4425.8 5328.3 5527.4 5629.4 5630.2 3806.1 3811.0 3832.3 3841.8 3842.2 4979.0 5878.7 5884.6 5898.5 5912.0 3401.4 3425.2 3863.5 3870.3 3904.0 3878.7 3930.3 3930.4 3942.3 3955.6 4529.9 4579.2 4588.0 4596.8 4608.8 5530.5 5729.3 5729.5 5730.9 5740.3 1215.2 1257.8 1261.7 1289.7 1290.2 848.4 867.7 877.8 879.5 881.6 4401.6 5141.6 5148.0 5148.4 5173.0 4780.6 4867.0 5598.9 5612.0 5617.4 4363.7 4599.6 4889.6 5014.6 5175.7 2841.4 2922.8 2936.3 2940.8 2958.7 4862.9 5336.5 5649.9 5886.8 5891.4 4728.4 4749.6 5272.9 5601.2 6067.7 6165.7 6169.7 6177.8 6194.9 6225.3 5246.0 5450.0 5650.2 5692.5 6014.6 4625.4 5566.2 5874.1 5876.6 5904.9 5600.4 5683.0 6200.2 6202.5 6227.4 3378.9 3552.5 3888.0 3893.0 3930.5 5255.2 5768.6 5783.6 5815.0 5892.2 5699.9 5703.6 5713.6 5715.3 5732.7 4782.0 5516.4 5545.4 5603.9 5675.2 4817.6 4994.9 5509.3 5598.4 5689.3 4532.8 4752.0 4963.7 5207.8 5450.7 4833.8 5139.1 5459.0 5460.8 5544.4 10:09:54 INFO - PROCESS | 1936 | 10:09:54 INFO - PROCESS | 1936 | [#5] yui.html Cycles:180 Average:19483.64 Median:4393.67 stddev:28367.21 (645.6%) stddev-sans-first:28411.63 10:09:54 INFO - PROCESS | 1936 | Values: 673.7 680.6 737.2 741.2 781.4 13692.1 14580.4 14608.6 14646.4 14656.9 11852.3 11874.8 11968.6 11980.3 12035.0 620.7 650.0 777.5 795.0 809.5 779.5 805.8 809.2 809.4 810.4 848.5 850.2 858.1 858.6 860.0 712.9 850.0 854.3 857.1 859.0 613.2 630.0 634.1 635.5 635.7 13291.8 13295.7 13301.5 13325.5 13343.8 12801.7 13317.0 13328.3 13352.9 13479.3 10935.9 11045.0 11274.4 11281.4 11284.0 3426.8 3564.7 3582.3 3615.9 3708.7 86736.7 87366.0 87681.0 89910.0 90221.5 10039.6 10204.3 10410.4 10452.8 10516.2 19711.0 19937.9 20000.4 20282.6 20308.5 7439.5 7474.9 7492.8 7587.5 7646.1 4122.3 4136.7 4233.3 4304.4 4308.7 3213.3 3301.0 3325.0 3326.7 3330.1 533.0 601.4 621.1 621.7 632.5 556.7 561.7 581.2 628.3 682.7 8854.0 8943.7 9121.7 9162.0 9176.0 576.2 661.0 662.5 665.5 671.4 4122.4 4478.6 4491.1 4529.5 4617.7 104452.0 105746.9 108359.0 109560.0 110859.0 75204.2 87266.6 89671.6 91894.5 97946.5 48158.8 57026.0 72494.6 80044.2 81309.6 6949.3 8791.0 8956.9 9365.6 9400.5 37804.9 38847.8 48580.8 51885.0 53159.0 71813.2 72579.0 74668.6 74704.6 77461.6 12134.2 12336.2 12370.4 12570.4 12680.6 13511.5 14047.7 14436.9 14455.0 14521.7 12237.4 12788.0 13051.5 13655.0 13666.6 12451.3 12882.2 13531.4 13620.7 13962.8 12935.7 13017.1 13055.9 13480.7 13493.4 10444.3 10761.8 11037.4 11374.9 11454.1 7443.3 8934.0 10570.8 10748.0 11364.8 10:09:54 INFO - PROCESS | 1936 | -------- Summary: end -------- 10:09:54 INFO - PROCESS | 1936 | 10:09:55 INFO - TEST-INFO | 1936: exit 0 10:09:55 INFO - TEST-OK | dromaeo_css | took 1116006ms 10:09:55 INFO - TEST-START | kraken 10:09:55 INFO - operating with platform_type : mac_ 10:09:55 INFO - Initialising browser for kraken test... 10:09:55 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpt7a2Nm/profile http://localhost:49433/getInfo.html) 10:09:56 ERROR - PROCESS | 1943 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 10:09:58 INFO - PROCESS | 1943 | __metrics Screen width/height:1600/1200 10:09:58 INFO - PROCESS | 1943 | colorDepth:24 10:09:58 INFO - PROCESS | 1943 | Browser inner width/height: 1024/689 10:09:58 INFO - PROCESS | 1943 | __metrics 10:09:58 ERROR - PROCESS | 1943 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 10:09:58 INFO - TEST-INFO | 1943: exit 0 10:09:58 INFO - Browser initialized. 10:09:58 INFO - Running cycle 1/1 for kraken test... 10:09:58 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpt7a2Nm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:10 INFO - PROCESS | 1945 | RSS: Main: 224047104 10:10:10 INFO - PROCESS | 1945 | 10:10:13 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49433/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:14 INFO - PROCESS | 1945 | RSS: Main: 236478464 10:10:14 INFO - PROCESS | 1945 | 10:10:17 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49433/tests/kraken/driver.html?testName=audio-dft) 10:10:18 INFO - PROCESS | 1945 | RSS: Main: 244109312 10:10:18 INFO - PROCESS | 1945 | 10:10:21 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49433/tests/kraken/driver.html?testName=audio-fft) 10:10:21 INFO - PROCESS | 1945 | RSS: Main: 247689216 10:10:21 INFO - PROCESS | 1945 | 10:10:23 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49433/tests/kraken/driver.html?testName=audio-oscillator) 10:10:24 INFO - PROCESS | 1945 | RSS: Main: 249032704 10:10:24 INFO - PROCESS | 1945 | 10:10:26 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49433/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:10:27 INFO - PROCESS | 1945 | RSS: Main: 249401344 10:10:27 INFO - PROCESS | 1945 | 10:10:30 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49433/tests/kraken/driver.html?testName=imaging-darkroom) 10:10:30 INFO - PROCESS | 1945 | RSS: Main: 252936192 10:10:30 INFO - PROCESS | 1945 | 10:10:33 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49433/tests/kraken/driver.html?testName=imaging-desaturate) 10:10:34 INFO - PROCESS | 1945 | RSS: Main: 253575168 10:10:34 INFO - PROCESS | 1945 | 10:10:37 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49433/tests/kraken/driver.html?testName=json-parse-financial) 10:10:38 INFO - PROCESS | 1945 | RSS: Main: 253038592 10:10:38 INFO - PROCESS | 1945 | 10:10:39 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49433/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:10:40 INFO - PROCESS | 1945 | RSS: Main: 251912192 10:10:40 INFO - PROCESS | 1945 | 10:10:42 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49433/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:10:43 INFO - PROCESS | 1945 | RSS: Main: 251965440 10:10:43 INFO - PROCESS | 1945 | 10:10:45 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49433/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:10:45 INFO - PROCESS | 1945 | RSS: Main: 251990016 10:10:45 INFO - PROCESS | 1945 | 10:10:48 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:10:49 INFO - PROCESS | 1945 | RSS: Main: 252301312 10:10:49 INFO - PROCESS | 1945 | 10:10:52 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:10:53 INFO - PROCESS | 1945 | RSS: Main: 251969536 10:10:53 INFO - PROCESS | 1945 | 10:10:54 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49433/tests/kraken/driver.html?testName=ai-astar) 10:10:55 INFO - PROCESS | 1945 | RSS: Main: 254046208 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | __start_tp_report 10:10:55 INFO - PROCESS | 1945 | _x_x_mozilla_page_load 10:10:55 INFO - PROCESS | 1945 | _x_x_mozilla_page_load_details 10:10:55 INFO - PROCESS | 1945 | |i|pagename|runs| 10:10:55 INFO - PROCESS | 1945 | |0;ai-astar;109;118;120;122;100;163;176;176;117;122 10:10:55 INFO - PROCESS | 1945 | |1;audio-beat-detection;140;140;145;171;115;118;116;110;148;121 10:10:55 INFO - PROCESS | 1945 | |2;audio-dft;201;198;194;197;195;199;196;195;201;243 10:10:55 INFO - PROCESS | 1945 | |3;audio-fft;67;82;83;84;60;62;58;59;81;59 10:10:55 INFO - PROCESS | 1945 | |4;audio-oscillator;88;72;89;71;68;68;84;69;72;88 10:10:55 INFO - PROCESS | 1945 | |5;imaging-gaussian-blur;134;131;89;86;91;86;91;74;135;131 10:10:55 INFO - PROCESS | 1945 | |6;imaging-darkroom;99;99;98;100;141;172;157;98;97;97 10:10:55 INFO - PROCESS | 1945 | |7;imaging-desaturate;92;137;82;103;99;106;81;75;122;133 10:10:55 INFO - PROCESS | 1945 | |8;json-parse-financial;56;56;55;57;59;59;61;59;60;60 10:10:55 INFO - PROCESS | 1945 | |9;json-stringify-tinderbox;69;88;69;87;122;112;105;73;71;71 10:10:55 INFO - PROCESS | 1945 | |10;stanford-crypto-aes;86;86;86;84;84;86;86;86;84;89 10:10:55 INFO - PROCESS | 1945 | |11;stanford-crypto-ccm;159;160;168;163;158;163;153;152;225;164 10:10:55 INFO - PROCESS | 1945 | |12;stanford-crypto-pbkdf2;169;170;168;170;171;169;167;163;172;169 10:10:55 INFO - PROCESS | 1945 | |13;stanford-crypto-sha256-iterative;67;67;65;68;69;69;66;66;67;66 10:10:55 INFO - PROCESS | 1945 | __end_tp_report 10:10:55 INFO - PROCESS | 1945 | __start_cc_report 10:10:55 INFO - PROCESS | 1945 | _x_x_mozilla_cycle_collect,1000 10:10:55 INFO - PROCESS | 1945 | __end_cc_report 10:10:55 INFO - PROCESS | 1945 | __startTimestamp1479147055049__endTimestamp 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | ------- Summary: start ------- 10:10:55 INFO - PROCESS | 1945 | Number of tests: 14 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#0] ai-astar Cycles:10 Average:132.30 Median:122.00 stddev:28.19 (23.1%) stddev-sans-first:28.61 10:10:55 INFO - PROCESS | 1945 | Values: 109.0 118.0 120.0 122.0 100.0 163.0 176.0 176.0 117.0 122.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:140.00 stddev:19.49 (13.9%) stddev-sans-first:20.48 10:10:55 INFO - PROCESS | 1945 | Values: 140.0 140.0 145.0 171.0 115.0 118.0 116.0 110.0 148.0 121.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#2] audio-dft Cycles:10 Average:201.90 Median:198.50 stddev:14.65 (7.4%) stddev-sans-first:15.53 10:10:55 INFO - PROCESS | 1945 | Values: 201.0 198.0 194.0 197.0 195.0 199.0 196.0 195.0 201.0 243.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#3] audio-fft Cycles:10 Average:69.50 Median:74.00 stddev:11.48 (15.5%) stddev-sans-first:12.14 10:10:55 INFO - PROCESS | 1945 | Values: 67.0 82.0 83.0 84.0 60.0 62.0 58.0 59.0 81.0 59.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:78.00 stddev:9.11 (11.7%) stddev-sans-first:8.73 10:10:55 INFO - PROCESS | 1945 | Values: 88.0 72.0 89.0 71.0 68.0 68.0 84.0 69.0 72.0 88.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#5] imaging-gaussian-blur Cycles:10 Average:104.80 Median:86.00 stddev:24.55 (28.5%) stddev-sans-first:23.65 10:10:55 INFO - PROCESS | 1945 | Values: 134.0 131.0 89.0 86.0 91.0 86.0 91.0 74.0 135.0 131.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#6] imaging-darkroom Cycles:10 Average:115.80 Median:97.50 stddev:29.15 (29.9%) stddev-sans-first:30.27 10:10:55 INFO - PROCESS | 1945 | Values: 99.0 99.0 98.0 100.0 141.0 172.0 157.0 98.0 97.0 97.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#7] imaging-desaturate Cycles:10 Average:103.00 Median:78.00 stddev:21.79 (27.9%) stddev-sans-first:22.74 10:10:55 INFO - PROCESS | 1945 | Values: 92.0 137.0 82.0 103.0 99.0 106.0 81.0 75.0 122.0 133.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:59.00 stddev:2.04 (3.5%) stddev-sans-first:2.01 10:10:55 INFO - PROCESS | 1945 | Values: 56.0 56.0 55.0 57.0 59.0 59.0 61.0 59.0 60.0 60.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#9] json-stringify-tinderbox Cycles:10 Average:86.70 Median:71.00 stddev:19.80 (27.9%) stddev-sans-first:19.94 10:10:55 INFO - PROCESS | 1945 | Values: 69.0 88.0 69.0 87.0 122.0 112.0 105.0 73.0 71.0 71.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:1.49 (1.7%) stddev-sans-first:1.58 10:10:55 INFO - PROCESS | 1945 | Values: 86.0 86.0 86.0 84.0 84.0 86.0 86.0 86.0 84.0 89.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#11] stanford-crypto-ccm Cycles:10 Average:166.50 Median:163.00 stddev:21.13 (13.0%) stddev-sans-first:22.24 10:10:55 INFO - PROCESS | 1945 | Values: 159.0 160.0 168.0 163.0 158.0 163.0 153.0 152.0 225.0 164.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.50 stddev:2.49 (1.5%) stddev-sans-first:2.64 10:10:55 INFO - PROCESS | 1945 | Values: 169.0 170.0 168.0 170.0 171.0 169.0 167.0 163.0 172.0 169.0 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - PROCESS | 1945 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.33 (2.0%) stddev-sans-first:1.41 10:10:55 INFO - PROCESS | 1945 | Values: 67.0 67.0 65.0 68.0 69.0 69.0 66.0 66.0 67.0 66.0 10:10:55 INFO - PROCESS | 1945 | -------- Summary: end -------- 10:10:55 INFO - PROCESS | 1945 | 10:10:55 INFO - TEST-INFO | 1945: exit 0 10:10:55 INFO - TEST-OK | kraken | took 60507ms 10:10:55 INFO - SUITE-END | took 1176s 10:10:56 INFO - Completed test suite (00:19:36) 10:10:56 INFO - javascript benchmark 10:10:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7012.049928281681, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3018.185090025693, 3361.008502491765, 3364.192593777494, 3376.25722341085, 3381.5265862779215, 5678.545716342693, 5683.65898046117, 5742.081266997281, 5783.942160578398, 5798.2172406725185, 4557.293619488976, 4782.067496838118, 4907.190313598252, 5415.13357862742, 5795.2466179396615, 5212.895742085156, 5216.478352164772, 5221.112410890158, 5273.499017593323, 5307.38965019022, 5237.3453318335205, 5276.314079169702, 5292.36491621006, 5306.0, 5328.040952628526, 4169.541350451448, 4310.482742070956, 4826.7586620669, 5150.484951504838, 5294.85070534869, 4360.672949528798, 4833.854984350458, 5215.530602245778, 5227.921581176285, 5250.159974404115, 4312.654987601016, 5065.518775716301, 5069.391672999227, 5190.584753219733, 5212.29633999409, 5723.198752174699, 5754.510866576346, 5773.9422605773825, 5785.768569257225, 5812.854678633025, 4455.933161002587, 5255.500727430888, 5797.724500609859, 6150.0, 6189.752409903598, 4935.5804756595735, 6177.011678131522, 6195.349488303708, 6268.592541484834, 6316.494680425555, 5819.621724587888, 5827.79602713903, 5835.5915085944, 5862.325832529228, 5897.882042359129, 6191.535634827316, 6294.716737746767, 6294.779682711129, 6300.59046161998, 6413.909635362, 6071.2714474263375, 6089.391060893964, 6106.175666284995, 6113.449789518964, 6129.969350153221, 5790.681512516852, 6147.907781383283, 6163.0, 6182.938170618326, 6211.689415529296, 6106.642687876592, 6199.5660303779205, 6202.534809889276, 6218.098375735583, 6251.9687401562705, 6174.567780255429, 6203.596766210182, 6279.466245369194, 6280.811575652738, 6294.244690637152, 4757.333973243749, 4760.143174228672, 4839.927401088987, 4861.076395484917, 4997.175466048134, 4360.127974405132, 4361.803718832597, 4388.319810429389, 4402.965303153756, 4407.647388208936, 5833.79581714638, 5851.180834683148, 5858.56060795442, 5877.177195192677, 5903.970480147572, 5133.640645154804, 6140.166841500592, 6183.96908015466, 6205.100260462208, 6293.527985401113, 5887.558433117533, 5907.940920590825, 5909.6158749681135, 5968.582199246011, 5970.641761494324, 5457.126859702508, 5459.836204913859, 5467.425920278393, 5475.315585551806, 5482.095454250004, 6211.9068213977735, 6232.407921247474, 6293.496520278275, 6339.080833279241, 6367.140436041261, 6209.96895015522, 6296.181496405438, 6296.937030629635, 6304.842378940563, 6317.96841015792, 6193.411625895713, 6282.371762823681, 6287.088372186099, 6330.430261276323, 6353.14232578596, 6138.6336396323695, 6181.3200547938795, 6199.225096862892, 6240.344763799736, 6267.749290028531, 4565.7488838112895, 5318.813841515528, 5823.505002074701, 6167.044108163242, 6300.558960872695, 5051.520105589963, 6131.509479241561, 6144.692765361625, 6146.5390095742105, 6168.475679567107, 6087.847803804941, 6143.784967526115, 6160.229971253593, 6165.106059621419, 6170.10533472635, 5043.067032598981, 5598.076317407582, 5798.913016304675, 5974.4324289192455, 5979.402059793986, 6148.1699970503405, 6155.692215389302, 6156.015037593964, 6171.59884607499, 6182.690865456799, 4454.777261136995, 5993.520518358434, 6006.3693312201585, 6014.849628759316, 6020.698965051817], "value": 5599.866989791795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.8053298147759, 525.3590619444277, 526.4735264735265, 527.3434573955426, 539.2073651731953, 37722.81138594307, 39550.60449395505, 39622.603773962284, 39708.60291397085, 41375.79312103435, 39817.00457488557, 40506.59493405065, 40713.79643101781, 40763.79618101913, 40768.796156019256, 9118.726438206864, 9268.119528644767, 9304.116108969638, 9304.72085837426, 9320.114589114024, 5190.403103643072, 5238.13570760824, 5263.421023687391, 5273.156294992802, 5288.127458969266, 5237.2144178373355, 5263.315768950031, 5275.736213189325, 5285.920711189336, 5304.469553044703, 5260.1583746600745, 5271.051210782058, 5272.156454967187, 5274.789008439677, 5281.524662780349, 9120.771980700469, 9178.908210917873, 9217.170454659046, 9217.539123043887, 9236.769080772967, 38783.8060809697, 38815.61184388148, 38829.611703883165, 38852.80573597114, 38923.026924326834, 3268.852901619433, 3348.7153591944716, 3348.916277093068, 3375.2405708715587, 3736.327461057009, 25802.096926607668, 29285.41429171426, 29929.0, 30557.847210763804, 30852.845735771178, 3013.89451369201, 3109.129443755752, 3118.70372314632, 3162.130414136108, 3202.1674364665123, 416038.0, 494962.0, 499596.5020174912, 500794.0, 501625.0, 60692.0, 61088.38911610916, 61441.0, 61442.385576143664, 61604.07593886095, 63207.0, 63732.68133659302, 63756.0, 64249.0, 64593.67703161548, 14843.851561484464, 14848.2575871206, 14917.776233356508, 14958.878084143733, 15072.397104115931, 12326.691832704075, 12359.196652217577, 12368.690782730504, 12394.690132746753, 12394.75210495803, 15881.52355429339, 17001.894876832965, 18193.49336052188, 19122.52193695169, 19338.90330548338, 3146.528020796899, 6413.583117097373, 6732.798016059526, 7632.1986191450205, 7759.650815713307, 839.8740188971703, 1014.4724743133677, 1033.245730616654, 1086.8261078227445, 1110.622388387952, 24856.627150592754, 29857.85071074674, 29886.701132988826, 30237.848810755804, 30257.848710756305, 779.9571023593757, 914.5290175559592, 948.4167237149242, 982.6266018912768, 1048.8688913885765, 14646.095749173806, 14681.632959176106, 15478.380864765508, 15778.0, 16121.952073115444, 670868.0, 677732.0, 678658.0, 679276.0, 680986.0, 57671.71164144152, 58331.541711457554, 58396.0, 58590.707046465344, 58758.0, 1314.1655049043734, 1337.1442276942764, 1361.6936189357514, 1363.1820907455447, 1367.589723083071, 24391.51216975686, 29964.22802897479, 30904.0728778137, 31273.37453250968, 31431.057068287988, 50896.49103508917, 51563.0, 51629.48370516247, 51646.70883227799, 51913.22130168126, 615352.0, 618699.0, 621582.0, 621671.0, 623150.0, 22907.19824806124, 25365.98536058537, 26395.0, 26695.0, 26800.865995669898, 42229.521966731016, 45197.0, 46127.76936115432, 46212.7689361551, 46633.533664664275, 30485.847570762005, 36113.0, 38293.0, 38629.806850965564, 39584.0, 37746.87134575738, 37869.24261514809, 38313.61686383212, 38397.424038638885, 38883.611163887996, 30677.846610767698, 36787.264254715294, 36905.63094369022, 37071.81464092662, 37876.0, 32199.839000804845, 34025.65974340225, 34095.31809363848, 34163.316733665684, 34211.31577368489, 21172.788272117083, 25193.622095668947, 25274.494510110064, 25354.60549669786, 25630.615540766532], "value": 18609.82392981595, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.4665095658427, 369.7596562234547, 378.73677793933194, 381.4316668164435, 401.29372304743663, 16351.182440877938, 18806.717899231506, 18992.715109273373, 19717.901410492963, 19925.900370498126, 11568.958793708565, 14074.0, 18262.0, 19795.406137815888, 19808.504787380287, 5235.1885457754015, 5483.479069488392, 5491.533219676332, 5503.229547863302, 5504.394516603171, 5207.297014902996, 5356.1697936819855, 5368.141097424413, 5424.972875135619, 5438.646487978269, 5411.756470958816, 5417.3770016448025, 5427.158790387496, 5440.4287549807095, 5459.290292262001, 5212.6611770235, 5403.189521571776, 5420.322459692538, 5448.318960129984, 5454.072807622713, 5303.840884773463, 5311.62818602698, 5316.76074576645, 5318.335208098988, 5321.201819727034, 10654.467276636136, 12788.360581970865, 12947.611571652771, 13106.344682765919, 13210.405531750997, 1909.5608010157603, 2076.909622448227, 2165.155589320166, 2410.5781488239486, 2927.975208676946, 9416.952915235448, 9951.55218015191, 10134.189264858793, 10285.9485702571, 10299.53652085658, 1774.698301288771, 1786.22299299805, 1825.6257467219189, 1835.4310163849116, 1843.8801477903894, 114055.0, 117605.0, 117818.82181178078, 117918.0, 118424.81575184224, 11303.03924166455, 11483.0, 11633.825492617618, 11657.242279251821, 11675.299482031105, 14604.488842890449, 14614.196219208046, 14617.707645847024, 14618.707625847423, 14661.853381466262, 7571.3500274903345, 7586.62066896653, 8406.285465735358, 8470.322374210049, 8535.914640853636, 8103.716369927024, 8148.429609927248, 8164.795880102926, 8261.710840120568, 8280.544570048585, 4400.22995975703, 4494.258447356215, 4506.3465797459185, 4612.123696497655, 4618.399608050999, 1919.5393105654543, 1929.8938558379423, 1946.1728765274702, 1995.5310502032012, 1999.4001799460104, 797.3820289275858, 943.1417410156862, 949.027247071757, 965.1120968708805, 995.2535598301274, 15634.3746250151, 16665.583360416087, 17962.640747185244, 18372.632547349247, 20559.794402055788, 894.1058941058941, 897.4570384917162, 901.5176880368971, 908.9368827052874, 911.2846415563884, 8066.798330041796, 8674.696385626472, 9389.530523473935, 10795.0, 11073.72315692098, 598148.0, 598957.0, 600769.0, 609918.0, 611973.0, 116993.41503292428, 119434.40282798531, 121888.0, 126265.0, 132323.0, 787.8857565653063, 967.5210770668424, 992.836182029957, 993.5345365585704, 993.7316924430363, 14192.290385480892, 14753.704925901207, 18732.812671873107, 18737.625247495245, 18886.96121713319, 38965.61034389733, 39424.605753942094, 39849.800750997216, 53382.46617533775, 56346.7182664084, 75101.62449187718, 75303.62348188224, 76055.23944760703, 78856.2114378849, 79110.60444697739, 7862.056553213651, 7897.131315555399, 7916.485428447132, 8142.7557173284895, 8238.423310368216, 11175.161862860155, 12029.759404811679, 12296.631101066982, 12367.75264494723, 12434.875651243372, 10427.843582346119, 10540.789184216426, 10554.841677374692, 10659.360438373722, 10937.671869843918, 9693.903060969582, 9953.203743700631, 10412.635557755442, 10582.523786429783, 10747.516361763583, 9879.259055570717, 10717.732056698333, 10755.677329680122, 10779.299345542515, 11013.063889569476, 7857.567833769198, 7917.604119794102, 7922.286994170552, 8116.310113640407, 8132.634031468479, 10410.791784164427, 10524.210684198868, 10727.302725322828, 10853.077488413574, 10981.83527247076], "value": 8960.226976862139, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.5787521618727, 1490.2474250503494, 1662.7672125902375, 1800.13593475132, 1817.100535235059, 7669.923300766991, 7892.329152022085, 8101.473404228728, 8570.957145214274, 8592.398532102756, 8125.796855078626, 8373.58132093396, 8403.327733781298, 8550.65797368106, 8562.914370856306, 2286.908523659056, 2325.2907863101746, 2329.301209637111, 2332.24202134307, 2337.0768546424238, 2307.3078076577044, 2338.7778161074757, 2353.4587044979667, 2355.611324131516, 2358.5636657218383, 2315.953680926389, 2321.2339927823778, 2336.8130549555995, 2343.261872510154, 2347.6149072047488, 2295.747467778543, 2298.1841446286494, 2329.2080692564523, 2331.4404542909665, 2333.953320933572, 2152.1821707750955, 2185.519185779126, 2185.9016344264546, 2188.2888061379954, 2194.0, 8243.05204901432, 8308.459950103224, 8317.168283171695, 8327.250547450758, 8327.83344333116, 5104.183330667112, 5232.502912223333, 5280.49835265653, 5281.551068159172, 5298.523132918017, 3245.1562593725566, 3288.3094550144497, 3585.0, 3587.7847329160336, 3597.3344931187553, 1019.7450637340664, 1025.3950169400016, 1067.2849191042021, 1076.5962763963514, 1077.983830242547, 10980.615678451215, 11074.723131921686, 11151.665450036511, 11172.944135279353, 11178.161637877192, 4576.931346029813, 4623.352730617717, 4697.530246975275, 4722.126406614787, 4815.398075240595, 9537.712408824858, 9579.0, 9614.615415383307, 9616.855747163798, 9629.855552166724, 3964.9691080319326, 4914.287428322873, 5221.843344699665, 5265.315508983884, 5437.293151890229, 4215.430916826251, 4342.5874541918465, 4477.350784136282, 4607.9308810367875, 4740.478547359788, 3818.1218319786603, 3880.6507414332846, 3936.5079365079364, 3959.287328280937, 3978.9403158952637, 1278.2905487454552, 1283.8716128387086, 1284.1203775413871, 1296.0, 1297.8455763432844, 811.7645882693953, 881.6076845803556, 896.3098414221143, 898.0749827677503, 898.1108702384593, 5578.24693666358, 5599.32808063035, 5675.574331925122, 5723.971380143073, 5761.049426844524, 818.6929901287017, 856.8357781183444, 904.7511934218011, 906.3338446242007, 939.1922946266205, 3471.8264086795557, 3665.376885929398, 3803.866864659779, 3946.1910308386714, 3966.861159859449, 9806.411615303105, 10293.073623373932, 10307.433091179908, 10351.430671312999, 10358.326708763907, 10229.539670714836, 10244.743881402876, 10252.6411575596, 10283.023112804272, 10340.017698318648, 7430.96284518574, 7756.340711039512, 7771.028621422322, 7861.4103942204565, 7886.64510097047, 4908.410990681141, 5010.273510340907, 5598.972005139948, 5723.170140329712, 5928.762849485972, 9321.161095501437, 9366.765830854283, 9406.0, 9467.810643786948, 9526.237900967768, 9602.759931001781, 9633.566489507848, 9656.082672146134, 9691.563879625293, 9733.318667693477, 6639.435647969976, 6873.48448866327, 7038.331358520933, 7139.500234983501, 7285.635718213962, 7857.017872765904, 8089.0, 8098.5545794981845, 8100.473469224482, 8127.0, 7083.7520686775715, 7192.172900116553, 7204.71181152748, 7259.9274007259255, 7341.74303899361, 7035.929640703527, 7106.218315985341, 7110.14678238594, 7212.278772122746, 7244.239354867874, 6649.800505984828, 6659.234188068434, 6728.192616886005, 6732.831679208059, 6752.155980502437, 4848.9757551212015, 4892.608591312757, 4894.339264199288, 4895.971845912399, 4944.554990050912, 4828.275758636232, 4829.6860704054125, 4863.221884498464, 4974.855783169964, 5001.299818025552], "value": 4439.100484447946, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.1545515711828, 270.73738473680527, 303.76761777240415, 311.27783542182135, 314.26775612822127, 4706.882327941803, 5137.972405518897, 5189.6107791915565, 5292.708901010443, 5480.588955828314, 4179.799301701785, 4851.63612729045, 4950.8860506386045, 5346.652467589604, 5357.919631205535, 3563.269529746409, 4062.8827072554986, 4099.754014759109, 4099.847580020491, 4139.4204811326435, 3574.8391322390553, 3591.5690117185845, 4001.1997600479876, 4090.3046482098116, 4152.68854835887, 3702.759320644163, 4029.97985010076, 4083.8162282697203, 4093.7339072960312, 4103.322951712964, 4048.1340319994333, 4048.967513284094, 4074.8166332515107, 4075.6331930126134, 4095.0376661484825, 3302.8513716882558, 3392.4741665041956, 3422.57217847769, 3549.7337699672626, 3562.5190599269026, 5176.844694659128, 5180.777666202033, 5192.1432963560965, 5197.402298735656, 5198.376194856603, 3857.537095548524, 4554.931676024862, 4570.520095389969, 4572.177008138534, 4583.495815460296, 4425.8229670813125, 5328.307320048408, 5527.447255274481, 5629.380768115504, 5630.211770352113, 3806.124591343979, 3810.9519882032387, 3832.291026160169, 3841.8079096045085, 3842.154725960312, 4978.954419571858, 5878.706064696748, 5884.617499862538, 5898.528117750569, 5912.0, 3401.3537427888623, 3425.1950791563963, 3863.5363756349416, 3870.3420418528917, 3903.980480097581, 3878.7478813877005, 3930.3121953657997, 3930.449737036817, 3942.3495123304906, 3955.64399204073, 4529.909401811945, 4579.221532339444, 4587.9541204588195, 4596.816127354935, 4608.815647374067, 5530.474604912527, 5729.338491837404, 5729.512991395694, 5730.914036289459, 5740.302058032718, 1215.197969340231, 1257.767313047071, 1261.703499677575, 1289.7420515896858, 1290.2129700882454, 848.4230723108345, 867.6616119713317, 877.8324827978773, 879.4855009819199, 881.5592203898051, 4401.559844015573, 5141.5886729061585, 5148.0, 5148.3564554430695, 5173.008391769121, 4780.641451891122, 4867.0, 5598.944010559923, 5611.959389239741, 5617.438256174431, 4363.738175709467, 4599.611805106282, 4889.584385327216, 5014.598832093424, 5175.741212939338, 2841.3606938438684, 2922.824630522133, 2936.265933516621, 2940.750181172993, 2958.65975412826, 4862.854114376574, 5336.46635336471, 5649.943500565024, 5886.793962211302, 5891.440313170242, 4728.361671174347, 4749.643776716691, 5272.883455191959, 5601.159826026129, 6067.696615169224, 6165.660888651168, 6169.722362493609, 6177.8455538611, 6194.938050619527, 6225.252969643671, 5245.973770131278, 5449.972750136224, 5650.180723795109, 5692.48767610917, 6014.609050411709, 4625.398698169217, 5566.192902029264, 5874.148248503858, 5876.6180198286975, 5904.911426328695, 5600.431879073866, 5682.977064128497, 6200.224971878515, 6202.503799695924, 6227.377262273918, 3378.915527111842, 3552.5026496290025, 3888.0, 3892.9805350973065, 3930.5479869815335, 5255.1884741663025, 5768.625039372428, 5783.595148339576, 5814.982378083903, 5892.204552385545, 5699.8860022800145, 5703.600747947769, 5713.571482138773, 5715.342735585461, 5732.684702341411, 4781.952180478151, 5516.400243929215, 5545.390007099135, 5603.915941260802, 5675.205471234113, 4817.566419022305, 4994.850154495371, 5509.311336082989, 5598.356189038313, 5689.288838895138, 4532.796024178986, 4752.0, 4963.671319068217, 5207.843764687065, 5450.656217826214, 4833.830815921426, 5139.066496163725, 5459.0, 5460.836174914759, 5544.390117087037], "value": 4064.0774135874476, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.6766352150964, 680.6086500262348, 737.2185483387609, 741.2093468092636, 781.3631890009642, 13692.11001284917, 14580.416783328654, 14608.634784130401, 14646.414143434276, 14656.926715366422, 11852.288862668225, 11874.821877671842, 11968.640940771791, 11980.34108124053, 12035.03719702424, 620.7175735040546, 650.0476801485822, 777.4635501503973, 794.972175973841, 809.5385630190793, 779.5050143159107, 805.7784109369941, 809.1867672988639, 809.3929552835374, 810.4205493072452, 848.5417874347845, 850.1795767084762, 858.120426562775, 858.6479543387212, 859.9871001934976, 712.8609921065395, 850.0479463001416, 854.2909385210261, 857.1128881607507, 859.0292968945115, 613.1875265273486, 629.9811005669792, 634.0679201573679, 635.4535099814157, 635.6821589205397, 13291.800622990662, 13295.734085318336, 13301.534446294334, 13325.533606323828, 13343.799843002364, 12801.743965120646, 13317.0, 13328.266945318004, 13352.86647133526, 13479.258640774753, 10935.890641093567, 11045.0, 11274.379909104997, 11281.37952412617, 11284.0, 3426.794392336468, 3564.6613571710905, 3582.301451217014, 3615.891523254307, 3708.6662200401825, 86736.6989495158, 87366.0, 87681.0, 89910.0, 90221.54889225577, 10039.598416063422, 10204.285700001077, 10410.427426491615, 10452.843207351896, 10516.158707303397, 19711.0, 19937.900310498353, 20000.399988000383, 20282.59434811325, 20308.492287692632, 7439.479236453504, 7474.887876681854, 7492.812679683051, 7587.544747315179, 7646.120696120018, 4122.3404255319, 4136.73111247768, 4233.280342341748, 4304.440422745023, 4308.698391112592, 3213.3091385352263, 3301.0, 3324.983375083109, 3326.7005969462866, 3330.0842268375904, 533.0, 601.4016054026184, 621.0652967284209, 621.6674079367517, 632.4782054804805, 556.6799090522966, 561.6770357044634, 581.2153592649889, 628.3308276685407, 682.7269092362995, 8854.0, 8943.747875297464, 9121.680741174026, 9161.954190229006, 9175.954120229357, 576.2105914896619, 660.9966950165218, 662.5329142954206, 665.4942243894675, 671.358852296056, 4122.361034039729, 4478.641708663299, 4491.146682130385, 4529.496661556225, 4617.653675974316, 104452.0, 105746.88506229833, 108359.0, 109560.0, 110859.0, 75204.24795751972, 87266.56366718125, 89671.55164224138, 91894.54052729828, 97946.53080203803, 48158.796030099526, 57026.0, 72494.63752681203, 80044.19955800367, 81309.59345203236, 6949.270326615632, 8790.95604521999, 8956.865647015169, 9365.57854896545, 9400.482973436254, 37804.86585402442, 38847.805760971016, 48580.78548036327, 51885.0, 53159.0, 71813.20466988366, 72579.0, 74668.62665686637, 74704.62647686944, 77461.61269193619, 12134.211276267015, 12336.198147120409, 12370.381480926098, 12570.43433045497, 12680.619581412573, 13511.527096551574, 14047.719045619235, 14436.927815360856, 14455.0, 14521.709565808413, 12237.388130593612, 12788.040896932582, 13051.543195988095, 13655.0, 13666.590002299947, 12451.315177665316, 12882.162659427107, 13531.391087400894, 13620.659483512594, 13962.79055814184, 12935.741285174056, 13017.088803784023, 13055.934720326337, 13480.662983425493, 13493.39279732434, 10444.268901177149, 10761.784764304513, 11037.392943388191, 11374.94312528432, 11454.14093942941, 7443.292887175709, 8934.0, 10570.788584228427, 10748.0, 11364.829527556927], "value": 7055.53708583296, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 120.0, 122.0, 100.0, 163.0, 176.0, 176.0, 117.0, 122.0], "value": 132.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 145.0, 171.0, 115.0, 118.0, 116.0, 110.0, 148.0, 121.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 198.0, 194.0, 197.0, 195.0, 199.0, 196.0, 195.0, 201.0, 243.0], "value": 201.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 82.0, 83.0, 84.0, 60.0, 62.0, 58.0, 59.0, 81.0, 59.0], "value": 69.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 89.0, 71.0, 68.0, 68.0, 84.0, 69.0, 72.0, 88.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 89.0, 86.0, 91.0, 86.0, 91.0, 74.0, 135.0, 131.0], "value": 104.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 98.0, 100.0, 141.0, 172.0, 157.0, 98.0, 97.0, 97.0], "value": 115.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 137.0, 82.0, 103.0, 99.0, 106.0, 81.0, 75.0, 122.0, 133.0], "value": 103.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 57.0, 59.0, 59.0, 61.0, 59.0, 60.0, 60.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 88.0, 69.0, 87.0, 122.0, 112.0, 105.0, 73.0, 71.0, 71.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 84.0, 84.0, 86.0, 86.0, 86.0, 84.0, 89.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 168.0, 163.0, 158.0, 163.0, 153.0, 152.0, 225.0, 164.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 168.0, 170.0, 171.0, 169.0, 167.0, 163.0, 172.0, 169.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 68.0, 69.0, 69.0, 66.0, 66.0, 67.0, 66.0], "value": 67.0, "unit": "score"}]}]} 10:10:56 INFO - Return code: 0 10:10:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:10:56 ERROR - # TBPL SUCCESS # 10:10:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:10:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:10:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:10:56 INFO - 2016-11-14 10:10:56.381 screenresolution[1950:17162] starting screenresolution argv=screenresolution get 10:10:56 INFO - 2016-11-14 10:10:56.383 screenresolution[1950:17162] Display 0: 1600x1200x32@60 10:10:56 INFO - 2016-11-14 10:10:56.389 screenresolution[1951:17165] starting screenresolution argv=screenresolution list 10:10:56 INFO - Available Modes on Display 0 10:10:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:10:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:10:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:10:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:10:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:10:56 INFO - Intel Iris: 10:10:56 INFO - Chipset Model: Intel Iris 10:10:56 INFO - Type: GPU 10:10:56 INFO - Bus: Built-In 10:10:56 INFO - VRAM (Dynamic, Max): 1536 MB 10:10:56 INFO - Vendor: Intel (0x8086) 10:10:56 INFO - Device ID: 0x0a2e 10:10:56 INFO - Revision ID: 0x0009 10:10:56 INFO - Displays: 10:10:56 INFO - Display: 10:10:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:10:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:10:56 INFO - Display Serial Number: 1600x1200 60 10:10:56 INFO - Main Display: Yes 10:10:56 INFO - Mirror: Off 10:10:56 INFO - Online: Yes 10:10:56 INFO - Rotation: Supported 10:10:56 INFO - Return code: 0 10:10:56 INFO - Running post-action listener: _resource_record_post_action 10:10:56 INFO - [mozharness: 2016-11-14 18:10:56.625482Z] Finished run-tests step (success) 10:10:56 INFO - Running post-run listener: _resource_record_post_run 10:10:56 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 1101824; Write bytes: 656211456; Read time: 14; Write time: 1798 10:10:56 INFO - TinderboxPrint: CPU usage
54.2% 10:10:56 INFO - TinderboxPrint: I/O read bytes / time
1,101,824 / 14 10:10:56 INFO - TinderboxPrint: I/O write bytes / time
656,211,456 / 1,798 10:10:56 INFO - TinderboxPrint: CPU idle
2,213.3 (45.8%) 10:10:56 INFO - TinderboxPrint: CPU system
979.0 (20.2%) 10:10:56 INFO - TinderboxPrint: CPU user
1,645.4 (34.0%) 10:10:56 INFO - TinderboxPrint: Swap in / out
355,033,088 / 0 10:10:56 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 353956352; Write bytes: 356836864; Read time: 27556; Write time: 685 10:10:56 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1085440; Write bytes: 297879552; Read time: 14; Write time: 1106 10:10:57 INFO - Running post-run listener: _upload_blobber_files 10:10:57 INFO - Blob upload gear active. 10:10:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:10:57 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 10:10:57 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'] 10:10:57 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 10:10:57 INFO - (blobuploader) - INFO - Open directory for files ... 10:10:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:10:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:10:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:58 INFO - (blobuploader) - INFO - Done attempting. 10:10:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:10:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:10:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:59 INFO - (blobuploader) - INFO - Done attempting. 10:10:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:10:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:02 INFO - (blobuploader) - INFO - Done attempting. 10:11:02 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:02 INFO - Return code: 0 10:11:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e319437bc96e2f2ae40c4f84132bdd1243242fe12b1a350423133f4f7a65c954fc710cf5e1f5438f5bd61b60a712bb5429d45e441bb64df54f9cf66db51430df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04d5038d66ea3c915e094b5da9f52e2f13a085e5c5cef3938849010dd309785fafdc81956295ba8af51198ffed29c8d264c5f0dec0f8a0e35d091b88f6281fc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/374403ed712e00333d95e5ded04c803c493001dcb0b375c0a9178506a0ac5f7892e2ad9961fe5e5a036d94d9a4cccf31633fefa539ce82f29a64b11d5f8c26ca"} 10:11:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:02 INFO - Contents: 10:11:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e319437bc96e2f2ae40c4f84132bdd1243242fe12b1a350423133f4f7a65c954fc710cf5e1f5438f5bd61b60a712bb5429d45e441bb64df54f9cf66db51430df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04d5038d66ea3c915e094b5da9f52e2f13a085e5c5cef3938849010dd309785fafdc81956295ba8af51198ffed29c8d264c5f0dec0f8a0e35d091b88f6281fc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/374403ed712e00333d95e5ded04c803c493001dcb0b375c0a9178506a0ac5f7892e2ad9961fe5e5a036d94d9a4cccf31633fefa539ce82f29a64b11d5f8c26ca"} 10:11:02 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:02 INFO - Copying logs to upload dir... 10:11:02 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.490072 ========= master_lag: 0.81 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-14 10:11:02.867478) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-11-14 10:11:02.872215) ========= 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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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/e319437bc96e2f2ae40c4f84132bdd1243242fe12b1a350423133f4f7a65c954fc710cf5e1f5438f5bd61b60a712bb5429d45e441bb64df54f9cf66db51430df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04d5038d66ea3c915e094b5da9f52e2f13a085e5c5cef3938849010dd309785fafdc81956295ba8af51198ffed29c8d264c5f0dec0f8a0e35d091b88f6281fc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/374403ed712e00333d95e5ded04c803c493001dcb0b375c0a9178506a0ac5f7892e2ad9961fe5e5a036d94d9a4cccf31633fefa539ce82f29a64b11d5f8c26ca"} build_url:https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011006 build_url: 'https://queue.taskcluster.net/v1/task/TxAWwqggTYi-RWuF_fdlGw/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/e319437bc96e2f2ae40c4f84132bdd1243242fe12b1a350423133f4f7a65c954fc710cf5e1f5438f5bd61b60a712bb5429d45e441bb64df54f9cf66db51430df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04d5038d66ea3c915e094b5da9f52e2f13a085e5c5cef3938849010dd309785fafdc81956295ba8af51198ffed29c8d264c5f0dec0f8a0e35d091b88f6281fc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/374403ed712e00333d95e5ded04c803c493001dcb0b375c0a9178506a0ac5f7892e2ad9961fe5e5a036d94d9a4cccf31633fefa539ce82f29a64b11d5f8c26ca"}' ========= master_lag: 5.58 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-11-14 10:11:08.461305) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:11:08.461632) ========= 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.mMvOdcBcjG/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.Q9D1cyzG1N/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005262 ========= master_lag: 0.23 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:11:08.695540) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 10:11:08.695884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 10:11:08.701897) ========= ========= Total master_lag: 6.70 =========