builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0171 starttime: 1485480638.89 results: success (0) buildid: 20170126161921 builduid: e4160d91676c4646b772a43cd1ceb287 revision: 1e0e193b0812f68a12fbd69198552af62347af1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:38.894849) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:38.895274) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:38.895558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:38.924195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:38.924498) ========= 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.qJRDQCidfd/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.Cxo71kaH4g/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 --2017-01-26 17:30:38-- 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% 27.3M=0s 2017-01-26 17:30:39 (27.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137946 ========= master_lag: 0.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:39.615371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:39.615707) ========= 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.qJRDQCidfd/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.Cxo71kaH4g/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.029086 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:39.666367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-26 17:30:39.666727) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1e0e193b0812f68a12fbd69198552af62347af1e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1e0e193b0812f68a12fbd69198552af62347af1e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qJRDQCidfd/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.Cxo71kaH4g/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 2017-01-26 17:30:39,736 truncating revision to first 12 chars 2017-01-26 17:30:39,737 Setting DEBUG logging. 2017-01-26 17:30:39,737 attempt 1/10 2017-01-26 17:30:39,737 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1e0e193b0812?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-26 17:30:42,131 unpacking tar archive at: mozilla-central-1e0e193b0812/testing/mozharness/ program finished with exit code 0 elapsedTime=2.669556 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-26 17:30:42.365706) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:42.366054) ========= script_repo_revision: 1e0e193b0812f68a12fbd69198552af62347af1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:42.366483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:42.366778) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 17:30:42.386490) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-26 17:30:42.386908) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qJRDQCidfd/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.Cxo71kaH4g/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:30:42 INFO - MultiFileLogger online at 20170126 17:30:42 in /builds/slave/test 17:30:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:30:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:30:42 INFO - {'append_to_log': False, 17:30:42 INFO - 'base_work_dir': '/builds/slave/test', 17:30:42 INFO - 'blob_upload_branch': 'Firefox', 17:30:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:30:42 INFO - 'branch': 'Firefox', 17:30:42 INFO - 'buildbot_json_path': 'buildprops.json', 17:30:42 INFO - 'config_files': ('talos/mac_config.py',), 17:30:42 INFO - 'default_actions': ('clobber', 17:30:42 INFO - 'read-buildbot-config', 17:30:42 INFO - 'download-and-extract', 17:30:42 INFO - 'populate-webroot', 17:30:42 INFO - 'create-virtualenv', 17:30:42 INFO - 'install', 17:30:42 INFO - 'run-tests'), 17:30:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:30:42 INFO - 'download_minidump_stackwalk': True, 17:30:42 INFO - 'download_symbols': 'ondemand', 17:30:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:30:42 INFO - 'tooltool.py': '/tools/tooltool.py', 17:30:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:30:42 INFO - '/tools/misc-python/virtualenv.py')}, 17:30:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:30:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:30:42 INFO - 'installer_path': 'installer.exe', 17:30:42 INFO - 'log_level': 'info', 17:30:42 INFO - 'log_name': 'talos', 17:30:42 INFO - 'log_to_console': True, 17:30:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:30:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:30:42 INFO - 'opt_config_files': (), 17:30:42 INFO - 'pip_index': False, 17:30:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:30:42 INFO - 'cmd': ('bash', 17:30:42 INFO - '-c', 17:30:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:30:42 INFO - 'enabled': True, 17:30:42 INFO - 'halt_on_failure': False, 17:30:42 INFO - 'name': 'check_screen_resolution'},), 17:30:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:30:42 INFO - 'cmd': ('bash', 17:30:42 INFO - '-c', 17:30:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:30:42 INFO - 'enabled': True, 17:30:42 INFO - 'halt_on_failure': False, 17:30:42 INFO - 'name': 'check_screen_resolution'},), 17:30:42 INFO - 'run_cmd_checks_enabled': True, 17:30:42 INFO - 'sps_profile': False, 17:30:42 INFO - 'sps_profile_interval': 0, 17:30:42 INFO - 'suite': 'dromaeojs-e10s', 17:30:42 INFO - 'system_bits': '32', 17:30:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:30:42 INFO - 'title': 't-yosemite-r7-0171', 17:30:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:30:42 INFO - 'use_talos_json': True, 17:30:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:30:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:30:42 INFO - 'work_dir': 'build'} 17:30:42 INFO - [mozharness: 2017-01-27 01:30:42.565072Z] Running clobber step. 17:30:42 INFO - Running pre-action listener: _resource_record_pre_action 17:30:42 INFO - Running main action method: clobber 17:30:42 INFO - rmtree: /builds/slave/test/build 17:30:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:30:45 INFO - Running post-action listener: _resource_record_post_action 17:30:45 INFO - [mozharness: 2017-01-27 01:30:45.194166Z] Finished clobber step (success) 17:30:45 INFO - [mozharness: 2017-01-27 01:30:45.194406Z] Running read-buildbot-config step. 17:30:45 INFO - Running pre-action listener: _resource_record_pre_action 17:30:45 INFO - Running main action method: read_buildbot_config 17:30:45 INFO - Using buildbot properties: 17:30:45 INFO - { 17:30:45 INFO - "project": "", 17:30:45 INFO - "product": "firefox", 17:30:45 INFO - "script_repo_revision": "production", 17:30:45 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:30:45 INFO - "repository": "", 17:30:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:30:45 INFO - "buildid": "20170126161921", 17:30:45 INFO - "pgo_build": "False", 17:30:45 INFO - "basedir": "/builds/slave/test", 17:30:45 INFO - "buildnumber": 25, 17:30:45 INFO - "slavename": "t-yosemite-r7-0171", 17:30:45 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 17:30:45 INFO - "platform": "yosemite_r7", 17:30:45 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:30:45 INFO - "branch": "mozilla-central", 17:30:45 INFO - "repo_path": "mozilla-central", 17:30:45 INFO - "revision": "1e0e193b0812f68a12fbd69198552af62347af1e", 17:30:45 INFO - "stage_platform": "macosx64", 17:30:45 INFO - "builduid": "e4160d91676c4646b772a43cd1ceb287", 17:30:45 INFO - "slavebuilddir": "test" 17:30:45 INFO - } 17:30:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 17:30:45 INFO - Running post-action listener: _resource_record_post_action 17:30:45 INFO - [mozharness: 2017-01-27 01:30:45.198297Z] Finished read-buildbot-config step (success) 17:30:45 INFO - [mozharness: 2017-01-27 01:30:45.198394Z] Running download-and-extract step. 17:30:45 INFO - Running pre-action listener: _resource_record_pre_action 17:30:45 INFO - Running main action method: download_and_extract 17:30:45 INFO - mkdir: /builds/slave/test/build/tests 17:30: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')]} 17:30:45 INFO - trying https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 17:30:45 INFO - Downloading https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 17:30:46 INFO - Downloaded 1199 bytes. 17:30:46 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:30:46 INFO - Using the following test package requirements: 17:30:46 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:30:46 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 17:30:46 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 17:30:46 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:30:46 INFO - u'jsshell-mac.zip'], 17:30:46 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 17:30:46 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:30:46 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 17:30:46 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 17:30:46 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 17:30:46 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 17:30:46 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:30:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:30:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:30:46 INFO - Fetch https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:30:47 INFO - Expected file size: 16363194 17:30:47 INFO - Obtained file size: 16363194 17:30:54 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:30:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:30:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:30:54 INFO - Fetch https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:30:54 INFO - Expected file size: 16363194 17:30:54 INFO - Obtained file size: 16363194 17:31:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 17:31:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:31:01 INFO - Fetch https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 17:31:02 INFO - Expected file size: 14403438 17:31:02 INFO - Obtained file size: 14403438 17:31:02 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')]} 17:31:02 INFO - trying https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:31:02 INFO - Downloading https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 17:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 17:31:04 INFO - Downloaded 70121256 bytes. 17:31:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:31:04 INFO - mkdir: /builds/slave/test/properties 17:31:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:31:04 INFO - Writing to file /builds/slave/test/properties/build_url 17:31:04 INFO - Contents: 17:31:04 INFO - build_url:https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:31:05 INFO - Running post-action listener: _resource_record_post_action 17:31:05 INFO - Running post-action listener: set_extra_try_arguments 17:31:05 INFO - [mozharness: 2017-01-27 01:31:05.478493Z] Finished download-and-extract step (success) 17:31:05 INFO - [mozharness: 2017-01-27 01:31:05.478616Z] Running populate-webroot step. 17:31:05 INFO - Running pre-action listener: _resource_record_pre_action 17:31:05 INFO - Running main action method: populate_webroot 17:31:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:31:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:31:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:31:05 INFO - '--tppagecycles', 17:31:05 INFO - '7'], 17:31:05 INFO - 'tests': ['tsvgm']}}, 17:31:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:31:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:31:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:31:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:31:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:31:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:31:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:31:05 INFO - 'talos_options': ['--disable-e10s'], 17:31:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:31:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:31:05 INFO - 'talos_options': ['--disable-e10s'], 17:31:05 INFO - 'tests': ['damp', 'tps']}, 17:31:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:31:05 INFO - 'tests': ['damp', 'tps']}, 17:31:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:31:05 INFO - 'tests': ['dromaeo_dom']}, 17:31:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:31:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:31:05 INFO - 'tests': ['basic_compositor_video']}, 17:31:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:31:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:31:05 INFO - 'tests': ['a11yr', 17:31:05 INFO - 'ts_paint', 17:31:05 INFO - 'tpaint', 17:31:05 INFO - 'sessionrestore', 17:31:05 INFO - 'sessionrestore_no_auto_restore', 17:31:05 INFO - 'tabpaint']}, 17:31:05 INFO - 'other-e10s': {'tests': ['a11yr', 17:31:05 INFO - 'ts_paint', 17:31:05 INFO - 'tpaint', 17:31:05 INFO - 'sessionrestore', 17:31:05 INFO - 'sessionrestore_no_auto_restore', 17:31:05 INFO - 'tabpaint']}, 17:31:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:31:05 INFO - 'ts_paint', 17:31:05 INFO - 'tpaint', 17:31:05 INFO - 'sessionrestore', 17:31:05 INFO - 'sessionrestore_no_auto_restore', 17:31:05 INFO - 'tabpaint']}, 17:31:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:31:05 INFO - 'ts_paint', 17:31:05 INFO - 'tpaint', 17:31:05 INFO - 'sessionrestore', 17:31:05 INFO - 'sessionrestore_no_auto_restore', 17:31:05 INFO - 'tabpaint']}, 17:31:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:31:05 INFO - 'tests': ['a11yr', 17:31:05 INFO - 'ts_paint', 17:31:05 INFO - 'tpaint', 17:31:05 INFO - 'sessionrestore', 17:31:05 INFO - 'sessionrestore_no_auto_restore', 17:31:05 INFO - 'tabpaint']}, 17:31:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:31:05 INFO - 'tests': ['a11yr', 17:31:05 INFO - 'ts_paint', 17:31:05 INFO - 'tpaint', 17:31:05 INFO - 'sessionrestore', 17:31:05 INFO - 'sessionrestore_no_auto_restore', 17:31:05 INFO - 'tabpaint']}, 17:31:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:31:05 INFO - 'tests': ['tsvgx', 17:31:05 INFO - 'tsvgr_opacity', 17:31:05 INFO - 'tart', 17:31:05 INFO - 'tscrollx', 17:31:05 INFO - 'cart', 17:31:05 INFO - 'tsvg_static']}, 17:31:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:31:05 INFO - 'tsvgr_opacity', 17:31:05 INFO - 'tart', 17:31:05 INFO - 'tscrollx', 17:31:05 INFO - 'cart', 17:31:05 INFO - 'tsvg_static']}, 17:31:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:31:05 INFO - 'talos_options': ['--disable-e10s'], 17:31:05 INFO - 'tests': ['tp5o']}, 17:31:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:31:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:31:05 INFO - 'talos_options': ['--disable-e10s', 17:31:05 INFO - '--xperf_path', 17:31:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:05 INFO - 'tests': ['tp5n']}, 17:31:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:31:05 INFO - 'talos_options': ['--xperf_path', 17:31:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:05 INFO - 'tests': ['tp5n']}}, 17:31:05 INFO - 'talos.zip': {'path': '', 17:31:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:31:05 INFO - Running post-action listener: _resource_record_post_action 17:31:05 INFO - [mozharness: 2017-01-27 01:31:05.496758Z] Finished populate-webroot step (success) 17:31:05 INFO - [mozharness: 2017-01-27 01:31:05.496888Z] Running create-virtualenv step. 17:31:05 INFO - Running pre-action listener: _resource_record_pre_action 17:31:05 INFO - Running main action method: create_virtualenv 17:31:05 INFO - Creating virtualenv /builds/slave/test/build/venv 17:31:05 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 17:31:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:31:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:31:05 INFO - Using real prefix '/tools/python27' 17:31:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:31:06 INFO - Installing distribute.............................................................................................................................................................................................done. 17:31:09 INFO - Installing pip.................done. 17:31:09 INFO - Return code: 0 17:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:31:09 INFO - Reading from file tmpfile_stdout 17:31:09 INFO - Output received: 17:31:09 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) 17:31:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ecb7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00c72420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea95d30>, '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 0x10e9bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8abe8>, '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.qJRDQCidfd/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.Cxo71kaH4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:31:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJRDQCidfd/Render', 17:31:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:09 INFO - 'HOME': '/Users/cltbld', 17:31:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:09 INFO - 'LOGNAME': 'cltbld', 17:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:09 INFO - 'MOZ_NO_REMOTE': '1', 17:31:09 INFO - 'NO_EM_RESTART': '1', 17:31:09 INFO - 'PAGER': '/bin/cat', 17:31:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:09 INFO - 'PWD': '/builds/slave/test', 17:31:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:09 INFO - 'SHELL': '/bin/bash', 17:31:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cxo71kaH4g/Listeners', 17:31:09 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:31:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:09 INFO - 'USER': 'cltbld', 17:31:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:09 INFO - 'XPC_FLAGS': '0x0', 17:31:09 INFO - 'XPC_SERVICE_NAME': '0', 17:31:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:09 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 17:31:09 INFO - Cleaning up... 17:31:09 INFO - Return code: 0 17:31:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ecb7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00c72420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea95d30>, '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 0x10e9bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8abe8>, '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.qJRDQCidfd/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.Cxo71kaH4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:31:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJRDQCidfd/Render', 17:31:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:09 INFO - 'HOME': '/Users/cltbld', 17:31:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:09 INFO - 'LOGNAME': 'cltbld', 17:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:09 INFO - 'MOZ_NO_REMOTE': '1', 17:31:09 INFO - 'NO_EM_RESTART': '1', 17:31:09 INFO - 'PAGER': '/bin/cat', 17:31:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:09 INFO - 'PWD': '/builds/slave/test', 17:31:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:09 INFO - 'SHELL': '/bin/bash', 17:31:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cxo71kaH4g/Listeners', 17:31:09 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:31:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:09 INFO - 'USER': 'cltbld', 17:31:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:09 INFO - 'XPC_FLAGS': '0x0', 17:31:09 INFO - 'XPC_SERVICE_NAME': '0', 17:31:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:09 INFO - Downloading/unpacking psutil>=3.1.1 17:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:31:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:31:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:31:13 INFO - Installing collected packages: psutil 17:31:13 INFO - Running setup.py install for psutil 17:31:13 INFO - building 'psutil._psutil_osx' extension 17:31:13 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 17:31:14 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 17:31:14 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 17:31:14 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 17:31:14 INFO - building 'psutil._psutil_posix' extension 17:31:14 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 17:31:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:31:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:31:14 INFO - ^ 17:31:14 INFO - 1 warning generated. 17:31:14 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 17:31:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:31:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:31:14 INFO - Successfully installed psutil 17:31:14 INFO - Cleaning up... 17:31:14 INFO - Return code: 0 17:31:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ecb7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00c72420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea95d30>, '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 0x10e9bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8abe8>, '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.qJRDQCidfd/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.Cxo71kaH4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:31:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJRDQCidfd/Render', 17:31:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:14 INFO - 'HOME': '/Users/cltbld', 17:31:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:14 INFO - 'LOGNAME': 'cltbld', 17:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:14 INFO - 'MOZ_NO_REMOTE': '1', 17:31:14 INFO - 'NO_EM_RESTART': '1', 17:31:14 INFO - 'PAGER': '/bin/cat', 17:31:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:14 INFO - 'PWD': '/builds/slave/test', 17:31:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:14 INFO - 'SHELL': '/bin/bash', 17:31:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cxo71kaH4g/Listeners', 17:31:14 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:31:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:14 INFO - 'USER': 'cltbld', 17:31:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:14 INFO - 'XPC_FLAGS': '0x0', 17:31:14 INFO - 'XPC_SERVICE_NAME': '0', 17:31:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:31:15 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 17:31:15 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 17:31:15 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 17:31:15 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 17:31:15 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 17:31:15 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 17:31:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:31:17 INFO - Installing collected packages: mozsystemmonitor 17:31:17 INFO - Running setup.py install for mozsystemmonitor 17:31:18 INFO - Successfully installed mozsystemmonitor 17:31:18 INFO - Cleaning up... 17:31:18 INFO - Return code: 0 17:31:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:31: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')]} 17:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31: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')]} 17:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31: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', '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 0x10ecb7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00c72420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea95d30>, '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 0x10e9bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8abe8>, '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.qJRDQCidfd/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.Cxo71kaH4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:31: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:31: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 jsonschema==2.5.1 17:31:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJRDQCidfd/Render', 17:31:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:18 INFO - 'HOME': '/Users/cltbld', 17:31:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:18 INFO - 'LOGNAME': 'cltbld', 17:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:18 INFO - 'MOZ_NO_REMOTE': '1', 17:31:18 INFO - 'NO_EM_RESTART': '1', 17:31:18 INFO - 'PAGER': '/bin/cat', 17:31:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:18 INFO - 'PWD': '/builds/slave/test', 17:31:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:18 INFO - 'SHELL': '/bin/bash', 17:31:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cxo71kaH4g/Listeners', 17:31:18 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:31:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:18 INFO - 'USER': 'cltbld', 17:31:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:18 INFO - 'XPC_FLAGS': '0x0', 17:31:18 INFO - 'XPC_SERVICE_NAME': '0', 17:31:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:18 INFO - Downloading/unpacking jsonschema==2.5.1 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:31:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:31:20 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 17:31:20 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 17:31:20 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 17:31:20 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 17:31:20 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 17:31:20 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 17:31:21 INFO - Downloading functools32-3.2.3-2.tar.gz 17:31:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:31:21 INFO - warning: no files found matching '*.txt' 17:31:21 INFO - no previously-included directories found matching 'build' 17:31:21 INFO - no previously-included directories found matching 'dist' 17:31:21 INFO - no previously-included directories found matching '.git*' 17:31:21 INFO - Installing collected packages: jsonschema, functools32 17:31:21 INFO - Running setup.py install for functools32 17:31:21 INFO - warning: no files found matching '*.txt' 17:31:21 INFO - no previously-included directories found matching 'build' 17:31:21 INFO - no previously-included directories found matching 'dist' 17:31:21 INFO - no previously-included directories found matching '.git*' 17:31:21 INFO - Successfully installed jsonschema functools32 17:31:21 INFO - Cleaning up... 17:31:21 INFO - Return code: 0 17:31:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ecb7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00c72420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea95d30>, '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 0x10e9bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8abe8>, '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.qJRDQCidfd/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.Cxo71kaH4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:31:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJRDQCidfd/Render', 17:31:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:21 INFO - 'HOME': '/Users/cltbld', 17:31:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:21 INFO - 'LOGNAME': 'cltbld', 17:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:21 INFO - 'MOZ_NO_REMOTE': '1', 17:31:21 INFO - 'NO_EM_RESTART': '1', 17:31:21 INFO - 'PAGER': '/bin/cat', 17:31:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:21 INFO - 'PWD': '/builds/slave/test', 17:31:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:21 INFO - 'SHELL': '/bin/bash', 17:31:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cxo71kaH4g/Listeners', 17:31:21 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:31:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:21 INFO - 'USER': 'cltbld', 17:31:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:21 INFO - 'XPC_FLAGS': '0x0', 17:31:21 INFO - 'XPC_SERVICE_NAME': '0', 17:31:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:31:22 INFO - Cleaning up... 17:31:22 INFO - Return code: 0 17:31:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:31:22 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')]} 17:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:22 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')]} 17:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:22 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 0x10ecb7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00c72420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea95d30>, '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 0x10e9bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8abe8>, '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.qJRDQCidfd/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.Cxo71kaH4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:31:22 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 17:31:22 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 17:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJRDQCidfd/Render', 17:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:22 INFO - 'HOME': '/Users/cltbld', 17:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:22 INFO - 'LOGNAME': 'cltbld', 17:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:22 INFO - 'MOZ_NO_REMOTE': '1', 17:31:22 INFO - 'NO_EM_RESTART': '1', 17:31:22 INFO - 'PAGER': '/bin/cat', 17:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:22 INFO - 'PWD': '/builds/slave/test', 17:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:22 INFO - 'SHELL': '/bin/bash', 17:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cxo71kaH4g/Listeners', 17:31:22 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:22 INFO - 'USER': 'cltbld', 17:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:22 INFO - 'XPC_FLAGS': '0x0', 17:31:22 INFO - 'XPC_SERVICE_NAME': '0', 17:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:22 INFO - Downloading/unpacking blobuploader==1.2.4 17:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:25 INFO - Downloading blobuploader-1.2.4.tar.gz 17:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:31:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:31:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:26 INFO - Downloading docopt-0.6.1.tar.gz 17:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:31:26 INFO - Installing collected packages: blobuploader, requests, docopt 17:31:26 INFO - Running setup.py install for blobuploader 17:31:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:31:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:31:26 INFO - Running setup.py install for requests 17:31:27 INFO - Running setup.py install for docopt 17:31:27 INFO - Successfully installed blobuploader requests docopt 17:31:27 INFO - Cleaning up... 17:31:27 INFO - Return code: 0 17:31:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:28 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 0x10ecb7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00c72420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea95d30>, '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 0x10e9bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8abe8>, '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.qJRDQCidfd/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.Cxo71kaH4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:31:28 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 17:31:28 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 17:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJRDQCidfd/Render', 17:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:28 INFO - 'HOME': '/Users/cltbld', 17:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:28 INFO - 'LOGNAME': 'cltbld', 17:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:28 INFO - 'MOZ_NO_REMOTE': '1', 17:31:28 INFO - 'NO_EM_RESTART': '1', 17:31:28 INFO - 'PAGER': '/bin/cat', 17:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:28 INFO - 'PWD': '/builds/slave/test', 17:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:28 INFO - 'SHELL': '/bin/bash', 17:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cxo71kaH4g/Listeners', 17:31:28 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:28 INFO - 'USER': 'cltbld', 17:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:28 INFO - 'XPC_FLAGS': '0x0', 17:31:28 INFO - 'XPC_SERVICE_NAME': '0', 17:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:31:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-13aGDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:31:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-LxpNlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:31:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-RU_DwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:31:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-S7PHDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:31:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-ECrk2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:31:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-K_ainh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:31:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-5gj4l2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:31:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-YwRBmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:31:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-1l6I35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:31:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-BXIbWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:31:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-9xKiDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:31:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-bFFU3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:31:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-VLWVjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:31:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-r4fJ7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-vOgxrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:31:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-eSU8j6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:31:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-zQ0fZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:31:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:31:30 INFO - Running setup.py install for manifestparser 17:31:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:31:30 INFO - Running setup.py install for mozcrash 17:31:30 INFO - Running setup.py install for mozdebug 17:31:30 INFO - Running setup.py install for mozdevice 17:31:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:31:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:31:30 INFO - Running setup.py install for mozfile 17:31:30 INFO - Running setup.py install for mozhttpd 17:31:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:31:30 INFO - Running setup.py install for mozinfo 17:31:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:31:31 INFO - Running setup.py install for mozInstall 17:31:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:31:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:31:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:31:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:31:31 INFO - Running setup.py install for mozleak 17:31:31 INFO - Running setup.py install for mozlog 17:31:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:31:31 INFO - Running setup.py install for moznetwork 17:31:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:31:31 INFO - Running setup.py install for mozprocess 17:31:31 INFO - Running setup.py install for mozprofile 17:31:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:31:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:31:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:31:32 INFO - Running setup.py install for mozrunner 17:31:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:31:32 INFO - Running setup.py install for mozscreenshot 17:31:32 INFO - Running setup.py install for moztest 17:31:32 INFO - Running setup.py install for mozversion 17:31:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:31:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:31:32 INFO - Cleaning up... 17:31:32 INFO - Return code: 0 17:31:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:32 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')]} 17:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:32 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')]} 17:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:33 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 0x10ecb7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00c72420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea95d30>, '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 0x10e9bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8abe8>, '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.qJRDQCidfd/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.Cxo71kaH4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:31:33 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 17:31:33 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 17:31:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJRDQCidfd/Render', 17:31:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:33 INFO - 'HOME': '/Users/cltbld', 17:31:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:33 INFO - 'LOGNAME': 'cltbld', 17:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:33 INFO - 'MOZ_NO_REMOTE': '1', 17:31:33 INFO - 'NO_EM_RESTART': '1', 17:31:33 INFO - 'PAGER': '/bin/cat', 17:31:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:33 INFO - 'PWD': '/builds/slave/test', 17:31:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:33 INFO - 'SHELL': '/bin/bash', 17:31:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cxo71kaH4g/Listeners', 17:31:33 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:31:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:33 INFO - 'USER': 'cltbld', 17:31:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:33 INFO - 'XPC_FLAGS': '0x0', 17:31:33 INFO - 'XPC_SERVICE_NAME': '0', 17:31:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:31:33 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Nojdnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:31:33 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)) 17:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:31:33 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-H_LTeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:31:33 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)) 17:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:31:33 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-V1eEmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:31:33 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)) 17:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:31:33 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-ec84jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 17:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:31:33 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-0Wtvm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:31:33 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)) 17:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:31:33 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-igCb87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:31:33 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)) 17:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:31:33 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-8MxM1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:31:34 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)) 17:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:31:34 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-UOv2YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:31:34 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)) 17:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:31:34 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-mL9xDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:31:34 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)) 17:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:31:34 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-tw303e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:31:34 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)) 17:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:31:34 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-SxQdQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:31:34 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)) 17:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:31:34 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-0DQOrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 17:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:31:34 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-HJNJrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:31:34 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)) 17:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:31:34 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-1Nu3mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:31:34 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)) 17:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:34 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-dZoj5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:34 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)) 17:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:31:34 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-lKaWlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 17:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:31:35 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-YPv5ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:31:35 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)) 17:31:35 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)) 17:31:35 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)) 17:31:35 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)) 17:31:35 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:31:35 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:31:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:31:35 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 17:31:35 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 17:31:35 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 17:31:35 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 17:31:35 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 17:31:35 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 17:31:38 INFO - Downloading blessings-1.6.tar.gz 17:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:31:38 INFO - Installing collected packages: blessings 17:31:38 INFO - Running setup.py install for blessings 17:31:38 INFO - Successfully installed blessings 17:31:38 INFO - Cleaning up... 17:31:38 INFO - Return code: 0 17:31:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:31:38 INFO - Reading from file tmpfile_stdout 17:31:38 INFO - Current package versions: 17:31:38 INFO - blessings == 1.6 17:31:38 INFO - blobuploader == 1.2.4 17:31:38 INFO - docopt == 0.6.1 17:31:38 INFO - functools32 == 3.2.3-2 17:31:38 INFO - jsonschema == 2.5.1 17:31:38 INFO - manifestparser == 1.1 17:31:38 INFO - mozInstall == 1.12 17:31:38 INFO - mozcrash == 1.0 17:31:38 INFO - mozdebug == 0.1 17:31:38 INFO - mozdevice == 0.49 17:31:38 INFO - mozfile == 1.2 17:31:38 INFO - mozhttpd == 0.7 17:31:38 INFO - mozinfo == 0.9 17:31:38 INFO - mozleak == 0.1 17:31:38 INFO - mozlog == 3.4 17:31:38 INFO - moznetwork == 0.27 17:31:38 INFO - mozprocess == 0.24 17:31:38 INFO - mozprofile == 0.28 17:31:38 INFO - mozrunner == 6.13 17:31:38 INFO - mozscreenshot == 0.1 17:31:38 INFO - mozsystemmonitor == 0.3 17:31:38 INFO - moztest == 0.8 17:31:38 INFO - mozversion == 1.4 17:31:38 INFO - psutil == 3.1.1 17:31:38 INFO - requests == 1.2.3 17:31:38 INFO - wsgiref == 0.1.2 17:31:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:38 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 0x10ecb7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00c72420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea95d30>, '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 0x10e9bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8abe8>, '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.qJRDQCidfd/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.Cxo71kaH4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:31:38 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 17:31:38 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 17:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJRDQCidfd/Render', 17:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:38 INFO - 'HOME': '/Users/cltbld', 17:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:38 INFO - 'LOGNAME': 'cltbld', 17:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:38 INFO - 'MOZ_NO_REMOTE': '1', 17:31:38 INFO - 'NO_EM_RESTART': '1', 17:31:38 INFO - 'PAGER': '/bin/cat', 17:31:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:38 INFO - 'PWD': '/builds/slave/test', 17:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:38 INFO - 'SHELL': '/bin/bash', 17:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cxo71kaH4g/Listeners', 17:31:38 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:38 INFO - 'USER': 'cltbld', 17:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:38 INFO - 'XPC_FLAGS': '0x0', 17:31:38 INFO - 'XPC_SERVICE_NAME': '0', 17:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:38 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)) 17:31:38 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)) 17:31:38 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)) 17:31:38 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)) 17:31:38 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)) 17:31:38 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)) 17:31:38 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)) 17:31:38 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)) 17:31:38 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)) 17:31:38 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)) 17:31:38 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)) 17:31:38 INFO - Cleaning up... 17:31:38 INFO - Return code: 0 17:31:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:38 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 0x10ecb7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00c72420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea95d30>, '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 0x10e9bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8abe8>, '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.qJRDQCidfd/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.Cxo71kaH4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:31:38 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 17:31:38 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 17:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJRDQCidfd/Render', 17:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:38 INFO - 'HOME': '/Users/cltbld', 17:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:38 INFO - 'LOGNAME': 'cltbld', 17:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:38 INFO - 'MOZ_NO_REMOTE': '1', 17:31:38 INFO - 'NO_EM_RESTART': '1', 17:31:38 INFO - 'PAGER': '/bin/cat', 17:31:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:38 INFO - 'PWD': '/builds/slave/test', 17:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:38 INFO - 'SHELL': '/bin/bash', 17:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cxo71kaH4g/Listeners', 17:31:38 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:38 INFO - 'USER': 'cltbld', 17:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:38 INFO - 'XPC_FLAGS': '0x0', 17:31:38 INFO - 'XPC_SERVICE_NAME': '0', 17:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:31:39 INFO - Cleaning up... 17:31:39 INFO - Return code: 0 17:31:39 INFO - Running post-action listener: _resource_record_post_action 17:31:39 INFO - Running post-action listener: _start_resource_monitoring 17:31:39 INFO - Starting resource monitoring. 17:31:39 INFO - [mozharness: 2017-01-27 01:31:39.273092Z] Finished create-virtualenv step (success) 17:31:39 INFO - [mozharness: 2017-01-27 01:31:39.274123Z] Running install step. 17:31:39 INFO - Running pre-action listener: _resource_record_pre_action 17:31:39 INFO - Running main action method: install 17:31:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:31:39 INFO - Reading from file tmpfile_stdout 17:31:39 INFO - Detecting whether we're running mozinstall >=1.0... 17:31:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:31:39 INFO - Reading from file tmpfile_stdout 17:31:39 INFO - Output received: 17:31:39 INFO - Usage: mozinstall [options] installer 17:31:39 INFO - Options: 17:31:39 INFO - -h, --help show this help message and exit 17:31:39 INFO - -d DEST, --destination=DEST 17:31:39 INFO - Directory to install application into. [default: 17:31:39 INFO - "/builds/slave/test"] 17:31:39 INFO - --app=APP Application being installed. [default: firefox] 17:31:39 INFO - mkdir: /builds/slave/test/build/application 17:31:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:32:01 INFO - Reading from file tmpfile_stdout 17:32:01 INFO - Output received: 17:32:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:32:01 INFO - Running post-action listener: _resource_record_post_action 17:32:01 INFO - [mozharness: 2017-01-27 01:32:01.586171Z] Finished install step (success) 17:32:01 INFO - [mozharness: 2017-01-27 01:32:01.586312Z] Running run-tests step. 17:32:01 INFO - Running pre-action listener: _resource_record_pre_action 17:32:01 INFO - Running main action method: run_tests 17:32:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:32:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:32:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:32:01 INFO - 2017-01-26 17:32:01.600 screenresolution[1622:7418] starting screenresolution argv=screenresolution get 17:32:01 INFO - 2017-01-26 17:32:01.603 screenresolution[1622:7418] Display 0: 1600x1200x32@60 17:32:01 INFO - 2017-01-26 17:32:01.609 screenresolution[1623:7420] starting screenresolution argv=screenresolution list 17:32:01 INFO - Available Modes on Display 0 17:32:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:32:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:32:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:32:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:32:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:32:01 INFO - Intel Iris: 17:32:01 INFO - Chipset Model: Intel Iris 17:32:01 INFO - Type: GPU 17:32:01 INFO - Bus: Built-In 17:32:01 INFO - VRAM (Dynamic, Max): 1536 MB 17:32:01 INFO - Vendor: Intel (0x8086) 17:32:01 INFO - Device ID: 0x0a2e 17:32:01 INFO - Revision ID: 0x0009 17:32:01 INFO - Displays: 17:32:01 INFO - Display: 17:32:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:32:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:32:01 INFO - Display Serial Number: 1600x1200 60 17:32:01 INFO - Main Display: Yes 17:32:01 INFO - Mirror: Off 17:32:01 INFO - Online: Yes 17:32:01 INFO - Rotation: Supported 17:32:01 INFO - Return code: 0 17:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:32:01 INFO - Python 2.7.3 17:32:01 INFO - Return code: 0 17:32:01 INFO - grabbing minidump binary from tooltool 17:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:32:01 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 0x10ea95d30>, '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 0x10e9bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:32:01 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 17:32:01 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 17:32:01 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 17:32:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:32:01 INFO - Return code: 0 17:32:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:32:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:32:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:32:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:32:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--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 17:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0171 --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 17:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJRDQCidfd/Render', 17:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:32:01 INFO - 'HOME': '/Users/cltbld', 17:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:32:01 INFO - 'LOGNAME': 'cltbld', 17:32:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:32:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:01 INFO - 'MOZ_NO_REMOTE': '1', 17:32:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:32:01 INFO - 'NO_EM_RESTART': '1', 17:32:01 INFO - 'PAGER': '/bin/cat', 17:32:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:01 INFO - 'PWD': '/builds/slave/test', 17:32:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:32:01 INFO - 'SHELL': '/bin/bash', 17:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cxo71kaH4g/Listeners', 17:32:01 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:32:01 INFO - 'USER': 'cltbld', 17:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:01 INFO - 'XPC_FLAGS': '0x0', 17:32:01 INFO - 'XPC_SERVICE_NAME': '0', 17:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:32:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--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 17:32:02 INFO - mozversion application_buildid: 20170126161921 17:32:02 INFO - mozversion application_changeset: 1e0e193b0812f68a12fbd69198552af62347af1e 17:32:02 INFO - mozversion application_display_name: Nightly 17:32:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:32:02 INFO - mozversion application_name: Firefox 17:32:02 INFO - mozversion application_remotingname: firefox 17:32:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:32:02 INFO - mozversion application_vendor: Mozilla 17:32:02 INFO - mozversion application_version: 54.0a1 17:32:02 INFO - mozversion platform_buildid: 20170126161921 17:32:02 INFO - mozversion platform_changeset: 1e0e193b0812f68a12fbd69198552af62347af1e 17:32:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:32:02 INFO - mozversion platform_version: 54.0a1 17:32:02 INFO - using testdate: 1485480722 17:32:02 INFO - actual date: 1485480722 17:32:02 INFO - starting webserver on 'localhost:49241' 17:32:02 INFO - SUITE-START | Running 2 tests 17:32:02 INFO - TEST-START | dromaeo_css 17:32:02 INFO - operating with platform_type : mac_ 17:32:02 INFO - Initialising browser for dromaeo_css test... 17:32:02 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmphtJrHz/profile http://localhost:49241/getInfo.html) 17:32:05 INFO - PROCESS | 1633 | 2017-01-26 17:32:05.063 plugin-container[1635:7588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e2f, name = 'com.apple.tsm.portname' 17:32:05 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:32:05 INFO - PROCESS | 1633 | 2017-01-26 17:32:05.066 plugin-container[1635:7588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 17:32:05 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:32:05 INFO - PROCESS | 1633 | 2017-01-26 17:32:05.066 plugin-container[1635:7588] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:32:05 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 17:32:05 INFO - PROCESS | 1633 | colorDepth:24 17:32:05 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 17:32:05 INFO - PROCESS | 1633 | __metrics 17:32:05 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 17:32:05 INFO - TEST-INFO | 1633: exit 0 17:32:05 INFO - Browser initialized. 17:32:05 INFO - Running cycle 1/1 for dromaeo_css test... 17:32:05 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmphtJrHz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:08 INFO - PROCESS | 1636 | 2017-01-26 17:32:08.441 plugin-container[1637:7706] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 17:32:08 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:32:08 INFO - PROCESS | 1636 | 2017-01-26 17:32:08.442 plugin-container[1637:7706] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 17:32:08 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:32:08 INFO - PROCESS | 1636 | 2017-01-26 17:32:08.442 plugin-container[1637:7706] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:32:18 INFO - PROCESS | 1636 | RSS: Main: 233365504 17:32:18 INFO - PROCESS | 1636 | 17:35:20 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 17:35:22 INFO - PROCESS | 1636 | RSS: Main: 259538944 17:35:22 INFO - PROCESS | 1636 | 17:37:06 INFO - PROCESS | 1636 | ************************* 17:37:06 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 17:37:06 INFO - PROCESS | 1636 | 17:37:06 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:37:06 INFO - PROCESS | 1636 | Full stack: 17:37:06 INFO - PROCESS | 1636 | ************************* 17:38:24 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 17:38:25 INFO - PROCESS | 1636 | RSS: Main: 262574080 17:38:25 INFO - PROCESS | 1636 | 17:41:27 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 17:41:28 INFO - PROCESS | 1636 | RSS: Main: 274542592 17:41:28 INFO - PROCESS | 1636 | 17:44:30 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 17:44:30 INFO - PROCESS | 1636 | RSS: Main: 268247040 17:44:30 INFO - PROCESS | 1636 | 17:47:33 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 17:47:34 INFO - PROCESS | 1636 | RSS: Main: 273551360 17:47:34 INFO - PROCESS | 1636 | 17:50:37 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 17:50:37 INFO - PROCESS | 1636 | RSS: Main: 276660224 17:50:37 INFO - PROCESS | 1636 | 17:50:37 INFO - PROCESS | 1636 | __start_tp_report 17:50:37 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 17:50:37 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 17:50:37 INFO - PROCESS | 1636 | |i|pagename|runs| 17:50:37 INFO - PROCESS | 1636 | |0;dojo.html;3233.9676603233975;3267.869285228591;3291.275919297755;3303.5209894565287;3304.1409233599256;3923.5291764988206;4496.3705081288645;5188.792448302068;5477.3427188737305;5478.424765399635;4512.916899944014;5355.4912283333115;5397.865053373667;5459.372172200188;5567.331920169585;4366.301391777316;4997.725125118135;4998.200287953928;5030.170021946393;5153.587712982971;5020.272060551218;5081.695098294095;5144.948550514484;5163.096458119833;5185.092608793465;4933.703977761345;5000.849974500771;5086.821961231339;5087.592992560586;5093.974530127344;5000.799968001275;5039.924401133986;5075.416327122354;5085.847424577231;5134.948650513485;5011.173156429185;5021.874453138665;5037.395512538519;5050.772715227824;5056.646034777567;5316.4683531646915;5394.973025134849;5477.643953143033;5510.531604813596;5534.059209934321;5953.91069133959;6019.367966363557;6081.574289799716;6087.756489740405;6115.788007244199;6146.416090471398;6146.5390095743;6152.507799376084;6155.4767844732805;6168.629882207037;5683.175939488792;5688;5690.573207009491;5690.829275121753;5696.572757043197;6060.272767267956;6122.112293717386;6124.136831511461;6140.412224875342;6155.415235552616;5942.70286485674;5954.732037058343;5991.880162396727;6000.0999850022845;6062.393760623991;6092.878142437126;6115.296740874767;6145.477634401126;6148.385161483905;6175.814725558241;5834.154047663065;5886.264216972879;5903.468687818117;5994.940050599525;6001;5988.700564971734;6021.066734656048;6036.698165091728;6039.758409663565;6081.847953801191;4837.854864354075;4854.126257273654;4869.805207791719;4883.047805677858;4891.804327826918;4278.935815962763;4349.847755328548;4351.390805287262;4352.086061927031;4377.212101821703;5407.242985981966;5469.535089517356;5500.779968801203;5510.118381059011;5576.888462230732;6147.784827531015;6150.538709596798;6157.630542167484;6160.383961603804;6164.106204600308;5573.247611572386;5580.665160090326;5584.162375643686;5587.497125258747;5616.382197958222;5159.613029022838;5181.53366197044;5189.662671926313;5232.2674825524455;5277.788888444419;6145.66198859067;6174.66039367839;6208.317085120723;6214.9689251553455;6222.408871157233;6099.66451845135;6133.601315914451;6152.938470615237;6156.722947467464;6158.661273629814;6037.275526936795;6084.482818960438;6210.5652604317265;6225.3774622539195;6248.375162483897;5923.881522369442;5962.314333851663;5974.641521508724;6054.212952316171;6079.240094988127;6030.03519436888;6085.2393450818645;6121.387861213843;6130.6628135452975;6164.321924588202;5499.807506737245;5563.638363506359;5932.080527518242;5943.019401798655;5961.552883533665;4843.903121937612;5756.222909907109;5771.249737534094;5832.212651292191;5857.209276747584;5442.374126975448;5611.775528978795;5684.062129748545;5696.886062278814;5739.339975902824;4794.424669039738;5742.425757424391;5754.683492407958;5908.497777688945;5927.525797936241;4848.733319667311;5690.715464226855;5772.7690892363835;5796.101604251347;5803.970980145073 17:50:37 INFO - PROCESS | 1636 | |1;ext.html;442.51323544101484;473.77258915720455;488.8999750561238;491.80082066762975;492.75087652800136;29239.56140657892;42562;42704.50534231302;42791.57208427915;42870.571294287125;43454.78272608633;43818.12363752723;43858.56141438585;43866.342004869875;43942.12115757683;9356.204722598588;9587.856182157273;9603.32776705631;9612.56743446543;11114.666560003172;11149.386783726892;11262.4368781561;11460.255083419594;11472.426378681073;11484.196106272564;11464.598739044135;11480.483378247998;11494.195406321562;11511.539538418454;11539.826902596467;11366.204365694404;11367.147463940237;11399.316041037564;11435.771284574344;11451.370174640433;9325.953370233174;11180.04969577587;11282.379469129195;11317.717057073556;11328.546858125665;36443.4533481998;36760;37136.44295335572;37151.81424092889;37192.81403592992;3925.509311336083;3977.2642061218476;3983.0440694233466;3993.101552150743;4004.3192657248046;28458.288542786388;28820.423591528262;28892.277693057633;29127.708722912925;29131.70868291311;3142.858571364271;3169.429502689515;3180.7614428917923;3188.6333071696818;3217.7104060634656;440889;443569;446714.76642616576;447600;448920;47661.5233847664;57083;57173.71413142908;57209;57305.14042289369;59583.510412240044;59590.70204648949;59686.80626387448;59955;59996;15260.923695381452;15613.84386156124;15748.291326890318;15750.68498630021;15760.76358854618;10252.923443038522;10872.836907446395;11107.611233606785;12032.03743700502;12189;15664.060156390653;16477.423290184786;17058.31766729317;17972.55068623295;18136.45840103606;6649.468042556584;6798.456123510107;6859.348361905611;6917.9308206917285;7618.961905190549;701.3897908819258;833.204289903141;834.745402652197;857.5412154497315;858.3648100405654;25254.116105936206;28500;30205.395892082037;30322.241943951136;30355.69644303573;1034.6016783538391;1039.7504598896362;1060.4008735064817;1064.7976884392097;1129.8757136714955;15449.5365139046;15942.20288985546;15949.601259968362;16052.598685032734;16169;221724;223182;223483;224047;225122;52257;61989;62478;62514.062289064794;62973;1376.717772856562;1406.2687402550616;1418.5035237666941;1419.524459306144;1424.0814674534868;24581.262562123164;29475.263118422212;30106.688264291348;30217.69782302237;30569.694303057575;52885;52904.47095528995;53445.7327713359;53559;53751.73124134354;462383;546452;549780;551188.2440587771;552707;20545;23644.763552364257;26204.606930895672;26693.332666683487;27158.32104197332;44133.77933110314;46417.53582464132;46520.53479465162;47335.28997065116;47462.525374747194;31929.840350799026;37242.8137859309;39288;39588.76799016049;40760.388594170516;39335.01662458347;39415.40876886906;40538.39192412057;40729.59270407258;40805.59194408018;37348;37997.620023799405;38083.5245709028;38660.80669596634;38914.610853892234;33511.66488335085;33985.66014339825;34747.65252347444;35170.47244291286;35321.470177947864;24994.75005249997;25422.491550169263;25451;25597.3600659985;25829.741702583484 17:50:37 INFO - PROCESS | 1636 | |2;jquery.html;383.53400618248855;385.34876059459526;389.99220015599684;399.17968574579237;422.4887885658353;19642.70535941962;20365.28721494748;20568.8971555142;21221.363359099232;21225.68161477579;20722.171113155495;21000.789992100075;21624;21873.12507499698;21925.451863703416;4978.87552811179;5269.710165940872;5306.204069389584;5307.203919412081;5364.517193452589;5068.873278168038;5283.973580132094;5330.227117068022;5359;5378.731063446831;5259.184826351902;5322.65402748822;5330.253764472977;5333.013392522395;5336.279602253704;5171.870703232412;5201.349831271091;5216.217567364888;5312.831177141042;5317.521423071923;5214.947850521484;5238.711870847102;5248.081585722522;5251.789928402859;5253.133233016548;11162.497687603996;13308.401121949439;13562.254076025913;13635.977301702413;13714.24571648559;2557.5524283250356;2639.736026397345;2643.41844794145;2646.7088620251757;2655.097266929234;8788.51663158526;11632.651020469399;12556.623301300975;15007.624809379744;16407.42574009904;1749.737539369092;1774.1216115763964;1843.815618438159;1884.6230753849286;1888.773347198345;117291;117293;121280.39359803233;137415.31292343573;141465;11682.70793230176;12143.574974875837;12147.271163730204;12169.695757605954;12213.511459541518;15798.447054353272;15959.845420868267;15965.920170399073;15988;16007.839921600635;8509.957450212833;8691.826163476822;8760.080191579793;8790.406829985042;8860.468371897707;8257.463264887763;8363.790905227297;8509.404341696145;8529.829403411897;8564.74305770828;4768.189407800683;4860.756962151878;4883.682560633619;4897.363342765489;4924.852254432372;2043.7036629688612;2079.6048750737314;2087.6242276390394;2088.3526106906907;2097.643400621898;1002.1882275356984;1006.8087063458066;1008.9798204035878;1010.8635334229932;1022.9079382855579;18195.727064094048;20999.160033598484;21932.45168870759;22029.779702202773;22071.448213794785;941.6704153546204;1029.433811403725;1040.3653771199563;1069.1179776684112;1076.316538997742;10319.277650564538;11255.943720281346;11432.828507572392;11452.656420307405;11498.885011149781;508920;687281;694785;695466;698874;126054;142525;143478;149183;160115;1030.8144533983805;1042.7810159866513;1089.6513115803025;1092.0662833277593;1093.7265683579105;16280.592985175464;19647.508812279808;20085.397438076296;20294.086766095264;20559.588808223452;54438.727806360715;54781;57790.42209577851;57996.710016449644;59661.10508342292;70345.9448108289;84207;85239.72140417775;85869.14130858611;86363.1363686355;8452.577371131541;8526.488410695378;8607.440516366416;8675.86986195195;8714.956425217833;7682.769516914502;10717.464126793786;13270.336483175995;13554.59336219915;13795.724085518434;11389.54441822351;11519.596814111466;11959.581414650445;11984.04127669767;12114.001189803585;9506.809863802548;10055.949720251352;11028.503717332578;11288.548458061585;11335.376554289593;11289.096872250037;11522.251053681484;11688.240264382788;12051.397430128283;12181.025517958366;7163.498555101093;8483.363747718822;8754.08082151365;8861.778455538662;8888.64445422176;9397.389169703947;10562.630307939493;10790.62232821879;11176.441177941233;11275.718107047389 17:50:37 INFO - PROCESS | 1636 | |3;mootools.html;1405.9648508787286;1416.8016477693118;1425.1947649577987;1437.5687293811857;1438.2161721861587;7442.292982166686;7692.192319806423;7952.880706789396;8376.497410155394;8395.664173433062;7777.18339574345;8023.956885604878;8051.879221811663;8098.838023239532;8112.148224436423;2200.746914104878;2244.8540844845115;2245.932622021342;2259.8644081355174;2280.350100221437;2034.1761586557468;2121.628714974881;2283.5547068321684;2318;2321.1411777642297;2208.4258092895884;2284.7258329000542;2284.8286378521593;2296.3455415206668;2298.839081264312;2270.761570035139;2276.009935677977;2286.9937227619794;2291.9770802291932;2293.908243670251;2249.089118906845;2256;2299.091858715798;2308.1459859851793;2309.953800923989;8343.290820280283;8375.664973401057;8438.198371154731;8458.74623761288;8471.15288471154;5063.822766203165;5170.25031370453;5217.34783152106;5220.634555581111;5222.63441559091;3421.1789170599127;3467.133216695826;3489.040513858684;3497.5278337424375;3528.6824185823143;1217.190568272098;1217.4034722985762;1252.3487786351047;1275.2412314672754;1278.181963543333;9481.952590237073;9889.950550247202;10655.094316983066;10664.680059598224;10687.14502839771;4317.8272869084885;4584.404027476474;4654.697444666086;4665.533446655375;4678.836240731558;7824.178461261599;9261.398009129385;9408.858867116998;9416.764580885532;9428.245740340757;5139.820106296262;5214.139666954986;5228.05894938907;5231.947680523146;5236.6857988520815;4073.592640735962;4645.9303110453375;4677.368555245066;4711.269753188261;4774.570288674036;3248.3016151527536;3790;3820.102275965146;3852.4413959975645;3901.4147877818555;1066.6266806617778;1171.6485054483792;1217.0385395537426;1269.5620011096157;1279.6992706713916;760.1828034862544;762.1692355332714;787.5078076202374;809.5024205220413;825.5789547330904;5049.444561098277;5555.555555555627;5557.888842223133;5695.686737229492;5729.5702822288495;868.2836659755727;998.9800203995879;999.3104757717152;1012.579779391559;1023.4217667018111;3460.8406183928164;3603.442539096052;3621.873234436835;3725.869594564177;3885.242377736314;9356.485393303434;9617.951910240545;9679.612815487442;9712.125908668253;9755.756106097262;9648.951755241178;9661.516924153764;9675.806483870283;9684.661036863818;9687.370320929118;7749.496282741604;7819.530828150329;7893.802654933673;7900.3284720799375;7961.641726122339;4611.746353950565;5452.945470545403;5495.422980586981;5604.8038318658655;5611.6352437091455;8605.6988005422;8661.090585488433;8821.470711757314;9052.456852588866;9179.908200917906;9157.954210228907;9264.675736349196;9317.627294908129;9441.33910626277;9531.523423828643;7631.275028872248;7836.529808211526;7839.33365663925;7843.803904902423;7850.960745196237;7754.7673569793;7772.727954521564;7802.375809935305;7802.921970780447;7884.408669349937;6479.838004049748;7045.718171273092;7091.539049961736;7094.538854974617;7136.464765142531;6936.79189624312;6973.372396484341;6977.1278590176225;7084.397826184832;7109;6371.96814015927;6380.234371875405;6443.291237963914;6463.385978332051;6467.902981455188;4859.878503037452;4953.975230123826;5003.473940448198;5042.9243561345875;5158.484151584811;4930.381419092409;5023.648344615842;5047.671901326402;5173.793048278178;5184.274201611702 17:50:37 INFO - PROCESS | 1636 | |4;prototype.html;297.7216302756921;357.8658003248782;365.92132691471335;371.8215256676797;375.79519162056675;4689.48415674276;5042.82350117746;5207;5353.357597088345;5354.678719276846;4754.714717116975;5277.947220527793;5284.81503147389;5309.920351194735;5310.522053015228;3607.603163651996;3887.5270652179233;3904.1996390739973;3929.98035009826;4049.286977724931;3651.214988777412;3982.426941358162;4122.876313710593;4124.773137477452;4133.5659755725665;3407.30150319184;3425.9722083374886;3607.7654952428006;3645.325614761278;4167.687423443239;3461.549998500204;3497.91255218619;4166.812493437803;4166.9791651041705;4182.874513764592;3484.6863782259466;3509.6841284284537;3597.9745772454985;3642.5993140754763;3679.7608155469807;3937.2912875682364;4330.653547716175;4505.842295519641;5128.948710512922;5161.741912904377;4288.44250247469;4764.595009424169;4784.66507344486;4810;4828.430760003013;4401.40317212846;4797.688150270221;4804.711717296974;4963.170992534257;5635.5773317001385;3799.556168655921;3865.4781604483314;4071.97964010181;4080.449429216879;4127.360259159835;5193.350831146106;5804.113663059523;5882.794102206402;5887.352391237004;5925.4963328117165;3313.337332533503;3748.325301445766;3961.3067713150085;4061.147159096564;4099.467069281034;4139.606737359946;4157.501099868035;4168.416421700964;4169.728967617095;4179;4597.586217240398;4759.786254505079;4768.1126844984165;4798.568128868418;4813.663043586986;5628.60599758013;5632.352279487829;5634.830955071355;5676.814426445848;5706.885862282731;1229.4467489629703;1257.9874201257871;1265.4052595280205;1355.5323413422354;1383.8270216222973;885.5395194498825;890.3144578674385;910.899801021887;984.4544065816599;985.4973963278779;4361.781910904506;4591.380163677861;4883.388481800997;4918.680285781413;4940;4862.78117484714;4954.677945933575;4970.776315065831;5523.364813046471;5555.972220138873;4161.563035881189;4530.29780384041;4538.092278783848;4593.770311484413;4865.537773911473;2524.6465494830736;2540.326813394452;2622.593498007812;2767.501849667039;2841.218664867137;4958.851234462972;4961.82633607822;5067.417247016567;5497.642653227527;5541.810984661117;4595.954040459619;4776.617870570346;5300.3639563252655;5355.580771095662;5697.4587414195585;5238.73806309683;5467.5625949923915;5701.1756238003445;5703.714814259353;5704.515116215085;4579.5878370946775;4618.330342100309;5430.9185362218805;5454.3454785426;5485.68116289655;4248.808803603783;4992.134242265396;5280.867978300574;5370.677759334452;5415.079436495884;5314.156926044548;5318.377894742141;5527.972360138174;5606.943930560642;5760.404337034156;3641.5630124385243;3846.74996125251;4076.9399956011057;4119.178362821477;4121.609466509358;5048.495150485069;5563.8579147029495;5742.712864356682;5758.798442054508;5761.711914404179;4291.098869237495;4870.512948705101;5555.416681248573;5564.1900840075505;5641.464060914206;4552.430946131733;5506.862328441821;5542.63972841764;5560.416156303691;5561.803087780385;5404.486573775485;5414.6699779634455;5415;5419.945800541944;5439.265699130567;4922.901541969212;4928.778204980713;5163.535281824654;5477.45225477465;5636.323641163087;5461.453854614666;5491.588130890119;5503.110866794965;5504.623844038991;5521.309836270466 17:50:37 INFO - PROCESS | 1636 | |5;yui.html;625.2965413909354;705.5625512182442;767.6507189228902;820.917908209179;830.3938125168625;14740;15007.849921500781;15194;15704.371825126995;15751.84248157518;14130.576082717535;14314.42742290307;14446.783298250535;14501.709965800677;14535.854641453583;836.8326334733048;861.732862812527;862.3058437957442;862.5687156421789;863.1109956744532;810.2262339465796;843.2410830252791;852.1606217875387;852.1819053708448;854.8504011797942;890.1499068389672;893.4505279253245;893.865920111982;895.3642913531368;897.7845317123908;880.493716113231;881.0968757024069;884.91150884911;885.4333226734894;886.1448702002566;635.1711017122653;643.5109316919128;657.5955787190891;666.796627028756;667.7863083813181;15232.923835380752;15457.613559660986;15460.5361839145;15515.99146055514;15714.21428928549;13791.51729689466;13948.86051139496;14058;14117.08238964464;14379.78430323546;11565.421728913605;11658.94170529142;11739.530418783239;12076.939615301868;12299.938500307531;3428.794272343642;3639.581448133472;3680.4651093690195;3714.53568303962;3835.117922877726;96737;99620.00379996179;99658.50170749173;102011;102425;10895;10911.290766100177;10945.945270273598;11011.119110471143;11221.60724374643;21998.230061948074;22088.447788805086;22198.778012219995;22207.66688499674;22220.666689999664;7606.847863042708;7650.081990161217;7677.500962437535;7736.303732664087;7753.651085701157;4189.2668782962855;4210.5157906841105;4298.570142985739;4403.581659742319;4427.579379958899;3398.150462384404;3464.7401444891734;3483.5819701635965;3488.598811136752;3495.3883070462566;639.7856717999522;643.2923783837741;646.8382904273932;653.5588477777482;654.0810161722692;619.7366119399328;628.7302836759295;636.7900988122511;642.4988508963016;670.0786418674322;8329.791755206168;9236.676716314896;9795.265355098396;10038.849417258747;10060.446675432922;623.554158776477;661.9503537234726;668.7425341243656;669.334012657409;677.864427114579;3824.904377390532;4712.540959189793;4761.880952976203;4788.281757736368;4807.423109226916;102554;107455.46272268589;107611.46194268978;107673.4616326929;108677.45661271643;73256;96316.03683963211;96356.51821740846;98844.01155988492;99159;61997.690011550556;62020.93727815355;68571.65714171398;78339.60830195813;79364.60317698374;10935;11062.502187401426;11077.058450031514;11153.275037122561;11278.49246783913;45232;46914.76542617265;47498;49432.25851612157;50468.990620188124;67732.661336693;68779.62440751257;70119.29880701128;70526;71656.64171679108;10447.634332798316;12572.874271257171;12592.181508201938;12701;12797.744045119232;13805.24071176095;13808.930955345159;13968.161910285415;14386.640333991734;14590.781138282722;13264.86735132675;13298.933505332412;13470.730585388434;13912.373943172379;13932.93033534826;12687.492500300254;13170.60488185356;13172.538961136313;13197.36052789465;13203.207807531195;13281.070325077151;13399.196048237138;13423.463061477432;13451.798223026466;13456.394462249418;9573.473458959825;11344.432778360884;11393.658190254306;11723.472443740222;11853.288802671867;9119.407238529475;10163.7459063524;10899;10970.616028438966;10989 17:50:37 INFO - PROCESS | 1636 | __end_tp_report 17:50:37 INFO - PROCESS | 1636 | __start_cc_report 17:50:37 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,379 17:50:37 INFO - PROCESS | 1636 | __end_cc_report 17:50:37 INFO - PROCESS | 1636 | __startTimestamp1485481837343__endTimestamp 17:50:37 INFO - PROCESS | 1636 | 17:50:37 INFO - PROCESS | 1636 | ------- Summary: start ------- 17:50:37 INFO - PROCESS | 1636 | Number of tests: 6 17:50:37 INFO - PROCESS | 1636 | 17:50:37 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5535.13 Median:5690.83 stddev:657.14 (11.5%) stddev-sans-first:633.87 17:50:37 INFO - PROCESS | 1636 | Values: 3234.0 3267.9 3291.3 3303.5 3304.1 3923.5 4496.4 5188.8 5477.3 5478.4 4512.9 5355.5 5397.9 5459.4 5567.3 4366.3 4997.7 4998.2 5030.2 5153.6 5020.3 5081.7 5144.9 5163.1 5185.1 4933.7 5000.8 5086.8 5087.6 5094.0 5000.8 5039.9 5075.4 5085.8 5134.9 5011.2 5021.9 5037.4 5050.8 5056.6 5316.5 5395.0 5477.6 5510.5 5534.1 5953.9 6019.4 6081.6 6087.8 6115.8 6146.4 6146.5 6152.5 6155.5 6168.6 5683.2 5688.0 5690.6 5690.8 5696.6 6060.3 6122.1 6124.1 6140.4 6155.4 5942.7 5954.7 5991.9 6000.1 6062.4 6092.9 6115.3 6145.5 6148.4 6175.8 5834.2 5886.3 5903.5 5994.9 6001.0 5988.7 6021.1 6036.7 6039.8 6081.8 4837.9 4854.1 4869.8 4883.0 4891.8 4278.9 4349.8 4351.4 4352.1 4377.2 5407.2 5469.5 5500.8 5510.1 5576.9 6147.8 6150.5 6157.6 6160.4 6164.1 5573.2 5580.7 5584.2 5587.5 5616.4 5159.6 5181.5 5189.7 5232.3 5277.8 6145.7 6174.7 6208.3 6215.0 6222.4 6099.7 6133.6 6152.9 6156.7 6158.7 6037.3 6084.5 6210.6 6225.4 6248.4 5923.9 5962.3 5974.6 6054.2 6079.2 6030.0 6085.2 6121.4 6130.7 6164.3 5499.8 5563.6 5932.1 5943.0 5961.6 4843.9 5756.2 5771.2 5832.2 5857.2 5442.4 5611.8 5684.1 5696.9 5739.3 4794.4 5742.4 5754.7 5908.5 5927.5 4848.7 5690.7 5772.8 5796.1 5804.0 17:50:37 INFO - PROCESS | 1636 | 17:50:37 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:56057.47 Median:35245.97 stddev:112296.48 (318.6%) stddev-sans-first:112533.87 17:50:37 INFO - PROCESS | 1636 | Values: 442.5 473.8 488.9 491.8 492.8 29239.6 42562.0 42704.5 42791.6 42870.6 43454.8 43818.1 43858.6 43866.3 43942.1 9356.2 9587.9 9603.3 9612.6 11114.7 11149.4 11262.4 11460.3 11472.4 11484.2 11464.6 11480.5 11494.2 11511.5 11539.8 11366.2 11367.1 11399.3 11435.8 11451.4 9326.0 11180.0 11282.4 11317.7 11328.5 36443.5 36760.0 37136.4 37151.8 37192.8 3925.5 3977.3 3983.0 3993.1 4004.3 28458.3 28820.4 28892.3 29127.7 29131.7 3142.9 3169.4 3180.8 3188.6 3217.7 440889.0 443569.0 446714.8 447600.0 448920.0 47661.5 57083.0 57173.7 57209.0 57305.1 59583.5 59590.7 59686.8 59955.0 59996.0 15260.9 15613.8 15748.3 15750.7 15760.8 10252.9 10872.8 11107.6 12032.0 12189.0 15664.1 16477.4 17058.3 17972.6 18136.5 6649.5 6798.5 6859.3 6917.9 7619.0 701.4 833.2 834.7 857.5 858.4 25254.1 28500.0 30205.4 30322.2 30355.7 1034.6 1039.8 1060.4 1064.8 1129.9 15449.5 15942.2 15949.6 16052.6 16169.0 221724.0 223182.0 223483.0 224047.0 225122.0 52257.0 61989.0 62478.0 62514.1 62973.0 1376.7 1406.3 1418.5 1419.5 1424.1 24581.3 29475.3 30106.7 30217.7 30569.7 52885.0 52904.5 53445.7 53559.0 53751.7 462383.0 546452.0 549780.0 551188.2 552707.0 20545.0 23644.8 26204.6 26693.3 27158.3 44133.8 46417.5 46520.5 47335.3 47462.5 31929.8 37242.8 39288.0 39588.8 40760.4 39335.0 39415.4 40538.4 40729.6 40805.6 37348.0 37997.6 38083.5 38660.8 38914.6 33511.7 33985.7 34747.7 35170.5 35321.5 24994.8 25422.5 25451.0 25597.4 25829.7 17:50:37 INFO - PROCESS | 1636 | 17:50:37 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:37425.05 Median:20999.98 stddev:110578.24 (526.6%) stddev-sans-first:110853.46 17:50:37 INFO - PROCESS | 1636 | Values: 383.5 385.3 390.0 399.2 422.5 19642.7 20365.3 20568.9 21221.4 21225.7 20722.2 21000.8 21624.0 21873.1 21925.5 4978.9 5269.7 5306.2 5307.2 5364.5 5068.9 5284.0 5330.2 5359.0 5378.7 5259.2 5322.7 5330.3 5333.0 5336.3 5171.9 5201.3 5216.2 5312.8 5317.5 5214.9 5238.7 5248.1 5251.8 5253.1 11162.5 13308.4 13562.3 13636.0 13714.2 2557.6 2639.7 2643.4 2646.7 2655.1 8788.5 11632.7 12556.6 15007.6 16407.4 1749.7 1774.1 1843.8 1884.6 1888.8 117291.0 117293.0 121280.4 137415.3 141465.0 11682.7 12143.6 12147.3 12169.7 12213.5 15798.4 15959.8 15965.9 15988.0 16007.8 8510.0 8691.8 8760.1 8790.4 8860.5 8257.5 8363.8 8509.4 8529.8 8564.7 4768.2 4860.8 4883.7 4897.4 4924.9 2043.7 2079.6 2087.6 2088.4 2097.6 1002.2 1006.8 1009.0 1010.9 1022.9 18195.7 20999.2 21932.5 22029.8 22071.4 941.7 1029.4 1040.4 1069.1 1076.3 10319.3 11255.9 11432.8 11452.7 11498.9 508920.0 687281.0 694785.0 695466.0 698874.0 126054.0 142525.0 143478.0 149183.0 160115.0 1030.8 1042.8 1089.7 1092.1 1093.7 16280.6 19647.5 20085.4 20294.1 20559.6 54438.7 54781.0 57790.4 57996.7 59661.1 70345.9 84207.0 85239.7 85869.1 86363.1 8452.6 8526.5 8607.4 8675.9 8715.0 7682.8 10717.5 13270.3 13554.6 13795.7 11389.5 11519.6 11959.6 11984.0 12114.0 9506.8 10055.9 11028.5 11288.5 11335.4 11289.1 11522.3 11688.2 12051.4 12181.0 7163.5 8483.4 8754.1 8861.8 8888.6 9397.4 10562.6 10790.6 11176.4 11275.7 17:50:37 INFO - PROCESS | 1636 | 17:50:37 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5373.16 Median:5234.32 stddev:2897.14 (55.3%) stddev-sans-first:2889.92 17:50:37 INFO - PROCESS | 1636 | Values: 1406.0 1416.8 1425.2 1437.6 1438.2 7442.3 7692.2 7952.9 8376.5 8395.7 7777.2 8024.0 8051.9 8098.8 8112.1 2200.7 2244.9 2245.9 2259.9 2280.4 2034.2 2121.6 2283.6 2318.0 2321.1 2208.4 2284.7 2284.8 2296.3 2298.8 2270.8 2276.0 2287.0 2292.0 2293.9 2249.1 2256.0 2299.1 2308.1 2310.0 8343.3 8375.7 8438.2 8458.7 8471.2 5063.8 5170.3 5217.3 5220.6 5222.6 3421.2 3467.1 3489.0 3497.5 3528.7 1217.2 1217.4 1252.3 1275.2 1278.2 9482.0 9890.0 10655.1 10664.7 10687.1 4317.8 4584.4 4654.7 4665.5 4678.8 7824.2 9261.4 9408.9 9416.8 9428.2 5139.8 5214.1 5228.1 5231.9 5236.7 4073.6 4645.9 4677.4 4711.3 4774.6 3248.3 3790.0 3820.1 3852.4 3901.4 1066.6 1171.6 1217.0 1269.6 1279.7 760.2 762.2 787.5 809.5 825.6 5049.4 5555.6 5557.9 5695.7 5729.6 868.3 999.0 999.3 1012.6 1023.4 3460.8 3603.4 3621.9 3725.9 3885.2 9356.5 9618.0 9679.6 9712.1 9755.8 9649.0 9661.5 9675.8 9684.7 9687.4 7749.5 7819.5 7893.8 7900.3 7961.6 4611.7 5452.9 5495.4 5604.8 5611.6 8605.7 8661.1 8821.5 9052.5 9179.9 9158.0 9264.7 9317.6 9441.3 9531.5 7631.3 7836.5 7839.3 7843.8 7851.0 7754.8 7772.7 7802.4 7802.9 7884.4 6479.8 7045.7 7091.5 7094.5 7136.5 6936.8 6973.4 6977.1 7084.4 7109.0 6372.0 6380.2 6443.3 6463.4 6467.9 4859.9 4954.0 5003.5 5042.9 5158.5 4930.4 5023.6 5047.7 5173.8 5184.3 17:50:37 INFO - PROCESS | 1636 | 17:50:37 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4421.63 Median:4845.61 stddev:1321.03 (27.3%) stddev-sans-first:1287.97 17:50:37 INFO - PROCESS | 1636 | Values: 297.7 357.9 365.9 371.8 375.8 4689.5 5042.8 5207.0 5353.4 5354.7 4754.7 5277.9 5284.8 5309.9 5310.5 3607.6 3887.5 3904.2 3930.0 4049.3 3651.2 3982.4 4122.9 4124.8 4133.6 3407.3 3426.0 3607.8 3645.3 4167.7 3461.5 3497.9 4166.8 4167.0 4182.9 3484.7 3509.7 3598.0 3642.6 3679.8 3937.3 4330.7 4505.8 5128.9 5161.7 4288.4 4764.6 4784.7 4810.0 4828.4 4401.4 4797.7 4804.7 4963.2 5635.6 3799.6 3865.5 4072.0 4080.4 4127.4 5193.4 5804.1 5882.8 5887.4 5925.5 3313.3 3748.3 3961.3 4061.1 4099.5 4139.6 4157.5 4168.4 4169.7 4179.0 4597.6 4759.8 4768.1 4798.6 4813.7 5628.6 5632.4 5634.8 5676.8 5706.9 1229.4 1258.0 1265.4 1355.5 1383.8 885.5 890.3 910.9 984.5 985.5 4361.8 4591.4 4883.4 4918.7 4940.0 4862.8 4954.7 4970.8 5523.4 5556.0 4161.6 4530.3 4538.1 4593.8 4865.5 2524.6 2540.3 2622.6 2767.5 2841.2 4958.9 4961.8 5067.4 5497.6 5541.8 4596.0 4776.6 5300.4 5355.6 5697.5 5238.7 5467.6 5701.2 5703.7 5704.5 4579.6 4618.3 5430.9 5454.3 5485.7 4248.8 4992.1 5280.9 5370.7 5415.1 5314.2 5318.4 5528.0 5606.9 5760.4 3641.6 3846.7 4076.9 4119.2 4121.6 5048.5 5563.9 5742.7 5758.8 5761.7 4291.1 4870.5 5555.4 5564.2 5641.5 4552.4 5506.9 5542.6 5560.4 5561.8 5404.5 5414.7 5415.0 5419.9 5439.3 4922.9 4928.8 5163.5 5477.5 5636.3 5461.5 5491.6 5503.1 5504.6 5521.3 17:50:37 INFO - PROCESS | 1636 | 17:50:37 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20298.16 Median:3769.72 stddev:29203.32 (774.7%) stddev-sans-first:29247.88 17:50:37 INFO - PROCESS | 1636 | Values: 625.3 705.6 767.7 820.9 830.4 14740.0 15007.8 15194.0 15704.4 15751.8 14130.6 14314.4 14446.8 14501.7 14535.9 836.8 861.7 862.3 862.6 863.1 810.2 843.2 852.2 852.2 854.9 890.1 893.5 893.9 895.4 897.8 880.5 881.1 884.9 885.4 886.1 635.2 643.5 657.6 666.8 667.8 15232.9 15457.6 15460.5 15516.0 15714.2 13791.5 13948.9 14058.0 14117.1 14379.8 11565.4 11658.9 11739.5 12076.9 12299.9 3428.8 3639.6 3680.5 3714.5 3835.1 96737.0 99620.0 99658.5 102011.0 102425.0 10895.0 10911.3 10945.9 11011.1 11221.6 21998.2 22088.4 22198.8 22207.7 22220.7 7606.8 7650.1 7677.5 7736.3 7753.7 4189.3 4210.5 4298.6 4403.6 4427.6 3398.2 3464.7 3483.6 3488.6 3495.4 639.8 643.3 646.8 653.6 654.1 619.7 628.7 636.8 642.5 670.1 8329.8 9236.7 9795.3 10038.8 10060.4 623.6 662.0 668.7 669.3 677.9 3824.9 4712.5 4761.9 4788.3 4807.4 102554.0 107455.5 107611.5 107673.5 108677.5 73256.0 96316.0 96356.5 98844.0 99159.0 61997.7 62020.9 68571.7 78339.6 79364.6 10935.0 11062.5 11077.1 11153.3 11278.5 45232.0 46914.8 47498.0 49432.3 50469.0 67732.7 68779.6 70119.3 70526.0 71656.6 10447.6 12572.9 12592.2 12701.0 12797.7 13805.2 13808.9 13968.2 14386.6 14590.8 13264.9 13298.9 13470.7 13912.4 13932.9 12687.5 13170.6 13172.5 13197.4 13203.2 13281.1 13399.2 13423.5 13451.8 13456.4 9573.5 11344.4 11393.7 11723.5 11853.3 9119.4 10163.7 10899.0 10970.6 10989.0 17:50:37 INFO - PROCESS | 1636 | -------- Summary: end -------- 17:50:37 INFO - PROCESS | 1636 | 17:50:38 INFO - TEST-INFO | 1636: exit 0 17:50:38 INFO - TEST-OK | dromaeo_css | took 1115844ms 17:50:38 INFO - TEST-START | kraken 17:50:38 INFO - operating with platform_type : mac_ 17:50:38 INFO - Initialising browser for kraken test... 17:50:38 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpyYiw4A/profile http://localhost:49241/getInfo.html) 17:50:40 INFO - PROCESS | 1648 | 2017-01-26 17:50:40.769 plugin-container[1649:9918] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4f, name = 'com.apple.tsm.portname' 17:50:40 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:50:40 INFO - PROCESS | 1648 | 2017-01-26 17:50:40.772 plugin-container[1649:9918] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x440f, name = 'com.apple.CFPasteboardClient' 17:50:40 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:50:40 INFO - PROCESS | 1648 | 2017-01-26 17:50:40.772 plugin-container[1649:9918] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:50:40 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 17:50:40 INFO - PROCESS | 1648 | colorDepth:24 17:50:40 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 17:50:40 INFO - PROCESS | 1648 | __metrics 17:50:40 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 17:50:41 INFO - TEST-INFO | 1648: exit 0 17:50:41 INFO - Browser initialized. 17:50:41 INFO - Running cycle 1/1 for kraken test... 17:50:41 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpyYiw4A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:50:44 INFO - PROCESS | 1650 | 2017-01-26 17:50:44.124 plugin-container[1651:10037] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 17:50:44 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:50:44 INFO - PROCESS | 1650 | 2017-01-26 17:50:44.125 plugin-container[1651:10037] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 17:50:44 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:50:44 INFO - PROCESS | 1650 | 2017-01-26 17:50:44.125 plugin-container[1651:10037] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:50:53 INFO - PROCESS | 1650 | RSS: Main: 233246720 17:50:53 INFO - PROCESS | 1650 | 17:50:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 17:50:57 INFO - PROCESS | 1650 | RSS: Main: 246677504 17:50:57 INFO - PROCESS | 1650 | 17:51:00 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 17:51:00 INFO - PROCESS | 1650 | RSS: Main: 255696896 17:51:00 INFO - PROCESS | 1650 | 17:51:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 17:51:04 INFO - PROCESS | 1650 | RSS: Main: 257613824 17:51:04 INFO - PROCESS | 1650 | 17:51:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 17:51:07 INFO - PROCESS | 1650 | RSS: Main: 258453504 17:51:07 INFO - PROCESS | 1650 | 17:51:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:51:10 INFO - PROCESS | 1650 | RSS: Main: 258818048 17:51:10 INFO - PROCESS | 1650 | 17:51:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 17:51:14 INFO - PROCESS | 1650 | RSS: Main: 264343552 17:51:14 INFO - PROCESS | 1650 | 17:51:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 17:51:17 INFO - PROCESS | 1650 | RSS: Main: 265351168 17:51:17 INFO - PROCESS | 1650 | 17:51:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 17:51:21 INFO - PROCESS | 1650 | RSS: Main: 264790016 17:51:21 INFO - PROCESS | 1650 | 17:51:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:51:23 INFO - PROCESS | 1650 | RSS: Main: 264417280 17:51:23 INFO - PROCESS | 1650 | 17:51:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:51:26 INFO - PROCESS | 1650 | RSS: Main: 264445952 17:51:26 INFO - PROCESS | 1650 | 17:51:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:51:29 INFO - PROCESS | 1650 | RSS: Main: 264650752 17:51:29 INFO - PROCESS | 1650 | 17:51:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:51:33 INFO - PROCESS | 1650 | RSS: Main: 265031680 17:51:33 INFO - PROCESS | 1650 | 17:51:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:51:37 INFO - PROCESS | 1650 | RSS: Main: 273551360 17:51:37 INFO - PROCESS | 1650 | 17:51:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 17:51:39 INFO - PROCESS | 1650 | RSS: Main: 276324352 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | __start_tp_report 17:51:39 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 17:51:39 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 17:51:39 INFO - PROCESS | 1650 | |i|pagename|runs| 17:51:39 INFO - PROCESS | 1650 | |0;ai-astar;103;117;118;118;117;117;117;119;118;120 17:51:39 INFO - PROCESS | 1650 | |1;audio-beat-detection;151;114;117;153;117;116;113;115;132;117 17:51:39 INFO - PROCESS | 1650 | |2;audio-dft;200;215;206;212;198;198;199;249;215;193 17:51:39 INFO - PROCESS | 1650 | |3;audio-fft;75;75;84;107;84;57;59;59;86;85 17:51:39 INFO - PROCESS | 1650 | |4;audio-oscillator;91;57;69;85;99;101;113;101;75;82 17:51:39 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;136;132;93;131;112;86;112;132;102;87 17:51:39 INFO - PROCESS | 1650 | |6;imaging-darkroom;170;169;101;100;100;100;98;100;100;101 17:51:39 INFO - PROCESS | 1650 | |7;imaging-desaturate;114;80;146;142;128;95;113;114;94;93 17:51:39 INFO - PROCESS | 1650 | |8;json-parse-financial;60;58;60;62;66;52;81;95;95;93 17:51:39 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;71;76;72;79;75;71;71;75;100;68 17:51:39 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;79;107;112;112;96;88;89;91;89;75 17:51:39 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;163;137;148;149;155;173;152;159;210;175 17:51:39 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;187;179;185;246;173;173;178;223;235;217 17:51:39 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;69;79;86;88;75;68;80;62;67 17:51:39 INFO - PROCESS | 1650 | __end_tp_report 17:51:39 INFO - PROCESS | 1650 | __start_cc_report 17:51:39 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,925 17:51:39 INFO - PROCESS | 1650 | __end_cc_report 17:51:39 INFO - PROCESS | 1650 | __startTimestamp1485481899173__endTimestamp 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | ------- Summary: start ------- 17:51:39 INFO - PROCESS | 1650 | Number of tests: 14 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:116.40 Median:118.00 stddev:4.81 (4.1%) stddev-sans-first:1.05 17:51:39 INFO - PROCESS | 1650 | Values: 103.0 117.0 118.0 118.0 117.0 117.0 117.0 119.0 118.0 120.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:124.50 Median:117.00 stddev:15.44 (13.2%) stddev-sans-first:13.06 17:51:39 INFO - PROCESS | 1650 | Values: 151.0 114.0 117.0 153.0 117.0 116.0 113.0 115.0 132.0 117.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:208.50 Median:209.00 stddev:16.22 (7.8%) stddev-sans-first:16.90 17:51:39 INFO - PROCESS | 1650 | Values: 200.0 215.0 206.0 212.0 198.0 198.0 199.0 249.0 215.0 193.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:77.10 Median:79.50 stddev:15.63 (19.7%) stddev-sans-first:16.56 17:51:39 INFO - PROCESS | 1650 | Values: 75.0 75.0 84.0 107.0 84.0 57.0 59.0 59.0 86.0 85.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:87.30 Median:78.50 stddev:17.08 (21.8%) stddev-sans-first:18.06 17:51:39 INFO - PROCESS | 1650 | Values: 91.0 57.0 69.0 85.0 99.0 101.0 113.0 101.0 75.0 82.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:112.30 Median:134.00 stddev:19.71 (14.7%) stddev-sans-first:18.95 17:51:39 INFO - PROCESS | 1650 | Values: 136.0 132.0 93.0 131.0 112.0 86.0 112.0 132.0 102.0 87.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:113.90 Median:101.00 stddev:29.32 (29.0%) stddev-sans-first:23.02 17:51:39 INFO - PROCESS | 1650 | Values: 170.0 169.0 101.0 100.0 100.0 100.0 98.0 100.0 100.0 101.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:111.90 Median:113.00 stddev:21.91 (19.4%) stddev-sans-first:23.22 17:51:39 INFO - PROCESS | 1650 | Values: 114.0 80.0 146.0 142.0 128.0 95.0 113.0 114.0 94.0 93.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:72.20 Median:73.50 stddev:17.00 (23.1%) stddev-sans-first:17.44 17:51:39 INFO - PROCESS | 1650 | Values: 60.0 58.0 60.0 62.0 66.0 52.0 81.0 95.0 95.0 93.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:75.80 Median:73.50 stddev:9.08 (12.4%) stddev-sans-first:9.46 17:51:39 INFO - PROCESS | 1650 | Values: 71.0 76.0 72.0 79.0 75.0 71.0 71.0 75.0 100.0 68.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:93.80 Median:88.50 stddev:12.92 (14.6%) stddev-sans-first:12.54 17:51:39 INFO - PROCESS | 1650 | Values: 79.0 107.0 112.0 112.0 96.0 88.0 89.0 91.0 89.0 75.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:162.10 Median:161.00 stddev:20.39 (12.7%) stddev-sans-first:21.63 17:51:39 INFO - PROCESS | 1650 | Values: 163.0 137.0 148.0 149.0 155.0 173.0 152.0 159.0 210.0 175.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.60 Median:202.00 stddev:27.76 (13.7%) stddev-sans-first:29.06 17:51:39 INFO - PROCESS | 1650 | Values: 187.0 179.0 185.0 246.0 173.0 173.0 178.0 223.0 235.0 217.0 17:51:39 INFO - PROCESS | 1650 | 17:51:39 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:77.00 stddev:8.85 (11.5%) stddev-sans-first:9.01 17:51:39 INFO - PROCESS | 1650 | Values: 67.0 69.0 79.0 86.0 88.0 75.0 68.0 80.0 62.0 67.0 17:51:39 INFO - PROCESS | 1650 | -------- Summary: end -------- 17:51:39 INFO - PROCESS | 1650 | 17:51:40 INFO - TEST-INFO | 1650: exit 0 17:51:40 INFO - TEST-OK | kraken | took 62048ms 17:51:40 INFO - SUITE-END | took 1177s 17:51:40 INFO - Completed test suite (00:19:38) 17:51:40 INFO - javascript benchmark 17:51:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7158.98892196223, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3233.9676603233975, 3267.869285228591, 3291.275919297755, 3303.5209894565287, 3304.1409233599256, 3923.5291764988206, 4496.3705081288645, 5188.792448302068, 5477.3427188737305, 5478.424765399635, 4512.916899944014, 5355.4912283333115, 5397.865053373667, 5459.372172200188, 5567.331920169585, 4366.301391777316, 4997.725125118135, 4998.200287953928, 5030.170021946393, 5153.587712982971, 5020.272060551218, 5081.695098294095, 5144.948550514484, 5163.096458119833, 5185.092608793465, 4933.703977761345, 5000.849974500771, 5086.821961231339, 5087.592992560586, 5093.974530127344, 5000.799968001275, 5039.924401133986, 5075.416327122354, 5085.847424577231, 5134.948650513485, 5011.173156429185, 5021.874453138665, 5037.395512538519, 5050.772715227824, 5056.646034777567, 5316.4683531646915, 5394.973025134849, 5477.643953143033, 5510.531604813596, 5534.059209934321, 5953.91069133959, 6019.367966363557, 6081.574289799716, 6087.756489740405, 6115.788007244199, 6146.416090471398, 6146.5390095743, 6152.507799376084, 6155.4767844732805, 6168.629882207037, 5683.175939488792, 5688.0, 5690.573207009491, 5690.829275121753, 5696.572757043197, 6060.272767267956, 6122.112293717386, 6124.136831511461, 6140.412224875342, 6155.415235552616, 5942.70286485674, 5954.732037058343, 5991.880162396727, 6000.0999850022845, 6062.393760623991, 6092.878142437126, 6115.296740874767, 6145.477634401126, 6148.385161483905, 6175.814725558241, 5834.154047663065, 5886.264216972879, 5903.468687818117, 5994.940050599525, 6001.0, 5988.700564971734, 6021.066734656048, 6036.698165091728, 6039.758409663565, 6081.847953801191, 4837.854864354075, 4854.126257273654, 4869.805207791719, 4883.047805677858, 4891.804327826918, 4278.935815962763, 4349.847755328548, 4351.390805287262, 4352.086061927031, 4377.212101821703, 5407.242985981966, 5469.535089517356, 5500.779968801203, 5510.118381059011, 5576.888462230732, 6147.784827531015, 6150.538709596798, 6157.630542167484, 6160.383961603804, 6164.106204600308, 5573.247611572386, 5580.665160090326, 5584.162375643686, 5587.497125258747, 5616.382197958222, 5159.613029022838, 5181.53366197044, 5189.662671926313, 5232.2674825524455, 5277.788888444419, 6145.66198859067, 6174.66039367839, 6208.317085120723, 6214.9689251553455, 6222.408871157233, 6099.66451845135, 6133.601315914451, 6152.938470615237, 6156.722947467464, 6158.661273629814, 6037.275526936795, 6084.482818960438, 6210.5652604317265, 6225.3774622539195, 6248.375162483897, 5923.881522369442, 5962.314333851663, 5974.641521508724, 6054.212952316171, 6079.240094988127, 6030.03519436888, 6085.2393450818645, 6121.387861213843, 6130.6628135452975, 6164.321924588202, 5499.807506737245, 5563.638363506359, 5932.080527518242, 5943.019401798655, 5961.552883533665, 4843.903121937612, 5756.222909907109, 5771.249737534094, 5832.212651292191, 5857.209276747584, 5442.374126975448, 5611.775528978795, 5684.062129748545, 5696.886062278814, 5739.339975902824, 4794.424669039738, 5742.425757424391, 5754.683492407958, 5908.497777688945, 5927.525797936241, 4848.733319667311, 5690.715464226855, 5772.7690892363835, 5796.101604251347, 5803.970980145073], "value": 5493.792821953631, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.51323544101484, 473.77258915720455, 488.8999750561238, 491.80082066762975, 492.75087652800136, 29239.56140657892, 42562.0, 42704.50534231302, 42791.57208427915, 42870.571294287125, 43454.78272608633, 43818.12363752723, 43858.56141438585, 43866.342004869875, 43942.12115757683, 9356.204722598588, 9587.856182157273, 9603.32776705631, 9612.56743446543, 11114.666560003172, 11149.386783726892, 11262.4368781561, 11460.255083419594, 11472.426378681073, 11484.196106272564, 11464.598739044135, 11480.483378247998, 11494.195406321562, 11511.539538418454, 11539.826902596467, 11366.204365694404, 11367.147463940237, 11399.316041037564, 11435.771284574344, 11451.370174640433, 9325.953370233174, 11180.04969577587, 11282.379469129195, 11317.717057073556, 11328.546858125665, 36443.4533481998, 36760.0, 37136.44295335572, 37151.81424092889, 37192.81403592992, 3925.509311336083, 3977.2642061218476, 3983.0440694233466, 3993.101552150743, 4004.3192657248046, 28458.288542786388, 28820.423591528262, 28892.277693057633, 29127.708722912925, 29131.70868291311, 3142.858571364271, 3169.429502689515, 3180.7614428917923, 3188.6333071696818, 3217.7104060634656, 440889.0, 443569.0, 446714.76642616576, 447600.0, 448920.0, 47661.5233847664, 57083.0, 57173.71413142908, 57209.0, 57305.14042289369, 59583.510412240044, 59590.70204648949, 59686.80626387448, 59955.0, 59996.0, 15260.923695381452, 15613.84386156124, 15748.291326890318, 15750.68498630021, 15760.76358854618, 10252.923443038522, 10872.836907446395, 11107.611233606785, 12032.03743700502, 12189.0, 15664.060156390653, 16477.423290184786, 17058.31766729317, 17972.55068623295, 18136.45840103606, 6649.468042556584, 6798.456123510107, 6859.348361905611, 6917.9308206917285, 7618.961905190549, 701.3897908819258, 833.204289903141, 834.745402652197, 857.5412154497315, 858.3648100405654, 25254.116105936206, 28500.0, 30205.395892082037, 30322.241943951136, 30355.69644303573, 1034.6016783538391, 1039.7504598896362, 1060.4008735064817, 1064.7976884392097, 1129.8757136714955, 15449.5365139046, 15942.20288985546, 15949.601259968362, 16052.598685032734, 16169.0, 221724.0, 223182.0, 223483.0, 224047.0, 225122.0, 52257.0, 61989.0, 62478.0, 62514.062289064794, 62973.0, 1376.717772856562, 1406.2687402550616, 1418.5035237666941, 1419.524459306144, 1424.0814674534868, 24581.262562123164, 29475.263118422212, 30106.688264291348, 30217.69782302237, 30569.694303057575, 52885.0, 52904.47095528995, 53445.7327713359, 53559.0, 53751.73124134354, 462383.0, 546452.0, 549780.0, 551188.2440587771, 552707.0, 20545.0, 23644.763552364257, 26204.606930895672, 26693.332666683487, 27158.32104197332, 44133.77933110314, 46417.53582464132, 46520.53479465162, 47335.28997065116, 47462.525374747194, 31929.840350799026, 37242.8137859309, 39288.0, 39588.76799016049, 40760.388594170516, 39335.01662458347, 39415.40876886906, 40538.39192412057, 40729.59270407258, 40805.59194408018, 37348.0, 37997.620023799405, 38083.5245709028, 38660.80669596634, 38914.610853892234, 33511.66488335085, 33985.66014339825, 34747.65252347444, 35170.47244291286, 35321.470177947864, 24994.75005249997, 25422.491550169263, 25451.0, 25597.3600659985, 25829.741702583484], "value": 19344.073129505134, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.53400618248855, 385.34876059459526, 389.99220015599684, 399.17968574579237, 422.4887885658353, 19642.70535941962, 20365.28721494748, 20568.8971555142, 21221.363359099232, 21225.68161477579, 20722.171113155495, 21000.789992100075, 21624.0, 21873.12507499698, 21925.451863703416, 4978.87552811179, 5269.710165940872, 5306.204069389584, 5307.203919412081, 5364.517193452589, 5068.873278168038, 5283.973580132094, 5330.227117068022, 5359.0, 5378.731063446831, 5259.184826351902, 5322.65402748822, 5330.253764472977, 5333.013392522395, 5336.279602253704, 5171.870703232412, 5201.349831271091, 5216.217567364888, 5312.831177141042, 5317.521423071923, 5214.947850521484, 5238.711870847102, 5248.081585722522, 5251.789928402859, 5253.133233016548, 11162.497687603996, 13308.401121949439, 13562.254076025913, 13635.977301702413, 13714.24571648559, 2557.5524283250356, 2639.736026397345, 2643.41844794145, 2646.7088620251757, 2655.097266929234, 8788.51663158526, 11632.651020469399, 12556.623301300975, 15007.624809379744, 16407.42574009904, 1749.737539369092, 1774.1216115763964, 1843.815618438159, 1884.6230753849286, 1888.773347198345, 117291.0, 117293.0, 121280.39359803233, 137415.31292343573, 141465.0, 11682.70793230176, 12143.574974875837, 12147.271163730204, 12169.695757605954, 12213.511459541518, 15798.447054353272, 15959.845420868267, 15965.920170399073, 15988.0, 16007.839921600635, 8509.957450212833, 8691.826163476822, 8760.080191579793, 8790.406829985042, 8860.468371897707, 8257.463264887763, 8363.790905227297, 8509.404341696145, 8529.829403411897, 8564.74305770828, 4768.189407800683, 4860.756962151878, 4883.682560633619, 4897.363342765489, 4924.852254432372, 2043.7036629688612, 2079.6048750737314, 2087.6242276390394, 2088.3526106906907, 2097.643400621898, 1002.1882275356984, 1006.8087063458066, 1008.9798204035878, 1010.8635334229932, 1022.9079382855579, 18195.727064094048, 20999.160033598484, 21932.45168870759, 22029.779702202773, 22071.448213794785, 941.6704153546204, 1029.433811403725, 1040.3653771199563, 1069.1179776684112, 1076.316538997742, 10319.277650564538, 11255.943720281346, 11432.828507572392, 11452.656420307405, 11498.885011149781, 508920.0, 687281.0, 694785.0, 695466.0, 698874.0, 126054.0, 142525.0, 143478.0, 149183.0, 160115.0, 1030.8144533983805, 1042.7810159866513, 1089.6513115803025, 1092.0662833277593, 1093.7265683579105, 16280.592985175464, 19647.508812279808, 20085.397438076296, 20294.086766095264, 20559.588808223452, 54438.727806360715, 54781.0, 57790.42209577851, 57996.710016449644, 59661.10508342292, 70345.9448108289, 84207.0, 85239.72140417775, 85869.14130858611, 86363.1363686355, 8452.577371131541, 8526.488410695378, 8607.440516366416, 8675.86986195195, 8714.956425217833, 7682.769516914502, 10717.464126793786, 13270.336483175995, 13554.59336219915, 13795.724085518434, 11389.54441822351, 11519.596814111466, 11959.581414650445, 11984.04127669767, 12114.001189803585, 9506.809863802548, 10055.949720251352, 11028.503717332578, 11288.548458061585, 11335.376554289593, 11289.096872250037, 11522.251053681484, 11688.240264382788, 12051.397430128283, 12181.025517958366, 7163.498555101093, 8483.363747718822, 8754.08082151365, 8861.778455538662, 8888.64445422176, 9397.389169703947, 10562.630307939493, 10790.62232821879, 11176.441177941233, 11275.718107047389], "value": 9687.476036970042, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.9648508787286, 1416.8016477693118, 1425.1947649577987, 1437.5687293811857, 1438.2161721861587, 7442.292982166686, 7692.192319806423, 7952.880706789396, 8376.497410155394, 8395.664173433062, 7777.18339574345, 8023.956885604878, 8051.879221811663, 8098.838023239532, 8112.148224436423, 2200.746914104878, 2244.8540844845115, 2245.932622021342, 2259.8644081355174, 2280.350100221437, 2034.1761586557468, 2121.628714974881, 2283.5547068321684, 2318.0, 2321.1411777642297, 2208.4258092895884, 2284.7258329000542, 2284.8286378521593, 2296.3455415206668, 2298.839081264312, 2270.761570035139, 2276.009935677977, 2286.9937227619794, 2291.9770802291932, 2293.908243670251, 2249.089118906845, 2256.0, 2299.091858715798, 2308.1459859851793, 2309.953800923989, 8343.290820280283, 8375.664973401057, 8438.198371154731, 8458.74623761288, 8471.15288471154, 5063.822766203165, 5170.25031370453, 5217.34783152106, 5220.634555581111, 5222.63441559091, 3421.1789170599127, 3467.133216695826, 3489.040513858684, 3497.5278337424375, 3528.6824185823143, 1217.190568272098, 1217.4034722985762, 1252.3487786351047, 1275.2412314672754, 1278.181963543333, 9481.952590237073, 9889.950550247202, 10655.094316983066, 10664.680059598224, 10687.14502839771, 4317.8272869084885, 4584.404027476474, 4654.697444666086, 4665.533446655375, 4678.836240731558, 7824.178461261599, 9261.398009129385, 9408.858867116998, 9416.764580885532, 9428.245740340757, 5139.820106296262, 5214.139666954986, 5228.05894938907, 5231.947680523146, 5236.6857988520815, 4073.592640735962, 4645.9303110453375, 4677.368555245066, 4711.269753188261, 4774.570288674036, 3248.3016151527536, 3790.0, 3820.102275965146, 3852.4413959975645, 3901.4147877818555, 1066.6266806617778, 1171.6485054483792, 1217.0385395537426, 1269.5620011096157, 1279.6992706713916, 760.1828034862544, 762.1692355332714, 787.5078076202374, 809.5024205220413, 825.5789547330904, 5049.444561098277, 5555.555555555627, 5557.888842223133, 5695.686737229492, 5729.5702822288495, 868.2836659755727, 998.9800203995879, 999.3104757717152, 1012.579779391559, 1023.4217667018111, 3460.8406183928164, 3603.442539096052, 3621.873234436835, 3725.869594564177, 3885.242377736314, 9356.485393303434, 9617.951910240545, 9679.612815487442, 9712.125908668253, 9755.756106097262, 9648.951755241178, 9661.516924153764, 9675.806483870283, 9684.661036863818, 9687.370320929118, 7749.496282741604, 7819.530828150329, 7893.802654933673, 7900.3284720799375, 7961.641726122339, 4611.746353950565, 5452.945470545403, 5495.422980586981, 5604.8038318658655, 5611.6352437091455, 8605.6988005422, 8661.090585488433, 8821.470711757314, 9052.456852588866, 9179.908200917906, 9157.954210228907, 9264.675736349196, 9317.627294908129, 9441.33910626277, 9531.523423828643, 7631.275028872248, 7836.529808211526, 7839.33365663925, 7843.803904902423, 7850.960745196237, 7754.7673569793, 7772.727954521564, 7802.375809935305, 7802.921970780447, 7884.408669349937, 6479.838004049748, 7045.718171273092, 7091.539049961736, 7094.538854974617, 7136.464765142531, 6936.79189624312, 6973.372396484341, 6977.1278590176225, 7084.397826184832, 7109.0, 6371.96814015927, 6380.234371875405, 6443.291237963914, 6463.385978332051, 6467.902981455188, 4859.878503037452, 4953.975230123826, 5003.473940448198, 5042.9243561345875, 5158.484151584811, 4930.381419092409, 5023.648344615842, 5047.671901326402, 5173.793048278178, 5184.274201611702], "value": 4370.237127732614, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.7216302756921, 357.8658003248782, 365.92132691471335, 371.8215256676797, 375.79519162056675, 4689.48415674276, 5042.82350117746, 5207.0, 5353.357597088345, 5354.678719276846, 4754.714717116975, 5277.947220527793, 5284.81503147389, 5309.920351194735, 5310.522053015228, 3607.603163651996, 3887.5270652179233, 3904.1996390739973, 3929.98035009826, 4049.286977724931, 3651.214988777412, 3982.426941358162, 4122.876313710593, 4124.773137477452, 4133.5659755725665, 3407.30150319184, 3425.9722083374886, 3607.7654952428006, 3645.325614761278, 4167.687423443239, 3461.549998500204, 3497.91255218619, 4166.812493437803, 4166.9791651041705, 4182.874513764592, 3484.6863782259466, 3509.6841284284537, 3597.9745772454985, 3642.5993140754763, 3679.7608155469807, 3937.2912875682364, 4330.653547716175, 4505.842295519641, 5128.948710512922, 5161.741912904377, 4288.44250247469, 4764.595009424169, 4784.66507344486, 4810.0, 4828.430760003013, 4401.40317212846, 4797.688150270221, 4804.711717296974, 4963.170992534257, 5635.5773317001385, 3799.556168655921, 3865.4781604483314, 4071.97964010181, 4080.449429216879, 4127.360259159835, 5193.350831146106, 5804.113663059523, 5882.794102206402, 5887.352391237004, 5925.4963328117165, 3313.337332533503, 3748.325301445766, 3961.3067713150085, 4061.147159096564, 4099.467069281034, 4139.606737359946, 4157.501099868035, 4168.416421700964, 4169.728967617095, 4179.0, 4597.586217240398, 4759.786254505079, 4768.1126844984165, 4798.568128868418, 4813.663043586986, 5628.60599758013, 5632.352279487829, 5634.830955071355, 5676.814426445848, 5706.885862282731, 1229.4467489629703, 1257.9874201257871, 1265.4052595280205, 1355.5323413422354, 1383.8270216222973, 885.5395194498825, 890.3144578674385, 910.899801021887, 984.4544065816599, 985.4973963278779, 4361.781910904506, 4591.380163677861, 4883.388481800997, 4918.680285781413, 4940.0, 4862.78117484714, 4954.677945933575, 4970.776315065831, 5523.364813046471, 5555.972220138873, 4161.563035881189, 4530.29780384041, 4538.092278783848, 4593.770311484413, 4865.537773911473, 2524.6465494830736, 2540.326813394452, 2622.593498007812, 2767.501849667039, 2841.218664867137, 4958.851234462972, 4961.82633607822, 5067.417247016567, 5497.642653227527, 5541.810984661117, 4595.954040459619, 4776.617870570346, 5300.3639563252655, 5355.580771095662, 5697.4587414195585, 5238.73806309683, 5467.5625949923915, 5701.1756238003445, 5703.714814259353, 5704.515116215085, 4579.5878370946775, 4618.330342100309, 5430.9185362218805, 5454.3454785426, 5485.68116289655, 4248.808803603783, 4992.134242265396, 5280.867978300574, 5370.677759334452, 5415.079436495884, 5314.156926044548, 5318.377894742141, 5527.972360138174, 5606.943930560642, 5760.404337034156, 3641.5630124385243, 3846.74996125251, 4076.9399956011057, 4119.178362821477, 4121.609466509358, 5048.495150485069, 5563.8579147029495, 5742.712864356682, 5758.798442054508, 5761.711914404179, 4291.098869237495, 4870.512948705101, 5555.416681248573, 5564.1900840075505, 5641.464060914206, 4552.430946131733, 5506.862328441821, 5542.63972841764, 5560.416156303691, 5561.803087780385, 5404.486573775485, 5414.6699779634455, 5415.0, 5419.945800541944, 5439.265699130567, 4922.901541969212, 4928.778204980713, 5163.535281824654, 5477.45225477465, 5636.323641163087, 5461.453854614666, 5491.588130890119, 5503.110866794965, 5504.623844038991, 5521.309836270466], "value": 4019.9844834843775, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.2965413909354, 705.5625512182442, 767.6507189228902, 820.917908209179, 830.3938125168625, 14740.0, 15007.849921500781, 15194.0, 15704.371825126995, 15751.84248157518, 14130.576082717535, 14314.42742290307, 14446.783298250535, 14501.709965800677, 14535.854641453583, 836.8326334733048, 861.732862812527, 862.3058437957442, 862.5687156421789, 863.1109956744532, 810.2262339465796, 843.2410830252791, 852.1606217875387, 852.1819053708448, 854.8504011797942, 890.1499068389672, 893.4505279253245, 893.865920111982, 895.3642913531368, 897.7845317123908, 880.493716113231, 881.0968757024069, 884.91150884911, 885.4333226734894, 886.1448702002566, 635.1711017122653, 643.5109316919128, 657.5955787190891, 666.796627028756, 667.7863083813181, 15232.923835380752, 15457.613559660986, 15460.5361839145, 15515.99146055514, 15714.21428928549, 13791.51729689466, 13948.86051139496, 14058.0, 14117.08238964464, 14379.78430323546, 11565.421728913605, 11658.94170529142, 11739.530418783239, 12076.939615301868, 12299.938500307531, 3428.794272343642, 3639.581448133472, 3680.4651093690195, 3714.53568303962, 3835.117922877726, 96737.0, 99620.00379996179, 99658.50170749173, 102011.0, 102425.0, 10895.0, 10911.290766100177, 10945.945270273598, 11011.119110471143, 11221.60724374643, 21998.230061948074, 22088.447788805086, 22198.778012219995, 22207.66688499674, 22220.666689999664, 7606.847863042708, 7650.081990161217, 7677.500962437535, 7736.303732664087, 7753.651085701157, 4189.2668782962855, 4210.5157906841105, 4298.570142985739, 4403.581659742319, 4427.579379958899, 3398.150462384404, 3464.7401444891734, 3483.5819701635965, 3488.598811136752, 3495.3883070462566, 639.7856717999522, 643.2923783837741, 646.8382904273932, 653.5588477777482, 654.0810161722692, 619.7366119399328, 628.7302836759295, 636.7900988122511, 642.4988508963016, 670.0786418674322, 8329.791755206168, 9236.676716314896, 9795.265355098396, 10038.849417258747, 10060.446675432922, 623.554158776477, 661.9503537234726, 668.7425341243656, 669.334012657409, 677.864427114579, 3824.904377390532, 4712.540959189793, 4761.880952976203, 4788.281757736368, 4807.423109226916, 102554.0, 107455.46272268589, 107611.46194268978, 107673.4616326929, 108677.45661271643, 73256.0, 96316.03683963211, 96356.51821740846, 98844.01155988492, 99159.0, 61997.690011550556, 62020.93727815355, 68571.65714171398, 78339.60830195813, 79364.60317698374, 10935.0, 11062.502187401426, 11077.058450031514, 11153.275037122561, 11278.49246783913, 45232.0, 46914.76542617265, 47498.0, 49432.25851612157, 50468.990620188124, 67732.661336693, 68779.62440751257, 70119.29880701128, 70526.0, 71656.64171679108, 10447.634332798316, 12572.874271257171, 12592.181508201938, 12701.0, 12797.744045119232, 13805.24071176095, 13808.930955345159, 13968.161910285415, 14386.640333991734, 14590.781138282722, 13264.86735132675, 13298.933505332412, 13470.730585388434, 13912.373943172379, 13932.93033534826, 12687.492500300254, 13170.60488185356, 13172.538961136313, 13197.36052789465, 13203.207807531195, 13281.070325077151, 13399.196048237138, 13423.463061477432, 13451.798223026466, 13456.394462249418, 9573.473458959825, 11344.432778360884, 11393.658190254306, 11723.472443740222, 11853.288802671867, 9119.407238529475, 10163.7459063524, 10899.0, 10970.616028438966, 10989.0], "value": 7442.208266539602, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1629.4999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 118.0, 120.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 117.0, 153.0, 117.0, 116.0, 113.0, 115.0, 132.0, 117.0], "value": 124.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 215.0, 206.0, 212.0, 198.0, 198.0, 199.0, 249.0, 215.0, 193.0], "value": 208.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 84.0, 107.0, 84.0, 57.0, 59.0, 59.0, 86.0, 85.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 57.0, 69.0, 85.0, 99.0, 101.0, 113.0, 101.0, 75.0, 82.0], "value": 87.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 93.0, 131.0, 112.0, 86.0, 112.0, 132.0, 102.0, 87.0], "value": 112.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 101.0, 100.0, 100.0, 100.0, 98.0, 100.0, 100.0, 101.0], "value": 113.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 80.0, 146.0, 142.0, 128.0, 95.0, 113.0, 114.0, 94.0, 93.0], "value": 111.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 60.0, 62.0, 66.0, 52.0, 81.0, 95.0, 95.0, 93.0], "value": 72.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 72.0, 79.0, 75.0, 71.0, 71.0, 75.0, 100.0, 68.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 107.0, 112.0, 112.0, 96.0, 88.0, 89.0, 91.0, 89.0, 75.0], "value": 93.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 137.0, 148.0, 149.0, 155.0, 173.0, 152.0, 159.0, 210.0, 175.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 179.0, 185.0, 246.0, 173.0, 173.0, 178.0, 223.0, 235.0, 217.0], "value": 199.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 79.0, 86.0, 88.0, 75.0, 68.0, 80.0, 62.0, 67.0], "value": 74.1, "unit": "score"}]}]} 17:51:40 INFO - Return code: 0 17:51:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:51:40 ERROR - # TBPL SUCCESS # 17:51:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:51:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:51:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:51:40 INFO - 2017-01-26 17:51:40.540 screenresolution[1655:10445] starting screenresolution argv=screenresolution get 17:51:40 INFO - 2017-01-26 17:51:40.543 screenresolution[1655:10445] Display 0: 1600x1200x32@60 17:51:40 INFO - 2017-01-26 17:51:40.549 screenresolution[1656:10448] starting screenresolution argv=screenresolution list 17:51:40 INFO - Available Modes on Display 0 17:51:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:51:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:51:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:51:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:51:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:51:40 INFO - Intel Iris: 17:51:40 INFO - Chipset Model: Intel Iris 17:51:40 INFO - Type: GPU 17:51:40 INFO - Bus: Built-In 17:51:40 INFO - VRAM (Dynamic, Max): 1536 MB 17:51:40 INFO - Vendor: Intel (0x8086) 17:51:40 INFO - Device ID: 0x0a2e 17:51:40 INFO - Revision ID: 0x0009 17:51:40 INFO - Displays: 17:51:40 INFO - Display: 17:51:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:51:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:51:40 INFO - Display Serial Number: 1600x1200 60 17:51:40 INFO - Main Display: Yes 17:51:40 INFO - Mirror: Off 17:51:40 INFO - Online: Yes 17:51:40 INFO - Rotation: Supported 17:51:40 INFO - Return code: 0 17:51:40 INFO - Running post-action listener: _resource_record_post_action 17:51:40 INFO - [mozharness: 2017-01-27 01:51:40.784235Z] Finished run-tests step (success) 17:51:40 INFO - Running post-run listener: _resource_record_post_run 17:51:40 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 37997056; Write bytes: 557250560; Read time: 386; Write time: 1824 17:51:40 INFO - TinderboxPrint: CPU usage
54.7% 17:51:40 INFO - TinderboxPrint: I/O read bytes / time
37,997,056 / 386 17:51:40 INFO - TinderboxPrint: I/O write bytes / time
557,250,560 / 1,824 17:51:40 INFO - TinderboxPrint: CPU idle
2,178.0 (45.3%) 17:51:40 INFO - TinderboxPrint: CPU system
972.9 (20.2%) 17:51:40 INFO - TinderboxPrint: CPU user
1,654.8 (34.4%) 17:51:40 INFO - TinderboxPrint: Swap in / out
290,193,408 / 0 17:51:40 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 248642048; Write bytes: 243357696; Read time: 17962; Write time: 593 17:51:40 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 35871232; Write bytes: 300474368; Read time: 362; Write time: 1194 17:51:41 INFO - Running post-run listener: _upload_blobber_files 17:51:41 INFO - Blob upload gear active. 17:51:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:51:41 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 17:51:41 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:51:41 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:51:41 INFO - (blobuploader) - INFO - Open directory for files ... 17:51:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:51:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:42 INFO - (blobuploader) - INFO - Done attempting. 17:51:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:51:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:51:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:43 INFO - (blobuploader) - INFO - Done attempting. 17:51:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:51:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:44 INFO - (blobuploader) - INFO - Done attempting. 17:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:51:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:47 INFO - (blobuploader) - INFO - Done attempting. 17:51:47 INFO - (blobuploader) - INFO - Iteration through files over. 17:51:47 INFO - Return code: 0 17:51:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:51:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:51:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adc0847fc61cd2785c7b02673c09a3e7b71391078fe7b2854b95479c95c1094ef87f432e0e93c7dc20623c7f579cbeb2bb953407b94f38b179607e5be5d49181", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb93b5d5c489783f738ee35db78b46828b212ddcf552f371fe8b588b726080a4a1f142ab054be0619b7cb2e77fb7de15275b9014bbae70a226018549f5f6281c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da781a3422e56485d62d8c4ed7fc8e15b7701d3a951b6ecf92a18f2ddbbb014a7c92b8e94f8b59c4c4b4bfd7c98ace6702ce04b478210af2bc042841cdd1b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19ad199337cb96d70007dc8121a088c4224b14f07d6f6bad668643c5d248fca3da480815cea09fd7fc2c193d33529a8f1dc8cda2b537f256cae1f2f758ac9c3"} 17:51:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:51:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:51:47 INFO - Contents: 17:51:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adc0847fc61cd2785c7b02673c09a3e7b71391078fe7b2854b95479c95c1094ef87f432e0e93c7dc20623c7f579cbeb2bb953407b94f38b179607e5be5d49181", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb93b5d5c489783f738ee35db78b46828b212ddcf552f371fe8b588b726080a4a1f142ab054be0619b7cb2e77fb7de15275b9014bbae70a226018549f5f6281c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da781a3422e56485d62d8c4ed7fc8e15b7701d3a951b6ecf92a18f2ddbbb014a7c92b8e94f8b59c4c4b4bfd7c98ace6702ce04b478210af2bc042841cdd1b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19ad199337cb96d70007dc8121a088c4224b14f07d6f6bad668643c5d248fca3da480815cea09fd7fc2c193d33529a8f1dc8cda2b537f256cae1f2f758ac9c3"} 17:51:47 INFO - Running post-run listener: copy_logs_to_upload_dir 17:51:47 INFO - Copying logs to upload dir... 17:51:47 INFO - mkdir: /builds/slave/test/build/upload/logs 17:51:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.086463 ========= master_lag: -0.49 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-26 17:51:46.984229) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 17:51:46.991745) ========= 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.qJRDQCidfd/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.Cxo71kaH4g/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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/Firefox/sha512/adc0847fc61cd2785c7b02673c09a3e7b71391078fe7b2854b95479c95c1094ef87f432e0e93c7dc20623c7f579cbeb2bb953407b94f38b179607e5be5d49181", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb93b5d5c489783f738ee35db78b46828b212ddcf552f371fe8b588b726080a4a1f142ab054be0619b7cb2e77fb7de15275b9014bbae70a226018549f5f6281c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da781a3422e56485d62d8c4ed7fc8e15b7701d3a951b6ecf92a18f2ddbbb014a7c92b8e94f8b59c4c4b4bfd7c98ace6702ce04b478210af2bc042841cdd1b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19ad199337cb96d70007dc8121a088c4224b14f07d6f6bad668643c5d248fca3da480815cea09fd7fc2c193d33529a8f1dc8cda2b537f256cae1f2f758ac9c3"} build_url:https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011056 build_url: 'https://queue.taskcluster.net/v1/task/RLjymeWNTbSncw_ElX0iMw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adc0847fc61cd2785c7b02673c09a3e7b71391078fe7b2854b95479c95c1094ef87f432e0e93c7dc20623c7f579cbeb2bb953407b94f38b179607e5be5d49181", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb93b5d5c489783f738ee35db78b46828b212ddcf552f371fe8b588b726080a4a1f142ab054be0619b7cb2e77fb7de15275b9014bbae70a226018549f5f6281c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da781a3422e56485d62d8c4ed7fc8e15b7701d3a951b6ecf92a18f2ddbbb014a7c92b8e94f8b59c4c4b4bfd7c98ace6702ce04b478210af2bc042841cdd1b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19ad199337cb96d70007dc8121a088c4224b14f07d6f6bad668643c5d248fca3da480815cea09fd7fc2c193d33529a8f1dc8cda2b537f256cae1f2f758ac9c3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 17:51:47.028644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:51:47.028947) ========= 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.qJRDQCidfd/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.Cxo71kaH4g/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.004478 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:51:47.076949) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 17:51:47.077252) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 17:51:47.080581) ========= ========= Total master_lag: 0.18 =========