builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0371 starttime: 1477359607.05 results: success (0) buildid: 20161024163422 builduid: ffd332a51cc145c4b3042b07ea82fa72 revision: fcd7ad8a2488527ce094cbdb3582c29437c155a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:07.050865) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:07.051313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:07.051588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:07.076011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:07.076402) ========= 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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-24 18:40:07-- 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% 19.4M=0.001s 2016-10-24 18:40:07 (19.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097995 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:07.279267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:07.279671) ========= 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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.027752 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:07.327620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 18:40:07.327975) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fcd7ad8a2488527ce094cbdb3582c29437c155a8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fcd7ad8a2488527ce094cbdb3582c29437c155a8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-24 18:40:07,410 truncating revision to first 12 chars 2016-10-24 18:40:07,410 Setting DEBUG logging. 2016-10-24 18:40:07,410 attempt 1/10 2016-10-24 18:40:07,410 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fcd7ad8a2488?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 18:40:08,159 unpacking tar archive at: mozilla-aurora-fcd7ad8a2488/testing/mozharness/ program finished with exit code 0 elapsedTime=1.016595 ========= master_lag: 0.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 18:40:08.657829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:08.658246) ========= script_repo_revision: fcd7ad8a2488527ce094cbdb3582c29437c155a8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:08.658648) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:08.658916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 18:40:08.678302) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-24 18:40:08.678697) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:40:08 INFO - MultiFileLogger online at 20161024 18:40:08 in /builds/slave/test 18:40:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:40:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:40:08 INFO - {'append_to_log': False, 18:40:08 INFO - 'base_work_dir': '/builds/slave/test', 18:40:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:40:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:40:08 INFO - 'branch': 'Mozilla-Aurora', 18:40:08 INFO - 'buildbot_json_path': 'buildprops.json', 18:40:08 INFO - 'config_files': ('talos/mac_config.py',), 18:40:08 INFO - 'default_actions': ('clobber', 18:40:08 INFO - 'read-buildbot-config', 18:40:08 INFO - 'download-and-extract', 18:40:08 INFO - 'populate-webroot', 18:40:08 INFO - 'create-virtualenv', 18:40:08 INFO - 'install', 18:40:08 INFO - 'run-tests'), 18:40:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:40:08 INFO - 'download_minidump_stackwalk': True, 18:40:08 INFO - 'download_symbols': 'ondemand', 18:40:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:40:08 INFO - 'tooltool.py': '/tools/tooltool.py', 18:40:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:40:08 INFO - '/tools/misc-python/virtualenv.py')}, 18:40:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:40:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:40:08 INFO - 'installer_path': 'installer.exe', 18:40:08 INFO - 'log_level': 'info', 18:40:08 INFO - 'log_name': 'talos', 18:40:08 INFO - 'log_to_console': True, 18:40:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:40:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:40:08 INFO - 'opt_config_files': (), 18:40:08 INFO - 'pip_index': False, 18:40:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:40:08 INFO - 'cmd': ('bash', 18:40:08 INFO - '-c', 18:40:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:40:08 INFO - 'enabled': True, 18:40:08 INFO - 'halt_on_failure': False, 18:40:08 INFO - 'name': 'check_screen_resolution'},), 18:40:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:40:08 INFO - 'cmd': ('bash', 18:40:08 INFO - '-c', 18:40:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:40:08 INFO - 'enabled': True, 18:40:08 INFO - 'halt_on_failure': False, 18:40:08 INFO - 'name': 'check_screen_resolution'},), 18:40:08 INFO - 'run_cmd_checks_enabled': True, 18:40:08 INFO - 'sps_profile': False, 18:40:08 INFO - 'sps_profile_interval': 0, 18:40:08 INFO - 'suite': 'dromaeojs-e10s', 18:40:08 INFO - 'system_bits': '32', 18:40:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:40:08 INFO - 'title': 't-yosemite-r7-0371', 18:40:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:40:08 INFO - 'use_talos_json': True, 18:40:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:40:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:40:08 INFO - 'work_dir': 'build'} 18:40:08 INFO - [mozharness: 2016-10-25 01:40:08.877898Z] Running clobber step. 18:40:08 INFO - Running pre-action listener: _resource_record_pre_action 18:40:08 INFO - Running main action method: clobber 18:40:08 INFO - rmtree: /builds/slave/test/build 18:40:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:40:10 INFO - Running post-action listener: _resource_record_post_action 18:40:10 INFO - [mozharness: 2016-10-25 01:40:10.940449Z] Finished clobber step (success) 18:40:10 INFO - [mozharness: 2016-10-25 01:40:10.940577Z] Running read-buildbot-config step. 18:40:10 INFO - Running pre-action listener: _resource_record_pre_action 18:40:10 INFO - Running main action method: read_buildbot_config 18:40:10 INFO - Using buildbot properties: 18:40:10 INFO - { 18:40:10 INFO - "project": "", 18:40:10 INFO - "product": "firefox", 18:40:10 INFO - "script_repo_revision": "production", 18:40:10 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 18:40:10 INFO - "repository": "", 18:40:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 18:40:10 INFO - "buildid": "20161024163422", 18:40:10 INFO - "pgo_build": "False", 18:40:10 INFO - "basedir": "/builds/slave/test", 18:40:10 INFO - "buildnumber": 19, 18:40:10 INFO - "slavename": "t-yosemite-r7-0371", 18:40:10 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:40:10 INFO - "platform": "yosemite_r7", 18:40:10 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:40:10 INFO - "branch": "mozilla-aurora", 18:40:10 INFO - "repo_path": "releases/mozilla-aurora", 18:40:10 INFO - "revision": "fcd7ad8a2488527ce094cbdb3582c29437c155a8", 18:40:10 INFO - "stage_platform": "macosx64", 18:40:10 INFO - "builduid": "ffd332a51cc145c4b3042b07ea82fa72", 18:40:10 INFO - "slavebuilddir": "test" 18:40:10 INFO - } 18:40:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 18:40:10 INFO - Running post-action listener: _resource_record_post_action 18:40:10 INFO - [mozharness: 2016-10-25 01:40:10.943933Z] Finished read-buildbot-config step (success) 18:40:10 INFO - [mozharness: 2016-10-25 01:40:10.944143Z] Running download-and-extract step. 18:40:10 INFO - Running pre-action listener: _resource_record_pre_action 18:40:10 INFO - Running main action method: download_and_extract 18:40:10 INFO - mkdir: /builds/slave/test/build/tests 18:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:10 INFO - trying https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 18:40:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 18:40:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 18:40:12 INFO - Downloaded 1199 bytes. 18:40:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 18:40:12 INFO - Using the following test package requirements: 18:40:12 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:40:12 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:40:12 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 18:40:12 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:40:12 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 18:40:12 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:40:12 INFO - u'jsshell-mac.zip'], 18:40:12 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:40:12 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 18:40:12 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:40:12 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:40:12 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 18:40:12 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:40:12 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 18:40:12 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:40:12 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 18:40:12 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:40:12 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 18:40:12 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:40:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:40:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:40:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:40:12 INFO - Expected file size: 16438564 18:40:19 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:40:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:40:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:40:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:40:20 INFO - Expected file size: 16438564 18:40:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 18:40:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:40:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 18:40:27 INFO - Expected file size: 14414081 18:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:28 INFO - trying https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:40:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 18:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 18:40:31 INFO - Downloaded 115434671 bytes. 18:40:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:40:31 INFO - mkdir: /builds/slave/test/properties 18:40:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:40:31 INFO - Writing to file /builds/slave/test/properties/build_url 18:40:31 INFO - Contents: 18:40:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:40:31 INFO - Running post-action listener: _resource_record_post_action 18:40:31 INFO - Running post-action listener: set_extra_try_arguments 18:40:31 INFO - [mozharness: 2016-10-25 01:40:31.914320Z] Finished download-and-extract step (success) 18:40:31 INFO - [mozharness: 2016-10-25 01:40:31.914462Z] Running populate-webroot step. 18:40:31 INFO - Running pre-action listener: _resource_record_pre_action 18:40:31 INFO - Running main action method: populate_webroot 18:40:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:40:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:40:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:40:31 INFO - '--tppagecycles', 18:40:31 INFO - '7'], 18:40:31 INFO - 'tests': ['tsvgm']}}, 18:40:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:40:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:40:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:40:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:40:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:40:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:40:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:31 INFO - 'talos_options': ['--disable-e10s'], 18:40:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:31 INFO - 'talos_options': ['--disable-e10s'], 18:40:31 INFO - 'tests': ['damp', 'tps']}, 18:40:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:31 INFO - 'tests': ['damp', 'tps']}, 18:40:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:40:31 INFO - 'tests': ['dromaeo_dom']}, 18:40:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:40:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:40:31 INFO - 'tests': ['basic_compositor_video']}, 18:40:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:40:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:40:31 INFO - 'tests': ['a11yr', 18:40:31 INFO - 'ts_paint', 18:40:31 INFO - 'tpaint', 18:40:31 INFO - 'sessionrestore', 18:40:31 INFO - 'sessionrestore_no_auto_restore', 18:40:31 INFO - 'tabpaint']}, 18:40:31 INFO - 'other-e10s': {'tests': ['a11yr', 18:40:31 INFO - 'ts_paint', 18:40:31 INFO - 'tpaint', 18:40:31 INFO - 'sessionrestore', 18:40:31 INFO - 'sessionrestore_no_auto_restore', 18:40:31 INFO - 'tabpaint']}, 18:40:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:40:31 INFO - 'ts_paint', 18:40:31 INFO - 'tpaint', 18:40:31 INFO - 'sessionrestore', 18:40:31 INFO - 'sessionrestore_no_auto_restore', 18:40:31 INFO - 'tabpaint']}, 18:40:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:40:31 INFO - 'ts_paint', 18:40:31 INFO - 'tpaint', 18:40:31 INFO - 'sessionrestore', 18:40:31 INFO - 'sessionrestore_no_auto_restore', 18:40:31 INFO - 'tabpaint']}, 18:40:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:40:31 INFO - 'tests': ['a11yr', 18:40:31 INFO - 'ts_paint', 18:40:31 INFO - 'tpaint', 18:40:31 INFO - 'sessionrestore', 18:40:31 INFO - 'sessionrestore_no_auto_restore', 18:40:31 INFO - 'tabpaint']}, 18:40:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:40:31 INFO - 'tests': ['a11yr', 18:40:31 INFO - 'ts_paint', 18:40:31 INFO - 'tpaint', 18:40:31 INFO - 'sessionrestore', 18:40:31 INFO - 'sessionrestore_no_auto_restore', 18:40:31 INFO - 'tabpaint']}, 18:40:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:40:31 INFO - 'tests': ['tsvgx', 18:40:31 INFO - 'tsvgr_opacity', 18:40:31 INFO - 'tart', 18:40:31 INFO - 'tscrollx', 18:40:31 INFO - 'cart']}, 18:40:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:40:31 INFO - 'tsvgr_opacity', 18:40:31 INFO - 'tart', 18:40:31 INFO - 'tscrollx', 18:40:31 INFO - 'cart']}, 18:40:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:31 INFO - 'talos_options': ['--disable-e10s'], 18:40:31 INFO - 'tests': ['tp5o']}, 18:40:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:31 INFO - 'tests': ['tp5o']}, 18:40:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:31 INFO - 'talos_options': ['--disable-e10s', 18:40:31 INFO - '--xperf_path', 18:40:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:31 INFO - 'tests': ['tp5n']}, 18:40:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:31 INFO - 'talos_options': ['--xperf_path', 18:40:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:31 INFO - 'tests': ['tp5n']}}, 18:40:31 INFO - 'talos.zip': {'path': '', 18:40:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:40:31 INFO - Running post-action listener: _resource_record_post_action 18:40:31 INFO - [mozharness: 2016-10-25 01:40:31.933413Z] Finished populate-webroot step (success) 18:40:31 INFO - [mozharness: 2016-10-25 01:40:31.933542Z] Running create-virtualenv step. 18:40:31 INFO - Running pre-action listener: _resource_record_pre_action 18:40:31 INFO - Running main action method: create_virtualenv 18:40:31 INFO - Creating virtualenv /builds/slave/test/build/venv 18:40:31 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 18:40:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:40:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:40:32 INFO - Using real prefix '/tools/python27' 18:40:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:40:32 INFO - Installing distribute.............................................................................................................................................................................................done. 18:40:35 INFO - Installing pip.................done. 18:40:35 INFO - Return code: 0 18:40:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:35 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 0x100fa4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2cc3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100db8d30>, '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 0x100c1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db0b20>, '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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:40:35 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 18:40:35 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 18:40:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y2EvmyX2T/Render', 18:40:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:40:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:40:35 INFO - 'HOME': '/Users/cltbld', 18:40:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:40:35 INFO - 'LOGNAME': 'cltbld', 18:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:35 INFO - 'MOZ_NO_REMOTE': '1', 18:40:35 INFO - 'NO_EM_RESTART': '1', 18:40:35 INFO - 'PAGER': '/bin/cat', 18:40:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:35 INFO - 'PWD': '/builds/slave/test', 18:40:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:40:35 INFO - 'SHELL': '/bin/bash', 18:40:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6tgiYuPN6/Listeners', 18:40:35 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:40:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:40:35 INFO - 'USER': 'cltbld', 18:40:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:40:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:35 INFO - 'XPC_FLAGS': '0x0', 18:40:35 INFO - 'XPC_SERVICE_NAME': '0', 18:40:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:35 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 18:40:35 INFO - Cleaning up... 18:40:35 INFO - Return code: 0 18:40:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:35 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 0x100fa4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2cc3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100db8d30>, '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 0x100c1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db0b20>, '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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:40:35 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 18:40:35 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 18:40:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y2EvmyX2T/Render', 18:40:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:40:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:40:35 INFO - 'HOME': '/Users/cltbld', 18:40:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:40:35 INFO - 'LOGNAME': 'cltbld', 18:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:35 INFO - 'MOZ_NO_REMOTE': '1', 18:40:35 INFO - 'NO_EM_RESTART': '1', 18:40:35 INFO - 'PAGER': '/bin/cat', 18:40:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:35 INFO - 'PWD': '/builds/slave/test', 18:40:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:40:35 INFO - 'SHELL': '/bin/bash', 18:40:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6tgiYuPN6/Listeners', 18:40:35 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:40:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:40:35 INFO - 'USER': 'cltbld', 18:40:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:40:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:35 INFO - 'XPC_FLAGS': '0x0', 18:40:35 INFO - 'XPC_SERVICE_NAME': '0', 18:40:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:36 INFO - Downloading/unpacking psutil>=3.1.1 18:40:36 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 18:40:36 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 18:40:36 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 18:40:36 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 18:40:36 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 18:40:36 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 18:40:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:40:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:39 INFO - Installing collected packages: psutil 18:40:39 INFO - Running setup.py install for psutil 18:40:39 INFO - building 'psutil._psutil_osx' extension 18:40:39 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 18:40:40 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 18:40:40 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 18:40:40 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 18:40:40 INFO - building 'psutil._psutil_posix' extension 18:40:40 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 18:40:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:40:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:40:40 INFO - ^ 18:40:40 INFO - 1 warning generated. 18:40:40 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 18:40:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:40 INFO - Successfully installed psutil 18:40:40 INFO - Cleaning up... 18:40:40 INFO - Return code: 0 18:40:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:40 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 0x100fa4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2cc3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100db8d30>, '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 0x100c1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db0b20>, '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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:40:40 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 18:40:40 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 18:40:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y2EvmyX2T/Render', 18:40:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:40:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:40:40 INFO - 'HOME': '/Users/cltbld', 18:40:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:40:40 INFO - 'LOGNAME': 'cltbld', 18:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:40 INFO - 'MOZ_NO_REMOTE': '1', 18:40:40 INFO - 'NO_EM_RESTART': '1', 18:40:40 INFO - 'PAGER': '/bin/cat', 18:40:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:40 INFO - 'PWD': '/builds/slave/test', 18:40:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:40:40 INFO - 'SHELL': '/bin/bash', 18:40:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6tgiYuPN6/Listeners', 18:40:40 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:40:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:40:40 INFO - 'USER': 'cltbld', 18:40:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:40:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:40 INFO - 'XPC_FLAGS': '0x0', 18:40:40 INFO - 'XPC_SERVICE_NAME': '0', 18:40:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:40:43 INFO - Installing collected packages: mozsystemmonitor 18:40:43 INFO - Running setup.py install for mozsystemmonitor 18:40:43 INFO - Successfully installed mozsystemmonitor 18:40:43 INFO - Cleaning up... 18:40:43 INFO - Return code: 0 18:40:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100fa4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2cc3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100db8d30>, '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 0x100c1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db0b20>, '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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:40:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:40:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y2EvmyX2T/Render', 18:40:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:40:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:40:43 INFO - 'HOME': '/Users/cltbld', 18:40:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:40:43 INFO - 'LOGNAME': 'cltbld', 18:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:43 INFO - 'MOZ_NO_REMOTE': '1', 18:40:43 INFO - 'NO_EM_RESTART': '1', 18:40:43 INFO - 'PAGER': '/bin/cat', 18:40:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:43 INFO - 'PWD': '/builds/slave/test', 18:40:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:40:43 INFO - 'SHELL': '/bin/bash', 18:40:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6tgiYuPN6/Listeners', 18:40:43 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:40:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:40:43 INFO - 'USER': 'cltbld', 18:40:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:40:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:43 INFO - 'XPC_FLAGS': '0x0', 18:40:43 INFO - 'XPC_SERVICE_NAME': '0', 18:40:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:44 INFO - Downloading/unpacking jsonschema==2.5.1 18:40:44 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 18:40:44 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 18:40:44 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 18:40:44 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 18:40:44 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 18:40:44 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 18:40:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:40:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:40:46 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 18:40:46 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 18:40:46 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 18:40:46 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 18:40:46 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 18:40:46 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 18:40:47 INFO - Downloading functools32-3.2.3-2.tar.gz 18:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:40:47 INFO - warning: no files found matching '*.txt' 18:40:47 INFO - no previously-included directories found matching 'build' 18:40:47 INFO - no previously-included directories found matching 'dist' 18:40:47 INFO - no previously-included directories found matching '.git*' 18:40:47 INFO - Installing collected packages: jsonschema, functools32 18:40:47 INFO - Running setup.py install for functools32 18:40:47 INFO - warning: no files found matching '*.txt' 18:40:47 INFO - no previously-included directories found matching 'build' 18:40:47 INFO - no previously-included directories found matching 'dist' 18:40:47 INFO - no previously-included directories found matching '.git*' 18:40:47 INFO - Successfully installed jsonschema functools32 18:40:47 INFO - Cleaning up... 18:40:47 INFO - Return code: 0 18:40:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100fa4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2cc3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100db8d30>, '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 0x100c1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db0b20>, '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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:40:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y2EvmyX2T/Render', 18:40:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:40:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:40:47 INFO - 'HOME': '/Users/cltbld', 18:40:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:40:47 INFO - 'LOGNAME': 'cltbld', 18:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:47 INFO - 'MOZ_NO_REMOTE': '1', 18:40:47 INFO - 'NO_EM_RESTART': '1', 18:40:47 INFO - 'PAGER': '/bin/cat', 18:40:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:47 INFO - 'PWD': '/builds/slave/test', 18:40:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:40:47 INFO - 'SHELL': '/bin/bash', 18:40:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6tgiYuPN6/Listeners', 18:40:47 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:40:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:40:47 INFO - 'USER': 'cltbld', 18:40:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:40:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:47 INFO - 'XPC_FLAGS': '0x0', 18:40:47 INFO - 'XPC_SERVICE_NAME': '0', 18:40:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:40:47 INFO - Cleaning up... 18:40:47 INFO - Return code: 0 18:40:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100fa4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2cc3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100db8d30>, '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 0x100c1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db0b20>, '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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:40:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y2EvmyX2T/Render', 18:40:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:40:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:40:47 INFO - 'HOME': '/Users/cltbld', 18:40:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:40:47 INFO - 'LOGNAME': 'cltbld', 18:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:47 INFO - 'MOZ_NO_REMOTE': '1', 18:40:47 INFO - 'NO_EM_RESTART': '1', 18:40:47 INFO - 'PAGER': '/bin/cat', 18:40:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:47 INFO - 'PWD': '/builds/slave/test', 18:40:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:40:47 INFO - 'SHELL': '/bin/bash', 18:40:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6tgiYuPN6/Listeners', 18:40:47 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:40:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:40:47 INFO - 'USER': 'cltbld', 18:40:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:40:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:47 INFO - 'XPC_FLAGS': '0x0', 18:40:47 INFO - 'XPC_SERVICE_NAME': '0', 18:40:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:48 INFO - Downloading/unpacking blobuploader==1.2.4 18:40:48 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 18:40:48 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 18:40:48 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 18:40:48 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 18:40:48 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 18:40:48 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 18:40:50 INFO - Downloading blobuploader-1.2.4.tar.gz 18:40:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:40:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:40:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:40:51 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 18:40:51 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 18:40:51 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 18:40:51 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 18:40:51 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 18:40:51 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 18:40:51 INFO - Downloading docopt-0.6.1.tar.gz 18:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:40:51 INFO - Installing collected packages: blobuploader, requests, docopt 18:40:51 INFO - Running setup.py install for blobuploader 18:40:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:40:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:40:52 INFO - Running setup.py install for requests 18:40:52 INFO - Running setup.py install for docopt 18:40:52 INFO - Successfully installed blobuploader requests docopt 18:40:52 INFO - Cleaning up... 18:40:52 INFO - Return code: 0 18:40:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:52 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 0x100fa4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2cc3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100db8d30>, '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 0x100c1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db0b20>, '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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:40:52 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 18:40:52 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 18:40:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y2EvmyX2T/Render', 18:40:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:40:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:40:52 INFO - 'HOME': '/Users/cltbld', 18:40:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:40:52 INFO - 'LOGNAME': 'cltbld', 18:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:52 INFO - 'MOZ_NO_REMOTE': '1', 18:40:52 INFO - 'NO_EM_RESTART': '1', 18:40:52 INFO - 'PAGER': '/bin/cat', 18:40:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:52 INFO - 'PWD': '/builds/slave/test', 18:40:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:40:52 INFO - 'SHELL': '/bin/bash', 18:40:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6tgiYuPN6/Listeners', 18:40:52 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:40:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:40:52 INFO - 'USER': 'cltbld', 18:40:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:40:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:52 INFO - 'XPC_FLAGS': '0x0', 18:40:52 INFO - 'XPC_SERVICE_NAME': '0', 18:40:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-9Ppbe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-hNsAd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-6lOR6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-h8q63y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-V0lCUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-VZEluu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-cdNm0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-4HSHXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-7slic4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-wwcAxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Rg5MHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-jwFM2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-9syC1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Xinkor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-ZkHGqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-dD3bQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-543qVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:40:54 INFO - Running setup.py install for manifestparser 18:40:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:40:54 INFO - Running setup.py install for mozcrash 18:40:55 INFO - Running setup.py install for mozdebug 18:40:55 INFO - Running setup.py install for mozdevice 18:40:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:40:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:40:55 INFO - Running setup.py install for mozfile 18:40:55 INFO - Running setup.py install for mozhttpd 18:40:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:40:55 INFO - Running setup.py install for mozinfo 18:40:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:40:55 INFO - Running setup.py install for mozInstall 18:40:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:40:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:40:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:40:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:40:55 INFO - Running setup.py install for mozleak 18:40:56 INFO - Running setup.py install for mozlog 18:40:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:40:56 INFO - Running setup.py install for moznetwork 18:40:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:40:56 INFO - Running setup.py install for mozprocess 18:40:56 INFO - Running setup.py install for mozprofile 18:40:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:40:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:40:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:40:56 INFO - Running setup.py install for mozrunner 18:40:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:40:56 INFO - Running setup.py install for mozscreenshot 18:40:57 INFO - Running setup.py install for moztest 18:40:57 INFO - Running setup.py install for mozversion 18:40:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:40:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:40:57 INFO - Cleaning up... 18:40:57 INFO - Return code: 0 18:40:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:57 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')]} 18:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:57 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')]} 18:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:57 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 0x100fa4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2cc3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100db8d30>, '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 0x100c1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db0b20>, '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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:40:57 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 18:40:57 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 18:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y2EvmyX2T/Render', 18:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:40:57 INFO - 'HOME': '/Users/cltbld', 18:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:40:57 INFO - 'LOGNAME': 'cltbld', 18:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:57 INFO - 'MOZ_NO_REMOTE': '1', 18:40:57 INFO - 'NO_EM_RESTART': '1', 18:40:57 INFO - 'PAGER': '/bin/cat', 18:40:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:57 INFO - 'PWD': '/builds/slave/test', 18:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:40:57 INFO - 'SHELL': '/bin/bash', 18:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6tgiYuPN6/Listeners', 18:40:57 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:40:57 INFO - 'USER': 'cltbld', 18:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:57 INFO - 'XPC_FLAGS': '0x0', 18:40:57 INFO - 'XPC_SERVICE_NAME': '0', 18:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-r3aQMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-1kUX2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-T6Qnms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-HBcxwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-2ltR5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:58 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)) 18:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-lIitAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:58 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)) 18:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-B_sL3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:58 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)) 18:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-7CCnCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:58 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)) 18:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-LIL5NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:58 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)) 18:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-854CyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:58 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)) 18:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-eYH2c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:58 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)) 18:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-M7EVZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-hGm8oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:59 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)) 18:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-UmWVzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 18:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-CwBWgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:59 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)) 18:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-CVF50X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-j3F7uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:59 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)) 18:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:40:59 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)) 18:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:40:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:02 INFO - Downloading blessings-1.6.tar.gz 18:41:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:41:02 INFO - Installing collected packages: blessings 18:41:02 INFO - Running setup.py install for blessings 18:41:02 INFO - Successfully installed blessings 18:41:02 INFO - Cleaning up... 18:41:02 INFO - Return code: 0 18:41:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:41:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:41:02 INFO - Reading from file tmpfile_stdout 18:41:02 INFO - Current package versions: 18:41:02 INFO - blessings == 1.6 18:41:02 INFO - blobuploader == 1.2.4 18:41:02 INFO - docopt == 0.6.1 18:41:02 INFO - functools32 == 3.2.3-2 18:41:02 INFO - jsonschema == 2.5.1 18:41:02 INFO - manifestparser == 1.1 18:41:02 INFO - mozInstall == 1.12 18:41:02 INFO - mozcrash == 0.17 18:41:02 INFO - mozdebug == 0.1 18:41:02 INFO - mozdevice == 0.48 18:41:02 INFO - mozfile == 1.2 18:41:02 INFO - mozhttpd == 0.7 18:41:02 INFO - mozinfo == 0.9 18:41:02 INFO - mozleak == 0.1 18:41:02 INFO - mozlog == 3.4 18:41:02 INFO - moznetwork == 0.27 18:41:02 INFO - mozprocess == 0.23 18:41:02 INFO - mozprofile == 0.28 18:41:02 INFO - mozrunner == 6.12 18:41:02 INFO - mozscreenshot == 0.1 18:41:02 INFO - mozsystemmonitor == 0.3 18:41:02 INFO - moztest == 0.7 18:41:02 INFO - mozversion == 1.4 18:41:02 INFO - psutil == 3.1.1 18:41:02 INFO - requests == 1.2.3 18:41:02 INFO - wsgiref == 0.1.2 18:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41: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')]} 18:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:03 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 0x100fa4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2cc3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100db8d30>, '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 0x100c1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db0b20>, '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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:41:03 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 18:41:03 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 18:41:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y2EvmyX2T/Render', 18:41:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:03 INFO - 'HOME': '/Users/cltbld', 18:41:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:03 INFO - 'LOGNAME': 'cltbld', 18:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:03 INFO - 'MOZ_NO_REMOTE': '1', 18:41:03 INFO - 'NO_EM_RESTART': '1', 18:41:03 INFO - 'PAGER': '/bin/cat', 18:41:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:03 INFO - 'PWD': '/builds/slave/test', 18:41:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:03 INFO - 'SHELL': '/bin/bash', 18:41:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6tgiYuPN6/Listeners', 18:41:03 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:41:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:03 INFO - 'USER': 'cltbld', 18:41:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:03 INFO - 'XPC_FLAGS': '0x0', 18:41:03 INFO - 'XPC_SERVICE_NAME': '0', 18:41:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:03 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)) 18:41:03 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)) 18:41:03 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)) 18:41:03 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)) 18:41:03 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)) 18:41:03 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)) 18:41:03 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)) 18:41:03 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)) 18:41:03 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)) 18:41:03 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)) 18:41:03 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)) 18:41:03 INFO - Cleaning up... 18:41:03 INFO - Return code: 0 18:41:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fa4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2cc3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100db8d30>, '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 0x100c1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db0b20>, '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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:41:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y2EvmyX2T/Render', 18:41:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:03 INFO - 'HOME': '/Users/cltbld', 18:41:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:03 INFO - 'LOGNAME': 'cltbld', 18:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:03 INFO - 'MOZ_NO_REMOTE': '1', 18:41:03 INFO - 'NO_EM_RESTART': '1', 18:41:03 INFO - 'PAGER': '/bin/cat', 18:41:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:03 INFO - 'PWD': '/builds/slave/test', 18:41:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:03 INFO - 'SHELL': '/bin/bash', 18:41:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6tgiYuPN6/Listeners', 18:41:03 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:41:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:03 INFO - 'USER': 'cltbld', 18:41:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:03 INFO - 'XPC_FLAGS': '0x0', 18:41:03 INFO - 'XPC_SERVICE_NAME': '0', 18:41:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:41:03 INFO - Cleaning up... 18:41:03 INFO - Return code: 0 18:41:03 INFO - Running post-action listener: _resource_record_post_action 18:41:03 INFO - Running post-action listener: _start_resource_monitoring 18:41:03 INFO - Starting resource monitoring. 18:41:03 INFO - [mozharness: 2016-10-25 01:41:03.583697Z] Finished create-virtualenv step (success) 18:41:03 INFO - [mozharness: 2016-10-25 01:41:03.584628Z] Running install step. 18:41:03 INFO - Running pre-action listener: _resource_record_pre_action 18:41:03 INFO - Running main action method: install 18:41:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:41:03 INFO - Reading from file tmpfile_stdout 18:41:03 INFO - Detecting whether we're running mozinstall >=1.0... 18:41:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:41:03 INFO - Reading from file tmpfile_stdout 18:41:03 INFO - Output received: 18:41:03 INFO - Usage: mozinstall [options] installer 18:41:03 INFO - Options: 18:41:03 INFO - -h, --help show this help message and exit 18:41:03 INFO - -d DEST, --destination=DEST 18:41:03 INFO - Directory to install application into. [default: 18:41:03 INFO - "/builds/slave/test"] 18:41:03 INFO - --app=APP Application being installed. [default: firefox] 18:41:03 INFO - mkdir: /builds/slave/test/build/application 18:41:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:41:36 INFO - Reading from file tmpfile_stdout 18:41:36 INFO - Output received: 18:41:36 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:41:36 INFO - Running post-action listener: _resource_record_post_action 18:41:36 INFO - [mozharness: 2016-10-25 01:41:36.524004Z] Finished install step (success) 18:41:36 INFO - [mozharness: 2016-10-25 01:41:36.524172Z] Running run-tests step. 18:41:36 INFO - Running pre-action listener: _resource_record_pre_action 18:41:36 INFO - Running main action method: run_tests 18:41:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:41:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:41:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:41:36 INFO - 2016-10-24 18:41:36.538 screenresolution[1642:7540] starting screenresolution argv=screenresolution get 18:41:36 INFO - 2016-10-24 18:41:36.541 screenresolution[1642:7540] Display 0: 1600x1200x32@60 18:41:36 INFO - 2016-10-24 18:41:36.547 screenresolution[1643:7542] starting screenresolution argv=screenresolution list 18:41:36 INFO - Available Modes on Display 0 18:41:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:41:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:41:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:41:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:41:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:41:36 INFO - Intel Iris: 18:41:36 INFO - Chipset Model: Intel Iris 18:41:36 INFO - Type: GPU 18:41:36 INFO - Bus: Built-In 18:41:36 INFO - VRAM (Dynamic, Max): 1536 MB 18:41:36 INFO - Vendor: Intel (0x8086) 18:41:36 INFO - Device ID: 0x0a2e 18:41:36 INFO - Revision ID: 0x0009 18:41:36 INFO - Displays: 18:41:36 INFO - Display: 18:41:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:41:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:41:36 INFO - Display Serial Number: 1600x1200 60 18:41:36 INFO - Main Display: Yes 18:41:36 INFO - Mirror: Off 18:41:36 INFO - Online: Yes 18:41:36 INFO - Rotation: Supported 18:41:36 INFO - Return code: 0 18:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:41:36 INFO - Python 2.7.3 18:41:36 INFO - Return code: 0 18:41:36 INFO - grabbing minidump binary from tooltool 18:41:36 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')]} 18:41:36 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 0x100db8d30>, '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 0x100c1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100db0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:41:36 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 18:41:36 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 18:41:36 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 18:41:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:41:36 INFO - Return code: 0 18:41:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:41:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:41:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:41:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:41:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--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 18:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0371 --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 18:41:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Y2EvmyX2T/Render', 18:41:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:36 INFO - 'HOME': '/Users/cltbld', 18:41:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:36 INFO - 'LOGNAME': 'cltbld', 18:41:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:41:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:36 INFO - 'MOZ_NO_REMOTE': '1', 18:41:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:41:36 INFO - 'NO_EM_RESTART': '1', 18:41:36 INFO - 'PAGER': '/bin/cat', 18:41:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:36 INFO - 'PWD': '/builds/slave/test', 18:41:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:41:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:36 INFO - 'SHELL': '/bin/bash', 18:41:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6tgiYuPN6/Listeners', 18:41:36 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:41:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:36 INFO - 'USER': 'cltbld', 18:41:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:36 INFO - 'XPC_FLAGS': '0x0', 18:41:36 INFO - 'XPC_SERVICE_NAME': '0', 18:41:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:41:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--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 18:41:37 INFO - mozversion application_buildid: 20161024163422 18:41:37 INFO - mozversion application_changeset: fcd7ad8a2488527ce094cbdb3582c29437c155a8 18:41:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:41:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:41:37 INFO - mozversion application_name: Firefox 18:41:37 INFO - mozversion application_remotingname: firefox-dev 18:41:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:41:37 INFO - mozversion application_vendor: Mozilla 18:41:37 INFO - mozversion application_version: 51.0a2 18:41:37 INFO - mozversion platform_buildid: 20161024163422 18:41:37 INFO - mozversion platform_changeset: fcd7ad8a2488527ce094cbdb3582c29437c155a8 18:41:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:41:37 INFO - mozversion platform_version: 51.0a2 18:41:37 INFO - using testdate: 1477359697 18:41:37 INFO - actual date: 1477359697 18:41:37 INFO - starting webserver on 'localhost:49274' 18:41:37 INFO - SUITE-START | Running 2 tests 18:41:37 INFO - TEST-START | dromaeo_css 18:41:37 INFO - operating with platform_type : mac_ 18:41:37 INFO - Initialising browser for dromaeo_css test... 18:41:37 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpwk75Dv/profile http://localhost:49274/getInfo.html) 18:41:39 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 18:41:39 INFO - PROCESS | 1653 | colorDepth:24 18:41:39 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 18:41:39 INFO - PROCESS | 1653 | __metrics 18:41:39 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 18:41:40 INFO - TEST-INFO | 1653: exit 0 18:41:40 INFO - Browser initialized. 18:41:40 INFO - Running cycle 1/1 for dromaeo_css test... 18:41:40 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpwk75Dv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:52 INFO - PROCESS | 1656 | RSS: Main: 224849920 18:41:52 INFO - PROCESS | 1656 | 18:42:42 INFO - PROCESS | 1656 | 1477359762233 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:44:54 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 18:44:55 INFO - PROCESS | 1656 | RSS: Main: 237326336 18:44:55 INFO - PROCESS | 1656 | 18:47:58 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 18:47:58 INFO - PROCESS | 1656 | RSS: Main: 249139200 18:47:58 INFO - PROCESS | 1656 | 18:51:00 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 18:51:01 INFO - PROCESS | 1656 | RSS: Main: 253284352 18:51:01 INFO - PROCESS | 1656 | 18:54:03 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 18:54:03 INFO - PROCESS | 1656 | RSS: Main: 253460480 18:54:03 INFO - PROCESS | 1656 | 18:57:06 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 18:57:07 INFO - PROCESS | 1656 | RSS: Main: 257798144 18:57:07 INFO - PROCESS | 1656 | 19:00:09 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 19:00:09 INFO - PROCESS | 1656 | RSS: Main: 259719168 19:00:09 INFO - PROCESS | 1656 | 19:00:09 INFO - PROCESS | 1656 | __start_tp_report 19:00:09 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 19:00:09 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 19:00:09 INFO - PROCESS | 1656 | |i|pagename|runs| 19:00:09 INFO - PROCESS | 1656 | |0;dojo.html;3423.0586588688107;3436.398630239709;3439.9140021499466;3452.344054629622;3487.4768784682296;5825.679587622679;5873.647581145135;5907.40925907409;5922.437368449996;5946.345901950787;5799.9130013049835;5882.264716910387;5888.5877988540815;5908.08424694172;5915.733791979361;5273.657212281209;5315.176147697113;5343.038253114438;5369.194620806871;5445.292112025451;5372.462753724616;5391.838244852661;5400.675959442427;5403.51368376846;5411.918821217665;5266.394364648077;5277.947220527784;5392.083345831218;5408.2698835657275;5440;5313.601479889005;5357.785688572452;5361.490658387447;5363.54409875163;5413.377461591888;5278.208268759717;5301.390340110859;5324.627276090675;5395.05586522357;5406.297181366436;5695.886082278373;5963.2844058713235;5983.222181116427;6037;6038.57729958903;6150.84622884427;6157.568970172089;6167.568270221086;6202.28673702521;6210.627362358273;6216.471599914013;6267.561270711052;6285.340039295899;6287.591306565058;6320.083587879732;5909;6017.48851347636;6031.487323577458;6039.939600604026;6044.516438684895;6223.159873417031;6298.590591611531;6324.2410910691015;6341.55609107358;6372.267189273293;5312.495312945264;5990.011648078018;6181.598196117238;6252.781152659635;6257.43683068526;6122.367660829195;6182.6599537024995;6219.533534984895;6288.993760998218;6293.244810622755;5341;5531.9723401382735;6011.789587364421;6272.655003974825;6280.026595877646;6118.265808102967;6211.565190436717;6212.192414986023;6243.687815609202;6253.405926436982;4390.946172918477;4415.646748260196;4931;4979.925301120486;5028.32117664118;4437.378766972626;4442.73343599385;4464.732116073046;4476.6418686505;4580.335851301609;6019.578629495981;6033.487153591994;6040.969795150996;6077.9392206078255;6086.05666121743;5791.305043394819;6142.6314421134875;6291.087792270096;6295.937040629627;6330.208723909512;5534.861628459321;5839.824805255849;5962.403759624003;5989.790357337472;6035.456808887221;5543.667379957215;5565.582581306418;5568.554515638739;5570.303712035996;5575.804846830341;6393.680315984182;6404.1674582304;6485.1245081914285;6493.8701225976165;6558.606483610999;6123.632582045091;6130.264368275835;6130.826205142237;6154.723037463235;6251.906221406592;6433.935660643334;6442.484601231984;6444.420002199825;6449.419552240133;6464.644444555594;5597.216389705363;6148.815535533941;6177.722002509988;6284.057391391328;6294.653794041188;6121.663308518075;6181.289151747606;6181.443670069715;6231.40801623845;6309.526785491014;6116.1836049259855;6203.8138855834395;6260.467860231749;6274.592151510137;6274.686265686606;4887.633427492881;6133.938660613337;6247.687615619292;6269.937300626935;6281.309056003927;5867.237259156454;5965.522758179249;6063.969680151571;6161.815145545641;6177.073438984008;6056.606320589148;6080.787172448943;6126.203593532812;6132.356102609162;6140.017597184429;5979.581429300081;5997.580169388276;6013.849653758691;6027.246594175728;6041.939580604314 19:00:09 INFO - PROCESS | 1656 | |1;ext.html;476.4901555335791;509.5337765944161;527.9414773379374;530.7372850439033;565.9717014149292;38831;41296.58703412965;41335;41354.58645413545;41471.99999999996;42413.15173696524;42930.92672683184;42931;42936.57063429365;43066.569334306725;9711.902880971205;9875.851862222036;9907.50462476877;9928.751781205456;9989.150922171588;9802.509874506282;9857.211423086172;9863.556139973718;9874.210063194927;9927.652532161375;9866.408015519057;9888.505574721272;9929.652462163825;9935.254855885802;9951.850722239173;9880.802383952352;9890.406575605486;9909.405435673883;9925.156361709263;9926.65256716015;7977.960110199469;8309.8338033239;8334.66661333552;8341.708040218624;9840.261980351503;40570.59429405698;40771.38842917359;40778.18443631111;40912.59087409118;41190.58809411927;3252.9349413011846;3255.348930213943;3276.918077048069;3377.7804442711144;3386.5258863759095;29427.852860735773;29556.704432955827;29865.98280104363;31184;31386.21534461634;3063.326068264978;3175.4442972479956;3278.508223766454;3409.9488507672404;3412.9488057679155;513627;518306;520216;523352;523436;50432;64312;64411.67794161093;64414.71170576562;64518.67740661267;64615.67692161509;66219.66890165614;66323.66838165779;66704.33295666981;66876.6656166716;16462.259198336105;16494.587635309214;16863.409780657617;17003.40488082911;17028.233729481955;13011.414486348138;13053.28206948627;13161.407736651874;13185.802212966813;13209.273489958145;14760.48338308154;16259.51221463358;18195.27218911255;18201.908990455227;18234;3221.3396253767924;6983.615901125385;7129.073220481408;7206.171290301682;7261.41908647307;891.3359547137295;956.1307643556829;980.2648013989508;1010.685530135995;1037.6160820496314;29935.251618709706;30468.933587324336;30633.162010279008;30737.538936915964;30887.2278193047;991.9950400247952;1006.1347241372414;1029.6807989523272;1089.455272363818;1092.808758467265;14547.563573092824;16267.349306027627;16678.416255431002;16883.91558042202;17067.829321706624;690365;706509;706795;707815;709549;60713.392866071656;61046.38953610407;61081.38918610757;61560.076598851054;61589;1349.197227649547;1354.986450135486;1376.167418711685;1381.6407733989236;1383.557261676274;30471;30476.695233047387;30836.53745193779;31686.207844804063;32183.35633287368;52646.210306846195;57577;59078;59298.11052834125;62116.689416554436;657343;661522;663336;663620;665214;44305.11389772251;44343.556564433944;44720;44906.326405104606;44958.325625114994;47807.04385912332;48122.75938620425;48413;48817.511824881294;49301;33932.830335848164;40043.79978100091;40520.3921941177;40900.1819963605;42022;40943.18113637651;41488.79255603703;41562.792186038874;41635.1672966545;41764.791176043924;38491.42262866003;38776.418353724155;38809.2238155241;38914.02714932036;39232.607673922896;34145.31709365849;35257.76597819064;36159.63840361668;36220.27559448849;36253.456198157575;25115.623265651397;25240.873795630905;26429;26830.597541037292;26887.73112268852 19:00:09 INFO - PROCESS | 1656 | |2;jquery.html;379.1488109194858;382.2164562646575;387.83904679557975;390.0580099060765;408.98775530561863;15930;18640.440786776384;20542.178312867487;20725.481862953435;20945.37163885084;11669.24149930254;11774.646760597196;11797.99717024054;12127.029837612992;16877.73416993724;5373.704446255445;5651.463111004448;5663.915041274384;5683.204351390808;5688.232088668039;3971.344728119857;4412.271975124101;5575.888482230353;6222.502199824004;6295;6221.066839974017;6265.592736472115;6276.089966954789;6292.71682774274;6300.684965751717;5751.25233719618;6044;6090.5736598438125;6100.206973093514;6155.384461553854;5815.098659707752;5902.527797776168;5938.732757025901;5986.371430999726;6002.129691194752;13265.469381224739;13323.666908327272;13416.597502074954;13455.192688438725;13538.796918046237;2172.652375619893;2326.162581470669;2356.516914032636;2376.2871138658334;2632.7757592719286;9454.14912657864;9792.461414622192;9885.060919212663;10299.53652085658;10521.631742888962;1621.5216511129245;1882.1342182596022;1913.4642300155979;1946.4647222013919;1947.5617985953188;108835.91164088337;119295;123118.38440807829;132526.99999999904;134072;9560.713178604654;9935.701928942144;11635.41822908868;11687.824682629767;12274.509019639114;14907.627309317137;14926.402943882124;14934.40262389514;14942.70114597702;14968.925155374154;7373.446991475661;8494.702685406104;8658.567071646392;8739.43193692408;8825.867611985825;8571.871421928676;8673.392862499692;8674.6530138795;8811.162939520864;8821.955890220508;4524.728516289033;4590.380298659638;4593.885152871138;4607.470140933769;4661.953380466152;1433.5985923941314;1504;1700.9574760630835;1940.5348961534235;2005.8696184747944;894.7539426657592;954.8875559972693;965.4014511003082;972.2707969023232;982.8181786369545;19505.707414388795;20768.22038765635;20789;20801;20847.791522084888;888.3692578269372;902.7382059202889;959.2565761534727;992.3847214726771;1034.4414016431194;10509.579616815241;10899.400532970763;10930.398828064534;10946.397948112772;10978.670639880816;454542;563881;571556;578773;582065;65954;107971.92028079618;120523.39738301252;123454.38272808578;125739.37130314289;930.06993006993;953.6233187890883;953.7758626722715;969.9175570076482;974.0503009565617;14837.406503740161;15767.132807695687;16399.508014759576;17907;18657.72013419827;42452.787736061124;54049;55352.72323638517;55361.44638553563;57154;77294.61352693201;80185.396292075;87588;88403.11596883948;91620;8087.716929907425;8101.027876654839;8355.665773368997;8389.580520974048;8433.87349189775;8392.958035209786;8857.601407936787;12032.458539365574;13073;13308.134971226838;11036.779264414827;11098.167637427387;11345.829812552653;11374.31754094757;11419.771604568028;8844.73465796027;10572.784129825168;11000.119990400908;11107.222494425312;11597;10060.84908726355;11463.254888432559;11552.94223528877;11770;11891.227070240408;7182.389496892613;8067.919320806717;8311.750647480585;8426.988761348677;8508.872366914378;9486.33595648298;9618.759531011501;11254.38100904458;11540.076793856639;11705.648830535098 19:00:09 INFO - PROCESS | 1656 | |3;mootools.html;1519.3666808181201;1555.5411153709654;1682.629821439283;1785.0896043018056;1874;8209.220124088202;8482.660693572265;8707.259882909952;9300.720978370651;9312.255019598433;8677.869831952527;9006.549672516381;9018.323625728064;9148.542572871364;9180.586873590688;2351.7648235176475;2380.773826486481;2381.785639292463;2400.711914570254;2401.00358351284;2412.1316326122583;2412.336607432961;2449.7550244975537;2454.447749256421;2458.5943319352286;2049.600327936053;2414.9758502414925;2445.9388515287083;2456.2140115163156;2458.40998160442;2408.2534414331612;2416.6979127609047;2416.9516609667794;2432.501337225873;2434.513097380513;2404.5912194926905;2411.3730430088126;2422.6487159361795;2425.223928342931;2431.3435372449517;8939.821203575892;9154.40496367734;9176.403533770284;9187.26501879848;9191.264698824078;4839.27410888366;5333.2000199969925;5359.892802143935;5488.9725551372385;5495.587830912697;3544.131687736521;3676.2096149327754;3695.150115473429;3707.6292370762976;3731.0299322176156;1066.4667666166918;1084.3927400655657;1099.983500247497;1110.134095405585;1124.9943750281277;10532.42071686057;11992.460339284753;12157.574484892986;12213.694657633541;12258.570950016796;4199.4120823084795;4762.78567464465;4798.064377446434;4848.442429120696;4968.105740966588;8650.567471626393;9062.501562413998;10052.497375131361;10342.224333175041;10345.793084138426;4596.609288210473;5483.150111732688;5485.451454854483;5491.9725401373535;5498.45015498447;3622.9637703622625;4450.087732014929;4825.831095911626;4940.333055037596;5022.372203474566;3529.6117427083;4066.5323487799283;4169.728967617156;4174.935391475155;4210.768407737603;1336.9064165508516;1343.54991077988;1346.9932650336882;1356.6269275949194;1358.6875018745743;924.542351535994;940;945.635930166877;955;979.1285755677453;5920;6089.69551522431;6090.512758979271;6109.053096770008;6204.976178930516;437.1606515490266;438.4300409467679;441.8939454530889;444.6331776284578;459.7540315930961;4106.67146628269;4107.774072426046;4118.855840045584;4150.750954942713;4179.205950869386;10755.784884302426;10933.671989840317;10997.725056873642;11150.442477876073;11177;11063.502142403611;11073.114150867912;11073.892610739023;11078.446077696082;11121.165912556591;7950.681972721027;8292.958535207285;8347.540885251248;8351.1648835116;8381;6116.724747386467;6133;6170.969145154246;6252.499800016079;6259;9984.051515106054;10197.286189966631;10238.692839214835;10267.897321026694;10501.47492625381;10447.216458765472;10510.316829406063;10555.841662375224;10560.207984401048;10590.576376944837;7163.534370265916;7363.784975478986;7659.234076592296;7777.805554860947;7889.684412623431;8532.530710810965;8706.085860984758;8724.258438032584;8725.738227853175;8739.56302184901;7668.348190403878;7759.495632783851;7789.221077892165;7807;7901.565413902291;6449;7584.127825300161;7629.961850190713;7683.500572462772;7776.455648104805;7130.500864939404;7258.383037441666;7275.308845659654;7276.527025743309;7309.305615966475;4875.829345972874;5035.723035232951;5069.8732531687;5141.329068052823;5150.639455238097;4240.809163587584;4498.1003799239625;4503.301988191835;5200.427952925251;5215.295935048872 19:00:09 INFO - PROCESS | 1656 | |4;prototype.html;299.9130252226854;303.6856853156982;310.9331493728848;310.97978631388975;312.54680712966206;3860.4981352424215;4662.766861656921;5504.64219825711;5594.1749416544635;5678.48893599576;5320;5445.428230035839;5546.667199968005;5581.413951535092;5611.2144299798065;3619.7466177367596;3667.413213885779;4192.790360481979;4217.978910105445;4236.364545318212;3935.803209839511;4178.707490475668;4235.898666346741;4253.829846806124;4271.231178387889;4139.917201655965;4148.771817550033;4162.958370416287;4185.9953611133415;4192.5597812229735;3495.5805303363504;4151.398047283157;4177;4181.665466762652;4208.200441916026;3603.9279214415565;3608.891733248007;3613.927721445583;3620.7827530348263;3627.2951712695253;4442.755648439367;4960.61890292658;5013.849584512434;5258.39528454225;5421;4688.765561721901;4777.085977553689;4780.80876764929;4787.54518320759;4821.228603423436;5574.717814902555;5870.324912635059;5951.821445356646;5961.403859614047;5987.790427335066;3391.406503861839;3800.3919372900205;3805.2579746949355;3881.786501742403;3967.821448034845;6122.0715474625795;6160.87678246437;6194.81415557534;6210.7826226082325;6258.3428739982555;3991.820368083443;3996.760194388346;4004.2992476316526;4005.715313443007;4027.7381970171846;3593.2274560968995;3897.863574774926;3941.7832019239218;4035.8991025224605;4058.553559108496;4765.213739732974;4781.569658730731;4794.544518270759;4809;4810.278458231223;4862.41651001882;5249.380545120346;5470.589705772083;5851.795187168429;5860.912086318709;1252.6242127361754;1274.2800317820402;1294.2622705058216;1367.9042467027214;1379.7723375643106;809.7529804101617;813.7029984055895;844.6991632885411;848.3340577646518;850.4217132349937;4580.519045500241;4583.839565615188;4588.357629931812;4596.575551214367;4604.58558729716;4388.824447022083;4581.633469322446;5071;5072.032860776413;5117.923231151536;4164.6251837334785;4359;4614.946348874786;4639.652026098056;4682.461516925598;2165.8700477971056;2267.648514480258;2433.720122185936;2520.4625178641013;2625.5165831305635;4937.852034364991;4983.177775667047;5280.6039547034125;5290.68255904647;5298.735063246822;4484.820607175677;5086.685558071069;5235.089192444806;5254.92117618236;5264.473302742238;5277.8916427549875;5680.7727690892725;6074.605150665193;6110.358412366815;6311.305756366796;5910.23166988306;6109.297430795337;6169.352218017044;6174.289956655042;6174.938250617436;4815.7351345676325;5116.7441627917715;5754.1447230354925;6083.452489275986;6084.60450070744;5614.382417933943;5626.286650810445;6405.263394709668;6441.1304473895425;6471.320511346241;3328.484084966834;3934.488516492838;3994.980025099856;4061.735987160825;4110;4602.029807807627;5149.433562308218;5277.313949186581;5973.641581505123;6082.9695851520455;5787.2187254720075;5859.9121013183985;5920.348761636131;5927.496162826208;5948.434898684618;5137.743112844418;5397.622166448468;5945.732442040205;5968.373320801427;5981.491573216325;5319.46805319465;5616.6068375213345;5687.862427514431;5786.276715410574;5813.331466881194;4825.710457372569;5930;5949.977007817363;5970.492508136857;5992.490638295793;5493.23094766741;5797.507211887037;5802.245708057925;5823.883522329615;5846.912296315473 19:00:09 INFO - PROCESS | 1656 | |5;yui.html;651.8989556618723;701.2426579294361;709.4820780829994;710.7094154066674;722.3390597603193;15396.384144634216;15852.524424267262;15898.443554475596;16007;16070.598235044115;14270.857291427083;14369.856301436983;14390.712185756278;14434.42262309509;14441.711165776678;838.2246422059616;875.0811647769816;878.8945326560789;880.5553195636227;885.6678745470449;840.8318336332758;841.6633346661323;864.6282098697588;876.9429987050821;886.2422628652506;890.590328448911;917.2661870503604;918.9494577798218;920.2178148573693;922.5617831530037;873.9082396348388;902.7291812456302;912.4798864647154;913.1005959130251;917.2432742987029;675.746595026865;678.159082737407;679.7043286170482;680.397847904603;683.1494788987742;15196.848031519654;15212.46756363533;15576.688466230611;15589.844101559067;15685;13963.581092567138;13994.580162595139;14151.29243537819;14181.220032898187;14386.280685965765;11731.94134029333;11737.765244695143;11746.471408786625;11839.171258011942;12035;3695.334839728848;3724.478572999782;3781.3193625147464;3798.0694729791376;3883.2233553289457;118419.81580184175;118462;122068;123940;124053.9999999991;10698.251122421512;10704.732381690521;10854.945725271324;10867.69587649487;10928.672139835817;22187.889060554917;22201.77798221997;22261.109555617917;22363.55272894533;22580.548389032458;6294.968525157345;6839.794806155824;7310.122785265802;7353.786625206781;7882.330001949898;4405.383246345515;4405.669574781904;4449.17690227309;4456.108778244364;4524.185646583646;3626.6192049834917;3647.3434781739543;3735.3089678409583;3756.398976163801;3759.8684046058256;667.5393978155057;668.1581207678361;668.2949488289804;672.0758956434902;696.2132789947327;578.3695771608966;588.8586739182565;659.9439047680905;675.1830285354775;694.6075467360924;8883.422577532569;9526.523673816282;9701.514924253901;9763.609455621696;9769.853452198222;573.4695406748741;596.3916804859106;617.5831313863124;636.9968150159312;676.9187697476236;4024.678025757991;4318.265894797892;4508.32375143731;4657;4770;94055;98519.50740246254;106155.46922265494;135562;156640;130745;130926.34536827255;131499;133641;133699;111025.88974110155;112394;114069;116066;118438.40780796041;7635.503692259986;7714.537127772352;8650.221480066573;9068.22920051803;9146.085391460801;60782;62165;62553.061704075386;62981.370186299384;64191.037134442086;87542.1245787534;95064.52467737618;95360;97904;98198.5090074545;11548.711282218012;11691.181617286707;11747.17769756143;11831.763364732486;11833;11891.537739923087;12051.75896482048;12382.5666101686;12706.428210730724;12721.173123746927;11467.19729618952;11609.173710505573;12937.54718584845;13189.670258243237;14438.85561144375;12368.876311237133;13457.798133027816;13517.459301627825;14174.503892363718;14343.928280358949;13435.932820335836;13950.651233719238;14086.22525761093;14105.647358816112;14416.846652267584;11095.334279943228;11393.430328483708;11414.714632133931;11485.712857178638;11741.354225517336;10645.627403040857;10901.291416057931;11626;11671.824922626338;11878.346690932081 19:00:09 INFO - PROCESS | 1656 | __end_tp_report 19:00:09 INFO - PROCESS | 1656 | __start_cc_report 19:00:09 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,367 19:00:09 INFO - PROCESS | 1656 | __end_cc_report 19:00:09 INFO - PROCESS | 1656 | __startTimestamp1477360809865__endTimestamp 19:00:09 INFO - PROCESS | 1656 | 19:00:09 INFO - PROCESS | 1656 | ------- Summary: start ------- 19:00:09 INFO - PROCESS | 1656 | Number of tests: 6 19:00:09 INFO - PROCESS | 1656 | 19:00:09 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5808.57 Median:6037.00 stddev:634.98 (10.5%) stddev-sans-first:608.73 19:00:09 INFO - PROCESS | 1656 | Values: 3423.1 3436.4 3439.9 3452.3 3487.5 5825.7 5873.6 5907.4 5922.4 5946.3 5799.9 5882.3 5888.6 5908.1 5915.7 5273.7 5315.2 5343.0 5369.2 5445.3 5372.5 5391.8 5400.7 5403.5 5411.9 5266.4 5277.9 5392.1 5408.3 5440.0 5313.6 5357.8 5361.5 5363.5 5413.4 5278.2 5301.4 5324.6 5395.1 5406.3 5695.9 5963.3 5983.2 6037.0 6038.6 6150.8 6157.6 6167.6 6202.3 6210.6 6216.5 6267.6 6285.3 6287.6 6320.1 5909.0 6017.5 6031.5 6039.9 6044.5 6223.2 6298.6 6324.2 6341.6 6372.3 5312.5 5990.0 6181.6 6252.8 6257.4 6122.4 6182.7 6219.5 6289.0 6293.2 5341.0 5532.0 6011.8 6272.7 6280.0 6118.3 6211.6 6212.2 6243.7 6253.4 4390.9 4415.6 4931.0 4979.9 5028.3 4437.4 4442.7 4464.7 4476.6 4580.3 6019.6 6033.5 6041.0 6077.9 6086.1 5791.3 6142.6 6291.1 6295.9 6330.2 5534.9 5839.8 5962.4 5989.8 6035.5 5543.7 5565.6 5568.6 5570.3 5575.8 6393.7 6404.2 6485.1 6493.9 6558.6 6123.6 6130.3 6130.8 6154.7 6251.9 6433.9 6442.5 6444.4 6449.4 6464.6 5597.2 6148.8 6177.7 6284.1 6294.7 6121.7 6181.3 6181.4 6231.4 6309.5 6116.2 6203.8 6260.5 6274.6 6274.7 4887.6 6133.9 6247.7 6269.9 6281.3 5867.2 5965.5 6064.0 6161.8 6177.1 6056.6 6080.8 6126.2 6132.4 6140.0 5979.6 5997.6 6013.8 6027.2 6041.9 19:00:09 INFO - PROCESS | 1656 | 19:00:09 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:76465.50 Median:41893.40 stddev:169633.10 (404.9%) stddev-sans-first:170013.02 19:00:09 INFO - PROCESS | 1656 | Values: 476.5 509.5 527.9 530.7 566.0 38831.0 41296.6 41335.0 41354.6 41472.0 42413.2 42930.9 42931.0 42936.6 43066.6 9711.9 9875.9 9907.5 9928.8 9989.2 9802.5 9857.2 9863.6 9874.2 9927.7 9866.4 9888.5 9929.7 9935.3 9951.9 9880.8 9890.4 9909.4 9925.2 9926.7 7978.0 8309.8 8334.7 8341.7 9840.3 40570.6 40771.4 40778.2 40912.6 41190.6 3252.9 3255.3 3276.9 3377.8 3386.5 29427.9 29556.7 29866.0 31184.0 31386.2 3063.3 3175.4 3278.5 3409.9 3412.9 513627.0 518306.0 520216.0 523352.0 523436.0 50432.0 64312.0 64411.7 64414.7 64518.7 64615.7 66219.7 66323.7 66704.3 66876.7 16462.3 16494.6 16863.4 17003.4 17028.2 13011.4 13053.3 13161.4 13185.8 13209.3 14760.5 16259.5 18195.3 18201.9 18234.0 3221.3 6983.6 7129.1 7206.2 7261.4 891.3 956.1 980.3 1010.7 1037.6 29935.3 30468.9 30633.2 30737.5 30887.2 992.0 1006.1 1029.7 1089.5 1092.8 14547.6 16267.3 16678.4 16883.9 17067.8 690365.0 706509.0 706795.0 707815.0 709549.0 60713.4 61046.4 61081.4 61560.1 61589.0 1349.2 1355.0 1376.2 1381.6 1383.6 30471.0 30476.7 30836.5 31686.2 32183.4 52646.2 57577.0 59078.0 59298.1 62116.7 657343.0 661522.0 663336.0 663620.0 665214.0 44305.1 44343.6 44720.0 44906.3 44958.3 47807.0 48122.8 48413.0 48817.5 49301.0 33932.8 40043.8 40520.4 40900.2 42022.0 40943.2 41488.8 41562.8 41635.2 41764.8 38491.4 38776.4 38809.2 38914.0 39232.6 34145.3 35257.8 36159.6 36220.3 36253.5 25115.6 25240.9 26429.0 26830.6 26887.7 19:00:09 INFO - PROCESS | 1656 | 19:00:09 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:32820.46 Median:21430.89 stddev:92614.95 (432.2%) stddev-sans-first:92842.72 19:00:09 INFO - PROCESS | 1656 | Values: 379.1 382.2 387.8 390.1 409.0 15930.0 18640.4 20542.2 20725.5 20945.4 11669.2 11774.6 11798.0 12127.0 16877.7 5373.7 5651.5 5663.9 5683.2 5688.2 3971.3 4412.3 5575.9 6222.5 6295.0 6221.1 6265.6 6276.1 6292.7 6300.7 5751.3 6044.0 6090.6 6100.2 6155.4 5815.1 5902.5 5938.7 5986.4 6002.1 13265.5 13323.7 13416.6 13455.2 13538.8 2172.7 2326.2 2356.5 2376.3 2632.8 9454.1 9792.5 9885.1 10299.5 10521.6 1621.5 1882.1 1913.5 1946.5 1947.6 108835.9 119295.0 123118.4 132527.0 134072.0 9560.7 9935.7 11635.4 11687.8 12274.5 14907.6 14926.4 14934.4 14942.7 14968.9 7373.4 8494.7 8658.6 8739.4 8825.9 8571.9 8673.4 8674.7 8811.2 8822.0 4524.7 4590.4 4593.9 4607.5 4662.0 1433.6 1504.0 1701.0 1940.5 2005.9 894.8 954.9 965.4 972.3 982.8 19505.7 20768.2 20789.0 20801.0 20847.8 888.4 902.7 959.3 992.4 1034.4 10509.6 10899.4 10930.4 10946.4 10978.7 454542.0 563881.0 571556.0 578773.0 582065.0 65954.0 107971.9 120523.4 123454.4 125739.4 930.1 953.6 953.8 969.9 974.1 14837.4 15767.1 16399.5 17907.0 18657.7 42452.8 54049.0 55352.7 55361.4 57154.0 77294.6 80185.4 87588.0 88403.1 91620.0 8087.7 8101.0 8355.7 8389.6 8433.9 8393.0 8857.6 12032.5 13073.0 13308.1 11036.8 11098.2 11345.8 11374.3 11419.8 8844.7 10572.8 11000.1 11107.2 11597.0 10060.8 11463.3 11552.9 11770.0 11891.2 7182.4 8067.9 8311.8 8427.0 8508.9 9486.3 9618.8 11254.4 11540.1 11705.6 19:00:09 INFO - PROCESS | 1656 | 19:00:09 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5823.25 Median:4500.70 stddev:3308.20 (73.5%) stddev-sans-first:3301.67 19:00:09 INFO - PROCESS | 1656 | Values: 1519.4 1555.5 1682.6 1785.1 1874.0 8209.2 8482.7 8707.3 9300.7 9312.3 8677.9 9006.5 9018.3 9148.5 9180.6 2351.8 2380.8 2381.8 2400.7 2401.0 2412.1 2412.3 2449.8 2454.4 2458.6 2049.6 2415.0 2445.9 2456.2 2458.4 2408.3 2416.7 2417.0 2432.5 2434.5 2404.6 2411.4 2422.6 2425.2 2431.3 8939.8 9154.4 9176.4 9187.3 9191.3 4839.3 5333.2 5359.9 5489.0 5495.6 3544.1 3676.2 3695.2 3707.6 3731.0 1066.5 1084.4 1100.0 1110.1 1125.0 10532.4 11992.5 12157.6 12213.7 12258.6 4199.4 4762.8 4798.1 4848.4 4968.1 8650.6 9062.5 10052.5 10342.2 10345.8 4596.6 5483.2 5485.5 5492.0 5498.5 3623.0 4450.1 4825.8 4940.3 5022.4 3529.6 4066.5 4169.7 4174.9 4210.8 1336.9 1343.5 1347.0 1356.6 1358.7 924.5 940.0 945.6 955.0 979.1 5920.0 6089.7 6090.5 6109.1 6205.0 437.2 438.4 441.9 444.6 459.8 4106.7 4107.8 4118.9 4150.8 4179.2 10755.8 10933.7 10997.7 11150.4 11177.0 11063.5 11073.1 11073.9 11078.4 11121.2 7950.7 8293.0 8347.5 8351.2 8381.0 6116.7 6133.0 6171.0 6252.5 6259.0 9984.1 10197.3 10238.7 10267.9 10501.5 10447.2 10510.3 10555.8 10560.2 10590.6 7163.5 7363.8 7659.2 7777.8 7889.7 8532.5 8706.1 8724.3 8725.7 8739.6 7668.3 7759.5 7789.2 7807.0 7901.6 6449.0 7584.1 7630.0 7683.5 7776.5 7130.5 7258.4 7275.3 7276.5 7309.3 4875.8 5035.7 5069.9 5141.3 5150.6 4240.8 4498.1 4503.3 5200.4 5215.3 19:00:09 INFO - PROCESS | 1656 | 19:00:09 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4584.09 Median:4949.24 stddev:1457.52 (29.4%) stddev-sans-first:1425.70 19:00:09 INFO - PROCESS | 1656 | Values: 299.9 303.7 310.9 311.0 312.5 3860.5 4662.8 5504.6 5594.2 5678.5 5320.0 5445.4 5546.7 5581.4 5611.2 3619.7 3667.4 4192.8 4218.0 4236.4 3935.8 4178.7 4235.9 4253.8 4271.2 4139.9 4148.8 4163.0 4186.0 4192.6 3495.6 4151.4 4177.0 4181.7 4208.2 3603.9 3608.9 3613.9 3620.8 3627.3 4442.8 4960.6 5013.8 5258.4 5421.0 4688.8 4777.1 4780.8 4787.5 4821.2 5574.7 5870.3 5951.8 5961.4 5987.8 3391.4 3800.4 3805.3 3881.8 3967.8 6122.1 6160.9 6194.8 6210.8 6258.3 3991.8 3996.8 4004.3 4005.7 4027.7 3593.2 3897.9 3941.8 4035.9 4058.6 4765.2 4781.6 4794.5 4809.0 4810.3 4862.4 5249.4 5470.6 5851.8 5860.9 1252.6 1274.3 1294.3 1367.9 1379.8 809.8 813.7 844.7 848.3 850.4 4580.5 4583.8 4588.4 4596.6 4604.6 4388.8 4581.6 5071.0 5072.0 5117.9 4164.6 4359.0 4614.9 4639.7 4682.5 2165.9 2267.6 2433.7 2520.5 2625.5 4937.9 4983.2 5280.6 5290.7 5298.7 4484.8 5086.7 5235.1 5254.9 5264.5 5277.9 5680.8 6074.6 6110.4 6311.3 5910.2 6109.3 6169.4 6174.3 6174.9 4815.7 5116.7 5754.1 6083.5 6084.6 5614.4 5626.3 6405.3 6441.1 6471.3 3328.5 3934.5 3995.0 4061.7 4110.0 4602.0 5149.4 5277.3 5973.6 6083.0 5787.2 5859.9 5920.3 5927.5 5948.4 5137.7 5397.6 5945.7 5968.4 5981.5 5319.5 5616.6 5687.9 5786.3 5813.3 4825.7 5930.0 5950.0 5970.5 5992.5 5493.2 5797.5 5802.2 5823.9 5846.9 19:00:09 INFO - PROCESS | 1656 | 19:00:09 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:24547.10 Median:3709.91 stddev:38870.65 (1047.8%) stddev-sans-first:38938.29 19:00:09 INFO - PROCESS | 1656 | Values: 651.9 701.2 709.5 710.7 722.3 15396.4 15852.5 15898.4 16007.0 16070.6 14270.9 14369.9 14390.7 14434.4 14441.7 838.2 875.1 878.9 880.6 885.7 840.8 841.7 864.6 876.9 886.2 890.6 917.3 918.9 920.2 922.6 873.9 902.7 912.5 913.1 917.2 675.7 678.2 679.7 680.4 683.1 15196.8 15212.5 15576.7 15589.8 15685.0 13963.6 13994.6 14151.3 14181.2 14386.3 11731.9 11737.8 11746.5 11839.2 12035.0 3695.3 3724.5 3781.3 3798.1 3883.2 118419.8 118462.0 122068.0 123940.0 124054.0 10698.3 10704.7 10854.9 10867.7 10928.7 22187.9 22201.8 22261.1 22363.6 22580.5 6295.0 6839.8 7310.1 7353.8 7882.3 4405.4 4405.7 4449.2 4456.1 4524.2 3626.6 3647.3 3735.3 3756.4 3759.9 667.5 668.2 668.3 672.1 696.2 578.4 588.9 659.9 675.2 694.6 8883.4 9526.5 9701.5 9763.6 9769.9 573.5 596.4 617.6 637.0 676.9 4024.7 4318.3 4508.3 4657.0 4770.0 94055.0 98519.5 106155.5 135562.0 156640.0 130745.0 130926.3 131499.0 133641.0 133699.0 111025.9 112394.0 114069.0 116066.0 118438.4 7635.5 7714.5 8650.2 9068.2 9146.1 60782.0 62165.0 62553.1 62981.4 64191.0 87542.1 95064.5 95360.0 97904.0 98198.5 11548.7 11691.2 11747.2 11831.8 11833.0 11891.5 12051.8 12382.6 12706.4 12721.2 11467.2 11609.2 12937.5 13189.7 14438.9 12368.9 13457.8 13517.5 14174.5 14343.9 13435.9 13950.7 14086.2 14105.6 14416.8 11095.3 11393.4 11414.7 11485.7 11741.4 10645.6 10901.3 11626.0 11671.8 11878.3 19:00:09 INFO - PROCESS | 1656 | -------- Summary: end -------- 19:00:09 INFO - PROCESS | 1656 | 19:00:10 INFO - TEST-INFO | 1656: exit 0 19:00:10 INFO - TEST-OK | dromaeo_css | took 1113361ms 19:00:10 INFO - TEST-START | kraken 19:00:10 INFO - operating with platform_type : mac_ 19:00:10 INFO - Initialising browser for kraken test... 19:00:10 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpQxIAm2/profile http://localhost:49274/getInfo.html) 19:00:13 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 19:00:13 INFO - PROCESS | 1668 | colorDepth:24 19:00:13 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 19:00:13 INFO - PROCESS | 1668 | __metrics 19:00:13 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 19:00:13 INFO - TEST-INFO | 1668: exit 0 19:00:13 INFO - Browser initialized. 19:00:13 INFO - Running cycle 1/1 for kraken test... 19:00:13 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpQxIAm2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:25 INFO - PROCESS | 1670 | RSS: Main: 225120256 19:00:25 INFO - PROCESS | 1670 | 19:00:28 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 19:00:29 INFO - PROCESS | 1670 | RSS: Main: 237989888 19:00:29 INFO - PROCESS | 1670 | 19:00:32 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 19:00:32 INFO - PROCESS | 1670 | RSS: Main: 245129216 19:00:32 INFO - PROCESS | 1670 | 19:00:36 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 19:00:36 INFO - PROCESS | 1670 | RSS: Main: 249081856 19:00:36 INFO - PROCESS | 1670 | 19:00:38 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 19:00:39 INFO - PROCESS | 1670 | RSS: Main: 249749504 19:00:39 INFO - PROCESS | 1670 | 19:00:41 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:00:41 INFO - PROCESS | 1670 | RSS: Main: 249663488 19:00:41 INFO - PROCESS | 1670 | 19:00:44 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 19:00:45 INFO - PROCESS | 1670 | RSS: Main: 250621952 19:00:45 INFO - PROCESS | 1670 | 19:00:47 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 19:00:48 INFO - PROCESS | 1670 | RSS: Main: 251953152 19:00:48 INFO - PROCESS | 1670 | 19:00:51 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 19:00:52 INFO - PROCESS | 1670 | RSS: Main: 252211200 19:00:52 INFO - PROCESS | 1670 | 19:00:53 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:00:54 INFO - PROCESS | 1670 | RSS: Main: 251318272 19:00:54 INFO - PROCESS | 1670 | 19:00:56 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:00:56 INFO - PROCESS | 1670 | RSS: Main: 251375616 19:00:56 INFO - PROCESS | 1670 | 19:00:59 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:00:59 INFO - PROCESS | 1670 | RSS: Main: 251367424 19:00:59 INFO - PROCESS | 1670 | 19:01:02 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:01:03 INFO - PROCESS | 1670 | RSS: Main: 251654144 19:01:03 INFO - PROCESS | 1670 | 19:01:06 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:01:06 INFO - PROCESS | 1670 | RSS: Main: 251654144 19:01:06 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 19:01:08 INFO - PROCESS | 1670 | RSS: Main: 253464576 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | __start_tp_report 19:01:08 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 19:01:08 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 19:01:08 INFO - PROCESS | 1670 | |i|pagename|runs| 19:01:08 INFO - PROCESS | 1670 | |0;ai-astar;107;118;119;119;119;95;174;174;117;119 19:01:08 INFO - PROCESS | 1670 | |1;audio-beat-detection;149;109;112;143;111;111;114;97;173;96 19:01:08 INFO - PROCESS | 1670 | |2;audio-dft;202;197;200;200;192;196;196;194;197;196 19:01:08 INFO - PROCESS | 1670 | |3;audio-fft;73;59;59;84;62;59;58;59;77;58 19:01:08 INFO - PROCESS | 1670 | |4;audio-oscillator;81;66;90;73;71;70;88;70;70;98 19:01:08 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;90;88;90;88;90;87;91;89;93;88 19:01:08 INFO - PROCESS | 1670 | |6;imaging-darkroom;112;94;152;139;96;103;97;96;96;96 19:01:08 INFO - PROCESS | 1670 | |7;imaging-desaturate;99;91;92;92;93;98;91;95;92;90 19:01:08 INFO - PROCESS | 1670 | |8;json-parse-financial;56;56;56;57;59;61;60;57;60;60 19:01:08 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;67;71;72;80;77;72;68;69;68;78 19:01:08 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;84;84;92;93;80;88;102;103;73;107 19:01:08 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;157;158;143;160;155;161;162;133;199;157 19:01:08 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;165;171;162;166;168;165;166;167;164;167 19:01:08 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;68;67;68;65;69;66;68;67;68;66 19:01:08 INFO - PROCESS | 1670 | __end_tp_report 19:01:08 INFO - PROCESS | 1670 | __start_cc_report 19:01:08 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,945 19:01:08 INFO - PROCESS | 1670 | __end_cc_report 19:01:08 INFO - PROCESS | 1670 | __startTimestamp1477360868742__endTimestamp 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | ------- Summary: start ------- 19:01:08 INFO - PROCESS | 1670 | Number of tests: 14 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:126.10 Median:119.00 stddev:26.40 (22.2%) stddev-sans-first:27.08 19:01:08 INFO - PROCESS | 1670 | Values: 107.0 118.0 119.0 119.0 119.0 95.0 174.0 174.0 117.0 119.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:121.50 Median:146.00 stddev:25.04 (17.2%) stddev-sans-first:24.51 19:01:08 INFO - PROCESS | 1670 | Values: 149.0 109.0 112.0 143.0 111.0 111.0 114.0 97.0 173.0 96.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:197.00 Median:197.00 stddev:2.98 (1.5%) stddev-sans-first:2.55 19:01:08 INFO - PROCESS | 1670 | Values: 202.0 197.0 200.0 200.0 192.0 196.0 196.0 194.0 197.0 196.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:64.80 Median:60.50 stddev:9.54 (15.8%) stddev-sans-first:9.65 19:01:08 INFO - PROCESS | 1670 | Values: 73.0 59.0 59.0 84.0 62.0 59.0 58.0 59.0 77.0 58.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:77.00 stddev:10.86 (14.1%) stddev-sans-first:11.46 19:01:08 INFO - PROCESS | 1670 | Values: 81.0 66.0 90.0 73.0 71.0 70.0 88.0 70.0 70.0 98.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:90.00 stddev:1.78 (2.0%) stddev-sans-first:1.87 19:01:08 INFO - PROCESS | 1670 | Values: 90.0 88.0 90.0 88.0 90.0 87.0 91.0 89.0 93.0 88.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:108.10 Median:96.00 stddev:20.63 (21.5%) stddev-sans-first:21.83 19:01:08 INFO - PROCESS | 1670 | Values: 112.0 94.0 152.0 139.0 96.0 103.0 97.0 96.0 96.0 96.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:92.50 stddev:3.06 (3.3%) stddev-sans-first:2.45 19:01:08 INFO - PROCESS | 1670 | Values: 99.0 91.0 92.0 92.0 93.0 98.0 91.0 95.0 92.0 90.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:59.50 stddev:1.99 (3.3%) stddev-sans-first:1.94 19:01:08 INFO - PROCESS | 1670 | Values: 56.0 56.0 56.0 57.0 59.0 61.0 60.0 57.0 60.0 60.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:4.61 (6.4%) stddev-sans-first:4.49 19:01:08 INFO - PROCESS | 1670 | Values: 67.0 71.0 72.0 80.0 77.0 72.0 68.0 69.0 68.0 78.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:84.00 stddev:10.94 (13.0%) stddev-sans-first:11.34 19:01:08 INFO - PROCESS | 1670 | Values: 84.0 84.0 92.0 93.0 80.0 88.0 102.0 103.0 73.0 107.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:158.50 Median:159.00 stddev:16.89 (10.6%) stddev-sans-first:17.91 19:01:08 INFO - PROCESS | 1670 | Values: 157.0 158.0 143.0 160.0 155.0 161.0 162.0 133.0 199.0 157.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:166.50 stddev:2.42 (1.5%) stddev-sans-first:2.54 19:01:08 INFO - PROCESS | 1670 | Values: 165.0 171.0 162.0 166.0 168.0 165.0 166.0 167.0 164.0 167.0 19:01:08 INFO - PROCESS | 1670 | 19:01:08 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 19:01:08 INFO - PROCESS | 1670 | Values: 68.0 67.0 68.0 65.0 69.0 66.0 68.0 67.0 68.0 66.0 19:01:08 INFO - PROCESS | 1670 | -------- Summary: end -------- 19:01:08 INFO - PROCESS | 1670 | 19:01:09 INFO - TEST-INFO | 1670: exit 0 19:01:09 INFO - TEST-OK | kraken | took 59030ms 19:01:09 INFO - SUITE-END | took 1172s 19:01:09 INFO - Completed test suite (00:19:32) 19:01:09 INFO - javascript benchmark 19:01:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7370.942908674904, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3423.0586588688107, 3436.398630239709, 3439.9140021499466, 3452.344054629622, 3487.4768784682296, 5825.679587622679, 5873.647581145135, 5907.40925907409, 5922.437368449996, 5946.345901950787, 5799.9130013049835, 5882.264716910387, 5888.5877988540815, 5908.08424694172, 5915.733791979361, 5273.657212281209, 5315.176147697113, 5343.038253114438, 5369.194620806871, 5445.292112025451, 5372.462753724616, 5391.838244852661, 5400.675959442427, 5403.51368376846, 5411.918821217665, 5266.394364648077, 5277.947220527784, 5392.083345831218, 5408.2698835657275, 5440.0, 5313.601479889005, 5357.785688572452, 5361.490658387447, 5363.54409875163, 5413.377461591888, 5278.208268759717, 5301.390340110859, 5324.627276090675, 5395.05586522357, 5406.297181366436, 5695.886082278373, 5963.2844058713235, 5983.222181116427, 6037.0, 6038.57729958903, 6150.84622884427, 6157.568970172089, 6167.568270221086, 6202.28673702521, 6210.627362358273, 6216.471599914013, 6267.561270711052, 6285.340039295899, 6287.591306565058, 6320.083587879732, 5909.0, 6017.48851347636, 6031.487323577458, 6039.939600604026, 6044.516438684895, 6223.159873417031, 6298.590591611531, 6324.2410910691015, 6341.55609107358, 6372.267189273293, 5312.495312945264, 5990.011648078018, 6181.598196117238, 6252.781152659635, 6257.43683068526, 6122.367660829195, 6182.6599537024995, 6219.533534984895, 6288.993760998218, 6293.244810622755, 5341.0, 5531.9723401382735, 6011.789587364421, 6272.655003974825, 6280.026595877646, 6118.265808102967, 6211.565190436717, 6212.192414986023, 6243.687815609202, 6253.405926436982, 4390.946172918477, 4415.646748260196, 4931.0, 4979.925301120486, 5028.32117664118, 4437.378766972626, 4442.73343599385, 4464.732116073046, 4476.6418686505, 4580.335851301609, 6019.578629495981, 6033.487153591994, 6040.969795150996, 6077.9392206078255, 6086.05666121743, 5791.305043394819, 6142.6314421134875, 6291.087792270096, 6295.937040629627, 6330.208723909512, 5534.861628459321, 5839.824805255849, 5962.403759624003, 5989.790357337472, 6035.456808887221, 5543.667379957215, 5565.582581306418, 5568.554515638739, 5570.303712035996, 5575.804846830341, 6393.680315984182, 6404.1674582304, 6485.1245081914285, 6493.8701225976165, 6558.606483610999, 6123.632582045091, 6130.264368275835, 6130.826205142237, 6154.723037463235, 6251.906221406592, 6433.935660643334, 6442.484601231984, 6444.420002199825, 6449.419552240133, 6464.644444555594, 5597.216389705363, 6148.815535533941, 6177.722002509988, 6284.057391391328, 6294.653794041188, 6121.663308518075, 6181.289151747606, 6181.443670069715, 6231.40801623845, 6309.526785491014, 6116.1836049259855, 6203.8138855834395, 6260.467860231749, 6274.592151510137, 6274.686265686606, 4887.633427492881, 6133.938660613337, 6247.687615619292, 6269.937300626935, 6281.309056003927, 5867.237259156454, 5965.522758179249, 6063.969680151571, 6161.815145545641, 6177.073438984008, 6056.606320589148, 6080.787172448943, 6126.203593532812, 6132.356102609162, 6140.017597184429, 5979.581429300081, 5997.580169388276, 6013.849653758691, 6027.246594175728, 6041.939580604314], "value": 5769.696940446007, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.4901555335791, 509.5337765944161, 527.9414773379374, 530.7372850439033, 565.9717014149292, 38831.0, 41296.58703412965, 41335.0, 41354.58645413545, 41471.99999999996, 42413.15173696524, 42930.92672683184, 42931.0, 42936.57063429365, 43066.569334306725, 9711.902880971205, 9875.851862222036, 9907.50462476877, 9928.751781205456, 9989.150922171588, 9802.509874506282, 9857.211423086172, 9863.556139973718, 9874.210063194927, 9927.652532161375, 9866.408015519057, 9888.505574721272, 9929.652462163825, 9935.254855885802, 9951.850722239173, 9880.802383952352, 9890.406575605486, 9909.405435673883, 9925.156361709263, 9926.65256716015, 7977.960110199469, 8309.8338033239, 8334.66661333552, 8341.708040218624, 9840.261980351503, 40570.59429405698, 40771.38842917359, 40778.18443631111, 40912.59087409118, 41190.58809411927, 3252.9349413011846, 3255.348930213943, 3276.918077048069, 3377.7804442711144, 3386.5258863759095, 29427.852860735773, 29556.704432955827, 29865.98280104363, 31184.0, 31386.21534461634, 3063.326068264978, 3175.4442972479956, 3278.508223766454, 3409.9488507672404, 3412.9488057679155, 513627.0, 518306.0, 520216.0, 523352.0, 523436.0, 50432.0, 64312.0, 64411.67794161093, 64414.71170576562, 64518.67740661267, 64615.67692161509, 66219.66890165614, 66323.66838165779, 66704.33295666981, 66876.6656166716, 16462.259198336105, 16494.587635309214, 16863.409780657617, 17003.40488082911, 17028.233729481955, 13011.414486348138, 13053.28206948627, 13161.407736651874, 13185.802212966813, 13209.273489958145, 14760.48338308154, 16259.51221463358, 18195.27218911255, 18201.908990455227, 18234.0, 3221.3396253767924, 6983.615901125385, 7129.073220481408, 7206.171290301682, 7261.41908647307, 891.3359547137295, 956.1307643556829, 980.2648013989508, 1010.685530135995, 1037.6160820496314, 29935.251618709706, 30468.933587324336, 30633.162010279008, 30737.538936915964, 30887.2278193047, 991.9950400247952, 1006.1347241372414, 1029.6807989523272, 1089.455272363818, 1092.808758467265, 14547.563573092824, 16267.349306027627, 16678.416255431002, 16883.91558042202, 17067.829321706624, 690365.0, 706509.0, 706795.0, 707815.0, 709549.0, 60713.392866071656, 61046.38953610407, 61081.38918610757, 61560.076598851054, 61589.0, 1349.197227649547, 1354.986450135486, 1376.167418711685, 1381.6407733989236, 1383.557261676274, 30471.0, 30476.695233047387, 30836.53745193779, 31686.207844804063, 32183.35633287368, 52646.210306846195, 57577.0, 59078.0, 59298.11052834125, 62116.689416554436, 657343.0, 661522.0, 663336.0, 663620.0, 665214.0, 44305.11389772251, 44343.556564433944, 44720.0, 44906.326405104606, 44958.325625114994, 47807.04385912332, 48122.75938620425, 48413.0, 48817.511824881294, 49301.0, 33932.830335848164, 40043.79978100091, 40520.3921941177, 40900.1819963605, 42022.0, 40943.18113637651, 41488.79255603703, 41562.792186038874, 41635.1672966545, 41764.791176043924, 38491.42262866003, 38776.418353724155, 38809.2238155241, 38914.02714932036, 39232.607673922896, 34145.31709365849, 35257.76597819064, 36159.63840361668, 36220.27559448849, 36253.456198157575, 25115.623265651397, 25240.873795630905, 26429.0, 26830.597541037292, 26887.73112268852], "value": 20692.975534536174, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.1488109194858, 382.2164562646575, 387.83904679557975, 390.0580099060765, 408.98775530561863, 15930.0, 18640.440786776384, 20542.178312867487, 20725.481862953435, 20945.37163885084, 11669.24149930254, 11774.646760597196, 11797.99717024054, 12127.029837612992, 16877.73416993724, 5373.704446255445, 5651.463111004448, 5663.915041274384, 5683.204351390808, 5688.232088668039, 3971.344728119857, 4412.271975124101, 5575.888482230353, 6222.502199824004, 6295.0, 6221.066839974017, 6265.592736472115, 6276.089966954789, 6292.71682774274, 6300.684965751717, 5751.25233719618, 6044.0, 6090.5736598438125, 6100.206973093514, 6155.384461553854, 5815.098659707752, 5902.527797776168, 5938.732757025901, 5986.371430999726, 6002.129691194752, 13265.469381224739, 13323.666908327272, 13416.597502074954, 13455.192688438725, 13538.796918046237, 2172.652375619893, 2326.162581470669, 2356.516914032636, 2376.2871138658334, 2632.7757592719286, 9454.14912657864, 9792.461414622192, 9885.060919212663, 10299.53652085658, 10521.631742888962, 1621.5216511129245, 1882.1342182596022, 1913.4642300155979, 1946.4647222013919, 1947.5617985953188, 108835.91164088337, 119295.0, 123118.38440807829, 132526.99999999904, 134072.0, 9560.713178604654, 9935.701928942144, 11635.41822908868, 11687.824682629767, 12274.509019639114, 14907.627309317137, 14926.402943882124, 14934.40262389514, 14942.70114597702, 14968.925155374154, 7373.446991475661, 8494.702685406104, 8658.567071646392, 8739.43193692408, 8825.867611985825, 8571.871421928676, 8673.392862499692, 8674.6530138795, 8811.162939520864, 8821.955890220508, 4524.728516289033, 4590.380298659638, 4593.885152871138, 4607.470140933769, 4661.953380466152, 1433.5985923941314, 1504.0, 1700.9574760630835, 1940.5348961534235, 2005.8696184747944, 894.7539426657592, 954.8875559972693, 965.4014511003082, 972.2707969023232, 982.8181786369545, 19505.707414388795, 20768.22038765635, 20789.0, 20801.0, 20847.791522084888, 888.3692578269372, 902.7382059202889, 959.2565761534727, 992.3847214726771, 1034.4414016431194, 10509.579616815241, 10899.400532970763, 10930.398828064534, 10946.397948112772, 10978.670639880816, 454542.0, 563881.0, 571556.0, 578773.0, 582065.0, 65954.0, 107971.92028079618, 120523.39738301252, 123454.38272808578, 125739.37130314289, 930.06993006993, 953.6233187890883, 953.7758626722715, 969.9175570076482, 974.0503009565617, 14837.406503740161, 15767.132807695687, 16399.508014759576, 17907.0, 18657.72013419827, 42452.787736061124, 54049.0, 55352.72323638517, 55361.44638553563, 57154.0, 77294.61352693201, 80185.396292075, 87588.0, 88403.11596883948, 91620.0, 8087.716929907425, 8101.027876654839, 8355.665773368997, 8389.580520974048, 8433.87349189775, 8392.958035209786, 8857.601407936787, 12032.458539365574, 13073.0, 13308.134971226838, 11036.779264414827, 11098.167637427387, 11345.829812552653, 11374.31754094757, 11419.771604568028, 8844.73465796027, 10572.784129825168, 11000.119990400908, 11107.222494425312, 11597.0, 10060.84908726355, 11463.254888432559, 11552.94223528877, 11770.0, 11891.227070240408, 7182.389496892613, 8067.919320806717, 8311.750647480585, 8426.988761348677, 8508.872366914378, 9486.33595648298, 9618.759531011501, 11254.38100904458, 11540.076793856639, 11705.648830535098], "value": 9162.205817997787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.3666808181201, 1555.5411153709654, 1682.629821439283, 1785.0896043018056, 1874.0, 8209.220124088202, 8482.660693572265, 8707.259882909952, 9300.720978370651, 9312.255019598433, 8677.869831952527, 9006.549672516381, 9018.323625728064, 9148.542572871364, 9180.586873590688, 2351.7648235176475, 2380.773826486481, 2381.785639292463, 2400.711914570254, 2401.00358351284, 2412.1316326122583, 2412.336607432961, 2449.7550244975537, 2454.447749256421, 2458.5943319352286, 2049.600327936053, 2414.9758502414925, 2445.9388515287083, 2456.2140115163156, 2458.40998160442, 2408.2534414331612, 2416.6979127609047, 2416.9516609667794, 2432.501337225873, 2434.513097380513, 2404.5912194926905, 2411.3730430088126, 2422.6487159361795, 2425.223928342931, 2431.3435372449517, 8939.821203575892, 9154.40496367734, 9176.403533770284, 9187.26501879848, 9191.264698824078, 4839.27410888366, 5333.2000199969925, 5359.892802143935, 5488.9725551372385, 5495.587830912697, 3544.131687736521, 3676.2096149327754, 3695.150115473429, 3707.6292370762976, 3731.0299322176156, 1066.4667666166918, 1084.3927400655657, 1099.983500247497, 1110.134095405585, 1124.9943750281277, 10532.42071686057, 11992.460339284753, 12157.574484892986, 12213.694657633541, 12258.570950016796, 4199.4120823084795, 4762.78567464465, 4798.064377446434, 4848.442429120696, 4968.105740966588, 8650.567471626393, 9062.501562413998, 10052.497375131361, 10342.224333175041, 10345.793084138426, 4596.609288210473, 5483.150111732688, 5485.451454854483, 5491.9725401373535, 5498.45015498447, 3622.9637703622625, 4450.087732014929, 4825.831095911626, 4940.333055037596, 5022.372203474566, 3529.6117427083, 4066.5323487799283, 4169.728967617156, 4174.935391475155, 4210.768407737603, 1336.9064165508516, 1343.54991077988, 1346.9932650336882, 1356.6269275949194, 1358.6875018745743, 924.542351535994, 940.0, 945.635930166877, 955.0, 979.1285755677453, 5920.0, 6089.69551522431, 6090.512758979271, 6109.053096770008, 6204.976178930516, 437.1606515490266, 438.4300409467679, 441.8939454530889, 444.6331776284578, 459.7540315930961, 4106.67146628269, 4107.774072426046, 4118.855840045584, 4150.750954942713, 4179.205950869386, 10755.784884302426, 10933.671989840317, 10997.725056873642, 11150.442477876073, 11177.0, 11063.502142403611, 11073.114150867912, 11073.892610739023, 11078.446077696082, 11121.165912556591, 7950.681972721027, 8292.958535207285, 8347.540885251248, 8351.1648835116, 8381.0, 6116.724747386467, 6133.0, 6170.969145154246, 6252.499800016079, 6259.0, 9984.051515106054, 10197.286189966631, 10238.692839214835, 10267.897321026694, 10501.47492625381, 10447.216458765472, 10510.316829406063, 10555.841662375224, 10560.207984401048, 10590.576376944837, 7163.534370265916, 7363.784975478986, 7659.234076592296, 7777.805554860947, 7889.684412623431, 8532.530710810965, 8706.085860984758, 8724.258438032584, 8725.738227853175, 8739.56302184901, 7668.348190403878, 7759.495632783851, 7789.221077892165, 7807.0, 7901.565413902291, 6449.0, 7584.127825300161, 7629.961850190713, 7683.500572462772, 7776.455648104805, 7130.500864939404, 7258.383037441666, 7275.308845659654, 7276.527025743309, 7309.305615966475, 4875.829345972874, 5035.723035232951, 5069.8732531687, 5141.329068052823, 5150.639455238097, 4240.809163587584, 4498.1003799239625, 4503.301988191835, 5200.427952925251, 5215.295935048872], "value": 4596.655278613358, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.9130252226854, 303.6856853156982, 310.9331493728848, 310.97978631388975, 312.54680712966206, 3860.4981352424215, 4662.766861656921, 5504.64219825711, 5594.1749416544635, 5678.48893599576, 5320.0, 5445.428230035839, 5546.667199968005, 5581.413951535092, 5611.2144299798065, 3619.7466177367596, 3667.413213885779, 4192.790360481979, 4217.978910105445, 4236.364545318212, 3935.803209839511, 4178.707490475668, 4235.898666346741, 4253.829846806124, 4271.231178387889, 4139.917201655965, 4148.771817550033, 4162.958370416287, 4185.9953611133415, 4192.5597812229735, 3495.5805303363504, 4151.398047283157, 4177.0, 4181.665466762652, 4208.200441916026, 3603.9279214415565, 3608.891733248007, 3613.927721445583, 3620.7827530348263, 3627.2951712695253, 4442.755648439367, 4960.61890292658, 5013.849584512434, 5258.39528454225, 5421.0, 4688.765561721901, 4777.085977553689, 4780.80876764929, 4787.54518320759, 4821.228603423436, 5574.717814902555, 5870.324912635059, 5951.821445356646, 5961.403859614047, 5987.790427335066, 3391.406503861839, 3800.3919372900205, 3805.2579746949355, 3881.786501742403, 3967.821448034845, 6122.0715474625795, 6160.87678246437, 6194.81415557534, 6210.7826226082325, 6258.3428739982555, 3991.820368083443, 3996.760194388346, 4004.2992476316526, 4005.715313443007, 4027.7381970171846, 3593.2274560968995, 3897.863574774926, 3941.7832019239218, 4035.8991025224605, 4058.553559108496, 4765.213739732974, 4781.569658730731, 4794.544518270759, 4809.0, 4810.278458231223, 4862.41651001882, 5249.380545120346, 5470.589705772083, 5851.795187168429, 5860.912086318709, 1252.6242127361754, 1274.2800317820402, 1294.2622705058216, 1367.9042467027214, 1379.7723375643106, 809.7529804101617, 813.7029984055895, 844.6991632885411, 848.3340577646518, 850.4217132349937, 4580.519045500241, 4583.839565615188, 4588.357629931812, 4596.575551214367, 4604.58558729716, 4388.824447022083, 4581.633469322446, 5071.0, 5072.032860776413, 5117.923231151536, 4164.6251837334785, 4359.0, 4614.946348874786, 4639.652026098056, 4682.461516925598, 2165.8700477971056, 2267.648514480258, 2433.720122185936, 2520.4625178641013, 2625.5165831305635, 4937.852034364991, 4983.177775667047, 5280.6039547034125, 5290.68255904647, 5298.735063246822, 4484.820607175677, 5086.685558071069, 5235.089192444806, 5254.92117618236, 5264.473302742238, 5277.8916427549875, 5680.7727690892725, 6074.605150665193, 6110.358412366815, 6311.305756366796, 5910.23166988306, 6109.297430795337, 6169.352218017044, 6174.289956655042, 6174.938250617436, 4815.7351345676325, 5116.7441627917715, 5754.1447230354925, 6083.452489275986, 6084.60450070744, 5614.382417933943, 5626.286650810445, 6405.263394709668, 6441.1304473895425, 6471.320511346241, 3328.484084966834, 3934.488516492838, 3994.980025099856, 4061.735987160825, 4110.0, 4602.029807807627, 5149.433562308218, 5277.313949186581, 5973.641581505123, 6082.9695851520455, 5787.2187254720075, 5859.9121013183985, 5920.348761636131, 5927.496162826208, 5948.434898684618, 5137.743112844418, 5397.622166448468, 5945.732442040205, 5968.373320801427, 5981.491573216325, 5319.46805319465, 5616.6068375213345, 5687.862427514431, 5786.276715410574, 5813.331466881194, 4825.710457372569, 5930.0, 5949.977007817363, 5970.492508136857, 5992.490638295793, 5493.23094766741, 5797.507211887037, 5802.245708057925, 5823.883522329615, 5846.912296315473], "value": 4113.258568986504, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.8989556618723, 701.2426579294361, 709.4820780829994, 710.7094154066674, 722.3390597603193, 15396.384144634216, 15852.524424267262, 15898.443554475596, 16007.0, 16070.598235044115, 14270.857291427083, 14369.856301436983, 14390.712185756278, 14434.42262309509, 14441.711165776678, 838.2246422059616, 875.0811647769816, 878.8945326560789, 880.5553195636227, 885.6678745470449, 840.8318336332758, 841.6633346661323, 864.6282098697588, 876.9429987050821, 886.2422628652506, 890.590328448911, 917.2661870503604, 918.9494577798218, 920.2178148573693, 922.5617831530037, 873.9082396348388, 902.7291812456302, 912.4798864647154, 913.1005959130251, 917.2432742987029, 675.746595026865, 678.159082737407, 679.7043286170482, 680.397847904603, 683.1494788987742, 15196.848031519654, 15212.46756363533, 15576.688466230611, 15589.844101559067, 15685.0, 13963.581092567138, 13994.580162595139, 14151.29243537819, 14181.220032898187, 14386.280685965765, 11731.94134029333, 11737.765244695143, 11746.471408786625, 11839.171258011942, 12035.0, 3695.334839728848, 3724.478572999782, 3781.3193625147464, 3798.0694729791376, 3883.2233553289457, 118419.81580184175, 118462.0, 122068.0, 123940.0, 124053.9999999991, 10698.251122421512, 10704.732381690521, 10854.945725271324, 10867.69587649487, 10928.672139835817, 22187.889060554917, 22201.77798221997, 22261.109555617917, 22363.55272894533, 22580.548389032458, 6294.968525157345, 6839.794806155824, 7310.122785265802, 7353.786625206781, 7882.330001949898, 4405.383246345515, 4405.669574781904, 4449.17690227309, 4456.108778244364, 4524.185646583646, 3626.6192049834917, 3647.3434781739543, 3735.3089678409583, 3756.398976163801, 3759.8684046058256, 667.5393978155057, 668.1581207678361, 668.2949488289804, 672.0758956434902, 696.2132789947327, 578.3695771608966, 588.8586739182565, 659.9439047680905, 675.1830285354775, 694.6075467360924, 8883.422577532569, 9526.523673816282, 9701.514924253901, 9763.609455621696, 9769.853452198222, 573.4695406748741, 596.3916804859106, 617.5831313863124, 636.9968150159312, 676.9187697476236, 4024.678025757991, 4318.265894797892, 4508.32375143731, 4657.0, 4770.0, 94055.0, 98519.50740246254, 106155.46922265494, 135562.0, 156640.0, 130745.0, 130926.34536827255, 131499.0, 133641.0, 133699.0, 111025.88974110155, 112394.0, 114069.0, 116066.0, 118438.40780796041, 7635.503692259986, 7714.537127772352, 8650.221480066573, 9068.22920051803, 9146.085391460801, 60782.0, 62165.0, 62553.061704075386, 62981.370186299384, 64191.037134442086, 87542.1245787534, 95064.52467737618, 95360.0, 97904.0, 98198.5090074545, 11548.711282218012, 11691.181617286707, 11747.17769756143, 11831.763364732486, 11833.0, 11891.537739923087, 12051.75896482048, 12382.5666101686, 12706.428210730724, 12721.173123746927, 11467.19729618952, 11609.173710505573, 12937.54718584845, 13189.670258243237, 14438.85561144375, 12368.876311237133, 13457.798133027816, 13517.459301627825, 14174.503892363718, 14343.928280358949, 13435.932820335836, 13950.651233719238, 14086.22525761093, 14105.647358816112, 14416.846652267584, 11095.334279943228, 11393.430328483708, 11414.714632133931, 11485.712857178638, 11741.354225517336, 10645.627403040857, 10901.291416057931, 11626.0, 11671.824922626338, 11878.346690932081], "value": 7753.327713699665, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1490.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 119.0, 119.0, 119.0, 95.0, 174.0, 174.0, 117.0, 119.0], "value": 126.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 109.0, 112.0, 143.0, 111.0, 111.0, 114.0, 97.0, 173.0, 96.0], "value": 121.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 197.0, 200.0, 200.0, 192.0, 196.0, 196.0, 194.0, 197.0, 196.0], "value": 197.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 59.0, 59.0, 84.0, 62.0, 59.0, 58.0, 59.0, 77.0, 58.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 66.0, 90.0, 73.0, 71.0, 70.0, 88.0, 70.0, 70.0, 98.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 90.0, 88.0, 90.0, 87.0, 91.0, 89.0, 93.0, 88.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 94.0, 152.0, 139.0, 96.0, 103.0, 97.0, 96.0, 96.0, 96.0], "value": 108.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 91.0, 92.0, 92.0, 93.0, 98.0, 91.0, 95.0, 92.0, 90.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 59.0, 61.0, 60.0, 57.0, 60.0, 60.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 72.0, 80.0, 77.0, 72.0, 68.0, 69.0, 68.0, 78.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 92.0, 93.0, 80.0, 88.0, 102.0, 103.0, 73.0, 107.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 143.0, 160.0, 155.0, 161.0, 162.0, 133.0, 199.0, 157.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 171.0, 162.0, 166.0, 168.0, 165.0, 166.0, 167.0, 164.0, 167.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 65.0, 69.0, 66.0, 68.0, 67.0, 68.0, 66.0], "value": 67.2, "unit": "score"}]}]} 19:01:10 INFO - Return code: 0 19:01:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:01:10 ERROR - # TBPL SUCCESS # 19:01:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:01:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:01:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:01:10 INFO - 2016-10-24 19:01:10.091 screenresolution[1675:10772] starting screenresolution argv=screenresolution get 19:01:10 INFO - 2016-10-24 19:01:10.094 screenresolution[1675:10772] Display 0: 1600x1200x32@60 19:01:10 INFO - 2016-10-24 19:01:10.100 screenresolution[1676:10775] starting screenresolution argv=screenresolution list 19:01:10 INFO - Available Modes on Display 0 19:01:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:01:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:01:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:01:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:01:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:01:10 INFO - Intel Iris: 19:01:10 INFO - Chipset Model: Intel Iris 19:01:10 INFO - Type: GPU 19:01:10 INFO - Bus: Built-In 19:01:10 INFO - VRAM (Dynamic, Max): 1536 MB 19:01:10 INFO - Vendor: Intel (0x8086) 19:01:10 INFO - Device ID: 0x0a2e 19:01:10 INFO - Revision ID: 0x0009 19:01:10 INFO - Displays: 19:01:10 INFO - Display: 19:01:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:01:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:01:10 INFO - Display Serial Number: 1600x1200 60 19:01:10 INFO - Main Display: Yes 19:01:10 INFO - Mirror: Off 19:01:10 INFO - Online: Yes 19:01:10 INFO - Rotation: Supported 19:01:10 INFO - Return code: 0 19:01:10 INFO - Running post-action listener: _resource_record_post_action 19:01:10 INFO - [mozharness: 2016-10-25 02:01:10.336578Z] Finished run-tests step (success) 19:01:10 INFO - Running post-run listener: _resource_record_post_run 19:01:10 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 37195776; Write bytes: 667145216; Read time: 241; Write time: 1919 19:01:10 INFO - TinderboxPrint: CPU usage
54.4% 19:01:10 INFO - TinderboxPrint: I/O read bytes / time
37,195,776 / 241 19:01:10 INFO - TinderboxPrint: I/O write bytes / time
667,145,216 / 1,919 19:01:10 INFO - TinderboxPrint: CPU idle
2,198.4 (45.6%) 19:01:10 INFO - TinderboxPrint: CPU system
977.7 (20.3%) 19:01:10 INFO - TinderboxPrint: CPU user
1,649.6 (34.2%) 19:01:10 INFO - TinderboxPrint: Swap in / out
400,957,440 / 0 19:01:10 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355561984; Write bytes: 357144576; Read time: 27424; Write time: 732 19:01:10 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 36237312; Write bytes: 299813888; Read time: 227; Write time: 1152 19:01:10 INFO - Running post-run listener: _upload_blobber_files 19:01:10 INFO - Blob upload gear active. 19:01:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:01:10 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 19:01:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:01:11 INFO - (blobuploader) - INFO - Open directory for files ... 19:01:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:01:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:01:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:12 INFO - (blobuploader) - INFO - Done attempting. 19:01:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:01:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:01:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:13 INFO - (blobuploader) - INFO - Done attempting. 19:01:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:01:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:15 INFO - (blobuploader) - INFO - Done attempting. 19:01:15 INFO - (blobuploader) - INFO - Iteration through files over. 19:01:15 INFO - Return code: 0 19:01:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:01:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:01:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f3934696ec98c96d30a841653c95f753172f5b937d21d0d242ebacac9d0cd29d81dd98054dac2cc3fab428b45674e2960aae388de145e5f15876fc108b67eb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c9f732eb8faa9c223afb0c940fa058f46e001013754caf1c53a2a68fd0fbcf4a5ddb66211c0e832a0d8af9a7780b6c24b4418cb37654e10b8f95d88f4e6183", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a52b2871b9f30b426f0232a9471efb1946f2b88e7402a4df1d49204ca7ffb11bc5edcfe8aafcfbf489279da2b9c30337d359146956d42bde6cb0a205bef8b649"} 19:01:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:01:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:01:15 INFO - Contents: 19:01:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f3934696ec98c96d30a841653c95f753172f5b937d21d0d242ebacac9d0cd29d81dd98054dac2cc3fab428b45674e2960aae388de145e5f15876fc108b67eb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c9f732eb8faa9c223afb0c940fa058f46e001013754caf1c53a2a68fd0fbcf4a5ddb66211c0e832a0d8af9a7780b6c24b4418cb37654e10b8f95d88f4e6183", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a52b2871b9f30b426f0232a9471efb1946f2b88e7402a4df1d49204ca7ffb11bc5edcfe8aafcfbf489279da2b9c30337d359146956d42bde6cb0a205bef8b649"} 19:01:15 INFO - Running post-run listener: copy_logs_to_upload_dir 19:01:15 INFO - Copying logs to upload dir... 19:01:15 INFO - mkdir: /builds/slave/test/build/upload/logs 19:01:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.247136 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-24 19:01:15.993597) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 19:01:16.002667) ========= 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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f3934696ec98c96d30a841653c95f753172f5b937d21d0d242ebacac9d0cd29d81dd98054dac2cc3fab428b45674e2960aae388de145e5f15876fc108b67eb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c9f732eb8faa9c223afb0c940fa058f46e001013754caf1c53a2a68fd0fbcf4a5ddb66211c0e832a0d8af9a7780b6c24b4418cb37654e10b8f95d88f4e6183", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a52b2871b9f30b426f0232a9471efb1946f2b88e7402a4df1d49204ca7ffb11bc5edcfe8aafcfbf489279da2b9c30337d359146956d42bde6cb0a205bef8b649"} build_url:https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/Pmc3hO1RSbecRhMU9I7Jjw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f3934696ec98c96d30a841653c95f753172f5b937d21d0d242ebacac9d0cd29d81dd98054dac2cc3fab428b45674e2960aae388de145e5f15876fc108b67eb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c9f732eb8faa9c223afb0c940fa058f46e001013754caf1c53a2a68fd0fbcf4a5ddb66211c0e832a0d8af9a7780b6c24b4418cb37654e10b8f95d88f4e6183", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a52b2871b9f30b426f0232a9471efb1946f2b88e7402a4df1d49204ca7ffb11bc5edcfe8aafcfbf489279da2b9c30337d359146956d42bde6cb0a205bef8b649"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 19:01:16.046757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:01:16.047081) ========= 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.3Y2EvmyX2T/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.n6tgiYuPN6/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.005127 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:01:16.098047) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 19:01:16.098373) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 19:01:16.098686) ========= ========= Total master_lag: 0.58 =========